Announcement

Collapse
No announcement yet.

XML error

Collapse
X
 
  • Filter
  • Time
  • Show
Clear All
new posts

    XML error

    The PI has been controlling my Hayward/Goldline panel since August.

    I am recently experiencing an XML error.
    HTML Code:
    ct-05 8:11:29 AM	 	Autelis	ERROR System.InvalidOperationException: There is an error in XML document (0, 0). ---> System.Xml.XmlException: Root element is missing. at System.Xml.XmlTextReaderImpl.Throw(Exception e) at System.Xml.XmlTextReaderImpl.ParseDocumentContent() at System.Xml.XmlTextReaderImpl.Read() at System.Xml.XmlTextReader.Read() at System.Xml.XmlReader.MoveToContent() at Microsoft.Xml.Serialization.GeneratedAssembly.XmlSerializationReaderHaywardStatusResponse.Read6_response() --- End of inner exception stack trace --- at System.Xml.Serialization.XmlSerializer.Deserialize(XmlReader xmlReader, String encodingStyle, XmlDeserializationEvents events) at System.Xml.Serialization.XmlSerializer.Deserialize(TextReader textReader) at HSPI_Autelis.HaywardController.GetStatusCmd() at HSPI_Autelis.AutelisApp.OnPollTimerEvent(Object sender, ElapsedEventArgs e)
    Oct-05 8:11:29 AM	 	Autelis	ERROR WebException: Timeout The operation has timed out
    I am able to access the Autelis GUI. I have run a on going ping test to the device with no dropped packets. Not sure why PI is timing out?

    XML status page for Autelis:
    HTML Code:
    <response>
    <system>
    <model>512</model>
    <opmode>0</opmode>
    <err>0</err>
    <version>1.0.12</version>
    <time>1507205950</time>
    </system>
    <equipment>
    <pump>1</pump>
    <spa>0</spa>
    <waterfall>1</waterfall>
    <valve3>0</valve3>
    <poolht>0</poolht>
    <valve4>0</valve4>
    <aux1>0</aux1>
    <aux2>0</aux2>
    <aux3>1</aux3>
    <aux4>0</aux4>
    <aux5>0</aux5>
    <aux6>0</aux6>
    <aux7>0</aux7>
    <aux8/>
    <aux9/>
    <aux10/>
    <aux11/>
    <aux12/>
    <aux13/>
    <aux14/>
    <aux15/>
    <schlor>0</schlor>
    </equipment>
    <temp>
    <pooltemp>84</pooltemp>
    <spatemp>101</spatemp>
    <airtemp>58</airtemp>
    <solartemp/>
    <tempunits>F</tempunits>
    </temp>
    </response>
    Larry

    #2
    did you make sure that the IP set in the config page is still the right one?

    Comment


      #3
      Yes. IP, port and password have not changed in the config.

      I have re-entered the above info in the config & returned on debug logging. It is working now.
      Last edited by lpcalcaterra; October 5, 2017, 07:47 AM. Reason: update
      Larry

      Comment


        #4
        Well it work for a while then error returns:
        Code:
        Oct-05 9:04:56 AM	 	Z-Wave	Device: BASEMENT Laundry Washing Machine Watts Set to 1.922 (1.922 Watts)
        Oct-05 9:04:29 AM	 	Autelis	ERROR System.InvalidOperationException: There is an error in XML document (0, 0). ---> System.Xml.XmlException: Root element is missing. at System.Xml.XmlTextReaderImpl.Throw(Exception e) at System.Xml.XmlTextReaderImpl.ParseDocumentContent() at System.Xml.XmlTextReaderImpl.Read() at System.Xml.XmlTextReader.Read() at System.Xml.XmlReader.MoveToContent() at Microsoft.Xml.Serialization.GeneratedAssembly.XmlSerializationReaderHaywardStatusResponse.Read6_response() --- End of inner exception stack trace --- at System.Xml.Serialization.XmlSerializer.Deserialize(XmlReader xmlReader, String encodingStyle, XmlDeserializationEvents events) at System.Xml.Serialization.XmlSerializer.Deserialize(TextReader textReader) at HSPI_Autelis.HaywardController.GetStatusCmd() at HSPI_Autelis.AutelisApp.OnPollTimerEvent(Object sender, ElapsedEventArgs e)
        Oct-05 9:04:29 AM	 	Autelis	ERROR WebException: Timeout The operation has timed out
        Oct-05 9:04:22 AM	 	Autelis	INFO CMD SENT: http://192.168.1.89:89/status.xml?
        Oct-05 9:04:18 AM	 	NO ECHO	No Echo for KITCHEN Motion Sensor, Echo (1 mins, 25 secs)
        Oct-05 9:04:16 AM	 	Z-Wave	Device: BASEMENT Laundry Washing Machine Watts Set to 1.998 (1.998 Watts)
        Oct-05 9:04:14 AM	 	NO ECHO	No Echo for Living Room Motion Sensor, Echo (1 mins, 29 secs)
        Oct-05 9:04:10 AM	 	NO ECHO	No Echo for MASTER Bedroom Motion Sensor, Echo (1 mins, 59 secs)
        Oct-05 9:04:09 AM	 	Z-Wave	Device: 3RD FLOOR Humidity Set to 56 (%)
        Oct-05 9:04:07 AM	 	Event	Running script in background: G:/Program Files/HomeSeer HS3/scripts/Jon00VDGraphingHS3.vben
        Oct-05 9:04:07 AM	 	Event	Event Trigger "Graphing SubZero power graph"
        Oct-05 9:04:07 AM	 	Z-Wave	Device: 1ST FLOOR KITCHEN Refridgerator Current Power Set to 243.979 (W)
        Oct-05 9:03:46 AM	 	Z-Wave	Device: BASEMENT Laundry Washing Machine Watts Set to 1.892 (1.892 Watts)
        Oct-05 9:03:46 AM	 	Z-Wave	Device: 1ST FLOOR FAMILY ROOM Motion Sensor Set to NOTIFICATION for type Home Security, Event: No Event
        Oct-05 9:03:39 AM	 	SENSOR RECOVERY	Sensor Recovery has occurred for Pool Pool Motion
        Oct-05 9:03:39 AM	 	NO ECHO	No Echo for Pool Pool Motion, Echo (5 mins, 3 secs)
        Oct-05 9:03:22 AM	 	Autelis	DEBUG 512 0 0 1.0.12 1507208599 1 0 1 0 0 0 0 0 1 0 0 0 0 0 84 101 60 F
        Oct-05 9:03:22 AM	 	Autelis	INFO CMD SENT: http://192.168.1.89:89/status.xml?
        Larry

        Comment


          #5
          I believe I found the issue. Windows Event viewer has multiple warnings 4226:
          "TCP/IP has reached the security limit imposed on the number of concurrent TCP connect attempts." Once limit reached PI can no longer access the XML.
          Larry

          Comment


            #6
            Originally posted by lpcalcaterra View Post
            I believe I found the issue. Windows Event viewer has multiple warnings 4226:
            "TCP/IP has reached the security limit imposed on the number of concurrent TCP connect attempts." Once limit reached PI can no longer access the XML.
            stange..., have you tried to find the process that try to open a lot of TCP connections?
            as explained here: https://serverfault.com/questions/51...-event-message

            Comment


              #7
              Blaser is my HS PC. I am not share how to troubleshoot this. The external connections look suspicious.

              With HS closed/off there are only 3-4 tcp connections.

              HTML Code:
              Active Connections
              
                Proto  Local Address          Foreign Address        State           PID
                TCP    blaser:1330            localhost:1331         ESTABLISHED     3828
                TCP    blaser:1331            localhost:1330         ESTABLISHED     6748
                TCP    blaser:1404            localhost:10400        ESTABLISHED     10744
                TCP    blaser:1405            localhost:10400        ESTABLISHED     10744
                TCP    blaser:1406            localhost:10400        ESTABLISHED     7324
                TCP    blaser:1407            localhost:10400        ESTABLISHED     7324
                TCP    blaser:1410            localhost:10400        ESTABLISHED     9892
                TCP    blaser:1411            localhost:10400        ESTABLISHED     9892
                TCP    blaser:1414            localhost:10400        ESTABLISHED     4128
                TCP    blaser:1415            localhost:10400        ESTABLISHED     4128
                TCP    blaser:1417            localhost:10400        ESTABLISHED     4884
                TCP    blaser:1418            localhost:10400        ESTABLISHED     4884
                TCP    blaser:1420            localhost:10400        ESTABLISHED     10608
                TCP    blaser:1421            localhost:10400        ESTABLISHED     10608
                TCP    blaser:1422            localhost:10400        ESTABLISHED     1892
                TCP    blaser:1423            localhost:10400        ESTABLISHED     1892
                TCP    blaser:1424            localhost:10400        ESTABLISHED     6276
                TCP    blaser:1425            localhost:10400        ESTABLISHED     6276
                TCP    blaser:1426            localhost:10400        ESTABLISHED     3784
                TCP    blaser:1427            localhost:10400        ESTABLISHED     3784
                TCP    blaser:1428            localhost:10400        ESTABLISHED     11260
                TCP    blaser:1429            localhost:10400        ESTABLISHED     11260
                TCP    blaser:1430            localhost:10400        ESTABLISHED     10168
                TCP    blaser:1431            localhost:10400        ESTABLISHED     10168
                TCP    blaser:1432            localhost:10400        ESTABLISHED     3956
                TCP    blaser:ms-sql-s        localhost:10400        ESTABLISHED     3956
                TCP    blaser:1436            localhost:10400        ESTABLISHED     1436
                TCP    blaser:1437            localhost:10400        ESTABLISHED     1436
                TCP    blaser:1438            localhost:10400        ESTABLISHED     9208
                TCP    blaser:1439            localhost:10400        ESTABLISHED     9208
                TCP    blaser:1532            localhost:10401        ESTABLISHED     5240
                TCP    blaser:1537            localhost:10401        ESTABLISHED     2324
                TCP    blaser:1542            localhost:10401        ESTABLISHED     3240
                TCP    blaser:10400           localhost:1404         ESTABLISHED     404
                TCP    blaser:10400           localhost:1405         ESTABLISHED     404
                TCP    blaser:10400           localhost:1406         ESTABLISHED     404
                TCP    blaser:10400           localhost:1407         ESTABLISHED     404
                TCP    blaser:10400           localhost:1410         ESTABLISHED     404
                TCP    blaser:10400           localhost:1411         ESTABLISHED     404
                TCP    blaser:10400           localhost:1414         ESTABLISHED     404
                TCP    blaser:10400           localhost:1415         ESTABLISHED     404
                TCP    blaser:10400           localhost:1417         ESTABLISHED     404
                TCP    blaser:10400           localhost:1418         ESTABLISHED     404
                TCP    blaser:10400           localhost:1420         ESTABLISHED     404
                TCP    blaser:10400           localhost:1421         ESTABLISHED     404
                TCP    blaser:10400           localhost:1422         ESTABLISHED     404
                TCP    blaser:10400           localhost:1423         ESTABLISHED     404
                TCP    blaser:10400           localhost:1424         ESTABLISHED     404
                TCP    blaser:10400           localhost:1425         ESTABLISHED     404
                TCP    blaser:10400           localhost:1426         ESTABLISHED     404
                TCP    blaser:10400           localhost:1427         ESTABLISHED     404
                TCP    blaser:10400           localhost:1428         ESTABLISHED     404
                TCP    blaser:10400           localhost:1429         ESTABLISHED     404
                TCP    blaser:10400           localhost:1430         ESTABLISHED     404
                TCP    blaser:10400           localhost:1431         ESTABLISHED     404
                TCP    blaser:10400           localhost:1432         ESTABLISHED     404
                TCP    blaser:10400           localhost:ms-sql-s     ESTABLISHED     404
                TCP    blaser:10400           localhost:1436         ESTABLISHED     404
                TCP    blaser:10400           localhost:1437         ESTABLISHED     404
                TCP    blaser:10400           localhost:1438         ESTABLISHED     404
                TCP    blaser:10400           localhost:1439         ESTABLISHED     404
                TCP    blaser:10401           localhost:1532         ESTABLISHED     404
                TCP    blaser:10401           localhost:1537         ESTABLISHED     404
                TCP    blaser:10401           localhost:1542         ESTABLISHED     404
                TCP    blaser:http            192.168.1.112:61865    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61866    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61867    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61868    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61869    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61870    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61889    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61890    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61891    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61892    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61893    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61894    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61895    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61896    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61897    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61898    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61899    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61900    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61901    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61902    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61903    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61904    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61907    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61908    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61909    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61910    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61911    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61912    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61913    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61914    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61916    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61917    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61918    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61919    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61920    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61921    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61922    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61923    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61924    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61925    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61926    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61927    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61928    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61929    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61930    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61931    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61932    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61933    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61934    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61935    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61943    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61944    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61945    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61946    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61947    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61948    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61949    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61950    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61951    TIME_WAIT       0
                TCP    blaser:http            192.168.1.112:61953    TIME_WAIT       0
                TCP    blaser:1399            ec2-54-200-211-218.us-west-2.compute.amazonaws.c
              om:https  CLOSE_WAIT      3900
                TCP    blaser:1401            server-13-33-164-51.ord50.r.cloudfront.net:https
                CLOSE_WAIT      3900
                TCP    blaser:1416            TIVO-6580201902226D7.XXX:31339  E
              STABLISHED     4128
                TCP    blaser:1419            192.168.1.253:4998     ESTABLISHED     4884
                TCP    blaser:1435            Z-Net220.XXX:2001  ESTABLISHED
                3956
                TCP    blaser:1443            40.76.43.114:8245      TIME_WAIT       0
                TCP    blaser:1444            40.76.43.114:https     TIME_WAIT       0
                TCP    blaser:1445            45.76.21.192.vultr.com:10300  ESTABLISHED     40
              4
                TCP    blaser:1447            40.76.43.114:https     TIME_WAIT       0
                TCP    blaser:1450            blaser.calc.local:10400  ESTABLISHED     11580
                TCP    blaser:1451            dhcp-0-e-c4-d1-44-af.cpe.quadro.net:http  TIME_W
              AIT       0
                TCP    blaser:1461            roc2.thegainhosting.com:http  LAST_ACK        40
              4
                TCP    blaser:1466            40.76.5.137:http       TIME_WAIT       0
                TCP    blaser:1467            72-250-139-196.midrivers.com:http  TIME_WAIT
                 0
                TCP    blaser:1468            23.101.118.145:http    TIME_WAIT       0
                TCP    blaser:1469            host.123hostingserver.com:http  LAST_ACK
              404
                TCP    blaser:1470            ip-23-229-173-26.ip.secureserver.net:http  TIME_
              WAIT       0
                TCP    blaser:1471            216.197.127.193:http   TIME_WAIT       0
                TCP    blaser:1474            c-98-194-4-150.hsd1.tx.comcast.net:http  TIME_WA
              IT       0
                TCP    blaser:1475            192.168.1.93:60128     ESTABLISHED     11260
                TCP    blaser:1476            192.168.1.96:60128     ESTABLISHED     11260
                TCP    blaser:1477            192.168.1.194:60128    ESTABLISHED     11260
                TCP    blaser:1478            192.168.1.93:60128     ESTABLISHED     11260
                TCP    blaser:1479            rev.opentransfer.com.7.164.131.98.in-addr.arpa:h
              ttp  LAST_ACK        404
                TCP    blaser:1480            blob.dm2prdstr01a.store.core.windows.net:https
              TIME_WAIT       0
                TCP    blaser:1481            webhosting2014.is.cc:http  LAST_ACK        404
                TCP    blaser:1482            ip-107-180-46-212.ip.secureserver.net:http  TIME
              _WAIT       0
                TCP    blaser:1484            90-229-140-183-no195.tbcn.telia.com:http  LAST_A
              CK        404
                TCP    blaser:1485            just49.justhost.com:http  LAST_ACK        404
                TCP    blaser:1486            194.63.249.218:http    LAST_ACK        404
                TCP    blaser:1488            wsip-98-172-24-4.dc.dc.cox.net:http  TIME_WAIT
                   0
                TCP    blaser:1491            www525.hostpc.com:http  LAST_ACK        404
                TCP    blaser:1516            a96-16-206-136.deploy.akamaitechnologies.com:htt
              p  TIME_WAIT       0
                TCP    blaser:1517            a96-16-206-136.deploy.akamaitechnologies.com:htt
              p  TIME_WAIT       0
                TCP    blaser:1528            blaser.calc.local:1529  ESTABLISHED     7248
                TCP    blaser:1529            blaser.calc.local:1528  ESTABLISHED     5240
                TCP    blaser:1530            blaser.calc.local:1531  ESTABLISHED     7248
                TCP    blaser:1531            blaser.calc.local:1530  ESTABLISHED     5240
                TCP    blaser:1533            blaser.calc.local:1534  ESTABLISHED     2540
                TCP    blaser:1534            blaser.calc.local:1533  ESTABLISHED     2324
                TCP    blaser:1535            blaser.calc.local:1536  ESTABLISHED     2540
                TCP    blaser:1536            blaser.calc.local:1535  ESTABLISHED     2324
                TCP    blaser:1538            blaser.calc.local:1539  ESTABLISHED     8068
                TCP    blaser:1539            blaser.calc.local:1538  ESTABLISHED     3240
                TCP    blaser:1540            blaser.calc.local:1541  ESTABLISHED     8068
                TCP    blaser:1541            blaser.calc.local:1540  ESTABLISHED     3240
                TCP    blaser:1543            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1544            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1545            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1547            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:1548            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:1549            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:1564            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1565            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1566            192.168.1.92:8100      TIME_WAIT       0
                TCP    blaser:1568            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:1569            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:1570            173-167-19-204-michigan.hfc.comcastbusiness.net:
              8100  TIME_WAIT       0
                TCP    blaser:5900            192.168.1.112:60234    ESTABLISHED     3828
                TCP    blaser:10400           blaser.calc.local:1450  ESTABLISHED     404
                TCP    blaser:10401           192.168.1.92:52440     ESTABLISHED     404
                TCP    blaser:10401           192.168.1.92:52442     ESTABLISHED     404
              Larry

              Comment

              Working...
              X