1 INFO Portal [main]: Start portal at 1173993527919 epoch msec 10 DEBUG Portal [main]: Setting security manager startRetrieveTime=1173682800000 Constructing Portal... Will publish packets to JMS 346 INFO Portal [main]: Starting registry... 360 INFO Portal [main]: registry started. 628 DEBUG Portal [main]: Creating Portal Server Socket on port 5510 Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) Save data to directory "/home/ops/siam/logs" 637 DEBUG Portal [main]: Lease time is 3600000 ms 638 DEBUG Portal [main]: Download interval is 1 seconds 638 DEBUG Portal [main]: System command is "runNtpDate" 638 DEBUG Portal [main]: Set socket factory 642 INFO PortalSocketFactory [main]: PortalSocketFactory: local host = siam-portal-3.shore.mbari.org/134.89.28.205 659 DEBUG Portal [main]: Trying to find node mse 661 DEBUG Portal [main]: Creating new PortalConnection for mse/10.1.36.2 803 DEBUG PortalConnection [main]: new PortalConnection() for node mse 863 DEBUG PublisherComponent [main]: Default constructor called 898 DEBUG PublisherComponent [main]: setTopicname called with name topic/SSDSIngestTopic 899 DEBUG PublisherComponent [main]: topicname is now topic/SSDSIngestTopic 899 DEBUG PublisherComponent [main]: Not connected so calling start 899 DEBUG PublisherComponent [main]: PublisherComponent stop called 900 DEBUG PublisherComponent [main]: Everything should be closed now 900 DEBUG PublisherComponent [main]: start called, setting connected to true 900 DEBUG PublisherComponent [main]: Going to get jndiContext 1113 DEBUG PublisherComponent [main]: JNDI environment = {java.naming.provider.url=bob:1099, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jnp.timeout=0, jnp.socketFactory=org.jnp.interfaces.TimedSocketFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, java.naming.factory.url.pkgs.Naming=org.jboss.naming, jnp.sotimeout=0} 1113 DEBUG PublisherComponent [main]: Going to get the topic connection factory from the JNDI 1152 DEBUG PortalSocketFactory [main]: PortalSocketFactory.createSocket() - host=134.89.12.73, port=1098 1153 DEBUG PortalSocketFactory [main]: return new Socket(134.89.12.73,1098)... 1154 DEBUG PortalSocketFactory [main]: PortalSocketFactory returned new Socket(134.89.12.73,1098) 1268 DEBUG SpyConnectionFactoryObjectFactory [main]: Extracting SpyConnectionFactory from reference 1537 DEBUG SpyConnectionFactoryObjectFactory [main]: The GenericConnectionFactory is: GenericConnectionFactory:[server=org.jboss.mq.il.uil2.UILServerIL@6a5671,connectionProperties={UIL_ADDRESS_KEY=134.89.12.73, UIL_CHUNKSIZE_KEY=1000000, UIL_TCPNODELAY_KEY=yes, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_PORT_KEY=8093, UIL_BUFFERSIZE_KEY=2048, PingPeriod=60000}] 1572 DEBUG PublisherComponent [main]: Going to create a topic connection from the factory 1686 DEBUG Connection [main]: Setting the clockDaemon's thread factory 1848 DEBUG SocketManager [UIL2.SocketManager.ReadTask#1]: Begin ReadTask.run 1862 DEBUG SocketManager [UIL2.SocketManager.WriteTask#2]: Begin WriteTask.run 1864 DEBUG SocketManager [UIL2.SocketManager.WriteTask#2]: Created ObjectOutputStream 1869 DEBUG SocketManager [UIL2.SocketManager.ReadTask#1]: Created ObjectInputStream 1893 DEBUG GenericConnectionFactory [main]: Handing out ClientIL: org.jboss.mq.il.uil2.UILClientILService 1893 DEBUG UILClientILService [main]: Starting 1958 DEBUG PublisherComponent [main]: Going to get the topic topic/SSDSIngestTopic from the JNDI lookup 1986 DEBUG SpyDestinationObjectFactory [main]: SpyDestinationObjectFactory->getObjectInstance() 1999 DEBUG PublisherComponent [main]: Going to create a topic session from the connection 2092 DEBUG PublisherComponent [main]: Now going to call start on the topic connection 2187 DEBUG PublisherComponent [main]: Connected was true after start 2187 DEBUG PublisherComponent [main]: Should have set the topicName to topic/SSDSIngestTopic 2189 DEBUG PortalConnection [main]: Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) 2191 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2]: DistributeWorker - started: Mar 15, 2007 2:18:50 PM 2192 DEBUG Portal [main]: Got new connection from 10.1.36.2 total = 1 2204 DEBUG NodeProbe [main]: Creating new ProbeWorker 3711 DEBUG NodeProbe [main]: got status - exiting 3712 DEBUG NodeProbe [main]: host available (1505 ms) 3735 DEBUG Portal [main]: Trying to download from mse 3793 DEBUG PortalSession [main]: new PortalSession: sid 1173993531717 3803 DEBUG PortalSession [main]: mse.sid 1173993531717 SESSION_START source: moos.operations.portal.PortalConnection@a012402 3803 DEBUG PortalSession [main]: mse.sid 1173993531717 SESSION_START message: Portal session_start - mse 3804 DEBUG PortalSession [main]: mse.sid 1173993531717 setting session start time 1173993531726 ThreadUtility.printThreads() 3813 INFO ThreadUtility [main]: ThreadGroup "main" includes about 7 threads 3830 INFO ThreadUtility [main-DBG-0]: thread: "main-DBG-0" alive thread: "_distributeWorker-mse/10.1.36.2-DBG-1" alive thread: "UIL2.SocketManager.ReadTask#1-DBG-2" alive daemon thread: "UIL2.SocketManager.WriteTask#2-DBG-3" alive daemon thread: "Connection Monitor Thread-DBG-4" alive daemon thread: "Thread-2-DBG-5" alive daemon 3832 INFO PortalConnection [main-DBG-0]: startSession()[mse]: Mar 15, 2007 2:18:51 PM 3833 DEBUG PortalConnection [main-DBG-0]: startSession()[mse] - get node proxy 3834 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.totalMemory: 2031616 3834 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.freeMemory: 1602744 3835 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - startSession: 7 3880 DEBUG PortalConnection [main-DBG-0]: Looking for node server stub at //mse/node 3881 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=mse, port=1099 3881 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(mse,1099)... 4617 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(mse,1099) 7458 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 7458 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.200,1025)... 8256 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(134.89.36.200,1025) 16576 DEBUG PortalConnection [main-DBG-0]: Connected to node surface/134.89.36.200 (id=1407) 18231 DEBUG PortalConnection [main-DBG-0]: host: surface/134.89.36.200 20316 DEBUG PortalConnection [main-DBG-0]: Lease established for 3600 sec, node mse; id=384 20316 DEBUG PortalConnection [main-DBG-0]: connectNode() done 28971 INFO PortalConnection [main-DBG-0]: WDT status: watchdog state: sleeping 28971 INFO PortalConnection [main-DBG-0]: mse Command Response: "15 Mar 20:17:37 ntpdate[10869]: no server suitable for synchronization found " 28981 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before new WakeupWorker: 7 28982 DEBUG PortalConnection [main-DBG-0]: wakeup thread: calling wakeup thread 28997 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After new WakeupWorker: 8 28998 INFO PortalConnection [main-DBG-0]: Node 1407 has 4 subnodes: node402/134.89.36.2 node413/134.89.36.13 node403/134.89.36.3 node418/134.89.36.18 /dev/ttySX0, Surface power can s/n 4, ID=1594 /dev/ttySX1, Radar repeater, ID=1597 NO SERVICE NO SERVICE NO SERVICE /dev/ttySX5, DummypCO2, ID=1020 NO SERVICE NO SERVICE NO SERVICE /dev/ttySX9, DummyAsimet, ID=1021 /dev/ttySX10, DummyWorkhorse, ID=1022 /dev/ttySX11, Garmin GPS s/n 81108743, ID=1590 /dev/ttySX15, MSP430 (sidearm4.06), ID=1412 /dev/ttySA2, Medusa card s/n 2.014, ID=1560 New node ID: 1407 29012 DEBUG PortalConnection [_wakeupWorker]: wakeup thread: attempt to add to available: node402/134.89.36.2 29013 INFO PortalConnection [_wakeupWorker]: wakeup thread: Send wakeup signal to subnode node402/134.89.36.2 , try #0 New device ID: 1594 New device ID: 1597 New device ID: 1020 New device ID: 1021 New device ID: 1022 New device ID: 1590 New device ID: 1412 New device ID: 1560 creating device log 1560 in /home/ops/siam/logs/1407 29226 DEBUG PortalConnection [main-DBG-0]: recording log entry 29227 DEBUG PortalConnection [main-DBG-0]: initializing device log 1560 mostRecent:1173983959634 startRetrieveTime:1173682800000 maxTimestamp:1173983959634 creating device log 1597 in /home/ops/siam/logs/1407 29263 DEBUG PortalConnection [main-DBG-0]: recording log entry 29263 DEBUG PortalConnection [main-DBG-0]: initializing device log 1597 mostRecent:1173982647202 startRetrieveTime:1173682800000 maxTimestamp:1173982647202 creating device log 1022 in /home/ops/siam/logs/1407 29307 DEBUG PortalConnection [main-DBG-0]: recording log entry 29308 DEBUG PortalConnection [main-DBG-0]: initializing device log 1022 mostRecent:1173982685523 startRetrieveTime:1173682800000 maxTimestamp:1173982685523 creating device log 1412 in /home/ops/siam/logs/1407 29357 DEBUG PortalConnection [main-DBG-0]: recording log entry 29357 DEBUG PortalConnection [main-DBG-0]: initializing device log 1412 mostRecent:1173983921274 startRetrieveTime:1173682800000 maxTimestamp:1173983921274 creating device log 1021 in /home/ops/siam/logs/1407 29404 DEBUG PortalConnection [main-DBG-0]: recording log entry 29404 DEBUG PortalConnection [main-DBG-0]: initializing device log 1021 mostRecent:1173983872273 startRetrieveTime:1173682800000 maxTimestamp:1173983872273 creating device log 1020 in /home/ops/siam/logs/1407 29428 DEBUG PortalConnection [main-DBG-0]: recording log entry 29428 DEBUG PortalConnection [main-DBG-0]: initializing device log 1020 mostRecent:1173982659884 startRetrieveTime:1173682800000 maxTimestamp:1173982659884 creating device log 1594 in /home/ops/siam/logs/1407 29456 DEBUG PortalConnection [main-DBG-0]: recording log entry 29457 DEBUG PortalConnection [main-DBG-0]: initializing device log 1594 mostRecent:1173983839034 startRetrieveTime:1173682800000 maxTimestamp:1173983839034 creating device log 1407 in /home/ops/siam/logs/1407 29582 DEBUG PortalConnection [main-DBG-0]: recording log entry 29582 DEBUG PortalConnection [main-DBG-0]: initializing device log 1407 mostRecent:1173982764751 startRetrieveTime:1173682800000 maxTimestamp:1173982764751 creating device log 1590 in /home/ops/siam/logs/1407 29612 DEBUG PortalConnection [main-DBG-0]: recording log entry 29613 DEBUG PortalConnection [main-DBG-0]: initializing device log 1590 mostRecent:1173983910006 startRetrieveTime:1173682800000 maxTimestamp:1173983910006 29613 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before retrieveAndDistributeData: 8 Retrieve data from device 1407 Retrieving data from device #1407 29615 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1407 29615 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 29615 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.200,1025)... 30596 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(134.89.36.200,1025) 33694 DEBUG NodeProbe [_wakeupWorker]: Creating new ProbeWorker 35705 DEBUG NodeProbe [_wakeupWorker]: got status - exiting 35705 DEBUG NodeProbe [_wakeupWorker]: host available (2010 ms) 35706 DEBUG PortalConnection [_wakeupWorker]: wakeup thread: NodeProbe returned true 35706 DEBUG Portal [_wakeupWorker]: Creating new PortalConnection for node402/134.89.36.2 35707 DEBUG PortalConnection [_wakeupWorker]: new PortalConnection() for node node402 35707 DEBUG PublisherComponent [_wakeupWorker]: Default constructor called 35712 DEBUG PublisherComponent [_wakeupWorker]: setTopicname called with name topic/SSDSIngestTopic 35713 DEBUG PublisherComponent [_wakeupWorker]: topicname is now topic/SSDSIngestTopic 35713 DEBUG PublisherComponent [_wakeupWorker]: Not connected so calling start 35713 DEBUG PublisherComponent [_wakeupWorker]: PublisherComponent stop called 35713 DEBUG PublisherComponent [_wakeupWorker]: Everything should be closed now 35714 DEBUG PublisherComponent [_wakeupWorker]: start called, setting connected to true 35714 DEBUG PublisherComponent [_wakeupWorker]: Going to get jndiContext 35715 DEBUG PublisherComponent [_wakeupWorker]: JNDI environment = {java.naming.provider.url=bob:1099, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jnp.timeout=0, jnp.socketFactory=org.jnp.interfaces.TimedSocketFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, java.naming.factory.url.pkgs.Naming=org.jboss.naming, jnp.sotimeout=0} 35715 DEBUG PublisherComponent [_wakeupWorker]: Going to get the topic connection factory from the JNDI 35716 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=134.89.12.73, port=1098 35716 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(134.89.12.73,1098)... 35726 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(134.89.12.73,1098) 35746 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker]: Extracting SpyConnectionFactory from reference 35768 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker]: The GenericConnectionFactory is: GenericConnectionFactory:[server=org.jboss.mq.il.uil2.UILServerIL@65b28,connectionProperties={UIL_ADDRESS_KEY=134.89.12.73, UIL_CHUNKSIZE_KEY=1000000, UIL_TCPNODELAY_KEY=yes, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_PORT_KEY=8093, UIL_BUFFERSIZE_KEY=2048, PingPeriod=60000}] 35768 DEBUG PublisherComponent [_wakeupWorker]: Going to create a topic connection from the factory 35772 DEBUG SocketManager [UIL2.SocketManager.ReadTask#3]: Begin ReadTask.run 35772 DEBUG SocketManager [UIL2.SocketManager.WriteTask#4]: Begin WriteTask.run 35773 DEBUG SocketManager [UIL2.SocketManager.WriteTask#4]: Created ObjectOutputStream 35775 DEBUG SocketManager [UIL2.SocketManager.ReadTask#3]: Created ObjectInputStream 35776 DEBUG GenericConnectionFactory [_wakeupWorker]: Handing out ClientIL: org.jboss.mq.il.uil2.UILClientILService 35776 DEBUG UILClientILService [_wakeupWorker]: Starting 35788 DEBUG PublisherComponent [_wakeupWorker]: Going to get the topic topic/SSDSIngestTopic from the JNDI lookup 35831 DEBUG SpyDestinationObjectFactory [_wakeupWorker]: SpyDestinationObjectFactory->getObjectInstance() 35832 DEBUG PublisherComponent [_wakeupWorker]: Going to create a topic session from the connection 35833 DEBUG PublisherComponent [_wakeupWorker]: Now going to call start on the topic connection 35835 DEBUG PublisherComponent [_wakeupWorker]: Connected was true after start 35835 DEBUG PublisherComponent [_wakeupWorker]: Should have set the topicName to topic/SSDSIngestTopic 35837 DEBUG PortalConnection [_wakeupWorker]: Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) 35838 DEBUG Portal [_wakeupWorker]: Got new connection from 134.89.36.2 total = 2 35838 DEBUG PortalConnection [_wakeupWorker]: Looking for node server stub at //node402/node 35839 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=node402, port=1099 35839 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(node402,1099)... 35842 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2]: DistributeWorker - started: Mar 15, 2007 2:19:23 PM Retrieved 11 packets from device #1407 38319 INFO PortalConnection [main-DBG-0]: Retrieved 11 packets from device #1407 parentID=0, recordType=1 devid=1407, t=1173986358985, seqNo=6946, mdref=6737 nBytes=543 Node started at: 03/15/2007 00:16:25 port=/dev/ttySX0,id=1594,samples=115,err=0,retries=26,status=0, port=/dev/ttySX1,id=1597,samples=20,err=0,retries=0,status=0, port=/dev/ttySX5,id=1020,samples=20,err=0,retries=0,status=0, port=/dev/ttySX9,id=1021,samples=115,err=0,retries=0,status=0, port=/dev/ttySX10,id=1022,samples=20,err=0,retries=0,status=0, port=/dev/ttySX11,id=1590,samples=115,err=0,retries=0,status=0, port=/dev/ttySX15,id=1412,samples=594,err=0,retries=0,status=5, port=/dev/ttySA2,id=1560,samples=228,err=0,retries=2,status=5, parentID=0, recordType=2 devid=1407, t=1173986360703, seqNo=6947, mdref=6737 nBytes=1957 /dev/ttySX0 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;27.047005;13.98852;0.0488;0x2;0xe7;0x38(OK);03/15/2007 07:17:14 minHtSnk;26.863998;13.915319;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:37:13 maxHtSnk;27.047005;13.90068;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:47:13 minVolt;27.047005;13.90068;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:47:13 maxVolt;26.986;13.98852;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:57:13 minAmp;26.925003;13.9629;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:27:13 maxAmp;26.925003;13.9629;0.0488;0x2;0xe7;0x38(OK);03/15/2007 06:27:13 /dev/ttySX1 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 minHtSnk;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 maxHtSnk;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 minVolt;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 maxVolt;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 minAmp;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 maxAmp;27.108002;13.97022;0.4026;0x2;0xc5;0x38(OK);03/15/2007 07:17:26 /dev/ttySX5 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX10 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX11 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;27.108002;14.050739;0.0976;0x2;0xe7;0x38(OK);03/15/2007 07:18:28 minHtSnk;26.925003;14.050739;0.0915;0x2;0xe7;0x38(OK);03/15/2007 07:08:28 maxHtSnk;27.413002;13.94094;0.09455;0x2;0xe7;0x38(OK);03/15/2007 06:48:28 minVolt;27.413002;13.94094;0.09455;0x2;0xe7;0x38(OK);03/15/2007 06:48:28 maxVolt;27.047005;14.050739;0.09455;0x2;0xe7;0x38(OK);03/15/2007 06:28:28 minAmp;26.925003;14.050739;0.0915;0x2;0xe7;0x38(OK);03/15/2007 07:08:28 maxAmp;27.108002;14.050739;0.0976;0x2;0xe7;0x38(OK);03/15/2007 07:18:28 parentID=0, recordType=4 devid=1407, t=1173986361637, seqNo=6948, mdref=6737 nBytes=71 $GPRMC,191821,A,3648.2017,N,12147.2529,W,000.0,249.6,150307,014.8,E*62 parentID=0, recordType=5 devid=1407, t=1173986362429, seqNo=6949, mdref=6737 nBytes=1065 name;tmprt;pressure;humidity;gfHi;gfLo;nTurns;time;note current;27.79;56.91;36.91;0.0;-0.71;0;03/15/2007 07:19:20;dev 1560 powerOn; nSample=25 minGfLo;27.71;73.79;37.26;0.0;-3.4;0;03/15/2007 07:17:27;dev 1597 powerOn; maxGfLo;27.6;94.9;35.91;54.54;1.42;0;03/15/2007 06:34:18;dev 1560 powerOn; minGfHi;28.07;86.46;36.19;-0.25;0.14;0;03/15/2007 06:28:28;dev 1590 powerOn; maxGfHi;28.86;76.61;34.52;55.55;-0.14;0;03/15/2007 06:54:19;dev 1560 powerOn; minTmprt;27.46;169.46;38.4;0.0;-0.28;0;03/15/2007 06:24:19;dev 1560 powerOn; maxTmprt;28.97;61.13;35.35;0.0;0.14;0;03/15/2007 06:47:14;dev 1594 powerOn; minPress;27.79;56.91;36.91;0.0;-0.71;0;03/15/2007 07:19:20;dev 1560 powerOn; maxPress;27.79;56.91;36.91;0.0;-0.71;0;03/15/2007 07:19:20;dev 1560 powerOn; minHumid;28.86;76.61;34.52;55.55;-0.14;0;03/15/2007 06:54:19;dev 1560 powerOn; maxHumid;27.46;169.46;38.4;0.0;-0.28;0;03/15/2007 06:24:19;dev 1560 powerOn; minTurns;27.46;169.46;38.4;0.0;-0.28;0;03/15/2007 06:24:19;dev 1560 powerOn; maxTurns;27.46;169.46;38.4;0.0;-0.28;0;03/15/2007 06:24:19;dev 1560 powerOn; parentID=0, recordType=6 devid=1407, t=1173986362993, seqNo=6950, mdref=6737 nBytes=257 Filesystem 1k-blocks Used Available Use% Mounted on /dev/root 14848 12972 1876 88% / tmpfs 31244 2004 29240 7% /mnt/ramfs /dev/hda1 3936904 337504 3399416 10% /mnt/hda parentID=0, recordType=7 devid=1407, t=1173986363487, seqNo=6951, mdref=6737 nBytes=60 #jvmthreads: 30 jvmmem: total=2621440, free=736808 (bytes) parentID=0, recordType=8 devid=1407, t=1173986363941, seqNo=6952, mdref=6737 nBytes=22 RFIO status goes here parentID=0, recordType=9 devid=1407, t=1173986364371, seqNo=6953, mdref=6737 nBytes=25 Optical status goes here parentID=0, recordType=10 devid=1407, t=1173986364965, seqNo=6954, mdref=6737 nBytes=624 /var/log/syslog:Mar 15 17:39:06 surface chat[26479]: RSSI: 0^M /var/log/syslog:Mar 15 17:42:32 surface chat[27004]: RSSI: 0^M /var/log/syslog:Mar 15 17:47:50 surface chat[27750]: RSSI: 0^M /var/log/syslog:Mar 15 17:50:47 surface chat[28118]: RSSI: 0^M /var/log/syslog:Mar 15 18:13:15 surface chat[30709]: RSSI: 4^M /var/log/syslog:Mar 15 18:32:13 surface chat[32442]: RSSI: 0^M /var/log/syslog:Mar 15 18:35:10 surface chat[342]: RSSI: 0^M /var/log/syslog:Mar 15 18:38:07 surface chat[766]: RSSI: 0^M /var/log/syslog:Mar 15 18:41:04 surface chat[1131]: RSSI: 0^M /var/log/syslog:Mar 15 19:12:13 surface chat[4230]: RSSI: 0^M parentID=0, recordType=11 devid=1407, t=1173986365376, seqNo=6955, mdref=6737 nBytes=47 03/15/2007 18:43:09; watchdog state: sleeping parentID=0, recordType=12 devid=1407, t=1173986365906, seqNo=6956, mdref=6737 nBytes=960 Sleep log since 03/15/2007 06:19:25 start,predictedDurSec,actualDurSec sleep,03/15/2007 06:20:17,68,72 sleep,03/15/2007 06:22:05,129,132 sleep,03/15/2007 06:24:48,133,21 sleep,03/15/2007 06:25:40,81,84 sleep,03/15/2007 06:27:41,7,10 sleep,03/15/2007 06:28:32,4,1 sleep,03/15/2007 06:29:04,10,13 sleep,03/15/2007 06:29:47,131,115 sleep,03/15/2007 06:53:34,40,44 sleep,03/15/2007 06:54:48,10,12 sleep,03/15/2007 06:55:37,92,94 sleep,03/15/2007 06:57:42,6,1 sleep,03/15/2007 06:58:14,10,13 sleep,03/15/2007 06:58:57,17,20 sleep,03/15/2007 06:59:48,45,48 sleep,03/15/2007 07:01:13,181,29 sleep,03/15/2007 07:02:13,121,124 sleep,03/15/2007 07:04:48,81,18 sleep,03/15/2007 07:05:37,32,34 sleep,03/15/2007 07:06:48,21,24 sleep,03/15/2007 07:07:43,5,1 sleep,03/15/2007 07:08:15,9,12 sleep,03/15/2007 07:08:57,17,20 sleep,03/15/2007 07:09:48,116,119 sleep,03/15/2007 07:15:37,91,95 sleep,03/15/2007 07:18:08,16,19 sleep,03/15/2007 07:18:57,17,20 38366 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(node402,1099) 38429 DEBUG PortalConnection [main-DBG-0]: new latest=1173986365906 38429 DEBUG PortalConnection [main-DBG-0]: put packet stats 38440 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieved total of 11 packets from device [J@5c6a77 Retrieve data from device 1594 Retrieving data from device #1594 38442 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1594 38598 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 41729 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=134.89.36.2, port=1025 41730 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(134.89.36.2,1025)... 43675 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(134.89.36.2,1025) Retrieved 10 packets from device #1594 52453 INFO PortalConnection [main-DBG-0]: Retrieved 10 packets from device #1594 parentID=1407, recordType=1 devid=1594, t=1173984438968, seqNo=2397, mdref=2285 nBytes=2973 ADC00 A-6.6076e-04 N0000600 L+6.1040e-04 H-2.7468e-03 D-3.0520e-04 E0 ADC01 A-1.2284e-03 N0000600 L+0.0000e+00 H-3.3572e-03 D-3.0520e-04 E0 ADC02 A+1.0828e-01 N0000600 L+7.9760e-02 H+1.0189e+00 D+4.7856e-02 E0 ADC03 A+2.1124e-01 N0000600 L+1.3958e-01 H+5.7826e-01 D+1.0768e-01 E0 ADC04 A-1.2646e-02 N0000600 L-9.6138e-02 H+2.6858e-02 D+1.4650e-02 E0 ADC05 A+3.0011e-04 N0000600 L-9.1560e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.4589e-04 N0000600 L+1.8312e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.4192e-04 N0000600 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.7284e-02 N0000600 L+6.9790e-02 H+1.2363e-01 D+3.9880e-03 E0 ADC13 A+8.3203e-02 N0000600 L+7.3778e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.5820e-04 N0000600 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.5230e-04 N0000600 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1830e+00 N0000600 L+1.0729e+00 H+1.5459e+00 D+1.2145e-01 E0 ADC21 A-3.6815e-02 N0000600 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC22 A+5.1742e+01 N0000600 L+5.1698e+01 H+5.1756e+01 D+1.3958e-02 E0 ADC23 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.3906e+01 N0000600 L+4.3821e+01 H+4.3974e+01 D+0.0000e+00 E0 ADC25 A-3.1939e-04 N0000600 L-2.4412e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6600e-02 N0000600 L-3.8449e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1568e+01 N0000600 L+5.1519e+01 H+5.1585e+01 D+1.5952e-02 E0 ADC28 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2327e+01 N0000600 L+3.2178e+01 H+3.2331e+01 D+0.0000e+00 E0 ADC30 A-6.6781e-01 N0002400 L-8.2526e-01 H-6.2200e-01 D+5.0053e-02 E0 ADC31 A-3.5497e-02 N0002400 L-2.7621e-01 H-6.1040e-03 D+7.4774e-02 E0 ADC32 A+3.7485e+02 N0000600 L+3.7457e+02 H+3.7490e+02 D+6.1200e-02 E0 ADC35 A-2.7704e-01 N0002400 L-3.2199e-01 H-2.2646e-01 D+1.7396e-02 E0 ADC36 A-1.0839e-01 N0002400 L-1.2971e-01 H-8.6677e-02 D+7.9352e-03 E0 ADC37 A+1.3953e+01 N0000600 L+1.3924e+01 H+1.3987e+01 D+1.1216e-02 E0 ADC42 A+0.0000e+00 N0002400 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4934e+01 N0000060 L-6.7000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8188e-03 N0002400 L-1.9032e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3348e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2432e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6482e-04 N0000005 L+6.6484e-04 H+6.6480e-04 E0 GFZ01 A+8.2404e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+1.2431e-04 N0000005 L+1.2467e-04 H+1.2368e-04 E0 GFH01 A+1.1395e-03 N0000005 L+1.1399e-03 H+1.1393e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000059 A00 B00 C00 D00 WS01 N0000059 A00 B00 C00 D00 PRES A+1.1190e+03 N0000058 L+1.1170e+03 H+1.1210e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173985038916, seqNo=2398, mdref=2285 nBytes=2973 ADC00 A-5.7785e-04 N0000600 L+6.1040e-04 H-2.7468e-03 D-3.0520e-04 E0 ADC01 A-1.1837e-03 N0000600 L+0.0000e+00 H-3.3572e-03 D-3.0520e-04 E0 ADC02 A+1.0299e-01 N0000600 L+7.9760e-02 H+6.5603e-01 D+3.3898e-02 E0 ADC03 A+1.9354e-01 N0000600 L+1.3559e-01 H+5.8025e-01 D+8.7736e-02 E0 ADC04 A-9.6753e-03 N0000600 L-9.3391e-02 H+2.5637e-02 D+1.2818e-02 E0 ADC05 A+2.9960e-04 N0000600 L-9.1560e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.4945e-04 N0000600 L+2.1364e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.9177e-04 N0000600 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.6493e-02 N0000600 L+7.1784e-02 H+1.0169e-01 D+3.9880e-03 E0 ADC13 A+8.3143e-02 N0000600 L+7.5772e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.8159e-04 N0000600 L-1.5260e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.6044e-04 N0000600 L-1.5260e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1535e+00 N0000600 L+1.0363e+00 H+1.5618e+00 D+1.0497e-01 E0 ADC21 A-3.6737e-02 N0000600 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1746e+01 N0000600 L+5.1696e+01 H+5.1760e+01 D+1.1964e-02 E0 ADC23 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.3972e+01 N0000600 L+4.3821e+01 H+4.3974e+01 D+0.0000e+00 E0 ADC25 A-3.3363e-04 N0000600 L-2.4412e-03 H+1.2206e-03 D+6.1030e-04 E0 ADC26 A-3.6605e-02 N0000600 L-3.8449e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC27 A+5.1572e+01 N0000600 L+5.1517e+01 H+5.1591e+01 D+1.3958e-02 E0 ADC28 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2431e+01 N0000600 L+3.2331e+01 H+3.2484e+01 D+0.0000e+00 E0 ADC30 A-6.5969e-01 N0002399 L-8.0634e-01 H-6.2230e-01 D+4.2423e-02 E0 ADC31 A-2.5470e-02 N0002399 L-2.8445e-01 H-6.1040e-03 D+6.1040e-02 E0 ADC32 A+3.7486e+02 N0000600 L+3.7459e+02 H+3.7490e+02 D+4.5900e-02 E0 ADC35 A-2.6770e-01 N0002399 L-3.2015e-01 H-2.1913e-01 D+2.7163e-02 E0 ADC36 A-1.0432e-01 N0002399 L-1.3002e-01 H-8.3014e-02 D+1.1903e-02 E0 ADC37 A+1.3959e+01 N0000600 L+1.3930e+01 H+1.3993e+01 D+1.8506e-02 E0 ADC42 A+0.0000e+00 N0002399 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4667e+01 N0000060 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8198e-03 N0002399 L-1.8849e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3424e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2280e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6484e-04 N0000005 L+6.6484e-04 H+6.6484e-04 E0 GFZ01 A+8.2404e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+9.9564e-05 N0000005 L+1.2425e-04 H+6.2871e-05 E0 GFH01 A+1.1392e-03 N0000005 L+1.1399e-03 H+1.1381e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+1.1190e+03 N0000058 L+1.1170e+03 H+1.1220e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173985642943, seqNo=2399, mdref=2285 nBytes=2973 ADC00 A-5.5556e-04 N0000601 L+6.1040e-04 H-2.1364e-03 D-3.0520e-04 E0 ADC01 A-1.2183e-03 N0000601 L-3.0520e-04 H-3.0520e-03 D-3.0520e-04 E0 ADC02 A+1.0302e-01 N0000601 L+7.9760e-02 H+4.5264e-01 D+2.9910e-02 E0 ADC03 A+1.9776e-01 N0000601 L+1.4556e-01 H+5.0648e-01 D+8.5742e-02 E0 ADC04 A-1.0719e-02 N0000601 L-9.1560e-02 H+3.4182e-02 D+1.2513e-02 E0 ADC05 A+2.7930e-04 N0000601 L-9.1560e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.3262e-04 N0000601 L+1.5260e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.9399e-04 N0000601 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.6698e-02 N0000601 L+7.1784e-02 H+1.0169e-01 D+3.9880e-03 E0 ADC13 A+8.3267e-02 N0000601 L+7.3778e-02 H+9.1724e-02 D+1.9940e-03 E0 ADC14 A-1.5692e-04 N0000601 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.4071e-04 N0000601 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.0972e+00 N0000601 L+1.0253e+00 H+1.4543e+00 D+1.0009e-01 E0 ADC21 A-3.6758e-02 N0000601 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC22 A+5.1750e+01 N0000601 L+5.1708e+01 H+5.1762e+01 D+9.9700e-03 E0 ADC23 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.3978e+01 N0000601 L+4.3974e+01 H+4.4127e+01 D+0.0000e+00 E0 ADC25 A-3.1886e-04 N0000601 L-2.4412e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6550e-02 N0000601 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC27 A+5.1578e+01 N0000601 L+5.1525e+01 H+5.1591e+01 D+1.1964e-02 E0 ADC28 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2483e+01 N0000601 L+3.2331e+01 H+3.2484e+01 D+0.0000e+00 E0 ADC30 A-6.5749e-01 N0002403 L-8.1397e-01 H-6.1284e-01 D+4.4254e-02 E0 ADC31 A-2.6741e-02 N0002403 L-2.6888e-01 H-5.7988e-03 D+6.2871e-02 E0 ADC32 A+3.7486e+02 N0000601 L+3.7461e+02 H+3.7491e+02 D+6.1200e-02 E0 ADC35 A-2.3042e-01 N0002403 L-2.6400e-01 H-2.1913e-01 D+7.9352e-03 E0 ADC36 A-8.8221e-02 N0002403 L-1.0316e-01 H-8.3014e-02 D+3.3572e-03 E0 ADC37 A+1.3985e+01 N0000601 L+1.3968e+01 H+1.3993e+01 D+5.6080e-03 E0 ADC42 A+0.0000e+00 N0002403 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4377e+01 N0000061 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8201e-03 N0002403 L-1.9581e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3348e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2280e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4111e-06 N0000005 L+2.4416e-06 H+2.4035e-06 E0 GFT00 A+6.6515e-04 N0000005 L+6.6530e-04 H+6.6484e-04 E0 GFZ01 A+8.3930e-07 N0000005 L+8.3930e-07 H+8.3930e-07 E0 GFL01 A+6.3199e-05 N0000005 L+6.3291e-05 H+6.2909e-05 E0 GFH01 A+1.1378e-03 N0000005 L+1.1380e-03 H+1.1375e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000061 A00 B00 C00 D00 WS01 N0000061 A00 B00 C00 D00 PRES A+1.1210e+03 N0000001 L+1.1210e+03 H+1.1210e+03 E0 TMP1 A+3.1000e+01 N0000001 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000001 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000001 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173986241680, seqNo=2400, mdref=2285 nBytes=2973 ADC00 A-5.8860e-04 N0000602 L+6.1040e-04 H-2.7468e-03 D-3.0520e-04 E0 ADC01 A-1.2314e-03 N0000602 L+0.0000e+00 H-3.3572e-03 D-3.0520e-04 E0 ADC02 A+1.0683e-01 N0000602 L+7.9760e-02 H+8.7736e-01 D+4.3868e-02 E0 ADC03 A+2.0916e-01 N0000602 L+1.4157e-01 H+5.9022e-01 D+1.0169e-01 E0 ADC04 A-1.1256e-02 N0000602 L-9.5833e-02 H+3.2656e-02 D+1.4955e-02 E0 ADC05 A+3.1990e-04 N0000602 L-9.1560e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.5488e-04 N0000602 L+1.5260e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.7896e-04 N0000602 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.6974e-02 N0000602 L+7.3778e-02 H+1.0768e-01 D+3.9880e-03 E0 ADC13 A+8.3023e-02 N0000602 L+7.3778e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.7288e-04 N0000602 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.4791e-04 N0000602 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1255e+00 N0000602 L+1.0253e+00 H+1.4562e+00 D+1.1291e-01 E0 ADC21 A-3.6778e-02 N0000602 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1747e+01 N0000602 L+5.1706e+01 H+5.1760e+01 D+1.1964e-02 E0 ADC23 A-2.7300e+02 N0000602 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4032e+01 N0000602 L+4.3974e+01 H+4.4127e+01 D+0.0000e+00 E0 ADC25 A-3.7307e-04 N0000602 L-2.4412e-03 H+1.2206e-03 D+6.1030e-04 E0 ADC26 A-3.6532e-02 N0000602 L-3.8449e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1575e+01 N0000602 L+5.1529e+01 H+5.1589e+01 D+1.3958e-02 E0 ADC28 A-2.7300e+02 N0000602 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2484e+01 N0000602 L+3.2484e+01 H+3.2637e+01 D+0.0000e+00 E0 ADC30 A-6.5882e-01 N0002408 L-8.2038e-01 H-6.1223e-01 D+5.2800e-02 E0 ADC31 A-3.3830e-02 N0002408 L-2.5606e-01 H-5.4936e-03 D+7.1112e-02 E0 ADC32 A+3.7485e+02 N0000602 L+3.7457e+02 H+3.7491e+02 D+7.6500e-02 E0 ADC35 A-2.4418e-01 N0002408 L-3.1069e-01 H-2.1944e-01 D+2.1669e-02 E0 ADC36 A-9.4120e-02 N0002408 L-1.2452e-01 H-8.2709e-02 D+9.1560e-03 E0 ADC37 A+1.3975e+01 N0000602 L+1.3930e+01 H+1.3993e+01 D+1.5142e-02 E0 ADC42 A+0.0000e+00 N0002408 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4316e+01 N0000060 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8208e-03 N0002408 L-1.9581e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3348e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2356e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.3958e-06 N0000005 L+2.4035e-06 H+2.3653e-06 E0 GFT00 A+6.6482e-04 N0000005 L+6.6503e-04 H+6.6442e-04 E0 GFZ01 A+8.3167e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+8.7501e-05 N0000005 L+1.2448e-04 H+6.2680e-05 E0 GFH01 A+1.1381e-03 N0000005 L+1.1390e-03 H+1.1374e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+1.1200e+03 N0000057 L+1.1180e+03 H+1.1220e+03 E0 TMP1 A+3.1000e+01 N0000057 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000057 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000057 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173986839162, seqNo=2401, mdref=2285 nBytes=2973 ADC00 A-5.7564e-04 N0000597 L+6.1040e-04 H-2.4416e-03 D-3.0520e-04 E0 ADC01 A-1.1998e-03 N0000597 L+0.0000e+00 H-3.0520e-03 D-3.0520e-04 E0 ADC02 A+1.0285e-01 N0000597 L+8.1754e-02 H+5.9222e-01 D+2.9910e-02 E0 ADC03 A+1.9642e-01 N0000597 L+1.3958e-01 H+5.4835e-01 D+8.5742e-02 E0 ADC04 A-1.1619e-02 N0000597 L-9.8580e-02 H+2.6552e-02 D+1.2513e-02 E0 ADC05 A+2.8935e-04 N0000597 L-6.1040e-04 H+1.2208e-03 D+3.0520e-04 E0 ADC10 A+3.5632e-04 N0000597 L+1.2208e-03 H-6.1040e-04 D-3.0520e-04 E0 ADC11 A+1.7586e-04 N0000597 L+1.2208e-03 H-1.2208e-03 D-3.0520e-04 E0 ADC12 A+8.6908e-02 N0000597 L+7.3778e-02 H+1.0568e-01 D+3.9880e-03 E0 ADC13 A+8.2883e-02 N0000597 L+7.3778e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.4621e-04 N0000597 L-1.2208e-03 H+6.1040e-04 D+3.0520e-04 E0 ADC15 A-2.4027e-04 N0000597 L-1.5260e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1259e+00 N0000597 L+1.0265e+00 H+1.5312e+00 D+1.1230e-01 E0 ADC21 A-3.6704e-02 N0000597 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC22 A+5.1747e+01 N0000597 L+5.1696e+01 H+5.1760e+01 D+1.1964e-02 E0 ADC23 A-2.7300e+02 N0000597 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4116e+01 N0000597 L+4.3974e+01 H+4.4127e+01 D+0.0000e+00 E0 ADC25 A-3.1486e-04 N0000597 L-2.4412e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6583e-02 N0000597 L-3.8449e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1574e+01 N0000597 L+5.1519e+01 H+5.1591e+01 D+1.3958e-02 E0 ADC28 A-2.7300e+02 N0000597 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2519e+01 N0000597 L+3.2484e+01 H+3.2637e+01 D+0.0000e+00 E0 ADC30 A-6.5264e-01 N0002389 L-8.0634e-01 H-6.1254e-01 D+4.4864e-02 E0 ADC31 A-2.5419e-02 N0002389 L-2.6797e-01 H-6.1040e-03 D+5.9819e-02 E0 ADC32 A+3.7486e+02 N0000597 L+3.7461e+02 H+3.7490e+02 D+6.1200e-02 E0 ADC35 A-2.5488e-01 N0002389 L-3.2015e-01 H-2.1944e-01 D+3.0215e-02 E0 ADC36 A-9.8927e-02 N0002389 L-1.2940e-01 H-8.2709e-02 D+1.3429e-02 E0 ADC37 A+1.3968e+01 N0000597 L+1.3926e+01 H+1.3993e+01 D+2.0750e-02 E0 ADC42 A+0.0000e+00 N0002389 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4170e+01 N0000059 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8218e-03 N0002389 L-1.9032e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3272e-06 N0000005 L+2.3272e-06 H+2.3272e-06 E0 GFL00 A+2.2432e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6479e-04 N0000005 L+6.6488e-04 H+6.6453e-04 E0 GFZ01 A+8.2404e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+8.6227e-05 N0000005 L+1.2403e-04 H+6.3062e-05 E0 GFH01 A+1.1381e-03 N0000005 L+1.1390e-03 H+1.1373e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000059 A00 B00 C00 D00 WS01 N0000059 A00 B00 C00 D00 PRES A+1.1200e+03 N0000058 L+1.1180e+03 H+1.1230e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000058 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173987439125, seqNo=2402, mdref=2285 nBytes=2973 ADC00 A-6.0124e-04 N0000600 L+6.1040e-04 H-2.4416e-03 D-3.0520e-04 E0 ADC01 A-1.2340e-03 N0000600 L+0.0000e+00 H-3.6624e-03 D-3.0520e-04 E0 ADC02 A+1.0564e-01 N0000600 L+7.7766e-02 H+8.4147e-01 D+3.9880e-02 E0 ADC03 A+2.0612e-01 N0000600 L+1.3360e-01 H+5.0648e-01 D+1.0369e-01 E0 ADC04 A-1.2677e-02 N0000600 L-9.4917e-02 H+3.0825e-02 D+1.5260e-02 E0 ADC05 A+3.1181e-04 N0000600 L-6.1040e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.6217e-04 N0000600 L+1.5260e-03 H-6.1040e-04 D-3.0520e-04 E0 ADC11 A+1.6481e-04 N0000600 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.7370e-02 N0000600 L+7.3778e-02 H+1.1366e-01 D+3.9880e-03 E0 ADC13 A+8.3140e-02 N0000600 L+7.3778e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.6379e-04 N0000600 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.2992e-04 N0000600 L-1.5260e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1828e+00 N0000600 L+1.0979e+00 H+1.5477e+00 D+1.1901e-01 E0 ADC21 A-3.6780e-02 N0000600 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1741e+01 N0000600 L+5.1696e+01 H+5.1754e+01 D+1.3958e-02 E0 ADC23 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4128e+01 N0000600 L+4.4127e+01 H+4.4280e+01 D+0.0000e+00 E0 ADC25 A-3.5296e-04 N0000600 L-1.8309e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6623e-02 N0000600 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1568e+01 N0000600 L+5.1519e+01 H+5.1583e+01 D+1.5952e-02 E0 ADC28 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2640e+01 N0000600 L+3.2637e+01 H+3.2790e+01 D+0.0000e+00 E0 ADC30 A-6.5915e-01 N0002400 L-8.0146e-01 H-6.1284e-01 D+5.2189e-02 E0 ADC31 A-3.3935e-02 N0002400 L-2.6797e-01 H-5.7988e-03 D+7.1722e-02 E0 ADC32 A+3.7485e+02 N0000600 L+3.7459e+02 H+3.7490e+02 D+6.1200e-02 E0 ADC35 A-2.8330e-01 N0002400 L-3.1954e-01 H-2.6888e-01 D+9.1560e-03 E0 ADC36 A-1.1112e-01 N0002400 L-1.2879e-01 H-1.0407e-01 D+4.2728e-03 E0 ADC37 A+1.3949e+01 N0000600 L+1.3929e+01 H+1.3957e+01 D+6.1688e-03 E0 ADC42 A+0.0000e+00 N0002400 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4134e+01 N0000060 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8224e-03 N0002400 L-1.8849e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3272e-06 N0000005 L+2.3272e-06 H+2.3272e-06 E0 GFL00 A+2.2127e-06 N0000005 L+2.2127e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6486e-04 N0000005 L+6.6488e-04 H+6.6484e-04 E0 GFZ01 A+8.0878e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+1.2259e-04 N0000005 L+1.2399e-04 H+1.1754e-04 E0 GFH01 A+1.1393e-03 N0000005 L+1.1395e-03 H+1.1392e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+1.1200e+03 N0000058 L+1.1180e+03 H+1.1220e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000058 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173988039938, seqNo=2403, mdref=2285 nBytes=2973 ADC00 A-6.1091e-04 N0000601 L+6.1040e-04 H-2.1364e-03 D-3.0520e-04 E0 ADC01 A-1.1553e-03 N0000601 L+0.0000e+00 H-3.0520e-03 D-3.0520e-04 E0 ADC02 A+1.0213e-01 N0000601 L+7.9760e-02 H+4.8454e-01 D+2.7916e-02 E0 ADC03 A+1.9623e-01 N0000601 L+1.4357e-01 H+5.0648e-01 D+8.5742e-02 E0 ADC04 A-1.0823e-02 N0000601 L-9.2781e-02 H+2.2280e-02 D+1.2208e-02 E0 ADC05 A+2.6051e-04 N0000601 L-6.1040e-04 H+1.5260e-03 D+3.0520e-04 E0 ADC10 A+3.3161e-04 N0000601 L+1.5260e-03 H-6.1040e-04 D-3.0520e-04 E0 ADC11 A+1.7317e-04 N0000601 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.6887e-02 N0000601 L+7.1784e-02 H+1.0169e-01 D+3.9880e-03 E0 ADC13 A+8.2842e-02 N0000601 L+7.5772e-02 H+9.1724e-02 D+1.9940e-03 E0 ADC14 A-1.5489e-04 N0000601 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.3360e-04 N0000601 L-1.5260e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1081e+00 N0000601 L+1.0229e+00 H+1.4519e+00 D+9.5817e-02 E0 ADC21 A-3.6798e-02 N0000601 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1747e+01 N0000601 L+5.1704e+01 H+5.1758e+01 D+9.9700e-03 E0 ADC23 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4234e+01 N0000601 L+4.4127e+01 H+4.4280e+01 D+0.0000e+00 E0 ADC25 A-3.1378e-04 N0000601 L-2.4412e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6567e-02 N0000601 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1575e+01 N0000601 L+5.1527e+01 H+5.1587e+01 D+1.1964e-02 E0 ADC28 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2748e+01 N0000601 L+3.2637e+01 H+3.2790e+01 D+0.0000e+00 E0 ADC30 A-6.5180e-01 N0002403 L-8.0725e-01 H-6.1223e-01 D+4.4559e-02 E0 ADC31 A-2.5028e-02 N0002403 L-2.6766e-01 H-5.7988e-03 D+5.9209e-02 E0 ADC32 A+3.7486e+02 N0000601 L+3.7461e+02 H+3.7490e+02 D+6.1200e-02 E0 ADC35 A-2.4153e-01 N0002403 L-3.0703e-01 H-2.1883e-01 D+2.1669e-02 E0 ADC36 A-9.3011e-02 N0002403 L-1.2208e-01 H-8.2709e-02 D+9.1560e-03 E0 ADC37 A+1.3978e+01 N0000601 L+1.3936e+01 H+1.3994e+01 D+1.4581e-02 E0 ADC42 A+0.0000e+00 N0002403 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4115e+01 N0000061 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8232e-03 N0002403 L-1.9581e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3348e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2356e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.3958e-06 N0000005 L+2.4035e-06 H+2.3653e-06 E0 GFT00 A+6.6484e-04 N0000005 L+6.6484e-04 H+6.6484e-04 E0 GFZ01 A+8.3167e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+7.5445e-05 N0000005 L+1.2391e-04 H+6.3215e-05 E0 GFH01 A+1.1382e-03 N0000005 L+1.1393e-03 H+1.1376e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000061 A00 B00 C00 D00 WS01 N0000061 A00 B00 C00 D00 PRES A+1.1200e+03 N0000057 L+1.1180e+03 H+1.1220e+03 E0 TMP1 A+3.1000e+01 N0000057 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000057 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000057 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173988638976, seqNo=2404, mdref=2285 nBytes=2973 ADC00 A-5.7632e-04 N0000600 L+6.1040e-04 H-2.1364e-03 D-3.0520e-04 E0 ADC01 A-1.1735e-03 N0000600 L-3.0520e-04 H-3.3572e-03 D-3.0520e-04 E0 ADC02 A+1.0308e-01 N0000600 L+7.9760e-02 H+8.7736e-01 D+3.7886e-02 E0 ADC03 A+1.9391e-01 N0000600 L+1.4357e-01 H+5.5034e-01 D+8.5742e-02 E0 ADC04 A-1.2820e-02 N0000600 L-9.6443e-02 H+2.3500e-02 D+1.2513e-02 E0 ADC05 A+2.7468e-04 N0000600 L-9.1560e-04 H+1.2208e-03 D+3.0520e-04 E0 ADC10 A+3.5658e-04 N0000600 L+1.5260e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.8465e-04 N0000600 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.7208e-02 N0000600 L+7.1784e-02 H+1.0768e-01 D+3.9880e-03 E0 ADC13 A+8.3014e-02 N0000600 L+7.3778e-02 H+9.1724e-02 D+1.9940e-03 E0 ADC14 A-1.6735e-04 N0000600 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.3755e-04 N0000600 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1469e+00 N0000600 L+1.0412e+00 H+1.5386e+00 D+1.0741e-01 E0 ADC21 A-3.6741e-02 N0000600 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1742e+01 N0000600 L+5.1696e+01 H+5.1756e+01 D+1.1964e-02 E0 ADC23 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4278e+01 N0000600 L+4.4127e+01 H+4.4280e+01 D+0.0000e+00 E0 ADC25 A-2.6751e-04 N0000600 L-2.4412e-03 H+1.8309e-03 D+6.1030e-04 E0 ADC26 A-3.6632e-02 N0000600 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1570e+01 N0000600 L+5.1515e+01 H+5.1587e+01 D+1.3958e-02 E0 ADC28 A-2.7300e+02 N0000600 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2781e+01 N0000600 L+3.2637e+01 H+3.2790e+01 D+0.0000e+00 E0 ADC30 A-6.5527e-01 N0002400 L-8.0115e-01 H-6.1162e-01 D+4.2728e-02 E0 ADC31 A-2.5019e-02 N0002400 L-2.6217e-01 H-5.7988e-03 D+5.8904e-02 E0 ADC32 A+3.7486e+02 N0000600 L+3.7461e+02 H+3.7490e+02 D+4.5900e-02 E0 ADC35 A-2.6715e-01 N0002400 L-3.2473e-01 H-2.1852e-01 D+3.5403e-02 E0 ADC36 A-1.0452e-01 N0002400 L-1.3276e-01 H-8.2709e-02 D+1.5565e-02 E0 ADC37 A+1.3961e+01 N0000600 L+1.3923e+01 H+1.3994e+01 D+2.4114e-02 E0 ADC42 A+0.0000e+00 N0002400 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4167e+01 N0000060 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8241e-03 N0002400 L-1.9581e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3348e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2356e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6481e-04 N0000005 L+6.6484e-04 H+6.6480e-04 E0 GFZ01 A+8.3167e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+9.9442e-05 N0000005 L+1.2387e-04 H+6.2986e-05 E0 GFH01 A+1.1384e-03 N0000005 L+1.1394e-03 H+1.1374e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+1.1200e+03 N0000058 L+1.1180e+03 H+1.1220e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.1000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000058 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173989243032, seqNo=2405, mdref=2285 nBytes=2973 ADC00 A-6.3173e-04 N0000601 L+3.0520e-04 H-2.4416e-03 D-3.0520e-04 E0 ADC01 A-1.2274e-03 N0000601 L+0.0000e+00 H-3.0520e-03 D-3.0520e-04 E0 ADC02 A+1.0624e-01 N0000601 L+7.9760e-02 H+9.5114e-01 D+4.5862e-02 E0 ADC03 A+2.0930e-01 N0000601 L+1.4357e-01 H+6.1615e-01 D+9.7706e-02 E0 ADC04 A-1.1316e-02 N0000601 L-9.9800e-02 H+3.1130e-02 D+1.5260e-02 E0 ADC05 A+2.9403e-04 N0000601 L-6.1040e-04 H+1.2208e-03 D+3.0520e-04 E0 ADC10 A+3.6258e-04 N0000601 L+1.8312e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC11 A+1.8535e-04 N0000601 L+1.2208e-03 H-9.1560e-04 D-3.0520e-04 E0 ADC12 A+8.6956e-02 N0000601 L+7.1784e-02 H+1.1565e-01 D+3.9880e-03 E0 ADC13 A+8.3074e-02 N0000601 L+7.3778e-02 H+9.5712e-02 D+1.9940e-03 E0 ADC14 A-1.4524e-04 N0000601 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.1633e-04 N0000601 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1258e+00 N0000601 L+1.0290e+00 H+1.5129e+00 D+1.2145e-01 E0 ADC21 A-3.6724e-02 N0000601 L-3.9669e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC22 A+5.1745e+01 N0000601 L+5.1694e+01 H+5.1760e+01 D+1.3958e-02 E0 ADC23 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4285e+01 N0000601 L+4.4280e+01 H+4.4434e+01 D+0.0000e+00 E0 ADC25 A-3.0160e-04 N0000601 L-2.4412e-03 H+1.2206e-03 D+6.1030e-04 E0 ADC26 A-3.6558e-02 N0000601 L-3.9059e-02 H-3.4787e-02 D+6.1030e-04 E0 ADC27 A+5.1573e+01 N0000601 L+5.1519e+01 H+5.1589e+01 D+1.5952e-02 E0 ADC28 A-2.7300e+02 N0000601 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2794e+01 N0000601 L+3.2790e+01 H+3.2944e+01 D+0.0000e+00 E0 ADC30 A-6.5932e-01 N0002403 L-8.0939e-01 H-6.1284e-01 D+5.1274e-02 E0 ADC31 A-3.2679e-02 N0002403 L-2.6034e-01 H-5.7988e-03 D+7.0196e-02 E0 ADC32 A+3.7485e+02 N0000601 L+3.7450e+02 H+3.7490e+02 D+6.1200e-02 E0 ADC35 A-2.4388e-01 N0002403 L-3.1008e-01 H-2.1883e-01 D+2.5942e-02 E0 ADC36 A-9.4176e-02 N0002403 L-1.2452e-01 H-8.3014e-02 D+1.1292e-02 E0 ADC37 A+1.3977e+01 N0000601 L+1.3935e+01 H+1.3994e+01 D+1.7946e-02 E0 ADC42 A+0.0000e+00 N0002403 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4000e+01 N0000060 L-6.4000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8243e-03 N0002403 L-1.9032e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3424e-06 N0000005 L+2.3653e-06 H+2.3272e-06 E0 GFL00 A+2.2509e-06 N0000005 L+2.2509e-06 H+2.2509e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6474e-04 N0000005 L+6.6484e-04 H+6.6438e-04 E0 GFZ01 A+8.3167e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+7.5026e-05 N0000005 L+1.2315e-04 H+6.2795e-05 E0 GFH01 A+1.1382e-03 N0000005 L+1.1394e-03 H+1.1377e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+0.0000e+00 N0000000 L+3.2767e+04 H-3.2768e+04 E0 TMP1 A+0.0000e+00 N0000000 L+3.2767e+04 H-3.2768e+04 E0 HUMI A+0.0000e+00 N0000000 L+3.2767e+04 H-3.2768e+04 E0 TMP2 A+0.0000e+00 N0000000 L+3.2767e+04 H-3.2768e+04 E0 DATA COUNT 02955 parentID=1407, recordType=1 devid=1594, t=1173989839091, seqNo=2406, mdref=2285 nBytes=2973 ADC00 A-5.9410e-04 N0000599 L+6.1040e-04 H-2.4416e-03 D-3.0520e-04 E0 ADC01 A-1.1800e-03 N0000599 L+0.0000e+00 H-3.3572e-03 D-3.0520e-04 E0 ADC02 A+1.0182e-01 N0000599 L+8.1754e-02 H+2.8315e-01 D+2.3928e-02 E0 ADC03 A+1.9645e-01 N0000599 L+1.3958e-01 H+5.0648e-01 D+8.3748e-02 E0 ADC04 A-1.2225e-02 N0000599 L-9.8274e-02 H+2.3500e-02 D+1.2513e-02 E0 ADC05 A+2.6597e-04 N0000599 L-9.1560e-04 H+1.8312e-03 D+3.0520e-04 E0 ADC10 A+3.5309e-04 N0000599 L+1.5260e-03 H-6.1040e-04 D-3.0520e-04 E0 ADC11 A+1.7273e-04 N0000599 L+1.2208e-03 H-6.1040e-04 D-3.0520e-04 E0 ADC12 A+8.6684e-02 N0000599 L+6.9790e-02 H+1.0568e-01 D+5.9820e-03 E0 ADC13 A+8.3026e-02 N0000599 L+7.1784e-02 H+9.3718e-02 D+1.9940e-03 E0 ADC14 A-1.5235e-04 N0000599 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC15 A-2.4253e-04 N0000599 L-1.2208e-03 H+9.1560e-04 D+3.0520e-04 E0 ADC20 A+1.1333e+00 N0000599 L+1.0345e+00 H+1.5380e+00 D+1.0497e-01 E0 ADC21 A-3.6744e-02 N0000599 L-3.9059e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC22 A+5.1742e+01 N0000599 L+5.1694e+01 H+5.1756e+01 D+1.1964e-02 E0 ADC23 A-2.7300e+02 N0000599 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC24 A+4.4358e+01 N0000599 L+4.4280e+01 H+4.4434e+01 D+0.0000e+00 E0 ADC25 A-2.9955e-04 N0000599 L-1.8309e-03 H+1.2206e-03 D+6.1030e-04 E0 ADC26 A-3.6545e-02 N0000599 L-3.8449e-02 H-3.4177e-02 D+6.1030e-04 E0 ADC27 A+5.1570e+01 N0000599 L+5.1515e+01 H+5.1583e+01 D+1.1964e-02 E0 ADC28 A-2.7300e+02 N0000599 L-2.7300e+02 H-2.7300e+02 D+0.0000e+00 E0 ADC29 A+3.2846e+01 N0000599 L+3.2790e+01 H+3.2944e+01 D+0.0000e+00 E0 ADC30 A-6.5270e-01 N0002397 L-8.0817e-01 H-6.1284e-01 D+4.4254e-02 E0 ADC31 A-2.5076e-02 N0002397 L-2.5606e-01 H-5.4936e-03 D+5.9514e-02 E0 ADC32 A+3.7485e+02 N0000599 L+3.7459e+02 H+3.7488e+02 D+6.1200e-02 E0 ADC35 A-2.5967e-01 N0002397 L-3.1588e-01 H-2.1974e-01 D+2.8078e-02 E0 ADC36 A-1.0117e-01 N0002397 L-1.2849e-01 H-8.2709e-02 D+1.2513e-02 E0 ADC37 A+1.3966e+01 N0000599 L+1.3929e+01 H+1.3993e+01 D+1.9067e-02 E0 ADC42 A+0.0000e+00 N0002397 L+0.0000e+00 H+0.0000e+00 D+0.0000e+00 E0 ADC43 A-6.4017e+01 N0000060 L-6.5000e+01 H-6.4000e+01 D+0.0000e+00 E0 ADC48 A-1.8251e-03 N0002397 L-1.9032e-03 H-1.8117e-03 D+0.0000e+00 E0 GFZ00 A+2.3272e-06 N0000005 L+2.3272e-06 H+2.3272e-06 E0 GFL00 A+2.2203e-06 N0000005 L+2.2509e-06 H+2.2127e-06 E0 GFH00 A+2.4035e-06 N0000005 L+2.4035e-06 H+2.4035e-06 E0 GFT00 A+6.6476e-04 N0000005 L+6.6484e-04 H+6.6446e-04 E0 GFZ01 A+8.3167e-07 N0000005 L+8.3930e-07 H+8.0115e-07 E0 GFL01 A+9.8580e-05 N0000005 L+1.2406e-04 H+6.3405e-05 E0 GFH01 A+1.1385e-03 N0000005 L+1.1393e-03 H+1.1378e-03 E0 GFT01 A+1.2501e-03 N0000005 L+1.2501e-03 H+1.2501e-03 E0 WS00 N0000060 A00 B00 C00 D00 WS01 N0000060 A00 B00 C00 D00 PRES A+1.1200e+03 N0000058 L+1.1190e+03 H+1.1240e+03 E0 TMP1 A+3.1000e+01 N0000058 L+3.1000e+01 H+3.2000e+01 E0 HUMI A+1.6000e+01 N0000058 L+1.6000e+01 H+1.6000e+01 E0 TMP2 A+3.4000e+01 N0000058 L+3.4000e+01 H+3.4000e+01 E0 DATA COUNT 02955 52530 DEBUG PortalConnection [main-DBG-0]: new latest=1173989839091 52530 DEBUG PortalConnection [main-DBG-0]: put packet stats 52531 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieved total of 10 packets from device [J@5c6a77 Retrieve data from device 1597 Retrieving data from device #1597 52533 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1597 52704 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets Retrieved 2 packets from device #1597 57007 INFO PortalConnection [main-DBG-0]: Retrieved 2 packets from device #1597 parentID=1407, recordType=1 devid=1597, t=1173986247232, seqNo=513, mdref=493 nBytes=2 ** parentID=1407, recordType=1 devid=1597, t=1173989847456, seqNo=514, mdref=493 nBytes=2 ** 57014 DEBUG PortalConnection [main-DBG-0]: new latest=1173989847456 57015 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 2 packets from device [J@5c6a77 Retrieve data from device 1020 Retrieving data from device #1020 57016 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1020 57022 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data 57052 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 57964 DEBUG PortalConnection [_wakeupWorker]: Connected to node node2/134.89.36.2 (id=1598) 59926 DEBUG PortalConnection [_wakeupWorker]: host: node2/134.89.36.2 Retrieved 2 packets from device #1020 61710 INFO PortalConnection [main-DBG-0]: Retrieved 2 packets from device #1020 parentID=1407, recordType=1 devid=1020, t=1173986259913, seqNo=508, mdref=488 nBytes=182 6****`l**>*** *X***f**\[%*)***H**t*k]*p****ACA**'*R***A*****A*I**Pi******ux****@*A*t***e*******-*B***g**:U**aZ*W***%y**k***wL9Y**}o* ** R****,***4**********Y***ea*o***t=d***1o******, parentID=1407, recordType=1 devid=1020, t=1173989859883, seqNo=509, mdref=488 nBytes=182 *u**\!q;^V*****19***A*4~***a***a*hj.#*3oJ*nc***F(E***|*~K***R*js******.***:Q** 9*"*N}*l****W ***********?*7c**}***+@******r**L******C***xe7***l**bi**__9*I***$*u*^*G1mS*** ***@:vI**** 61722 DEBUG PortalConnection [main-DBG-0]: new latest=1173989859883 61722 DEBUG PortalConnection [main-DBG-0]: put packet stats 61723 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieved total of 2 packets from device [J@5c6a77 Retrieve data from device 1021 Retrieving data from device #1021 61725 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1021 61770 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 62662 DEBUG PortalConnection [_wakeupWorker]: Lease established for 3600 sec, node node402; id=184 62663 DEBUG PortalConnection [_wakeupWorker]: connectNode() done 62663 DEBUG PortalConnection [_wakeupWorker]: wakeup thread: added to available: node402/134.89.36.2 62664 DEBUG PortalConnection [_wakeupWorker]: wakeup thread: attempt to add to available: node413/134.89.36.13 62664 INFO PortalConnection [_wakeupWorker]: wakeup thread: Send wakeup signal to subnode node413/134.89.36.13 , try #0 62664 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 62664 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(134.89.36.200,1025)... 63684 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(134.89.36.200,1025) Retrieved 10 packets from device #1021 66805 INFO PortalConnection [main-DBG-0]: Retrieved 10 packets from device #1021 parentID=1407, recordType=1 devid=1021, t=1173984472273, seqNo=2914, mdref=2802 nBytes=34 *z**{*********bq*******`***Hf3VC** parentID=1407, recordType=1 devid=1021, t=1173985072284, seqNo=2915, mdref=2802 nBytes=34 B**^******PoU******:j*H**SLO****** parentID=1407, recordType=1 devid=1021, t=1173985672283, seqNo=2916, mdref=2802 nBytes=34 DW*3%* ********** *****RG*****j*:* parentID=1407, recordType=1 devid=1021, t=1173986272312, seqNo=2917, mdref=2802 nBytes=34 ***/**)*A************5 ** ***RBb#* parentID=1407, recordType=1 devid=1021, t=1173986872284, seqNo=2918, mdref=2802 nBytes=34 ***%***x***R*r****P***37***q****2* parentID=1407, recordType=1 devid=1021, t=1173987472283, seqNo=2919, mdref=2802 nBytes=34 i*Z**R*G*******e*e**_****/R****L*Y parentID=1407, recordType=1 devid=1021, t=1173988072283, seqNo=2920, mdref=2802 nBytes=34 * **W*G*lJ****B**d****\******t**** parentID=1407, recordType=1 devid=1021, t=1173988672284, seqNo=2921, mdref=2802 nBytes=34 *y***|=**;:*****o****D*M2* ****r** parentID=1407, recordType=1 devid=1021, t=1173989272307, seqNo=2922, mdref=2802 nBytes=34 ***q*{****,***$5**bC**|**z****r* * parentID=1407, recordType=1 devid=1021, t=1173989872283, seqNo=2923, mdref=2802 nBytes=34 *]**:*b***A**0_*,*l**{3P***!***][z 66881 DEBUG PortalConnection [main-DBG-0]: new latest=1173989872283 66881 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 10 packets from device [J@5c6a77 Retrieve data from device 1022 Retrieving data from device #1022 66882 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1022 66883 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data 67035 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 73066 DEBUG NodeProbe [_wakeupWorker]: Creating new ProbeWorker Retrieved 2 packets from device #1022 73547 INFO PortalConnection [main-DBG-0]: Retrieved 2 packets from device #1022 parentID=1407, recordType=1 devid=1022, t=1173986285562, seqNo=508, mdref=488 nBytes=1348 ***YS***m1iB*e*******F****E*y *ko****%"*_/B******* 8*j**Y*A****l****l**H**]*f*G**Q***P**z****h7****"p****&"*>****Y*W*%*s*Ft*f* *i******z**b*'**(*d**w{**g<********w*** "**J*********@*+?***(?*J********?i******>$*(***y*,***o ***W****0**K* **s****\Lf**,O*TkK=***u**:**|Q$***;*@a'**L*:0**Z**N'****#*d****l******?****o***"*'***** *MU****x*$*****o****Ew**o**io*D*7S*****Eo*)*E *m***wc*`:9*:***}*z**>5******$***_*^r**M*0*******;******l*9*3=***P*d*F|**l2***{***)(5*z*bD**n***%Qk*****T%***I[Z**G*P'*@**}YH**[****]t*x*g****F :*(*%*j**s *I**[{***a\*#* *b*****H*JiK+!*z***s{@*>*|*k**z**x**z)x**E*******6^*e*******O*******x**********3*****B*h**x*aO|oN*l**g**zm***d**bx1/S****6i*****r***rR*6d*n***** ** N)***pM*r*************H******y!*******SAB***T)**.Z******&*7*\*d* *y*V***M***r********nq_+*k>+*****{***|*******3**[*****;I[**}*a_** ***}*xs**F6**<*.v*m*******+ca**x*N********** *2**E*B**s**=9z**\^**>*h*****_*q* *l+\b* *Ds****/********:*%**h"w!n*t~w**~9#***k*z***9*^*:*Z*v***j**VgYQ***]Q{.* yHpwaw*****-*****R%***w***`*]A*>%"*o*\**kEb** *Yrtj*1:A***35********{H****0****p$`*=*md***T!~******u;q*a***g*}**L9*~_S*p***L{****-*0**(*7*?**********iw*5~*****-**X**,**rM******c*x*,*f***h*****!*7*********a***8**<* *5w6*b***7**z parentID=1407, recordType=1 devid=1022, t=1173989885534, seqNo=509, mdref=488 nBytes=1348 *u*t*b*<**|d].`***&o'****"*{2*?*C****W*|*y***)*+*z**&~*******y*** **w* ***d*******h*qy%yj**4***wT****r_******v f*J*w*G***)**n***X**m*******s*M}z*uO(|******j** ** ***-*3Y****M*e**0**?*X*****V**+*Q**,*Q***************r**d(*b*f**Wn/*[@y*Q****9sR**5#O`*<*z**~G*C**r*+*****B***.[****{***1R**lg**h*m*"**.N*****g5&*=**/*5O;*|_;lS*`&'*******}|C***7*****_lb**@***********b*7**(*2**]/'**^**X**Y*}***. 6*********d***Q**w3 *f*:*su>,*K!*JY***9*7k*+R*:&+wt-9**p**G*!*PD****j;M***r*r**6;***k*1*|******h*q\***E*****u%**Nct*m*\**4u*[*p7**********7ie* ********wKC**c**]* x**,d*j*!'**nm***d****P* ";**m0**Y*!*e#* *xo~*****>i*********N4=\V**>B*o*******?h**o****S*Z l;**n*******~bX**/y***I****5*+*y*X***L*_*&EK*sq*'**1**G***g3*`t*J***** **P**i**Y**q****($*********8vm*p* ***y*****tb!***$c*S?Q*I*B-8**T****** **J [*q8**J**I*v****>*4,****p*********Hme*:**3****,****c**mva*6***+EB*@B,_* ********i******j*"L*A******P**%Yo*`*******;*U*******bW*v*t_*G*****kt***Ax**XO+**C7***6F****x*f\:/****=[*******M***** }****)***{*-*****]*.l_s**7*Q*A *h*******n***'**vU getObjectInstance() 74174 DEBUG PublisherComponent [_wakeupWorker]: Going to create a topic session from the connection 74176 DEBUG PublisherComponent [_wakeupWorker]: Now going to call start on the topic connection 74177 DEBUG PublisherComponent [_wakeupWorker]: Connected was true after start 74178 DEBUG PublisherComponent [_wakeupWorker]: Should have set the topicName to topic/SSDSIngestTopic 74180 DEBUG PortalConnection [_wakeupWorker]: Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) 74181 DEBUG Portal [_wakeupWorker]: Got new connection from 134.89.36.13 total = 3 74182 DEBUG PortalConnection [_wakeupWorker]: Looking for node server stub at //node413/node 74182 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=node413, port=1099 74183 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(node413,1099)... 74185 DEBUG PortalConnection [_distributeWorker-node413/134.89.36.13]: DistributeWorker - started: Mar 15, 2007 2:20:02 PM 75281 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(node413,1099) Retrieved 9 packets from device #1590 77519 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1590 parentID=1407, recordType=1 devid=1590, t=1173984510061, seqNo=1068, mdref=956 nBytes=70 $GPRMC,184821,A,3648.1996,N,12147.2561,W,000.0,342.5,150307,014.8,E*60 parentID=1407, recordType=1 devid=1590, t=1173985109985, seqNo=1069, mdref=956 nBytes=70 $GPRMC,185821,A,3648.1979,N,12147.2593,W,000.0,342.5,150307,014.8,E*6D parentID=1407, recordType=1 devid=1590, t=1173985710981, seqNo=1070, mdref=956 nBytes=70 $GPRMC,190822,A,3648.2091,N,12147.2515,W,000.0,342.5,150307,014.8,E*68 parentID=1407, recordType=1 devid=1590, t=1173986310161, seqNo=1071, mdref=956 nBytes=70 $GPRMC,191821,A,3648.2017,N,12147.2529,W,000.0,249.6,150307,014.8,E*62 parentID=1407, recordType=1 devid=1590, t=1173986910190, seqNo=1072, mdref=956 nBytes=70 $GPRMC,192821,A,3648.2028,N,12147.2513,W,000.0,249.6,150307,014.8,E*64 parentID=1407, recordType=1 devid=1590, t=1173987510260, seqNo=1073, mdref=956 nBytes=70 $GPRMC,193821,A,3648.2014,N,12147.2523,W,000.0,249.6,150307,014.8,E*69 parentID=1407, recordType=1 devid=1590, t=1173988110220, seqNo=1074, mdref=956 nBytes=70 $GPRMC,194822,A,3648.1988,N,12147.2543,W,000.0,249.6,150307,014.8,E*64 parentID=1407, recordType=1 devid=1590, t=1173988710271, seqNo=1075, mdref=956 nBytes=70 $GPRMC,195822,A,3648.2022,N,12147.2578,W,000.0,249.6,150307,014.8,E*67 parentID=1407, recordType=1 devid=1590, t=1173989310390, seqNo=1076, mdref=956 nBytes=70 $GPRMC,200822,A,3648.1941,N,12147.2537,W,000.0,249.0,150307,014.8,E*6A 77569 DEBUG PortalConnection [main-DBG-0]: new latest=1173989310390 77569 DEBUG PortalConnection [main-DBG-0]: put packet stats 77570 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieved total of 9 packets from device [J@5c6a77 Retrieve data from device 1412 Retrieving data from device #1412 77572 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1412 77699 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 78750 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory.createSocket() - host=134.89.36.13, port=1024 78750 DEBUG PortalSocketFactory [_wakeupWorker]: return new Socket(134.89.36.13,1024)... 79898 DEBUG PortalSocketFactory [_wakeupWorker]: PortalSocketFactory returned new Socket(134.89.36.13,1024) Retrieved 9 packets from device #1412 82207 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1412 parentID=1407, recordType=1 devid=1412, t=1173984521264, seqNo=2957, mdref=2845 nBytes=73 $PEDATA, P73.79, T28.30, H36.54, GFL0.00, GFH-0.13, C64.11, TC0.00, *3599 parentID=1407, recordType=1 devid=1412, t=1173985121303, seqNo=2958, mdref=2845 nBytes=73 $PEDATA, P83.64, T28.39, H34.87, GFL-0.42, GFH0.00, C64.11, TC0.00, *3609 parentID=1407, recordType=1 devid=1412, t=1173985721303, seqNo=2959, mdref=2845 nBytes=73 $PEDATA, P76.61, T28.09, H35.07, GFL-0.28, GFH0.38, C64.11, TC0.00, *3613 parentID=1407, recordType=1 devid=1412, t=1173986321585, seqNo=2960, mdref=2845 nBytes=73 $PEDATA, P78.01, T27.91, H36.78, GFL-0.71, GFH0.00, C63.95, TC0.00, *3616 parentID=1407, recordType=1 devid=1412, t=1173986921275, seqNo=2961, mdref=2845 nBytes=73 $PEDATA, P70.98, T28.09, H36.80, GFL0.28, GFH-0.13, C64.27, TC0.00, *3619 parentID=1407, recordType=1 devid=1412, t=1173987521264, seqNo=2962, mdref=2845 nBytes=73 $PEDATA, P56.91, T28.62, H34.01, GFL0.42, GFH-0.13, C63.63, TC0.00, *3601 parentID=1407, recordType=1 devid=1412, t=1173988121298, seqNo=2963, mdref=2845 nBytes=75 $PEDATA, P117.41, T27.79, H35.96, GFL-0.28, GFH-0.13, C63.31, TC0.00, *3708 parentID=1407, recordType=1 devid=1412, t=1173988721273, seqNo=2964, mdref=2845 nBytes=72 $PEDATA, P78.01, T28.44, H33.92, GFL0.14, GFH0.00, C63.14, TC0.00, *3551 parentID=1407, recordType=1 devid=1412, t=1173989321267, seqNo=2965, mdref=2845 nBytes=76 $PEDATA, P-293.91, T27.94, H36.93, GFL-0.28, GFH-0.13, C63.47, TC0.00, *3765 82246 DEBUG PortalConnection [main-DBG-0]: new latest=1173989321267 82246 DEBUG PortalConnection [main-DBG-0]: put packet stats 82247 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieved total of 9 packets from device [J@5c6a77 Retrieve data from device 1560 Retrieving data from device #1560 82253 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1560 82405 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets Retrieved 11 packets from device #1560 87900 INFO PortalConnection [main-DBG-0]: Retrieved 11 packets from device #1560 parentID=1407, recordType=1 devid=1560, t=1173984259584, seqNo=6881, mdref=6659 nBytes=200 -> channel=0, temp=54.73, vcc=3.2310, txBiasI=4.0984, txPower=-2.4652, rxPower=-15.1033, status=0x0 channel=2, temp=58.20, vcc=3.2186, txBiasI=7.5591, txPower=-1.9126, rxPower=-14.0113, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173984559660, seqNo=6882, mdref=6659 nBytes=200 -> channel=0, temp=55.02, vcc=3.2308, txBiasI=4.1477, txPower=-2.4621, rxPower=-14.9755, status=0x0 channel=2, temp=58.84, vcc=3.2186, txBiasI=7.6664, txPower=-1.9098, rxPower=-13.7536, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173984861250, seqNo=6883, mdref=6659 nBytes=200 -> channel=0, temp=55.05, vcc=3.2300, txBiasI=4.1448, txPower=-2.4590, rxPower=-15.0817, status=0x0 channel=2, temp=59.05, vcc=3.2168, txBiasI=7.6867, txPower=-1.9126, rxPower=-13.6476, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173985160413, seqNo=6884, mdref=6659 nBytes=200 -> channel=0, temp=54.87, vcc=3.2312, txBiasI=4.1042, txPower=-2.4652, rxPower=-15.3022, status=0x0 channel=2, temp=58.84, vcc=3.2198, txBiasI=7.6693, txPower=-1.9098, rxPower=-13.6651, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173985460386, seqNo=6885, mdref=6659 nBytes=200 -> channel=0, temp=54.88, vcc=3.2306, txBiasI=4.1361, txPower=-2.4372, rxPower=-14.8924, status=0x0 channel=2, temp=58.64, vcc=3.2184, txBiasI=7.6838, txPower=-1.9055, rxPower=-13.7715, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173985760383, seqNo=6886, mdref=6659 nBytes=200 -> channel=0, temp=54.60, vcc=3.2324, txBiasI=4.0955, txPower=-2.4434, rxPower=-15.1467, status=0x0 channel=2, temp=58.48, vcc=3.2174, txBiasI=7.6229, txPower=-1.9155, rxPower=-13.8075, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173986059693, seqNo=6887, mdref=6659 nBytes=200 -> channel=0, temp=54.58, vcc=3.2308, txBiasI=4.1187, txPower=-2.4403, rxPower=-15.1467, status=0x0 channel=2, temp=58.64, vcc=3.2186, txBiasI=7.6461, txPower=-1.9041, rxPower=-13.7894, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173986361186, seqNo=6888, mdref=6659 nBytes=200 -> channel=0, temp=54.66, vcc=3.2306, txBiasI=4.1013, txPower=-2.4652, rxPower=-15.1906, status=0x0 channel=2, temp=58.36, vcc=3.2184, txBiasI=7.6084, txPower=-1.9155, rxPower=-14.0494, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173986659624, seqNo=6889, mdref=6659 nBytes=200 -> channel=0, temp=54.42, vcc=3.2310, txBiasI=4.0897, txPower=-2.4372, rxPower=-15.3249, status=0x0 channel=2, temp=58.25, vcc=3.2194, txBiasI=7.5736, txPower=-1.9126, rxPower=-13.8438, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173986959593, seqNo=6890, mdref=6659 nBytes=200 -> channel=0, temp=54.59, vcc=3.2322, txBiasI=4.0897, txPower=-2.4652, rxPower=-15.1467, status=0x0 channel=2, temp=58.35, vcc=3.2170, txBiasI=7.6084, txPower=-1.9083, rxPower=-13.8805, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173987259594, seqNo=6891, mdref=6659 nBytes=200 -> channel=0, temp=54.62, vcc=3.2302, txBiasI=4.1245, txPower=-2.4746, rxPower=-14.7907, status=0x0 channel=2, temp=58.31, vcc=3.2194, txBiasI=7.5736, txPower=-1.9069, rxPower=-13.8438, status=0x0 87948 DEBUG PortalConnection [main-DBG-0]: new latest=1173987259594 87950 DEBUG PortalConnection [main-DBG-0]: put packet stats 87950 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data Retrieve data from device 1560 Retrieving data from device #1560 87952 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1560 88116 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets Retrieved 8 packets from device #1560 92368 INFO PortalConnection [main-DBG-0]: Retrieved 8 packets from device #1560 parentID=1407, recordType=1 devid=1560, t=1173987559594, seqNo=6892, mdref=6659 nBytes=200 -> channel=0, temp=54.65, vcc=3.2294, txBiasI=4.0897, txPower=-2.4403, rxPower=-15.0603, status=0x0 channel=2, temp=58.49, vcc=3.2172, txBiasI=7.6229, txPower=-1.9027, rxPower=-13.7003, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173987860413, seqNo=6893, mdref=6659 nBytes=200 -> channel=0, temp=54.63, vcc=3.2318, txBiasI=4.1187, txPower=-2.4590, rxPower=-15.0603, status=0x0 channel=2, temp=58.43, vcc=3.2190, txBiasI=7.6374, txPower=-1.9112, rxPower=-13.9923, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173988160363, seqNo=6894, mdref=6659 nBytes=200 -> channel=0, temp=54.51, vcc=3.2314, txBiasI=4.1071, txPower=-2.4652, rxPower=-15.1906, status=0x0 channel=2, temp=58.19, vcc=3.2180, txBiasI=7.5765, txPower=-1.9183, rxPower=-13.9361, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173988459644, seqNo=6895, mdref=6659 nBytes=200 -> channel=0, temp=54.58, vcc=3.2322, txBiasI=4.0955, txPower=-2.4528, rxPower=-15.1686, status=0x0 channel=2, temp=58.52, vcc=3.2200, txBiasI=7.6084, txPower=-1.9112, rxPower=-13.9547, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173988759664, seqNo=6896, mdref=6659 nBytes=200 -> channel=0, temp=54.80, vcc=3.2302, txBiasI=4.1361, txPower=-2.4434, rxPower=-15.0389, status=0x0 channel=2, temp=58.59, vcc=3.2186, txBiasI=7.6519, txPower=-1.9126, rxPower=-13.9923, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173989060113, seqNo=6897, mdref=6659 nBytes=200 -> channel=0, temp=54.79, vcc=3.2310, txBiasI=4.0926, txPower=-2.4715, rxPower=-15.1906, status=0x0 channel=2, temp=58.68, vcc=3.2182, txBiasI=7.6606, txPower=-1.8998, rxPower=-14.0303, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173989359624, seqNo=6898, mdref=6659 nBytes=200 -> channel=0, temp=54.86, vcc=3.2312, txBiasI=4.1042, txPower=-2.4684, rxPower=-14.9338, status=0x0 channel=2, temp=58.73, vcc=3.2172, txBiasI=7.6867, txPower=-1.9041, rxPower=-13.6826, status=0x0 parentID=1407, recordType=1 devid=1560, t=1173989659595, seqNo=6899, mdref=6659 nBytes=200 -> channel=0, temp=54.84, vcc=3.2292, txBiasI=4.0984, txPower=-2.4465, rxPower=-15.0603, status=0x0 channel=2, temp=58.48, vcc=3.2186, txBiasI=7.6026, txPower=-1.9055, rxPower=-13.8256, status=0x0 92394 DEBUG PortalConnection [main-DBG-0]: new latest=1173989659595 92395 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 19 packets from device [J@5c6a77 92395 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After retrieveAndDistributeData: 18 92396 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before subnode processing: 18 92396 DEBUG PortalConnection [main-DBG-0]: main thread: calling process node: node402/134.89.36.2 92396 DEBUG Portal [main-DBG-0]: Found existing connection to node402 ThreadUtility.printThreads() 92397 INFO ThreadUtility [main-DBG-0]: ThreadGroup "main" includes about 18 threads 92407 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: saving data 92419 INFO ThreadUtility [main-DBG-0]: thread: "main-DBG-0" alive thread: "_distributeWorker-mse/10.1.36.2-DBG-1" alive thread: "_wakeupWorker-DBG-6" alive thread: "_distributeWorker-node402/134.89.36.2-DBG-7" alive thread: "_distributeWorker-node413/134.89.36.13-DBG-8" alive thread: "UIL2.SocketManager.ReadTask#1-DBG-2" alive daemon thread: "UIL2.SocketManager.WriteTask#2-DBG-3" alive daemon thread: "Connection Monitor Thread-DBG-4" alive daemon thread: "Thread-2-DBG-5" alive daemon thread: "UIL2.SocketManager.ReadTask#3-DBG-9" alive daemon thread: "UIL2.SocketManager.WriteTask#4-DBG-10" alive daemon thread: "Thread-8-DBG-11" alive daemon thread: "UIL2.SocketManager.ReadTask#5-DBG-12" alive daemon thread: "UIL2.SocketManager.WriteTask#6-DBG-13" alive daemon thread: "Thread-12-DBG-14" alive daemon 92422 INFO PortalConnection [main-DBG-0]: startSession()[node402]: Mar 15, 2007 2:20:20 PM 92422 DEBUG PortalConnection [main-DBG-0]: startSession()[node402] - get node proxy 92422 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.totalMemory: 2031616 92422 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.freeMemory: 1333528 92423 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - startSession: 18 92423 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.2, port=1025 92423 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.2,1025)... 92528 DEBUG PortalConnection [_distributeWorker-mse/10.1.36.2-DBG-1]: publishing packets 93315 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(134.89.36.2,1025) 93491 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Connected to node node13/134.89.36.13 (id=1410) 95292 DEBUG PortalConnection [_wakeupWorker-DBG-6]: host: node13/134.89.36.13 98447 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Lease established for 3600 sec, node node413; id=175 98448 DEBUG PortalConnection [_wakeupWorker-DBG-6]: connectNode() done 98448 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: added to available: node413/134.89.36.13 98448 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: attempt to add to available: node403/134.89.36.3 98449 INFO PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: Send wakeup signal to subnode node403/134.89.36.3 , try #0 103078 INFO PortalConnection [main-DBG-0]: WDT status: watchdog state: sleeping 103078 INFO PortalConnection [main-DBG-0]: node402 Command Response: "15 Mar 20:19:16 ntpdate[31464]: no server suitable for synchronization found " /dev/ttySX13, BIN 400-12V Switch s/n 1.03, ID=1555 /dev/ttySX1, DummyWETLabsSummarizer, ID=1026 /dev/ttySX2, WETLabs ECO-Triplet s/n WL-30009, ID=1536 /dev/ttySX3, Aquadopp Current Meter s/n AQD2053, ID=1553 /dev/ttySX4, Aanderaa Optode s/n 677, ID=1524 NO SERVICE NO SERVICE /dev/ttySX7, WH Sentinel ADCP 300kHz s/n 1706, ID=1592 NO SERVICE NO SERVICE NO SERVICE NO SERVICE /dev/ttySX15, MSP430 (sidearm4.02), ID=1599 /dev/ttySA2, Medusa card s/n 2.003, ID=1528 New node ID: 1598 New device ID: 1555 New device ID: 1026 New device ID: 1536 New device ID: 1553 New device ID: 1524 New device ID: 1592 New device ID: 1599 New device ID: 1528 creating device log 1536 in /home/ops/siam/logs/1598 103138 DEBUG PortalConnection [main-DBG-0]: recording log entry 103138 DEBUG PortalConnection [main-DBG-0]: initializing device log 1536 mostRecent:1173983095464 startRetrieveTime:1173682800000 maxTimestamp:1173983095464 creating device log 1026 in /home/ops/siam/logs/1598 103166 DEBUG PortalConnection [main-DBG-0]: recording log entry 103166 DEBUG PortalConnection [main-DBG-0]: initializing device log 1026 mostRecent:1173983039086 startRetrieveTime:1173682800000 maxTimestamp:1173983039086 creating device log 1555 in /home/ops/siam/logs/1598 103214 DEBUG PortalConnection [main-DBG-0]: recording log entry 103214 DEBUG PortalConnection [main-DBG-0]: initializing device log 1555 mostRecent:1173984233057 startRetrieveTime:1173682800000 maxTimestamp:1173984233057 creating device log 1553 in /home/ops/siam/logs/1598 103253 DEBUG PortalConnection [main-DBG-0]: recording log entry 103253 DEBUG PortalConnection [main-DBG-0]: initializing device log 1553 mostRecent:1173984047652 startRetrieveTime:1173682800000 maxTimestamp:1173984047652 creating device log 1599 in /home/ops/siam/logs/1598 103298 DEBUG PortalConnection [main-DBG-0]: recording log entry 103298 DEBUG PortalConnection [main-DBG-0]: initializing device log 1599 mostRecent:1173984079914 startRetrieveTime:1173682800000 maxTimestamp:1173984079914 creating device log 1598 in /home/ops/siam/logs/1598 103353 DEBUG PortalConnection [main-DBG-0]: recording log entry 103353 DEBUG PortalConnection [main-DBG-0]: initializing device log 1598 mostRecent:1173984126766 startRetrieveTime:1173682800000 maxTimestamp:1173984126766 creating device log 1528 in /home/ops/siam/logs/1598 103395 DEBUG PortalConnection [main-DBG-0]: recording log entry 103395 DEBUG PortalConnection [main-DBG-0]: initializing device log 1528 mostRecent:1173984121428 startRetrieveTime:1173682800000 maxTimestamp:1173984121428 creating device log 1524 in /home/ops/siam/logs/1598 103418 DEBUG PortalConnection [main-DBG-0]: recording log entry 103418 DEBUG PortalConnection [main-DBG-0]: initializing device log 1524 mostRecent:1173982860682 startRetrieveTime:1173682800000 maxTimestamp:1173982860682 creating device log 1592 in /home/ops/siam/logs/1598 103456 DEBUG PortalConnection [main-DBG-0]: recording log entry 103457 DEBUG PortalConnection [main-DBG-0]: initializing device log 1592 mostRecent:1173984309365 startRetrieveTime:1173682800000 maxTimestamp:1173984309365 103457 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before retrieveAndDistributeData: 18 Retrieve data from device 1598 Retrieving data from device #1598 103458 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1598 104644 DEBUG NodeProbe [_wakeupWorker-DBG-6]: Creating new ProbeWorker 105647 DEBUG NodeProbe [_wakeupWorker-DBG-6]: got status - exiting 105648 DEBUG NodeProbe [_wakeupWorker-DBG-6]: host available (1003 ms) 105648 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: NodeProbe returned true 105648 DEBUG Portal [_wakeupWorker-DBG-6]: Creating new PortalConnection for node403/134.89.36.3 105649 DEBUG PortalConnection [_wakeupWorker-DBG-6]: new PortalConnection() for node node403 105649 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Default constructor called 105654 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: setTopicname called with name topic/SSDSIngestTopic 105654 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: topicname is now topic/SSDSIngestTopic 105655 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Not connected so calling start 105655 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: PublisherComponent stop called 105655 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Everything should be closed now 105656 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: start called, setting connected to true 105656 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get jndiContext 105657 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: JNDI environment = {java.naming.provider.url=bob:1099, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jnp.timeout=0, jnp.socketFactory=org.jnp.interfaces.TimedSocketFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, java.naming.factory.url.pkgs.Naming=org.jboss.naming, jnp.sotimeout=0} 105658 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get the topic connection factory from the JNDI 105658 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=134.89.12.73, port=1098 105659 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(134.89.12.73,1098)... 105660 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(134.89.12.73,1098) 105693 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker-DBG-6]: Extracting SpyConnectionFactory from reference 105711 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker-DBG-6]: The GenericConnectionFactory is: GenericConnectionFactory:[server=org.jboss.mq.il.uil2.UILServerIL@825b3,connectionProperties={UIL_ADDRESS_KEY=134.89.12.73, UIL_CHUNKSIZE_KEY=1000000, UIL_TCPNODELAY_KEY=yes, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_PORT_KEY=8093, UIL_BUFFERSIZE_KEY=2048, PingPeriod=60000}] 105711 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to create a topic connection from the factory 105714 DEBUG SocketManager [UIL2.SocketManager.ReadTask#7]: Begin ReadTask.run 105715 DEBUG SocketManager [UIL2.SocketManager.WriteTask#8]: Begin WriteTask.run 105715 DEBUG SocketManager [UIL2.SocketManager.WriteTask#8]: Created ObjectOutputStream 105717 DEBUG SocketManager [UIL2.SocketManager.ReadTask#7]: Created ObjectInputStream 105718 DEBUG GenericConnectionFactory [_wakeupWorker-DBG-6]: Handing out ClientIL: org.jboss.mq.il.uil2.UILClientILService 105718 DEBUG UILClientILService [_wakeupWorker-DBG-6]: Starting 105729 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get the topic topic/SSDSIngestTopic from the JNDI lookup 105740 DEBUG SpyDestinationObjectFactory [_wakeupWorker-DBG-6]: SpyDestinationObjectFactory->getObjectInstance() 105740 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to create a topic session from the connection 105742 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Now going to call start on the topic connection 105743 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Connected was true after start 105743 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Should have set the topicName to topic/SSDSIngestTopic 105744 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) 105745 DEBUG Portal [_wakeupWorker-DBG-6]: Got new connection from 134.89.36.3 total = 4 105746 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Looking for node server stub at //node403/node 105746 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=node403, port=1099 105747 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(node403,1099)... 105749 DEBUG PortalConnection [_distributeWorker-node403/134.89.36.3]: DistributeWorker - started: Mar 15, 2007 2:20:33 PM 106670 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(node403,1099) 109795 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=134.89.36.3, port=1024 109795 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(134.89.36.3,1024)... 110792 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(134.89.36.3,1024) 115031 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=134.89.36.3, port=1024 115032 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(134.89.36.3,1024)... 116069 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(134.89.36.3,1024) 121209 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Connected to node node3/134.89.36.3 (id=1544) 122866 DEBUG PortalConnection [_wakeupWorker-DBG-6]: host: node3/134.89.36.3 125090 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Lease established for 3600 sec, node node403; id=1147 125090 DEBUG PortalConnection [_wakeupWorker-DBG-6]: connectNode() done 125091 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: added to available: node403/134.89.36.3 125091 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: attempt to add to available: node418/134.89.36.18 125091 INFO PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: Send wakeup signal to subnode node418/134.89.36.18 , try #0 125091 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 125092 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(134.89.36.200,1025)... 126098 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(134.89.36.200,1025) 131672 DEBUG NodeProbe [_wakeupWorker-DBG-6]: Creating new ProbeWorker 133179 DEBUG NodeProbe [_wakeupWorker-DBG-6]: got status - exiting 133179 DEBUG NodeProbe [_wakeupWorker-DBG-6]: host available (1506 ms) 133179 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: NodeProbe returned true 133180 DEBUG Portal [_wakeupWorker-DBG-6]: Creating new PortalConnection for node418/134.89.36.18 133180 DEBUG PortalConnection [_wakeupWorker-DBG-6]: new PortalConnection() for node node418 133180 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Default constructor called 133185 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: setTopicname called with name topic/SSDSIngestTopic 133185 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: topicname is now topic/SSDSIngestTopic 133185 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Not connected so calling start 133186 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: PublisherComponent stop called 133186 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Everything should be closed now 133186 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: start called, setting connected to true 133186 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get jndiContext 133187 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: JNDI environment = {java.naming.provider.url=bob:1099, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jnp.timeout=0, jnp.socketFactory=org.jnp.interfaces.TimedSocketFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, java.naming.factory.url.pkgs.Naming=org.jboss.naming, jnp.sotimeout=0} 133187 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get the topic connection factory from the JNDI 133197 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker-DBG-6]: Extracting SpyConnectionFactory from reference 133202 DEBUG SpyConnectionFactoryObjectFactory [_wakeupWorker-DBG-6]: The GenericConnectionFactory is: GenericConnectionFactory:[server=org.jboss.mq.il.uil2.UILServerIL@61899b,connectionProperties={UIL_ADDRESS_KEY=134.89.12.73, UIL_CHUNKSIZE_KEY=1000000, UIL_TCPNODELAY_KEY=yes, ClientILService=org.jboss.mq.il.uil2.UILClientILService, UIL_PORT_KEY=8093, UIL_BUFFERSIZE_KEY=2048, PingPeriod=60000}] 133205 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to create a topic connection from the factory 133210 DEBUG SocketManager [UIL2.SocketManager.ReadTask#9]: Begin ReadTask.run 133211 DEBUG SocketManager [UIL2.SocketManager.WriteTask#10]: Begin WriteTask.run 133212 DEBUG SocketManager [UIL2.SocketManager.WriteTask#10]: Created ObjectOutputStream 133213 DEBUG SocketManager [UIL2.SocketManager.ReadTask#9]: Created ObjectInputStream 133214 DEBUG GenericConnectionFactory [_wakeupWorker-DBG-6]: Handing out ClientIL: org.jboss.mq.il.uil2.UILClientILService 133214 DEBUG UILClientILService [_wakeupWorker-DBG-6]: Starting 133216 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to get the topic topic/SSDSIngestTopic from the JNDI lookup 133223 DEBUG SpyDestinationObjectFactory [_wakeupWorker-DBG-6]: SpyDestinationObjectFactory->getObjectInstance() 133223 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Going to create a topic session from the connection 133225 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Now going to call start on the topic connection 133226 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Connected was true after start 133226 DEBUG PublisherComponent [_wakeupWorker-DBG-6]: Should have set the topicName to topic/SSDSIngestTopic 133227 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Retrieve all packets created since Mar 12, 2007 12:00:00 AM (1173682800000 sec) 133228 DEBUG Portal [_wakeupWorker-DBG-6]: Got new connection from 134.89.36.18 total = 5 133229 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Looking for node server stub at //node418/node 133229 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=node418, port=1099 133230 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(node418,1099)... 133232 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18]: DistributeWorker - started: Mar 15, 2007 2:21:01 PM 134195 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(node418,1099) 137720 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory.createSocket() - host=134.89.36.18, port=1025 137721 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: return new Socket(134.89.36.18,1025)... 139655 DEBUG PortalSocketFactory [_wakeupWorker-DBG-6]: PortalSocketFactory returned new Socket(134.89.36.18,1025) Retrieved 10 packets from device #1598 139739 INFO PortalConnection [main-DBG-0]: Retrieved 10 packets from device #1598 parentID=0, recordType=1 devid=1598, t=1173987721144, seqNo=1234, mdref=1044 nBytes=547 Node started at: 03/15/2007 00:23:12 port=/dev/ttySX13,id=1555,samples=116,err=0,retries=10,status=0, port=/dev/ttySX1,id=1026,samples=20,err=0,retries=0,status=0, port=/dev/ttySX2,id=1536,samples=230,err=2,retries=7,status=0, port=/dev/ttySX3,id=1553,samples=0,err=0,retries=0,status=1, port=/dev/ttySX4,id=1524,samples=231,err=1,retries=3,status=0, port=/dev/ttySX7,id=1592,samples=1109,err=24,retries=24,status=5, port=/dev/ttySX15,id=1599,samples=2049,err=0,retries=1,status=0, port=/dev/ttySA2,id=1528,samples=228,err=0,retries=17,status=5, parentID=0, recordType=2 devid=1598, t=1173987723135, seqNo=1235, mdref=1044 nBytes=2573 /dev/ttySX13 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;26.315002;0.00732;0.00915;0x2;0xe6;0x38(OK);03/15/2007 07:33:46 minHtSnk;26.132004;0.00366;0.00915;0x2;0xe6;0x38(OK);03/15/2007 06:43:44 maxHtSnk;26.376;0.01098;0.0122;0x2;0xe6;0x38(OK);03/15/2007 07:23:47 minVolt;26.132004;0.00366;0.00915;0x2;0xe6;0x38(OK);03/15/2007 06:43:44 maxVolt;26.376;0.01098;0.0122;0x2;0xe6;0x38(OK);03/15/2007 07:23:47 minAmp;26.132004;0.00366;0.00915;0x2;0xe6;0x38(OK);03/15/2007 06:43:44 maxAmp;26.376;0.01098;0.0122;0x2;0xe6;0x38(OK);03/15/2007 07:23:47 /dev/ttySX1 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX2 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;28.145004;13.999499;0.0366;0x2;0xe7;0x38(OK);03/15/2007 07:39:49 minHtSnk;27.656998;13.999499;0.0366;0x2;0xe7;0x38(OK);03/15/2007 06:44:47 maxHtSnk;28.145004;13.999499;0.0366;0x2;0xe7;0x38(OK);03/15/2007 07:39:49 minVolt;27.961998;13.655459;0.0366;0x2;0xe7;0x38(OK);03/15/2007 06:59:47 maxVolt;28.084;14.0031595;0.0366;0x2;0xe7;0x38(OK);03/15/2007 07:09:48 minAmp;27.718002;13.999499;0.033549998;0x2;0xe7;0x38(OK);03/15/2007 06:49:49 maxAmp;27.961998;13.999499;0.03965;0x2;0xe7;0x38(OK);03/15/2007 07:04:57 /dev/ttySX3 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX4 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;26.558998;13.92264;0.067099996;0x2;0xe7;0x38(OK);03/15/2007 07:40:54 minHtSnk;26.132004;13.9263;0.067099996;0x2;0xe7;0x38(OK);03/15/2007 06:45:54 maxHtSnk;26.558998;13.92264;0.067099996;0x2;0xe7;0x38(OK);03/15/2007 07:40:54 minVolt;26.498001;0.01098;0.027449999;0x2;0xc4;0x38(OK);03/15/2007 07:31:04 maxVolt;26.132004;13.9263;0.067099996;0x2;0xe7;0x38(OK);03/15/2007 06:45:54 minAmp;26.498001;0.01098;0.027449999;0x2;0xc4;0x38(OK);03/15/2007 07:31:04 maxAmp;26.498001;13.9263;0.070149995;0x2;0xe7;0x38(OK);03/15/2007 07:15:55 /dev/ttySX7 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;27.535004;13.99218;0.00915;0x2;0xe7;0x38(OK);03/15/2007 07:41:48 minHtSnk;26.925003;13.98852;0.0061;0x2;0xe7;0x38(OK);03/15/2007 06:43:47 maxHtSnk;27.535004;13.99218;0.00915;0x2;0xe7;0x38(OK);03/15/2007 07:41:48 minVolt;27.351997;13.552979;1.79035;0x2;0xe7;0x38(OK);03/15/2007 07:28:48 maxVolt;27.047005;13.99218;0.00915;0x2;0xe7;0x38(OK);03/15/2007 06:42:49 minAmp;26.925003;13.98852;0.0061;0x2;0xe7;0x38(OK);03/15/2007 06:43:47 maxAmp;27.351997;13.552979;1.79035;0x2;0xe7;0x38(OK);03/15/2007 07:28:48 parentID=0, recordType=5 devid=1598, t=1173987725533, seqNo=1236, mdref=1044 nBytes=1086 name;tmprt;pressure;humidity;gfHi;gfLo;nTurns;time;note current;32.91;1010.29;26.08;0.5;0.0;0;03/15/2007 07:42:00;dev 1528 powerOn; nSample=101 minGfLo;32.89;1011.33;26.89;0.25;-0.71;0;03/15/2007 06:48:49;dev 1592 powerOn; maxGfLo;33.29;1008.54;26.55;0.5;0.28;0;03/15/2007 07:15:48;dev 1592 powerOn; minGfHi;31.28;1010.21;28.69;-0.38;0.0;0;03/15/2007 06:52:48;dev 1592 powerOn; maxGfHi;33.68;1010.99;26.21;28.4;-0.28;0;03/15/2007 06:47:48;dev 1592 powerOn; minTmprt;30.72;1009.76;29.45;15.01;0.0;0;03/15/2007 06:54:48;dev 1592 powerOn; maxTmprt;33.94;1010.95;25.37;0.13;0.14;0;03/15/2007 06:46:48;dev 1592 powerOn; minPress;32.07;1007.66;27.83;26.02;-0.28;0;03/15/2007 07:21:48;dev 1592 powerOn; maxPress;32.91;1010.29;26.08;0.5;0.0;0;03/15/2007 07:42:00;dev 1528 powerOn; minHumid;33.27;1010.62;25.33;0.0;0.14;0;03/15/2007 07:28:48;dev 1592 powerOn; maxHumid;30.72;1009.76;29.45;15.01;0.0;0;03/15/2007 06:54:48;dev 1592 powerOn; minTurns;33.33;1010.62;27.92;8.13;0.0;0;03/15/2007 06:42:50;dev 1592 powerOn; maxTurns;33.33;1010.62;27.92;8.13;0.0;0;03/15/2007 06:42:50;dev 1592 powerOn; parentID=0, recordType=6 devid=1598, t=1173987727831, seqNo=1237, mdref=1044 nBytes=257 Filesystem 1k-blocks Used Available Use% Mounted on /dev/root 14848 12252 2596 83% / tmpfs 31244 932 30312 3% /mnt/ramfs /dev/hda1 3932872 149096 3583992 4% /mnt/hda parentID=0, recordType=7 devid=1598, t=1173987729552, seqNo=1238, mdref=1044 nBytes=60 #jvmthreads: 31 jvmmem: total=2883584, free=528360 (bytes) parentID=0, recordType=8 devid=1598, t=1173987731711, seqNo=1239, mdref=1044 nBytes=22 RFIO status goes here parentID=0, recordType=9 devid=1598, t=1173987733344, seqNo=1240, mdref=1044 nBytes=25 Optical status goes here parentID=0, recordType=10 devid=1598, t=1173987734260, seqNo=1241, mdref=1044 nBytes=31 GlobalStar status not available parentID=0, recordType=11 devid=1598, t=1173987735107, seqNo=1242, mdref=1044 nBytes=47 03/15/2007 19:25:44; watchdog state: sleeping parentID=0, recordType=12 devid=1598, t=1173987737939, seqNo=1243, mdref=1044 nBytes=1679 Sleep log since 03/15/2007 06:42:07 start,predictedDurSec,actualDurSec sleep,03/15/2007 06:42:16,27,31 sleep,03/15/2007 06:43:18,22,60 sleep,03/15/2007 06:44:53,3,3 sleep,03/15/2007 06:45:26,5,1 sleep,03/15/2007 06:46:10,13,24 sleep,03/15/2007 06:47:12,31,90 sleep,03/15/2007 06:49:13,31,35 sleep,03/15/2007 06:50:18,13,16 sleep,03/15/2007 06:51:22,21,25 sleep,03/15/2007 06:53:09,31,35 sleep,03/15/2007 06:54:14,29,32 sleep,03/15/2007 06:55:17,14,29 sleep,03/15/2007 06:56:17,26,41 sleep,03/15/2007 06:57:29,13,16 sleep,03/15/2007 06:58:22,21,24 sleep,03/15/2007 06:59:17,26,56 sleep,03/15/2007 07:01:21,22,32 sleep,03/15/2007 07:02:23,20,23 sleep,03/15/2007 07:04:12,31,44 sleep,03/15/2007 07:05:26,5,2 sleep,03/15/2007 07:06:09,35,38 sleep,03/15/2007 07:07:17,26,41 sleep,03/15/2007 07:08:30,14,18 sleep,03/15/2007 07:09:37,7,10 sleep,03/15/2007 07:10:17,14,17 sleep,03/15/2007 07:11:22,22,48 sleep,03/15/2007 07:12:40,8,12 sleep,03/15/2007 07:13:23,17,20 sleep,03/15/2007 07:14:14,17,20 sleep,03/15/2007 07:15:13,18,30 sleep,03/15/2007 07:16:14,29,45 sleep,03/15/2007 07:17:30,13,16 sleep,03/15/2007 07:18:17,26,29 sleep,03/15/2007 07:19:18,26,40 sleep,03/15/2007 07:21:11,4,0 sleep,03/15/2007 07:22:14,5,5 sleep,03/15/2007 07:23:11,30,35 sleep,03/15/2007 07:24:16,27,37 sleep,03/15/2007 07:26:25,19,23 sleep,03/15/2007 07:27:18,25,32 sleep,03/15/2007 07:28:22,22,25 sleep,03/15/2007 07:29:17,26,29 sleep,03/15/2007 07:30:18,13,45 sleep,03/15/2007 07:32:12,6,2 sleep,03/15/2007 07:33:09,32,36 sleep,03/15/2007 07:34:15,28,54 sleep,03/15/2007 07:38:20,23,28 sleep,03/15/2007 07:39:19,24,28 sleep,03/15/2007 07:40:18,13,16 sleep,03/15/2007 07:41:09,6,38 139796 DEBUG PortalConnection [main-DBG-0]: new latest=1173987737939 139797 DEBUG PortalConnection [main-DBG-0]: put packet stats 139797 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 10 packets from device [J@325b9d Retrieve data from device 1555 Retrieving data from device #1555 139803 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1555 139988 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 9 packets from device #1555 146440 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1555 parentID=1598, recordType=1 devid=1555, t=1173984829635, seqNo=687, mdref=575 nBytes=719 ADC00 A+3.7642e+02 N0000597 L+3.7603e+02 H+3.7650e+02 E0 ADC01 A-4.2467e-02 N0002388 L-8.8269e-02 H-3.5521e-02 E0 ADC02 A-4.2810e-03 N0002388 L-4.3505e-03 H-4.1967e-03 E0 ADC03 A-3.6245e-02 N0002388 L-3.9105e-02 H-3.5531e-02 E0 ADC04 A-2.7889e-06 N0002388 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.8540e-06 N0002388 L-2.2200e-05 H+2.2200e-05 E0 ADC10 A+1.3974e+01 N0000597 L+1.3626e+01 H+1.3996e+01 E0 ADC11 A-8.0208e-01 N0002388 L-2.5142e+00 H-6.4504e-01 E0 ADC12 A+1.3732e+01 N0000597 L+1.3622e+01 H+1.3747e+01 E0 ADC13 A+1.1775e-01 N0000597 L+5.8092e-02 H+1.8510e+00 E0 ADC14 A+4.2621e+01 N0000597 L+4.2080e+01 H+4.2686e+01 E0 BP00 N0002389 A2389 B2389 C2389 D2389 E0000 F2389 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173985434022, seqNo=688, mdref=575 nBytes=719 ADC00 A+3.7642e+02 N0000600 L+3.7603e+02 H+3.7650e+02 E0 ADC01 A-4.2491e-02 N0002400 L-8.8335e-02 H-3.5499e-02 E0 ADC02 A-4.2806e-03 N0002400 L-4.3431e-03 H-4.2113e-03 E0 ADC03 A-3.6237e-02 N0002400 L-3.9105e-02 H-3.5786e-02 E0 ADC04 A-2.6409e-06 N0002400 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.8259e-06 N0002400 L-2.2200e-05 H+1.1100e-05 E0 ADC10 A+1.3974e+01 N0000600 L+1.3630e+01 H+1.3996e+01 E0 ADC11 A-8.0465e-01 N0002400 L-2.5358e+00 H-6.4504e-01 E0 ADC12 A+1.3732e+01 N0000600 L+1.3626e+01 H+1.3744e+01 E0 ADC13 A+1.1581e-01 N0000600 L+5.8092e-02 H+1.8578e+00 E0 ADC14 A+4.2660e+01 N0000600 L+4.2080e+01 H+4.2889e+01 E0 BP00 N0002399 A2399 B2399 C2399 D2399 E0000 F2399 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173986029563, seqNo=689, mdref=575 nBytes=719 ADC00 A+3.7641e+02 N0000600 L+3.7603e+02 H+3.7650e+02 E0 ADC01 A-4.4111e-02 N0002400 L-8.8767e-02 H-3.5573e-02 E0 ADC02 A-4.2805e-03 N0002400 L-4.3431e-03 H-4.1454e-03 E0 ADC03 A-3.5019e-02 N0002400 L-3.8806e-02 H-3.4488e-02 E0 ADC04 A-2.7056e-06 N0002400 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.9785e-06 N0002400 L-2.2200e-05 H+2.2200e-05 E0 ADC10 A+1.3962e+01 N0000600 L+1.3608e+01 H+1.3995e+01 E0 ADC11 A-8.3719e-01 N0002400 L-2.5820e+00 H-6.4641e-01 E0 ADC12 A+1.3730e+01 N0000600 L+1.3604e+01 H+1.3748e+01 E0 ADC13 A+1.5315e-01 N0000600 L+5.8656e-02 H+1.8426e+00 E0 ADC14 A+4.2688e+01 N0000600 L+4.2080e+01 H+4.2889e+01 E0 BP00 N0002400 A2400 B2400 C2400 D2400 E0000 F2400 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173986633240, seqNo=690, mdref=575 nBytes=719 ADC00 A+3.7643e+02 N0000603 L+3.7603e+02 H+3.7650e+02 E0 ADC01 A-4.2386e-02 N0002411 L-8.7646e-02 H-3.5543e-02 E0 ADC02 A-4.2806e-03 N0002411 L-4.3505e-03 H-4.1967e-03 E0 ADC03 A-3.4944e-02 N0002411 L-3.7673e-02 H-3.4499e-02 E0 ADC04 A-2.7669e-06 N0002411 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-3.1030e-06 N0002411 L-2.2200e-05 H+1.1100e-05 E0 ADC10 A+1.3973e+01 N0000603 L+1.3618e+01 H+1.3995e+01 E0 ADC11 A-8.0031e-01 N0002411 L-2.5399e+00 H-6.4596e-01 E0 ADC12 A+1.3732e+01 N0000603 L+1.3615e+01 H+1.3744e+01 E0 ADC13 A+1.2050e-01 N0000603 L+5.8092e-02 H+1.8127e+00 E0 ADC14 A+4.2741e+01 N0000603 L+4.2080e+01 H+4.2889e+01 E0 BP00 N0002411 A2411 B2411 C2411 D2411 E0000 F2411 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173987235090, seqNo=691, mdref=575 nBytes=719 ADC00 A+3.7642e+02 N0000598 L+3.7601e+02 H+3.7650e+02 E0 ADC01 A-4.4226e-02 N0002395 L-8.8005e-02 H-3.5529e-02 E0 ADC02 A-4.2801e-03 N0002395 L-4.3871e-03 H-4.1234e-03 E0 ADC03 A-3.4956e-02 N0002395 L-3.7951e-02 H-3.4454e-02 E0 ADC04 A-2.7947e-06 N0002395 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.7066e-06 N0002395 L-3.3300e-05 H+1.1100e-05 E0 ADC10 A+1.3965e+01 N0000598 L+1.3632e+01 H+1.3995e+01 E0 ADC11 A-8.4206e-01 N0002395 L-2.4740e+00 H-6.4550e-01 E0 ADC12 A+1.3731e+01 N0000598 L+1.3629e+01 H+1.3747e+01 E0 ADC13 A+1.4263e-01 N0000598 L+5.8092e-02 H+1.8584e+00 E0 ADC14 A+4.2772e+01 N0000598 L+4.2080e+01 H+4.2889e+01 E0 BP00 N0002395 A2395 B2395 C2395 D2395 E0000 F2395 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173987841317, seqNo=692, mdref=575 nBytes=719 ADC00 A+3.7643e+02 N0000611 L+3.7605e+02 H+3.7650e+02 E0 ADC01 A-4.2631e-02 N0002441 L-8.8628e-02 H-3.5587e-02 E0 ADC02 A-4.2805e-03 N0002441 L-4.3724e-03 H-4.2333e-03 E0 ADC03 A-3.4943e-02 N0002441 L-3.7685e-02 H-3.4488e-02 E0 ADC04 A-2.9512e-06 N0002441 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.8512e-06 N0002441 L-2.2200e-05 H+2.2200e-05 E0 ADC10 A+1.3973e+01 N0000611 L+1.3621e+01 H+1.3996e+01 E0 ADC11 A-8.0572e-01 N0002441 L-2.5422e+00 H-6.4687e-01 E0 ADC12 A+1.3732e+01 N0000611 L+1.3617e+01 H+1.3742e+01 E0 ADC13 A+1.1917e-01 N0000611 L+5.8092e-02 H+1.8635e+00 E0 ADC14 A+4.2876e+01 N0000611 L+4.2080e+01 H+4.3091e+01 E0 BP00 N0002441 A2441 B2441 C2441 D2441 E0000 F2441 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173988439431, seqNo=693, mdref=575 nBytes=719 ADC00 A+3.7643e+02 N0000597 L+3.7605e+02 H+3.7650e+02 E0 ADC01 A-4.3607e-02 N0002389 L-8.7829e-02 H-3.5536e-02 E0 ADC02 A-4.2801e-03 N0002389 L-4.4383e-03 H-4.0282e-03 E0 ADC03 A-3.4968e-02 N0002389 L-3.7685e-02 H-3.4432e-02 E0 ADC04 A-2.9132e-06 N0002389 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.6670e-06 N0002389 L-2.2200e-05 H+1.1100e-05 E0 ADC10 A+1.3967e+01 N0000597 L+1.3630e+01 H+1.3995e+01 E0 ADC11 A-8.3646e-01 N0002389 L-2.4822e+00 H-6.4596e-01 E0 ADC12 A+1.3731e+01 N0000597 L+1.3626e+01 H+1.3741e+01 E0 ADC13 A+1.2109e-01 N0000597 L+5.8092e-02 H+1.8482e+00 E0 ADC14 A+4.2901e+01 N0000597 L+4.2282e+01 H+4.3091e+01 E0 BP00 N0002389 A2389 B2389 C2389 D2389 E0000 F2389 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173989033185, seqNo=694, mdref=575 nBytes=719 ADC00 A+3.7643e+02 N0000592 L+3.7605e+02 H+3.7650e+02 E0 ADC01 A-4.3216e-02 N0002369 L-8.7361e-02 H-3.5507e-02 E0 ADC02 A-4.2800e-03 N0002369 L-4.3578e-03 H-3.9183e-03 E0 ADC03 A-3.5045e-02 N0002369 L-3.8695e-02 H-3.4132e-02 E0 ADC04 A-2.6801e-06 N0002369 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.7363e-06 N0002369 L-2.2200e-05 H+2.2200e-05 E0 ADC10 A+1.3971e+01 N0000592 L+1.3632e+01 H+1.3995e+01 E0 ADC11 A-8.1040e-01 N0002369 L-2.4891e+00 H-6.4504e-01 E0 ADC12 A+1.3732e+01 N0000592 L+1.3628e+01 H+1.3748e+01 E0 ADC13 A+1.4151e-01 N0000592 L+5.8092e-02 H+1.8245e+00 E0 ADC14 A+4.2974e+01 N0000592 L+4.2484e+01 H+4.3091e+01 E0 BP00 N0002370 A2370 B2370 C2370 D2370 E0000 F2370 G0000 H0000 DATA COUNT 00701 parentID=1598, recordType=1 devid=1555, t=1173989629560, seqNo=695, mdref=575 nBytes=719 ADC00 A+3.7644e+02 N0000599 L+3.7605e+02 H+3.7650e+02 E0 ADC01 A-4.2340e-02 N0002394 L-8.7734e-02 H-3.5595e-02 E0 ADC02 A-4.2802e-03 N0002394 L-4.3431e-03 H-3.7279e-03 E0 ADC03 A-3.5031e-02 N0002394 L-3.9028e-02 H-3.3622e-02 E0 ADC04 A-2.8005e-06 N0002394 L-2.2200e-05 H+1.1100e-05 E0 ADC05 A-2.6753e-06 N0002394 L-2.2200e-05 H+2.2200e-05 E0 ADC10 A+1.3975e+01 N0000599 L+1.3636e+01 H+1.3995e+01 E0 ADC11 A-7.9945e-01 N0002394 L-2.4355e+00 H-6.4733e-01 E0 ADC12 A+1.3733e+01 N0000599 L+1.3633e+01 H+1.3749e+01 E0 ADC13 A+1.1228e-01 N0000599 L+5.8656e-02 H+1.8432e+00 E0 ADC14 A+4.3022e+01 N0000599 L+4.2484e+01 H+4.3091e+01 E0 BP00 N0002393 A2393 B2393 C2393 D2393 E0000 F2393 G0000 H0000 DATA COUNT 00701 146476 DEBUG PortalConnection [main-DBG-0]: new latest=1173989629560 146477 DEBUG PortalConnection [main-DBG-0]: put packet stats 146477 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 9 packets from device [J@325b9d Retrieve data from device 1026 Retrieving data from device #1026 146480 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1026 146614 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 1 packets from device #1026 152268 INFO PortalConnection [main-DBG-0]: Retrieved 1 packets from device #1026 parentID=1598, recordType=1 devid=1026, t=1173986639093, seqNo=124, mdref=104 nBytes=1450 **p*d*#***"Fx********{*!}XDW ****y l**g*Yw*,ZvG =~***-*9Y ****R*********!ly7*Zyr*~=*B***5*******^**>k**qw******@*m****r***$4*******YX*****D*r*******D *F***Z`3*9*******K***/*****@***P*V4c3v***X E **** $bM*D#*L*j*n$**** *H2x\@)***z ******* ******3***S**9**SQ**7***T******i-;*{.***\***`G+*****=*,******* *Ef-**N**a****[*+**Q`**\R***VI*i****'*<******* *o****L* "*****k**#*`***O,***#/*q***m}**J5*;**sr*****P)*>*******)*?**YX*7*a*U>***aF~*.**]***#****8*******ec]*`*/H**2**nc**U*FzHH**;***,. *** =*%S**(.*$%;7**Br****n*l*5R***$**4**3****<*V@**gy*,*v**I**g! ***'*n**o**@oyX**F******d*2***/******w E*&**c**)lE***N**IB#A*0Z*Ln*K*****~#**H`T8x]**=o*-H}***Pz***aI***bz'{**a**0 ***]****]* ****x*H *>T%w9**@**)**A*>S******7r***1****zc*=*\ @*paW***ejU***C** ****>***bH*JU%*P5*$***%**%****6 t*7****tb******Y***)H*(Ap**Q93*`q*LL*q****f*e|*}****M)*P*e}******J=***/**Lj* *;<**w**4q****`**o*X*:D*Wn*O*&***b*JA*****g0**:******; **H***p*p*eF***2*=a******+*******]* **8g*t**+**m|r***R*** **a***m(******|3***]******W(i**Q***T**g*)**A**N/uf**D**%D**`*}**\***Vi******hXU@****;y**************#d***r**E***y***x\**K**+*Yp*****f*** D*M!**!C***F~6BQ|******a*******%f**E*B**{~*3Y9T*6*#*K***w*N****j**&$******9*H********_*<***e7**|E**:***** **)**x**eB"****j***GT***/*IF*y***-**********H****<4+*Xl9j*w***T***1*W] *o*r****x**** *****rf********H**/***3O**M**k*******W*****"***,**e** **h*****f*{.****T*G**p3epg**;E*mZ**K*******>G****!*hyk{.*;**;*c*g9|* ******9**C$; *&***5*4*****^j*\l 152272 DEBUG PortalConnection [main-DBG-0]: new latest=1173986639093 152273 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 1 packets from device [J@325b9d Retrieve data from device 1536 Retrieving data from device #1536 152273 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1536 152277 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data 152307 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets 152420 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Connected to node node18/134.89.36.18 (id=1522) 154167 DEBUG PortalConnection [_wakeupWorker-DBG-6]: host: node18/134.89.36.18 156479 DEBUG PortalConnection [_wakeupWorker-DBG-6]: Lease established for 3600 sec, node node418; id=172 156479 DEBUG PortalConnection [_wakeupWorker-DBG-6]: connectNode() done 156479 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: added to available: node418/134.89.36.18 156479 DEBUG PortalConnection [_wakeupWorker-DBG-6]: wakeup thread: exiting wakeup thread Retrieved 5 packets from device #1536 159671 INFO PortalConnection [main-DBG-0]: Retrieved 5 packets from device #1536 parentID=1598, recordType=1000 devid=1536, t=1173986699561, seqNo=1691, mdref=1407 Chlorophyll1299012990129900Integer32counts1173986699.560000000Chlorophyll concentration12 parentID=1598, recordType=1000 devid=1536, t=1173986700121, seqNo=1692, mdref=1407 NTU11148111481114810Integer32counts1173986700.120000000Nominal Transmission units #112 parentID=1598, recordType=1000 devid=1536, t=1173986700730, seqNo=1693, mdref=1407 NTU21280612806128060Integer32counts1173986700.729000000Nominal Transmission units #212 parentID=1598, recordType=0 devid=1536, t=1173987594008, seqNo=1695, mdref=1407 ERR: :readUntil() Timed out:readUntil() Timed out:readUntil() Timed out:retry limit exceeded (3):port OK (1x since 1173987499 s) parentID=1598, recordType=0 devid=1536, t=1173989692229, seqNo=1702, mdref=1407 ERR: :readUntil() Timed out:readUntil() Timed out:readUntil() Timed out:retry limit exceeded (3):port OK (1x since 1173989593 s) 159691 DEBUG PortalConnection [main-DBG-0]: new latest=1173989692229 159691 DEBUG PortalConnection [main-DBG-0]: put packet stats 159692 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 5 packets from device [J@325b9d Retrieve data from device 1553 Retrieving data from device #1553 159694 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1553 159787 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 3 packets from device #1553 163868 INFO PortalConnection [main-DBG-0]: Retrieved 3 packets from device #1553 parentID=1598, recordType=0 devid=1553, t=1173985547281, seqNo=286, mdref=241 tried startStreaming(): Instrument didn't acknowledge SR command (5x since 1173984347 s) parentID=1598, recordType=0 devid=1553, t=1173987047271, seqNo=287, mdref=241 tried startStreaming(): Instrument didn't acknowledge SR command (5x since 1173985847 s) parentID=1598, recordType=0 devid=1553, t=1173988547281, seqNo=288, mdref=241 tried startStreaming(): Instrument didn't acknowledge SR command (5x since 1173987347 s) 163876 DEBUG PortalConnection [main-DBG-0]: new latest=1173988547281 163876 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 3 packets from device [J@325b9d Retrieve data from device 1524 Retrieving data from device #1524 163877 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1524 163879 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data 163929 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 2 packets from device #1524 168410 INFO PortalConnection [main-DBG-0]: Retrieved 2 packets from device #1524 parentID=1598, recordType=1000 devid=1524, t=1173986457820, seqNo=1470, mdref=1223 Oxygen259.89258.74259.28420.3407Float32mL/L1173986457.819000000Oxygen Concentration12 parentID=1598, recordType=0 devid=1524, t=1173987357520, seqNo=1472, mdref=1223 ERR: :readUntil() Timed out:readUntil() Timed out:readUntil() Timed out:retry limit exceeded (3):port OK (1x since 1173987083 s) 168421 DEBUG PortalConnection [main-DBG-0]: new latest=1173987357520 168421 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 2 packets from device [J@325b9d Retrieve data from device 1592 Retrieving data from device #1592 168422 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1592 168423 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data 168452 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 9 packets from device #1592 177316 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1592 parentID=1598, recordType=0 devid=1592, t=1173985269120, seqNo=6889, mdref=5729 ERR: :Timed out:retry limit exceeded (1):port OK (1x since 1173985221 s) parentID=1598, recordType=1000 devid=1592, t=1173985809232, seqNo=6900, mdref=5729 velocity-1-32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 Integer32mm/s1173985809.231000000Velocity for beam 160 parentID=1598, recordType=1000 devid=1592, t=1173985810351, seqNo=6901, mdref=5729 velocity-2-32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 Integer32mm/s1173985810.350000000Velocity for beam 260 parentID=1598, recordType=1000 devid=1592, t=1173985811483, seqNo=6902, mdref=5729 velocity-3-32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 Integer32mm/s1173985811.482000000Velocity for beam 360 parentID=1598, recordType=1000 devid=1592, t=1173985812387, seqNo=6903, mdref=5729 velocity-4-32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 -32768 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 Integer32mm/s1173985812.386000000Velocity for beam 460 parentID=1598, recordType=0 devid=1592, t=1173985988325, seqNo=6905, mdref=5729 ERR: :Timed out:retry limit exceeded (1):port OK (1x since 1173985937 s) parentID=1598, recordType=0 devid=1592, t=1173988629650, seqNo=6945, mdref=5729 ERR: :enterCommandMode() - Maximum retries attempted:retry limit exceeded (1):port OK (1x since 1173988569 s) parentID=1598, recordType=0 devid=1592, t=1173989168543, seqNo=6954, mdref=5729 ERR: :Timed out:retry limit exceeded (1):port OK (1x since 1173989115 s) parentID=1598, recordType=0 devid=1592, t=1173989588621, seqNo=6958, mdref=5729 ERR: :enterCommandMode() - Maximum retries attempted:retry limit exceeded (1):port OK (1x since 1173989542 s) ERR: :Timed out:retry limit exceeded (1):port OK (1x since 1173989354 s) 177349 DEBUG PortalConnection [main-DBG-0]: new latest=1173989588621 177349 DEBUG PortalConnection [main-DBG-0]: put packet stats 177350 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 9 packets from device [J@325b9d Retrieve data from device 1599 Retrieving data from device #1599 177352 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1599 177489 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 9 packets from device #1599 181436 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1599 parentID=1598, recordType=1 devid=1599, t=1173984679986, seqNo=674, mdref=564 nBytes=76 $PEDATA, P1010.29, T31.47, H28.59, GFL-0.57, GFH1.13, C284.06, TC0.00, *3759 parentID=1598, recordType=1 devid=1599, t=1173985280210, seqNo=675, mdref=564 nBytes=77 $PEDATA, P1011.56, T32.00, H27.20, GFL-0.14, GFH10.01, C285.51, TC0.00, *3776 parentID=1598, recordType=1 devid=1599, t=1173985879932, seqNo=676, mdref=564 nBytes=76 $PEDATA, P1010.71, T32.12, H28.27, GFL-0.28, GFH0.00, C285.19, TC0.00, *3742 parentID=1598, recordType=1 devid=1599, t=1173986479906, seqNo=677, mdref=564 nBytes=75 $PEDATA, P1010.47, T31.77, H28.21, GFL0.00, GFH1.13, C283.25, TC0.00, *3694 parentID=1598, recordType=1 devid=1599, t=1173987080647, seqNo=678, mdref=564 nBytes=76 $PEDATA, P1010.85, T32.26, H26.55, GFL-0.42, GFH0.38, C284.70, TC0.00, *3754 parentID=1598, recordType=1 devid=1599, t=1173987679967, seqNo=679, mdref=564 nBytes=76 $PEDATA, P1010.14, T32.85, H26.00, GFL0.00, GFH14.76, C284.06, TC0.00, *3744 parentID=1598, recordType=1 devid=1599, t=1173988279895, seqNo=680, mdref=564 nBytes=76 $PEDATA, P1010.29, T32.87, H25.45, GFL-0.14, GFH0.13, C285.35, TC0.00, *3751 parentID=1598, recordType=1 devid=1599, t=1173988879946, seqNo=681, mdref=564 nBytes=76 $PEDATA, P1010.68, T33.32, H24.89, GFL-0.42, GFH5.75, C283.74, TC0.00, *3767 parentID=1598, recordType=1 devid=1599, t=1173989479916, seqNo=682, mdref=564 nBytes=76 $PEDATA, P1010.86, T33.52, H24.30, GFL-0.14, GFH3.13, C284.54, TC0.00, *3743 181480 DEBUG PortalConnection [main-DBG-0]: new latest=1173989479916 181480 DEBUG PortalConnection [main-DBG-0]: put packet stats 181481 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 9 packets from device [J@325b9d Retrieve data from device 1528 Retrieving data from device #1528 181483 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1528 181601 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 11 packets from device #1528 186892 INFO PortalConnection [main-DBG-0]: Retrieved 11 packets from device #1528 parentID=1598, recordType=1 devid=1528, t=1173984422139, seqNo=1339, mdref=1121 nBytes=278 -> channel=0, tvcc=3.2088, txBiasI=4.3853, txPower=-2.4503, rxPower=-42.2401, status=0x2 channel=1, temp=58.42, vcc=3.2122, txBiasI=3.0839, txPower=-1.9133, rxPower=-20.5673, status=0x0 channel=3, temp=57.73.2338, txBiasI=3.1390, txPower=-2.5851, rxPower=-5.8379, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173984723648, seqNo=1340, mdref=1121 nBytes=211 -> channel=0, temp=58.23, vcc=3.2110, txBiasI=4.4085, txPower=-2.4503, rxPower=-39.6077, status=0x2 channel=1, tchannel=3, temp=56.70, vcc=3.2344, txBiasI=3.0955, txPower=-2.5879, rxPower=-5.7619, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173985021823, seqNo=1341, mdref=1121 nBytes=297 -> channel=0, temp=57.74, vcc=3.2128, txBiasI=4.2839, txPower=-2.4503, rxPower=-99.9999, status=0x2 channel=1, temp=57.24, vcc=3.2104, txBiasI=3.0926, txPower=-1.9600, rxPower=-20.6529, status=0x0 channel=3, temp=56.23, vcc=3.2354, txBiasI=3.0608, txPower=-2.5948, rxPower=-5.8142, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173985321360, seqNo=1342, mdref=1121 nBytes=297 -> channel=0, temp=57.77, vcc=3.2108, txBiasI=4.2781, txPower=-2.4207, rxPower=-99.9999, status=0x2 channel=1, temp=57.38, vcc=3.2088, txBiasI=3.1100, txPower=-1.9639, rxPower=-20.6964, status=0x0 channel=3, temp=56.70, vcc=3.2330, txBiasI=3.1506, txPower=-2.5810, rxPower=-5.8194, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173985621890, seqNo=1343, mdref=1121 nBytes=297 -> channel=0, temp=58.16, vcc=3.2086, txBiasI=4.3361, txPower=-2.4424, rxPower=-40.9908, status=0x2 channel=1, temp=57.78, vcc=3.2104, txBiasI=3.0492, txPower=-1.9541, rxPower=-20.5928, status=0x0 channel=3, temp=56.99, vcc=3.2356, txBiasI=3.0810, txPower=-2.5962, rxPower=-5.8353, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173985935197, seqNo=1344, mdref=1121 nBytes=297 -> channel=0, temp=57.90, vcc=3.2088, txBiasI=4.2897, txPower=-2.4722, rxPower=-40.4792, status=0x2 channel=1, temp=57.53, vcc=3.2122, txBiasI=3.0173, txPower=-1.9560, rxPower=-20.6185, status=0x0 channel=3, temp=56.79, vcc=3.2340, txBiasI=3.0839, txPower=-2.5865, rxPower=-5.8274, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173986222885, seqNo=1345, mdref=1121 nBytes=297 -> channel=0, temp=58.56, vcc=3.2108, txBiasI=4.3593, txPower=-2.4464, rxPower=-41.5707, status=0x2 channel=1, temp=57.96, vcc=3.2138, txBiasI=3.1042, txPower=-1.9580, rxPower=-20.6400, status=0x0 channel=3, temp=57.34, vcc=3.2348, txBiasI=3.1941, txPower=-2.5921, rxPower=-5.9261, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173986521333, seqNo=1346, mdref=1121 nBytes=297 -> channel=0, temp=58.20, vcc=3.2102, txBiasI=4.3216, txPower=-2.4424, rxPower=-40.4792, status=0x2 channel=1, temp=57.63, vcc=3.2146, txBiasI=3.0665, txPower=-1.9580, rxPower=-20.5168, status=0x0 channel=3, temp=56.60, vcc=3.2350, txBiasI=3.1100, txPower=-2.5934, rxPower=-5.8142, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173986821605, seqNo=1347, mdref=1121 nBytes=218 -> channel=0, temp=58.20, vcc=3.2138, txBiasI=4.3361, txPower=-2.4523, rxPower=-38.2607=0x2 channel=1, temp=57.34, vcc=3.2134, txBiasI=3.0752, txPower=-1.9191, rxPower=-20.5589, status=0x0 channel=3, t6, txBiasI=3 parentID=1598, recordType=1 devid=1528, t=1173987121547, seqNo=1348, mdref=1121 nBytes=297 -> channel=0, temp=58.20, vcc=3.2122, txBiasI=4.3853, txPower=-2.4365, rxPower=-45.2505, status=0x2 channel=1, temp=57.74, vcc=3.2108, txBiasI=3.0984, txPower=-1.9307, rxPower=-20.5971, status=0x0 channel=3, temp=56.91, vcc=3.2350, txBiasI=3.0868, txPower=-2.5837, rxPower=-5.8538, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173987421351, seqNo=1349, mdref=1121 nBytes=297 -> channel=0, temp=58.36, vcc=3.2088, txBiasI=4.4143, txPower=-2.4365, rxPower=-99.9999, status=0x2 channel=1, temp=57.63, vcc=3.2134, txBiasI=3.0608, txPower=-1.9404, rxPower=-20.5928, status=0x0 channel=3, temp=56.86, vcc=3.2346, txBiasI=3.0752, txPower=-2.5948, rxPower=-5.8459, status=0x0 186933 DEBUG PortalConnection [main-DBG-0]: new latest=1173987421351 186933 DEBUG PortalConnection [main-DBG-0]: put packet stats 186934 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieve data from device 1528 Retrieving data from device #1528 186937 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1528 187103 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets Retrieved 8 packets from device #1528 204641 INFO PortalConnection [main-DBG-0]: Retrieved 8 packets from device #1528 parentID=1598, recordType=1 devid=1528, t=1173987721752, seqNo=1350, mdref=1121 nBytes=247 -> channel=0, tasI=4.4027, 4523, rxPower=-45.2505, status=0x2 channel=1, temp=57.92, vcc=3.2112, txBiasI=3.0839, txPower=-1.9502, rxPower=-20.6357 channel=3, temp=57.21, vcc=3.2358, txBiasI=3.0839, txPower=-2.5851, rxPower=-5.9207, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173988021660, seqNo=1351, mdref=1121 nBytes=297 -> channel=0, temp=58.63, vcc=3.2112, txBiasI=4.3737, txPower=-2.4583, rxPower=-50.0217, status=0x2 channel=1, temp=58.08, vcc=3.2118, txBiasI=3.0926, txPower=-1.9619, rxPower=-20.5971, status=0x0 channel=3, temp=57.37, vcc=3.2342, txBiasI=3.1709, txPower=-2.5962, rxPower=-5.9776, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173988321385, seqNo=1352, mdref=1121 nBytes=297 -> channel=0, temp=58.52, vcc=3.2092, txBiasI=4.3998, txPower=-2.4484, rxPower=-45.2505, status=0x2 channel=1, temp=58.21, vcc=3.2102, txBiasI=3.0752, txPower=-1.9346, rxPower=-20.5335, status=0x0 channel=3, temp=57.20, vcc=3.2338, txBiasI=3.1303, txPower=-2.5962, rxPower=-5.9207, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173988621601, seqNo=1353, mdref=1121 nBytes=297 -> channel=0, temp=58.80, vcc=3.2114, txBiasI=4.4085, txPower=-2.4484, rxPower=-99.9999, status=0x2 channel=1, temp=58.35, vcc=3.2120, txBiasI=3.0579, txPower=-1.9619, rxPower=-20.5673, status=0x0 channel=3, temp=57.87, vcc=3.2342, txBiasI=3.0897, txPower=-2.5907, rxPower=-6.0659, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173988921358, seqNo=1354, mdref=1121 nBytes=297 -> channel=0, temp=58.95, vcc=3.2086, txBiasI=4.4723, txPower=-2.4523, rxPower=-99.9999, status=0x2 channel=1, temp=58.71, vcc=3.2100, txBiasI=3.1129, txPower=-1.9385, rxPower=-20.5504, status=0x0 channel=3, temp=57.65, vcc=3.2344, txBiasI=3.0897, txPower=-2.6018, rxPower=-5.9995, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173989221643, seqNo=1355, mdref=1121 nBytes=297 -> channel=0, temp=58.97, vcc=3.2116, txBiasI=4.4549, txPower=-2.4385, rxPower=-99.9999, status=0x2 channel=1, temp=58.67, vcc=3.2118, txBiasI=3.1042, txPower=-1.9541, rxPower=-20.6314, status=0x0 channel=3, temp=57.84, vcc=3.2334, txBiasI=3.0926, txPower=-2.5948, rxPower=-5.9640, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173989525193, seqNo=1356, mdref=1121 nBytes=297 -> channel=0, temp=59.38, vcc=3.2108, txBiasI=4.5129, txPower=-2.4227, rxPower=-44.0011, status=0x2 channel=1, temp=58.89, vcc=3.2134, txBiasI=3.0897, txPower=-1.9502, rxPower=-20.5801, status=0x0 channel=3, temp=58.20, vcc=3.2360, txBiasI=3.1912, txPower=-2.5768, rxPower=-6.0188, status=0x0 parentID=1598, recordType=1 devid=1528, t=1173989821369, seqNo=1357, mdref=1121 nBytes=297 -> channel=0, temp=59.18, vcc=3.2100, txBiasI=4.5100, txPower=-2.4464, rxPower=-41.5707, status=0x2 channel=1, temp=58.83, vcc=3.2110, txBiasI=3.1245, txPower=-1.9658, rxPower=-20.5758, status=0x0 channel=3, temp=57.88, vcc=3.2338, txBiasI=3.1390, txPower=-2.5741, rxPower=-5.9099, status=0x0 204672 DEBUG PortalConnection [main-DBG-0]: new latest=1173989821369 204673 DEBUG PortalConnection [main-DBG-0]: put packet stats 204676 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: saving data Retrieved total of 19 packets from device [J@325b9d 204678 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After retrieveAndDistributeData: 27 204678 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before subnode processing: 27 204679 DEBUG PortalConnection [main-DBG-0]: node402/134.89.36.2 disconnectNode() - Mar 15, 2007 2:22:12 PM 204680 DEBUG PortalConnection [main-DBG-0]: _nodeLinkConnected set FALSE 204680 DEBUG PortalConnection [main-DBG-0]: node402/134.89.36.2 disconnectNode(): normal connection termination 204681 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): Trying to terminate all leases with description containing "portal@siam-portal-3.shore.mbari.org" 204793 DEBUG PortalConnection [_distributeWorker-node402/134.89.36.2-DBG-7]: publishing packets 206874 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 184 209579 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After disconnectNode (startSession end): 27 209580 INFO PortalConnection [main-DBG-0]: startSession() [node402] - done: Mar 15, 2007 2:22:17 PM 209580 DEBUG PortalConnection [main-DBG-0]: main thread: calling process node: node413/134.89.36.13 209581 DEBUG Portal [main-DBG-0]: Found existing connection to node413 ThreadUtility.printThreads() 209581 INFO ThreadUtility [main-DBG-0]: ThreadGroup "main" includes about 27 threads 209591 INFO ThreadUtility [main-DBG-0]: thread: "main-DBG-0" alive thread: "_distributeWorker-mse/10.1.36.2-DBG-1" alive thread: "_distributeWorker-node402/134.89.36.2-DBG-7" alive thread: "_distributeWorker-node413/134.89.36.13-DBG-8" alive thread: "_distributeWorker-node403/134.89.36.3-DBG-15" alive thread: "_distributeWorker-node418/134.89.36.18-DBG-16" alive thread: "UIL2.SocketManager.ReadTask#1-DBG-2" alive daemon thread: "UIL2.SocketManager.WriteTask#2-DBG-3" alive daemon thread: "Connection Monitor Thread-DBG-4" alive daemon thread: "Thread-2-DBG-5" alive daemon thread: "UIL2.SocketManager.ReadTask#3-DBG-9" alive daemon thread: "UIL2.SocketManager.WriteTask#4-DBG-10" alive daemon thread: "Thread-8-DBG-11" alive daemon thread: "UIL2.SocketManager.ReadTask#5-DBG-12" alive daemon thread: "UIL2.SocketManager.WriteTask#6-DBG-13" alive daemon thread: "Thread-12-DBG-14" alive daemon thread: "UIL2.SocketManager.ReadTask#7-DBG-17" alive daemon thread: "UIL2.SocketManager.WriteTask#8-DBG-18" alive daemon thread: "Thread-16-DBG-19" alive daemon thread: "UIL2.SocketManager.ReadTask#9-DBG-20" alive daemon thread: "UIL2.SocketManager.WriteTask#10-DBG-21" alive daemon thread: "Thread-20-DBG-22" alive daemon 209592 INFO PortalConnection [main-DBG-0]: startSession()[node413]: Mar 15, 2007 2:22:17 PM 209592 DEBUG PortalConnection [main-DBG-0]: startSession()[node413] - get node proxy 209593 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.totalMemory: 2031616 209593 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.freeMemory: 1008864 209593 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - startSession: 27 209594 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.13, port=1024 209594 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.13,1024)... 234158 ERROR PortalConnection [main-DBG-0]: startSession(): Caught IOException: java.rmi.ConnectIOException: Exception creating connection to: 134.89.36.13; nested exception is: java.net.NoRouteToHostException: No route to host java.net.NoRouteToHostException: No route to host at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:350) at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:137) at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:124) at java.net.Socket.(Socket.java:268) at java.net.Socket.(Socket.java:95) at moos.operations.portal.PortalSocketFactory.createSocket(PortalSocketFactory.java:67) at sun.rmi.transport.tcp.TCPEndpoint.newSocket(TCPEndpoint.java:494) at sun.rmi.transport.tcp.TCPChannel.createConnection(TCPChannel.java:185) at sun.rmi.transport.tcp.TCPChannel.newConnection(TCPChannel.java:169) at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:78) at moos.deployed.NodeService_Stub.startSession(Unknown Source) at moos.operations.portal.PortalConnection.startSession(PortalConnection.java:380) at moos.operations.portal.PortalConnection.startSession(PortalConnection.java:574) at moos.operations.portal.Portal.(Portal.java:269) at moos.operations.portal.Portal.main(Portal.java:810) 234168 DEBUG PortalConnection [main-DBG-0]: node413/134.89.36.13 disconnectNode() - Mar 15, 2007 2:22:42 PM 234168 DEBUG PortalConnection [main-DBG-0]: _nodeLinkConnected set FALSE 234169 DEBUG PortalConnection [main-DBG-0]: node413 disconnectNode(): abrupt connection termination 234169 ERROR PortalConnection [main-DBG-0]: startSession() - node413 - throw IOException: java.rmi.ConnectIOException: Exception creating connection to: 134.89.36.13; nested exception is: java.net.NoRouteToHostException: No route to host 234169 ERROR PortalConnection [main-DBG-0]: startSession(): got exception from startSession() on subnode node413/134.89.36.13 234170 DEBUG PortalConnection [main-DBG-0]: main thread: calling process node: node403/134.89.36.3 234170 DEBUG Portal [main-DBG-0]: Found existing connection to node403 ThreadUtility.printThreads() 234170 INFO ThreadUtility [main-DBG-0]: ThreadGroup "main" includes about 27 threads 234177 INFO ThreadUtility [main-DBG-0]: thread: "main-DBG-0" alive thread: "_distributeWorker-mse/10.1.36.2-DBG-1" alive thread: "_distributeWorker-node402/134.89.36.2-DBG-7" alive thread: "_distributeWorker-node413/134.89.36.13-DBG-8" alive thread: "_distributeWorker-node403/134.89.36.3-DBG-15" alive thread: "_distributeWorker-node418/134.89.36.18-DBG-16" alive thread: "UIL2.SocketManager.ReadTask#1-DBG-2" alive daemon thread: "UIL2.SocketManager.WriteTask#2-DBG-3" alive daemon thread: "Connection Monitor Thread-DBG-4" alive daemon thread: "Thread-2-DBG-5" alive daemon thread: "UIL2.SocketManager.ReadTask#3-DBG-9" alive daemon thread: "UIL2.SocketManager.WriteTask#4-DBG-10" alive daemon thread: "Thread-8-DBG-11" alive daemon thread: "UIL2.SocketManager.ReadTask#5-DBG-12" alive daemon thread: "UIL2.SocketManager.WriteTask#6-DBG-13" alive daemon thread: "Thread-12-DBG-14" alive daemon thread: "UIL2.SocketManager.ReadTask#7-DBG-17" alive daemon thread: "UIL2.SocketManager.WriteTask#8-DBG-18" alive daemon thread: "Thread-16-DBG-19" alive daemon thread: "UIL2.SocketManager.ReadTask#9-DBG-20" alive daemon thread: "UIL2.SocketManager.WriteTask#10-DBG-21" alive daemon thread: "Thread-20-DBG-22" alive daemon 234178 INFO PortalConnection [main-DBG-0]: startSession()[node403]: Mar 15, 2007 2:22:42 PM 234178 DEBUG PortalConnection [main-DBG-0]: startSession()[node403] - get node proxy 234179 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.totalMemory: 2031616 234179 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.freeMemory: 1101992 234179 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - startSession: 27 234180 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.3, port=1024 234180 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.3,1024)... 239210 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.2:1025]]: PortalSocketFactory.createSocket() - host=134.89.36.2, port=1025 239210 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.2:1025]]: return new Socket(134.89.36.2,1025)... 239211 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.13:1024]]: PortalSocketFactory.createSocket() - host=134.89.36.13, port=1024 239211 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.13:1024]]: return new Socket(134.89.36.13,1024)... 258824 ERROR PortalConnection [main-DBG-0]: startSession(): Caught IOException: java.rmi.ConnectIOException: Exception creating connection to: 134.89.36.3; nested exception is: java.net.NoRouteToHostException: No route to host java.net.NoRouteToHostException: No route to host at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:350) at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:137) at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:124) at java.net.Socket.(Socket.java:268) at java.net.Socket.(Socket.java:95) at moos.operations.portal.PortalSocketFactory.createSocket(PortalSocketFactory.java:67) at sun.rmi.transport.tcp.TCPEndpoint.newSocket(TCPEndpoint.java:494) at sun.rmi.transport.tcp.TCPChannel.createConnection(TCPChannel.java:185) at sun.rmi.transport.tcp.TCPChannel.newConnection(TCPChannel.java:169) at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:78) at moos.deployed.NodeService_Stub.startSession(Unknown Source) at moos.operations.portal.PortalConnection.startSession(PortalConnection.java:380) at moos.operations.portal.PortalConnection.startSession(PortalConnection.java:574) at moos.operations.portal.Portal.(Portal.java:269) at moos.operations.portal.Portal.main(Portal.java:810) 258827 DEBUG PortalConnection [main-DBG-0]: node403/134.89.36.3 disconnectNode() - Mar 15, 2007 2:23:06 PM 258827 DEBUG PortalConnection [main-DBG-0]: _nodeLinkConnected set FALSE 258827 DEBUG PortalConnection [main-DBG-0]: node403 disconnectNode(): abrupt connection termination 258827 ERROR PortalConnection [main-DBG-0]: startSession() - node403 - throw IOException: java.rmi.ConnectIOException: Exception creating connection to: 134.89.36.3; nested exception is: java.net.NoRouteToHostException: No route to host 258828 ERROR PortalConnection [main-DBG-0]: startSession(): got exception from startSession() on subnode node403/134.89.36.3 258828 DEBUG PortalConnection [main-DBG-0]: main thread: calling process node: node418/134.89.36.18 258828 DEBUG Portal [main-DBG-0]: Found existing connection to node418 ThreadUtility.printThreads() 258828 INFO ThreadUtility [main-DBG-0]: ThreadGroup "main" includes about 27 threads 258831 INFO ThreadUtility [main-DBG-0]: thread: "main-DBG-0" alive thread: "_distributeWorker-mse/10.1.36.2-DBG-1" alive thread: "_distributeWorker-node402/134.89.36.2-DBG-7" alive thread: "_distributeWorker-node413/134.89.36.13-DBG-8" alive thread: "_distributeWorker-node403/134.89.36.3-DBG-15" alive thread: "_distributeWorker-node418/134.89.36.18-DBG-16" alive thread: "UIL2.SocketManager.ReadTask#1-DBG-2" alive daemon thread: "UIL2.SocketManager.WriteTask#2-DBG-3" alive daemon thread: "Connection Monitor Thread-DBG-4" alive daemon thread: "Thread-2-DBG-5" alive daemon thread: "UIL2.SocketManager.ReadTask#3-DBG-9" alive daemon thread: "UIL2.SocketManager.WriteTask#4-DBG-10" alive daemon thread: "Thread-8-DBG-11" alive daemon thread: "UIL2.SocketManager.ReadTask#5-DBG-12" alive daemon thread: "UIL2.SocketManager.WriteTask#6-DBG-13" alive daemon thread: "Thread-12-DBG-14" alive daemon thread: "UIL2.SocketManager.ReadTask#7-DBG-17" alive daemon thread: "UIL2.SocketManager.WriteTask#8-DBG-18" alive daemon thread: "Thread-16-DBG-19" alive daemon thread: "UIL2.SocketManager.ReadTask#9-DBG-20" alive daemon thread: "UIL2.SocketManager.WriteTask#10-DBG-21" alive daemon thread: "Thread-20-DBG-22" alive daemon 258832 INFO PortalConnection [main-DBG-0]: startSession()[node418]: Mar 15, 2007 2:23:06 PM 258832 DEBUG PortalConnection [main-DBG-0]: startSession()[node418] - get node proxy 258832 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.totalMemory: 2031616 258833 DEBUG PortalConnection [main-DBG-0]: portal JVM Runtime.freeMemory: 1049736 258833 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - startSession: 27 258833 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.18, port=1025 258834 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.18,1025)... 259685 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(134.89.36.18,1025) 269263 INFO PortalConnection [main-DBG-0]: WDT status: watchdog state: sleeping 269264 INFO PortalConnection [main-DBG-0]: node418 Command Response: "15 Mar 20:21:44 ntpdate[23449]: no server suitable for synchronization found " NO SERVICE /dev/ttySX1, DummySeabirdSummarizer, ID=1028 /dev/ttySX2, DummyWETLabsSummarizer, ID=1029 /dev/ttySX3, DummyAquadoppSummarizer, ID=1030 /dev/ttySX4, DummyAanderaaSummerizer, ID=1031 /dev/ttySX5, McLane Profiler s/n 001, ID=1510 NO SERVICE /dev/ttySX7, DummyWorkhorseSummarizer, ID=1032 NO SERVICE NO SERVICE NO SERVICE NO SERVICE /dev/ttySX15, MSP430 (sidearm4.18), ID=1413 /dev/ttySA2, Medusa card s/n 2.015, ID=1486 New node ID: 1522 New device ID: 1028 New device ID: 1029 New device ID: 1030 New device ID: 1031 New device ID: 1510 New device ID: 1032 New device ID: 1413 New device ID: 1486 creating device log 1032 in /home/ops/siam/logs/1522 269299 DEBUG PortalConnection [main-DBG-0]: recording log entry 269299 DEBUG PortalConnection [main-DBG-0]: initializing device log 1032 mostRecent:1173983078853 startRetrieveTime:1173682800000 maxTimestamp:1173983078853 creating device log 1031 in /home/ops/siam/logs/1522 269304 DEBUG PortalConnection [main-DBG-0]: recording log entry 269305 DEBUG PortalConnection [main-DBG-0]: initializing device log 1031 mostRecent:1173983054444 startRetrieveTime:1173682800000 maxTimestamp:1173983054444 creating device log 1030 in /home/ops/siam/logs/1522 269310 DEBUG PortalConnection [main-DBG-0]: recording log entry 269310 DEBUG PortalConnection [main-DBG-0]: initializing device log 1030 mostRecent:1173983037812 startRetrieveTime:1173682800000 maxTimestamp:1173983037812 creating device log 1029 in /home/ops/siam/logs/1522 269320 DEBUG PortalConnection [main-DBG-0]: recording log entry 269322 DEBUG PortalConnection [main-DBG-0]: initializing device log 1029 mostRecent:1173983024813 startRetrieveTime:1173682800000 maxTimestamp:1173983024813 creating device log 1028 in /home/ops/siam/logs/1522 269328 DEBUG PortalConnection [main-DBG-0]: recording log entry 269328 DEBUG PortalConnection [main-DBG-0]: initializing device log 1028 mostRecent:1173983010533 startRetrieveTime:1173682800000 maxTimestamp:1173983010533 creating device log 1510 in /home/ops/siam/logs/1522 269335 DEBUG PortalConnection [main-DBG-0]: recording log entry 269336 DEBUG PortalConnection [main-DBG-0]: initializing device log 1510 mostRecent:1173983254710 startRetrieveTime:1173682800000 maxTimestamp:1173983254710 creating device log 1486 in /home/ops/siam/logs/1522 269341 DEBUG PortalConnection [main-DBG-0]: recording log entry 269341 DEBUG PortalConnection [main-DBG-0]: initializing device log 1486 mostRecent:1173984636020 startRetrieveTime:1173682800000 maxTimestamp:1173984636020 creating device log 1413 in /home/ops/siam/logs/1522 269346 DEBUG PortalConnection [main-DBG-0]: recording log entry 269347 DEBUG PortalConnection [main-DBG-0]: initializing device log 1413 mostRecent:1173984295817 startRetrieveTime:1173682800000 maxTimestamp:1173984295817 creating device log 1522 in /home/ops/siam/logs/1522 269351 DEBUG PortalConnection [main-DBG-0]: recording log entry 269352 DEBUG PortalConnection [main-DBG-0]: initializing device log 1522 mostRecent:1173983139852 startRetrieveTime:1173682800000 maxTimestamp:1173983139852 269352 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before retrieveAndDistributeData: 27 Retrieve data from device 1522 Retrieving data from device #1522 269354 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1522 Retrieved 10 packets from device #1522 275273 INFO PortalConnection [main-DBG-0]: Retrieved 10 packets from device #1522 parentID=0, recordType=1 devid=1522, t=1173986735424, seqNo=1552, mdref=1356 nBytes=536 Node started at: 03/15/2007 00:23:08 port=/dev/ttySX1,id=1028,samples=20,err=0,retries=0,status=0, port=/dev/ttySX2,id=1029,samples=20,err=0,retries=0,status=0, port=/dev/ttySX3,id=1030,samples=20,err=0,retries=0,status=0, port=/dev/ttySX4,id=1031,samples=20,err=0,retries=0,status=0, port=/dev/ttySX5,id=1510,samples=1,err=3,retries=3,status=1, port=/dev/ttySX7,id=1032,samples=20,err=0,retries=0,status=0, port=/dev/ttySX15,id=1413,samples=372,err=0,retries=0,status=0, port=/dev/ttySA2,id=1486,samples=228,err=0,retries=1,status=5, parentID=0, recordType=2 devid=1522, t=1173986736500, seqNo=1553, mdref=1356 nBytes=956 /dev/ttySX1 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX2 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX3 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX4 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time no new samples /dev/ttySX5 DPA_FORMAT:name;htSnk;volts;amps;relayReg;cntrlReg;interruptReg;time latest;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 minHtSnk;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 maxHtSnk;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 minVolt;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 maxVolt;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 minAmp;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 maxAmp;28.084;13.92264;0.0366;0x6;0xef;0x38(OK);03/15/2007 07:02:47 parentID=0, recordType=5 devid=1522, t=1173986737365, seqNo=1554, mdref=1356 nBytes=1081 name;tmprt;pressure;humidity;gfHi;gfLo;nTurns;time;note current;29.58;1015.49;32.69;0.0;0.14;0;03/15/2007 07:25:35;dev 1486 powerOn; nSample=13 minGfLo;29.97;1017.13;33.01;0.0;-0.14;0;03/15/2007 06:45:35;dev 1486 powerOn; maxGfLo;29.95;1015.88;31.74;-0.13;0.14;0;03/15/2007 07:00:35;dev 1486 powerOn; minGfHi;29.3;1015.36;33.17;-0.13;-0.14;0;03/15/2007 06:55:35;dev 1486 powerOn; maxGfHi;30.0;1016.32;31.82;0.13;0.0;0;03/15/2007 06:30:35;dev 1486 powerOn; minTmprt;29.3;1015.36;33.17;-0.13;-0.14;0;03/15/2007 06:55:35;dev 1486 powerOn; maxTmprt;30.0;1016.32;31.82;0.13;0.0;0;03/15/2007 06:30:35;dev 1486 powerOn; minPress;29.44;1013.26;32.39;0.0;-0.14;0;03/15/2007 07:05:35;dev 1486 powerOn; maxPress;29.58;1015.49;32.69;0.0;0.14;0;03/15/2007 07:25:35;dev 1486 powerOn; minHumid;29.95;1015.88;31.74;-0.13;0.14;0;03/15/2007 07:00:35;dev 1486 powerOn; maxHumid;29.73;1016.95;33.89;0.0;0.0;0;03/15/2007 06:40:35;dev 1486 powerOn; minTurns;30.0;1016.32;31.82;0.13;0.0;0;03/15/2007 06:30:35;dev 1486 powerOn; maxTurns;30.0;1016.32;31.82;0.13;0.0;0;03/15/2007 06:30:35;dev 1486 powerOn; parentID=0, recordType=6 devid=1522, t=1173986737832, seqNo=1555, mdref=1356 nBytes=257 Filesystem 1k-blocks Used Available Use% Mounted on /dev/root 14848 11980 2868 81% / tmpfs 31244 456 30788 2% /mnt/ramfs /dev/hda1 7937168 168056 7365916 3% /mnt/hda parentID=0, recordType=7 devid=1522, t=1173986738119, seqNo=1556, mdref=1356 nBytes=60 #jvmthreads: 31 jvmmem: total=2621440, free=491680 (bytes) parentID=0, recordType=8 devid=1522, t=1173986738440, seqNo=1557, mdref=1356 nBytes=22 RFIO status goes here parentID=0, recordType=9 devid=1522, t=1173986738780, seqNo=1558, mdref=1356 nBytes=25 Optical status goes here parentID=0, recordType=10 devid=1522, t=1173986739231, seqNo=1559, mdref=1356 nBytes=31 GlobalStar status not available parentID=0, recordType=11 devid=1522, t=1173986739523, seqNo=1560, mdref=1356 nBytes=47 03/15/2007 18:51:38; watchdog state: sleeping parentID=0, recordType=12 devid=1522, t=1173986739824, seqNo=1561, mdref=1356 nBytes=18 sleep mgr disabled 275304 DEBUG PortalConnection [main-DBG-0]: new latest=1173986739824 275305 DEBUG PortalConnection [main-DBG-0]: put packet stats 275305 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data Retrieved total of 10 packets from device [J@32efa7 Retrieve data from device 1028 Retrieving data from device #1028 275309 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1028 275455 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 1 packets from device #1028 280918 INFO PortalConnection [main-DBG-0]: Retrieved 1 packets from device #1028 parentID=1522, recordType=1 devid=1028, t=1173986610532, seqNo=149, mdref=129 nBytes=1500 !*l}O*g*`6****}*20*X**G****,*s**b*"*****B**w-**8L* &***Im *$**'*m****o*D***8*****U**u**G*T***<'f****x* ***%*8*R*L* kfe **S**]* **Q** * ******U0iG*T***, ***$1****T_*****`U *m***U c**t****vK****[****n=I***@*;*v,z*K*cA*~*wy **J*sU*t** **s****p_**'******~*Jk* *?**{[***x*/5**E**y*zd***** *****n%**g*J*6 *******jRm**aR*6**}*******<*6*c***( ****H*X*V*0t*~***** *>h*?9L*&3&2*Im** wO3C****[*******%*O,d****F***6***V*u;Y***Ce6O******[***8Q*******M* 8F***l**bwQ**e*******4iv***:k*a*b****R***RA*ui'{*)**6***{*E*ZW**H*** *<** .*#****[*7******0*** **y**]*Bi**1)R**}*****ui`*^C3?**4**/**3**(**hnX*EY****X*JQGr'N*f****D*D***f****N*T*[*k*xU***>***c*****T***8v**p*1**_*s**2**:FC****@}2K**^***$*3***GH3?**J*(** *)J***l******8*5\*8*****A*6*V **Z****Q*0*n***P**f***>**`T|D$***u*****<****T**9**P*:*Fg*5***D***Z**w[;*S*]h*****t**E*****%** |**fOU* ***b***U9**<**S`b[ *[*a*]**P*>*b> *B*uY`*)****xk****-Z*******g **M*** **********7*****P****mK!"7kv**q**p*u$W*E*****@*G*****9**s******8;**X** |#*****I*8**#***n{***-*t**\*fj*#*:-******2**f** **4:*** *M**|*****2*******Z*=*[T3*Xy****r*7**gh*****D**$*****s*o*_Tk7)***@]$******=*+K*7*?**NR *\[.********c_O@***,**w[*/*91*A,*o*R+*:***|**{****T**0**y*9*****C**W***h**N*****d*******Z**%W******<*Nj**Z**********2*********|*m**|*f*[***>*#*/*i****9*k***********v*8**** *HI***************L**0**M***Z<*)m*y"~*%**2-****'**6o/**Q*q***\'f*****e* * **** m*****+*/********L=p**F*k**** GAS*y*******%**A****l*g}*5*D****c*F*O****$*K*mDU*q3\\+*qz**i***~H***l*|**q;**7*8*'** 280922 DEBUG PortalConnection [main-DBG-0]: new latest=1173986610532 280922 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 1 packets from device [J@32efa7 Retrieve data from device 1029 Retrieving data from device #1029 280923 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1029 280924 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data 280957 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 1 packets from device #1029 285374 INFO PortalConnection [main-DBG-0]: Retrieved 1 packets from device #1029 parentID=1522, recordType=1 devid=1029, t=1173986624812, seqNo=149, mdref=129 nBytes=900 ****8Q*8*o**9****k*L6p_9M**uE**Y**S******O***@***y**/****4|*h***ZV l*W**1***g****{***c**:****Cx:*r**$4*PG=K*]*****jGDM*\|W)*td**I**=****l***cv*W*C]***1o*q*cR ***%**M8*V*w*>*XIv*^6 `a**********.****+**8**0Q*****Qe< **e*.@*z]* c****_aV****b*****WO*R*#*b**.1H*#*yV%**o**x****%***&sH*5J***C*/9s**d`G***** *U]*,********}* **1********)*Em* *q*vt******J{.**wsq*f* 8**a*** * 8Z******Fe*4d****P***U** **************31** s1+O+C*z**~*****N*$/*K****d*b *_*C******y*****W** ***Lf****+}AI*-p"*q****C**v.*+*u}*f**!~*****'**j*,1**{$*o**%l^****Y******|*V#n`T*3*:**d***T***W*****J****q*4*0*IM|***O*Q*7**k**U#h***|***y*******z***I *d***`S*s****E*****}****vNj**** * **g*****{**rN***_*****${****T,q=w9***W_F*9W*q<***W*P*a*****g*E`"**B********+**J7*******%es********2*J*/***q*~*#*.****oN**6m*\*****O****C|*Au***Q*****+I< ********(**J[***_)*_***W** **b**J*3*|3S****3*#*,*(]**}***A d***l*p"7*****l****B* /*A)*********** 285387 DEBUG PortalConnection [main-DBG-0]: new latest=1173986624812 285387 DEBUG PortalConnection [main-DBG-0]: put packet stats 285388 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data Retrieved total of 1 packets from device [J@32efa7 Retrieve data from device 1030 Retrieving data from device #1030 285390 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1030 285451 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 1 packets from device #1030 289418 INFO PortalConnection [main-DBG-0]: Retrieved 1 packets from device #1030 parentID=1522, recordType=1 devid=1030, t=1173986637803, seqNo=148, mdref=128 nBytes=236 `U~SD~*******hn**** `gA_u* ******"\*2***m* * **y*h***DcGB**D*_+**_*F`*~*2z **w**j\***1|*"*5*9**=u*'*(;***N**/*****o@**d*Q*****v**_G**@****D*8|b*****#[******oM*p*<**|***r*M0*J****-%^*>*********]****5*i***/*y*******_*x*\N:!*****d***4** Cy***U***w****G**M**Q*]****r*4**K5**(*R**m***** ****2**Y*/******O ****(*;f**<*v** p3******** 293706 DEBUG PortalConnection [main-DBG-0]: new latest=1173986654444 293706 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 1 packets from device [J@32efa7 Retrieve data from device 1510 Retrieving data from device #1510 293707 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1510 293710 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data 293803 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets No data from device 1510 Retrieve data from device 1032 Retrieving data from device #1032 297461 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1032 299392 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.3:1024]]: PortalSocketFactory.createSocket() - host=134.89.36.3, port=1024 299392 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.3:1024]]: return new Socket(134.89.36.3,1024)... 300559 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.28.205:4534]]: PortalSocketFactory.createSocket() - host=134.89.28.205, port=4534 300559 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.28.205:4534]]: return new Socket(134.89.28.205,4534)... 300560 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.28.205:4534]]: PortalSocketFactory returned new Socket(134.89.28.205,4534) 300780 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.3:1024]]: PortalSocketFactory returned new Socket(134.89.36.3,1024) 301154 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.12.73:1098]]: PortalSocketFactory.createSocket() - host=134.89.12.73, port=1098 301155 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.12.73:1098]]: return new Socket(134.89.12.73,1098)... 301156 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.12.73:1098]]: PortalSocketFactory returned new Socket(134.89.12.73,1098) 307461 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.200:1025]]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 307461 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.200:1025]]: return new Socket(134.89.36.200,1025)... Retrieved 1 packets from device #1032 312859 INFO PortalConnection [main-DBG-0]: Retrieved 1 packets from device #1032 parentID=1522, recordType=1 devid=1032, t=1173986678853, seqNo=146, mdref=126 nBytes=10100 9*(q*U**A2**X}| =*5*K***+$* ****j*0aP3 h:t**T********i**c*.JJ`**z****vZ*******S@}-k***** ****9***O*Tqq2***1***R8B*****d%*%3R;**** ^$W****j*****J***D**\v"**6*****;***!**o<***u *I*T$*r****?s*.**5*[Pv***,e*J:i**=***O****R63.v***%\**`****.***l****X****6n**z****f4*Hr**g****A!HH***N**y**T*W*(**6**&"e*^**m***5*Ta7g*Z9*c****7*^IE***D%U**+A**n*&xrW****XXV***M{,o1*>1e{1**:*Y?**1***Y[*****xA***** **:****e*****n@******j***K4m***+**h****wi*X*l.**;f*kk***A***W*a **F*CHJ*u}**5*****T*}***j**L***Y**x***J: g*******y**e**%z***T**+*>T*******l**TI****C*j***[**a*JN*G***g*{ *******b****+]******@*^**/*"*7;U*ef2Gg**;*******~**16*\7**h***uP**Dz-\E*****.* *A**,B*,Le******&0@+*T****|*****!***tX******}*j* EU***W@***u******V***@D **UH*7*fe*F***-_*****(`**%****H******** *n******#*bQV*?d*******!**K***_p****z***/g***8*v** **K***Vv**r**2*0* ** +**z[***(*y*y*X********G2*Q**"#*HP****I*****q-*'#m* ZE**3}****.*~**%} *n/********A#** *)****km<*W*B*o*"*D.9******L**A*c* V*********1*Aw*1*****"***}*_***?**e8**********>*H*K****P****3X/*(*|*g**}ME|*= ****** ***Y***!Jw`gd***l*** @v*j**P*m[<**Xk***W****?*****>***** Y*~0*|n+vQ:#*****~[******+*[a *****BK*****pA***O***"*C**.**w***F*Xc*y*****Fg***`**h *bV9s*`**** y*****g>* *J******* *%*****5V*]**_W*****t*%***I**Q* r*w**** B *3b*****#***i*Cd*i*****"*4****q5**GY* *O**`*l*C* **d*******ZN*Y*v*Z*n****4*)**c:?z'**6***Z**z*a%**JX *-***)R**E***I*KV*F****nrR*u*********`*****jn*****>***j*`**** `*?*******)*iv**Q*,[***R*Y*g<**/**SU*O*****Y*s** ***iU*v**k**A**}****Y***!6*m*R**"***********!**y*-**(****0*S*&*@*o:H***k****n**]_!y*Q*_*B*S**}K********:B***7********%tF***7**2*}S<**?z*R****o*m*.***a*]***K*L********|$* ***G**&*E*****ko**nZ@ 4*****:*4*iw**q}*U*-**** ******(ck*FM*5***3*****8|M**10*{*:*****u***W* ******s***kT******FB#*w6****x*S0** ~***'*+******B*T*T**(s*<***<**@()** *****v*****r***E5*^**1*k8*W]g*}**m&*******`****;g*O*******~**n****p*)>XC}`****C**v********3c**'**C*f*** J***Q*NR*Ik*h***5*"**9****KV*}^*s**$H****** **L*2** S@***********6x*}Zr**n*F **G9*O*M*+]*E*x*r***Rn$******}6*?*****|0*I***i****Z*r7********`********A*****ys*T***mA************r*z*)**+*t*B******x****2*; **8*N***/**G[*********g***"****F\**L****U***O**A*$**8T****! ***5*w***[(G**}B*T*;**@c**b*C**k**{A|G*x*:*-*&*** **(IAXg**-*y*R**hX*=*JS**\*ci *** r*?5d$**(*M****c**G*****&*_**************}&pf*f*****y*9*******+@8,ppZ{*****moq*K ***@**#*g***Ee******f**F<**V*e*******:*|* u%***Xf* ***A**w**M***}**]Q*fZ*SNN**.$?***G**43**f*V*w*5***Y**Ao***n********0****A l*d*g*~***T*?N**@*lG&****V!*o**5*****jf*c**V***Mp*Fw%**^**G*r*>m>***** *-S***<*-**B~****o************6**h****?A**n*2*a* ******V* * #[* *6*V*f***n*Y1u,!****w******Sk*y*x& **U*7zC*r*[****}*** *!**lL1&*< *wt*xa'r*****dT*{**W**A***"H*>z*****>=*_^\**********ax*n****V**wh******hyc***q********b*J***DV******w\G*O******** Y**t******V]*****u*r*****P**Q**zWh@***CY********* 9*****T~*n* *m;**o**%N**F*F*T6P**s*(&1*8Cm****_*P**:****?***~6~**J**z'L*9*** *V***3 ***G* (t*UAhU<************5*X***K***3Z9*c;V mj*******5****:***/X*;**[**",*JP**2*(m*3**x**#**8{E-lQ!****8*****GL%*****F**]*=***** *7*****}*y** **, **F*$**)Y>*****[E***?*********F*0^7*|7 *BK**|`**l**[*5yG=MV*******L*eC*F#*i]***>*** ******z*r*Q****xY* ***je**@**g*****4>** **{9*B******U*Z*$*+@+**;**TE=*6g******!;X,*'***"*S2v*** *3w*'j*u|H** *o***0*N***su***x*:***&*^:***y******;*>*G ***G*`|**\*H){****"=*****<**MU**,=* *N.*****f^*ah*`**f*********7= *r*t** ** *^['*?*N<*V**8***i*D%h**ob* m*{-*+|#pY**cEz*8*Sn*****IO****_*_j*Un7*LH****(*[*O*****"*#**;hc#***y***t****n*zki**** 2***5* ***)*****? [*v**D****X*8?******<*y*-*^&**e~**********h+0******B*1**cv\,*;**K*r*.*K****q*oy**7a*R0*****o******TB*bKq'd*R$*.eU***Si*i**** *5*&*;5~*N*=f*****.***7*******[*vy*u*******4.*P*>*)*****'f|L&B***A***|**!****X*M******$*n(***x**2*****Tq*=********B,,*6*****9***kk********]|O**** ***rK*)e*****g**"*H*****g**Rk**p***}L*****:***3~/C*****z***E\**i*t**\***=*~z**4f*Nj*k]@**T**Q2***Io*)*y ***}****B*1****b***AH**0***, *[x*?d*d**Z***T*m**x*3q**13.*^?*-*\*****n**Z*F****=***Ry**M*P**a1**e;*@*ChDy****5*7**Rkh**!**09****+******* *0"***=**_Un****<*s*****K e0l**HU***+*0*V*=J*****I6&i********qL*g$******szf***.n****`****R2****R)*k# L****:*****=,n**9**U*UG**s***=*Qi** *g*^***e7"y**\)*z***1*Z*-**.q**)*`*d**L********]**\8$***:*)**G*****B**a**W*g*****U*******2:*_ D*w*g*8*t*******w**u*U*****S**`*<*&*****o*******(**N*********~*_1*r*j=****4******e****g***5******Wv**P*6****f$********z****ix**i****y********4***i**g*E*ijV****%*0* ** C*!-V****)Czs***"***6D* *CS***c**'v**** ~*f***Y>***M***C**3*****N5L*** ***Q1**`*****g*)*_i***1***a**_*$**.!**p*A***@*HS****W**w*/**2**{**BL**l5&k**.!(l*ff$**4**= j*v**2****(****x***** *** * p*'*)**Fah***V*P9****Q _**X**********nvis*******n*8*T***n****z5*6******n****#***u**Gw***0"* :******nI****V*$** <**3*_*****D$P******;**O**4*T* ***fep**********4*]*/4** ***_**=Tj*]**Q*4********,K** j************y****iD***e2**V-*i*5**r**~&*~U[,\*Q< *}0C***47**+****qL****v***O***V******,**O*Er>>******Y****k******8 *5*******m*L*****-r* ****UR*****<&*0**Xd)*w'6*^YiKb*-*p***1**{************q**** *G*01*d*;***Y***9********~**%***[*J**<**9*Q*A+****,o^*E/*\********>z***v*****y****B**2$-Eay*d*U*>j*J**[**m*"*;x@**o**Z**?*K*y***#* **\G***II%**/X***Vl**.**m*VIt* ** *O8**a4**$0***DQX***yM**m*4 ****C*zI*Z6**S* *5R****K**L `?*C****^****** ******<$***}w*.H**:V* * *|2q*3********B*L***vk**u ***0d* ********\\***=**l*:***?***zs*=*5**T***O*1*/*j****/**y******h****@v5m8*L*q$*!*u**i *_RKn*IW***M***o^*d*8**F*D*i****-*j**C****4x.*MIz8=*c**E****#**,j*\cT_**I>E*********x***_**@**t**l******!***** h*=********RSp{`*s****B*Sa*9&**yx*l**r**{********P*Y*k****SP*!**+****Y****U9**iu**R***o****CDF**=$*A*c08**7****9)j***=*<)**h\*;A**Fa*****:***?*lM* Q*x@***%v*IW***~******,***(d*Dv&**Y6***$ **{7. ***U ****T*U***J*********"H=**_**O+b**}.** .'**2***`***f***?*******kw***WH****/X\a!H**;***8***jq*r*0*CX 52*t*}a**(**%**[Y**J*i*"l**R>@***m*m1*' ******l*Mi:**Z*CX*^*~WM07l****$&MJ*****4***x***PR**H*!U***9**`********n-$**l***Y***m****V*t*******c******y *~O*a***e*C*K**(***1>*RxF***(******,"***D>R***a***5fR***#*c*T*d*******s******XM**** ** ** D*******"*#******~t****!^f***0**%sU*>*(***s*p*M**OuW*******]**+**"\uQ O*]DdZ*****G******smx***W*P**********J****XD****(** uu8*]**t i)******* */**1*^**Bc**NG****7****sN;***L**************P******* **wU*V*xfuX*R**]********!*$= p&NL*i*** ***G>***@~*****Q*)P*D**G*%nZ*OO***#****f*U******|cfB*=*O******D**}*:V*****pg**V*>*$*)A**,*<****A@**A*{*$*"**&***!***,*k$*C/D}*t?]{***p**n*z*x***q***Y*a***~I*3'** *V**Q*z*CN**/********z*E& ***-*&U,l)#*****L7 *%*i***Y%******* ****m********W******6\*g********* ***<*********O**l**w*w******`R*****'** *\*c*R*dU***4*********RN*sc****$***`c*ir**Y**?**h4zr*E***(3Q*m1"n****S**M**D*z***%*tj**:**,*********c*G***(*G***%****9**u*******=1*dxkO*]***Q**2*-**&***E****f***:****1(*3*j*L**l**?*Od****e******q*****L*+s **3!)**U***Z*****(!0**$n*R**Ll/**;******=(:D*jC**4***y*Yp*:%*T******=**S***c`**@**w********$*iA**`****g%%***{****R*;*m*****/*Z******]*e**Q*;+$*x|*****8*:****R:*l___n**e`***m**P ********e***h6**m|<]*&s',p*|*\A3**i***:****************R***: ****O**9*****>y***:h* *\**2****G*~e***r**W**|,szo**W*gk*Z49******T(*****S*7******1*******n:****hpVj2*7*|p"+)*aO*B********|*J8**** *cg****V6b***'****** *****M]*8v,*{*FU*p**i*******F*k**6***]******"***u**********oD*o^*E-**** ****\.[*V***|**R***"**^******yT#****U*{ V*hBr*****U*****r9**{7.B*=******+***1*Q***Z.*9*eInuL********T3A*****/*d*Z.H* ***3**xi*e *@[******\SXP****\***u***,I**'*=*d***0*\yqE***C**H****r***}*6*3*[>*****r*-**8Lp[=***Y***0***v***-M**\9*u :ha*_%***%F***5U***r**q*****r**-*l****_***;uW*u;*?*uXJo5*&**[`*Y%U**l* D**J!*, r*'**6******!********N*f0K*l_*******-)***'dl*********U* **O4****| **u]J***8**(***e**\*rl***%**,*A** **:N**@*X*eF**n****tG*@***WX*h*-****_*~X***:*o*c*1*7**L*I*I*w 9`]*******IF** ******L*M0**ZN*n******a*gt**t8**3****8*>***|****4*z*dx***,e**u*********5*$*****rn***a**m*v*=**>$Y*f*ZwZ*****d<***p*f**A***GG+cjq***X***z**>**o_*****5la****th*fr***)**L*Q**U*Liu}_****N%*;L**Z**s**Q***H********1D0**-6***4H**l*v****yO***-**C*********I**'j*****N*,,*******$**7***y7@*IY8*R*|Q***j**&**%**":**c*!***gy$**y**\**f**9[**ky*)|****[*E*****b*$*5****&*>y*3*X*=******G***Z**! **Z****)*b**{ *C***}?2****&*iq****$*f*l******c*C**_*****#*6*******<**n*V***_c********L****(!**Q**'** ***O!*0**G*Nw*********.n*v4*QDE*B****9g****T0&r*Y*)*m**4**%*3t******-;AF*?*L7**>:**M*p****0A!*****9*[V****nf{****?[V*D* 312869 DEBUG PortalConnection [main-DBG-0]: new latest=1173986678853 312869 DEBUG PortalConnection [main-DBG-0]: put packet stats 312869 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data Retrieved total of 1 packets from device [J@32efa7 Retrieve data from device 1413 Retrieving data from device #1413 312872 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1413 312883 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.200:1025]]: PortalSocketFactory returned new Socket(134.89.36.200,1025) 312943 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 9 packets from device #1413 317885 INFO PortalConnection [main-DBG-0]: Retrieved 9 packets from device #1413 parentID=1522, recordType=1 devid=1413, t=1173984895826, seqNo=825, mdref=713 nBytes=76 $PEDATA, P1014.27, T29.35, H33.10, GFL-0.14, GFH0.00, C270.04, TC0.00, *3729 parentID=1522, recordType=1 devid=1413, t=1173985495826, seqNo=826, mdref=713 nBytes=76 $PEDATA, P1016.45, T29.40, H32.64, GFL0.00, GFH-0.13, C270.20, TC0.00, *3732 parentID=1522, recordType=1 devid=1413, t=1173986095825, seqNo=827, mdref=713 nBytes=75 $PEDATA, P1014.63, T29.75, H33.56, GFL0.00, GFH0.00, C264.24, TC0.00, *3698 parentID=1522, recordType=1 devid=1413, t=1173986695825, seqNo=828, mdref=713 nBytes=76 $PEDATA, P1016.52, T29.55, H32.97, GFL-0.14, GFH0.00, C267.30, TC0.00, *3750 parentID=1522, recordType=1 devid=1413, t=1173987295825, seqNo=829, mdref=713 nBytes=76 $PEDATA, P1014.42, T29.39, H32.60, GFL0.00, GFH-0.13, C271.01, TC0.00, *3731 parentID=1522, recordType=1 devid=1413, t=1173987895826, seqNo=830, mdref=713 nBytes=75 $PEDATA, P1015.16, T29.31, H31.66, GFL0.00, GFH0.00, C271.65, TC0.00, *3691 parentID=1522, recordType=1 devid=1413, t=1173988495827, seqNo=831, mdref=713 nBytes=77 $PEDATA, P1014.45, T29.58, H31.79, GFL-0.28, GFH-0.13, C263.75, TC0.00, *3811 parentID=1522, recordType=1 devid=1413, t=1173989095876, seqNo=832, mdref=713 nBytes=75 $PEDATA, P1016.31, T29.41, H31.92, GFL0.00, GFH0.00, C271.81, TC0.00, *3687 parentID=1522, recordType=1 devid=1413, t=1173989695824, seqNo=833, mdref=713 nBytes=75 $PEDATA, P1016.36, T29.40, H31.81, GFL0.00, GFH0.13, C271.17, TC0.00, *3692 317927 DEBUG PortalConnection [main-DBG-0]: new latest=1173989695824 317928 DEBUG PortalConnection [main-DBG-0]: put packet stats 317928 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data Retrieved total of 9 packets from device [J@32efa7 Retrieve data from device 1486 Retrieving data from device #1486 317930 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1486 318203 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 11 packets from device #1486 322193 INFO PortalConnection [main-DBG-0]: Retrieved 11 packets from device #1486 parentID=1522, recordType=1 devid=1486, t=1173984935971, seqNo=1639, mdref=1416 nBytes=199 -> channel=0, temp=54.97, vcc=3.2010, txBiasI=4.0665, txPower=-2.5590, rxPower=-8.7281, status=0x0 channel=1, temp=57.13, vcc=3.1934, txBiasI=2.9796, txPower=-2.9637, rxPower=-23.8134, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173985236251, seqNo=1640, mdref=1416 nBytes=199 -> channel=0, temp=54.86, vcc=3.2002, txBiasI=4.0462, txPower=-2.5522, rxPower=-8.7495, status=0x0 channel=1, temp=57.08, vcc=3.1930, txBiasI=2.9709, txPower=-2.9688, rxPower=-23.4855, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173985535963, seqNo=1641, mdref=1416 nBytes=199 -> channel=0, temp=54.78, vcc=3.2008, txBiasI=4.0317, txPower=-2.5693, rxPower=-8.6963, status=0x0 channel=1, temp=57.03, vcc=3.1936, txBiasI=2.9709, txPower=-2.9644, rxPower=-24.1682, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173985836207, seqNo=1642, mdref=1416 nBytes=199 -> channel=0, temp=54.74, vcc=3.2002, txBiasI=4.0491, txPower=-2.5317, rxPower=-8.5507, status=0x0 channel=1, temp=56.96, vcc=3.1928, txBiasI=2.9854, txPower=-2.9755, rxPower=-23.6464, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173986135991, seqNo=1643, mdref=1416 nBytes=199 -> channel=0, temp=54.55, vcc=3.2006, txBiasI=4.0259, txPower=-2.5865, rxPower=-8.5558, status=0x0 channel=1, temp=56.88, vcc=3.1932, txBiasI=2.9535, txPower=-2.9637, rxPower=-23.9872, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173986436047, seqNo=1644, mdref=1416 nBytes=199 -> channel=0, temp=54.65, vcc=3.2002, txBiasI=4.0143, txPower=-2.5625, rxPower=-8.6021, status=0x0 channel=1, temp=57.01, vcc=3.1940, txBiasI=2.9564, txPower=-2.9614, rxPower=-23.9872, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173986736032, seqNo=1645, mdref=1416 nBytes=199 -> channel=0, temp=54.67, vcc=3.2012, txBiasI=4.0085, txPower=-2.5625, rxPower=-8.5558, status=0x0 channel=1, temp=57.01, vcc=3.1942, txBiasI=2.9680, txPower=-2.9614, rxPower=-23.1806, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173987036041, seqNo=1646, mdref=1416 nBytes=199 -> channel=0, temp=54.74, vcc=3.1998, txBiasI=4.0259, txPower=-2.5865, rxPower=-8.7016, status=0x0 channel=1, temp=57.02, vcc=3.1940, txBiasI=2.9709, txPower=-2.9570, rxPower=-24.5544, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173987336001, seqNo=1647, mdref=1416 nBytes=199 -> channel=0, temp=54.80, vcc=3.2004, txBiasI=4.0259, txPower=-2.5522, rxPower=-8.6804, status=0x0 channel=1, temp=56.97, vcc=3.1944, txBiasI=2.9477, txPower=-2.9637, rxPower=-24.9785, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173987636011, seqNo=1648, mdref=1416 nBytes=199 -> channel=0, temp=54.63, vcc=3.2002, txBiasI=4.0288, txPower=-2.5590, rxPower=-8.6125, status=0x0 channel=1, temp=56.91, vcc=3.1922, txBiasI=2.9622, txPower=-2.9600, rxPower=-24.7613, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173987936021, seqNo=1649, mdref=1416 nBytes=199 -> channel=0, temp=54.58, vcc=3.2008, txBiasI=3.9825, txPower=-2.5727, rxPower=-8.5151, status=0x0 channel=1, temp=56.85, vcc=3.1930, txBiasI=2.9767, txPower=-2.9644, rxPower=-24.5544, status=0x2 322238 DEBUG PortalConnection [main-DBG-0]: new latest=1173987936021 322238 DEBUG PortalConnection [main-DBG-0]: put packet stats 322239 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data Retrieve data from device 1486 Retrieving data from device #1486 322240 INFO PortalConnection [main-DBG-0]: Retrieving data from device #1486 322399 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets Retrieved 7 packets from device #1486 326459 INFO PortalConnection [main-DBG-0]: Retrieved 7 packets from device #1486 parentID=1522, recordType=1 devid=1486, t=1173988235993, seqNo=1650, mdref=1416 nBytes=199 -> channel=0, temp=54.55, vcc=3.2002, txBiasI=3.9998, txPower=-2.5625, rxPower=-8.6594, status=0x0 channel=1, temp=56.81, vcc=3.1940, txBiasI=2.9796, txPower=-2.9703, rxPower=-22.7600, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173988536021, seqNo=1651, mdref=1416 nBytes=199 -> channel=0, temp=54.45, vcc=3.2012, txBiasI=4.0027, txPower=-2.5796, rxPower=-8.5610, status=0x0 channel=1, temp=56.73, vcc=3.1922, txBiasI=2.9912, txPower=-2.9600, rxPower=-23.1806, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173988836021, seqNo=1652, mdref=1416 nBytes=199 -> channel=0, temp=54.53, vcc=3.2008, txBiasI=4.0056, txPower=-2.5625, rxPower=-8.7016, status=0x0 channel=1, temp=56.87, vcc=3.1940, txBiasI=2.9709, txPower=-2.9622, rxPower=-24.9785, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173989136021, seqNo=1653, mdref=1416 nBytes=199 -> channel=0, temp=54.77, vcc=3.2002, txBiasI=4.0346, txPower=-2.5762, rxPower=-8.6437, status=0x0 channel=1, temp=57.00, vcc=3.1920, txBiasI=2.9506, txPower=-2.9688, rxPower=-23.8134, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173989436140, seqNo=1654, mdref=1416 nBytes=199 -> channel=0, temp=54.70, vcc=3.2006, txBiasI=4.0143, txPower=-2.5659, rxPower=-8.5354, status=0x0 channel=1, temp=56.99, vcc=3.1914, txBiasI=2.9970, txPower=-2.9696, rxPower=-22.8957, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173989736071, seqNo=1655, mdref=1416 nBytes=199 -> channel=0, temp=54.91, vcc=3.2002, txBiasI=4.0491, txPower=-2.5659, rxPower=-8.6647, status=0x0 channel=1, temp=57.09, vcc=3.1922, txBiasI=2.9970, txPower=-2.9666, rxPower=-24.5544, status=0x2 parentID=1522, recordType=1 devid=1486, t=1173990036021, seqNo=1656, mdref=1416 nBytes=199 -> channel=0, temp=54.74, vcc=3.2014, txBiasI=4.0201, txPower=-2.5693, rxPower=-8.5354, status=0x0 channel=1, temp=57.01, vcc=3.1928, txBiasI=2.9825, txPower=-2.9644, rxPower=-22.3766, status=0x2 326487 DEBUG PortalConnection [main-DBG-0]: new latest=1173990036021 326487 DEBUG PortalConnection [main-DBG-0]: put packet stats Retrieved total of 18 packets from device [J@32efa7 326488 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After retrieveAndDistributeData: 27 326488 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - Before subnode processing: 27 326489 DEBUG PortalConnection [main-DBG-0]: node418/134.89.36.18 disconnectNode() - Mar 15, 2007 2:24:14 PM 326489 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: saving data 326496 DEBUG PortalConnection [main-DBG-0]: _nodeLinkConnected set FALSE 326496 DEBUG PortalConnection [main-DBG-0]: node418/134.89.36.18 disconnectNode(): normal connection termination 326496 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): Trying to terminate all leases with description containing "portal@siam-portal-3.shore.mbari.org" 326616 DEBUG PortalConnection [_distributeWorker-node418/134.89.36.18-DBG-16]: publishing packets 328913 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 171 330640 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 172 333319 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After disconnectNode (startSession end): 27 333320 INFO PortalConnection [main-DBG-0]: startSession() [node418] - done: Mar 15, 2007 2:24:21 PM 333321 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After subnode processing: 27 333321 DEBUG PortalConnection [main-DBG-0]: main thread: Exited subnode while loop for node ID 1407 333321 DEBUG PortalConnection [main-DBG-0]: mse/10.1.36.2 disconnectNode() - Mar 15, 2007 2:24:21 PM 333322 DEBUG PortalConnection [main-DBG-0]: _nodeLinkConnected set FALSE 333322 DEBUG PortalConnection [main-DBG-0]: mse/10.1.36.2 disconnectNode(): normal connection termination 333322 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): Trying to terminate all leases with description containing "portal@siam-portal-3.shore.mbari.org" 333322 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 333322 DEBUG PortalSocketFactory [main-DBG-0]: return new Socket(134.89.36.200,1025)... 334145 DEBUG PortalSocketFactory [main-DBG-0]: PortalSocketFactory returned new Socket(134.89.36.200,1025) 337433 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 379 339282 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 380 340938 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 381 341724 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.2:1025]]: PortalSocketFactory.createSocket() - host=134.89.36.2, port=1025 341725 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.2:1025]]: return new Socket(134.89.36.2,1025)... 342621 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.2:1025]]: PortalSocketFactory returned new Socket(134.89.36.2,1025) 342625 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 382 344713 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 383 346502 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 384 348359 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 385 349980 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 386 351603 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 387 353201 DEBUG PortalConnection [main-DBG-0]: disconnectNode(): terminating lease 388 359587 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.18:1025]]: PortalSocketFactory.createSocket() - host=134.89.36.18, port=1025 359587 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.18:1025]]: return new Socket(134.89.36.18,1025)... 360372 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.18:1025]]: PortalSocketFactory returned new Socket(134.89.36.18,1025) 371223 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Portal.nodeLinkNotify(mse/10.1.36.2, OFF) 371223 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to mse 371224 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: PortalConnection.nodeLinkNotify(OFF) 371225 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: mse/10.1.36.2 disconnectNode() - Mar 15, 2007 2:24:59 PM 371225 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371225 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: mse disconnectNode(): abrupt connection termination 371226 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node402 371226 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node402/134.89.36.2 disconnectNode() - Mar 15, 2007 2:24:59 PM 371227 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371227 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node402 disconnectNode(): abrupt connection termination 371227 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node413 371228 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node413/134.89.36.13 disconnectNode() - Mar 15, 2007 2:24:59 PM 371228 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371229 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node413 disconnectNode(): abrupt connection termination 371229 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node403 371230 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node403/134.89.36.3 disconnectNode() - Mar 15, 2007 2:24:59 PM 371230 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371230 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node403 disconnectNode(): abrupt connection termination 371231 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node418 371231 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node418/134.89.36.18 disconnectNode() - Mar 15, 2007 2:24:59 PM 371232 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371232 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node418 disconnectNode(): abrupt connection termination 371232 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node402 371233 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: PortalConnection.nodeLinkNotify(OFF) 371233 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node402/134.89.36.2 disconnectNode() - Mar 15, 2007 2:24:59 PM 371234 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371234 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node402 disconnectNode(): abrupt connection termination 371234 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node413 371235 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: PortalConnection.nodeLinkNotify(OFF) 371235 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node413/134.89.36.13 disconnectNode() - Mar 15, 2007 2:24:59 PM 371236 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371236 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node413 disconnectNode(): abrupt connection termination 371236 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node403 371236 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: PortalConnection.nodeLinkNotify(OFF) 371237 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node403/134.89.36.3 disconnectNode() - Mar 15, 2007 2:24:59 PM 371237 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371238 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node403 disconnectNode(): abrupt connection termination 371238 DEBUG Portal [RMI TCP Connection(7)-134.89.28.205]: Found existing connection to node418 371238 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: PortalConnection.nodeLinkNotify(OFF) 371239 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node418/134.89.36.18 disconnectNode() - Mar 15, 2007 2:24:59 PM 371239 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: _nodeLinkConnected set FALSE 371240 DEBUG PortalConnection [RMI TCP Connection(7)-134.89.28.205]: node418 disconnectNode(): abrupt connection termination 378743 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.13:1024]]: PortalSocketFactory.createSocket() - host=134.89.36.13, port=1024 378744 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.13:1024]]: return new Socket(134.89.36.13,1024)... 413201 ERROR PortalConnection [main-DBG-0]: Unable to terminate lease 388 413201 DEBUG PortalConnection [main-DBG-0]: portal JVM Thread.currentCount - After disconnectNode (startSession end): 27 413202 INFO PortalConnection [main-DBG-0]: startSession() [mse] - done: Mar 15, 2007 2:25:41 PM 413202 DEBUG PortalSession [main-DBG-0]: mse.sid 1173993531717 SESSION_END source: moos.operations.portal.PortalConnection@a012402 413203 DEBUG PortalSession [main-DBG-0]: mse.sid 1173993531717 SESSION_END message: Portal session_end - mse 413203 DEBUG PortalSession [main-DBG-0]: mse.sid 1173993531717 setting session end time 1173993941126 413365 DEBUG Portal [main-DBG-0]: Portal constructor finished 413429 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.3:1024]]: PortalSocketFactory.createSocket() - host=134.89.36.3, port=1024 413429 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.3:1024]]: return new Socket(134.89.36.3,1024)... 419771 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.200:1025]]: PortalSocketFactory.createSocket() - host=134.89.36.200, port=1025 419771 DEBUG PortalSocketFactory [RMI RenewClean-[134.89.36.200:1025]]: return new Socket(134.89.36.200,1025)...