0 INFO NodeMain [main]: NodeMain.main(): portalHost = null 559 INFO NodeManager [main]: Starting NodeManager: $Name: $ 560 INFO NodeManager [main]: Node IP: foce/127.0.1.1 654 INFO NodeManager [main]: Node ID has been set to 1726 990 DEBUG PublisherComponent [main]: Default constructor called 1032 DEBUG PublisherComponent [main]: setTopicname called with name topic/SSDSIngestTopic 1032 DEBUG PublisherComponent [main]: topicname is now topic/SSDSIngestTopic 1032 DEBUG PublisherComponent [main]: Not connected so calling start 1032 DEBUG PublisherComponent [main]: PublisherComponent stop called 1033 DEBUG PublisherComponent [main]: Everything should be closed now 1033 DEBUG PublisherComponent [main]: start called, setting connected to true 1033 DEBUG PublisherComponent [main]: Going to get jndiContext 1208 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} 1225 DEBUG PublisherComponent [main]: Going to get the topic connection factory from the JNDI 2877 DEBUG PublisherComponent [main]: Going to create a topic connection from the factory 3859 DEBUG PublisherComponent [main]: Going to get the topic topic/SSDSIngestTopic from the JNDI lookup 3890 DEBUG PublisherComponent [main]: Going to create a topic session from the connection 3970 DEBUG PublisherComponent [main]: Now going to call start on the topic connection 4067 DEBUG PublisherComponent [main]: Connected was true after start 4067 DEBUG PublisherComponent [main]: Should have set the topicName to topic/SSDSIngestTopic 4186 INFO IOMapper [main]: Exception in 1st try at connecting to ioport server: java.net.ConnectException: Connection refused 5154 INFO PortManager [main]: Found 23 configured ports in properties file 5598 INFO SleepManager [main]: SleepManager constructor 5599 INFO CommsLeaseListener [main]: CommsLeaseListener() complete 5608 INFO CpuLeaseSleepRollcallListener [main]: CpuLeaseSleepRollcallListener() constructor 5612 INFO CpuLease [main]: CpuLease() constructor 5623 INFO CpuLease [Thread-7]: CpuLease started 7009 INFO NodeManager [main]: Starting registry... 7015 INFO NodeManager [main]: registry started. 7015 INFO NodeManager [main]: binding NodeService to rmi://localhost/node 7141 INFO NodeManager [main]: NodeService is bound to rmi://localhost/node 7425 INFO PortManager [main]: Starting service... 10123 INFO BaseInstrumentService [main]: initializeInstrument() for 10124 INFO BaseInstrumentService [main]: done with initializeInstrument() for 32698 INFO PortManager [main]: service started 32702 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 33198 INFO PortManager [main]: Starting service... 35493 INFO BaseInstrumentService [main]: initializeInstrument() for 35495 INFO BaseInstrumentService [main]: done with initializeInstrument() for 52060 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 52061 INFO PortManager [main]: service started 52199 INFO PortManager [main]: Starting service... 54388 INFO BaseInstrumentService [main]: initializeInstrument() for 54389 INFO BaseInstrumentService [main]: done with initializeInstrument() for 72583 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 72583 INFO PortManager [main]: service started 72653 INFO PortManager [main]: Starting service... 73598 INFO BaseInstrumentService [main]: initializeInstrument() for 73599 INFO BaseInstrumentService [main]: done with initializeInstrument() for 95558 INFO PortManager [main]: service started 95560 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 95624 ERROR Turbinator [Thread-31]: dataCallback(): com.rbnb.sapi.SAPIException: Nesting java.lang.StringIndexOutOfBoundsException 95916 INFO PortManager [main]: Starting service... 99480 INFO BaseInstrumentService [main]: initializeInstrument() for 99481 INFO SBE52MP [main]: initializeInstrument() - Getting SBE's attention (Stops any previous logging). 104018 INFO BaseInstrumentService [main]: done with initializeInstrument() for 121924 INFO PortManager [main]: service started 121926 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 122078 INFO PortManager [main]: Starting service... 125727 INFO BaseInstrumentService [main]: initializeInstrument() for 125728 INFO SBE52MP [main]: initializeInstrument() - Getting SBE's attention (Stops any previous logging). 130265 INFO BaseInstrumentService [main]: done with initializeInstrument() for 157384 INFO PortManager [main]: service started 157387 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 157514 INFO PortManager [main]: Starting service... 162356 INFO BaseInstrumentService [main]: initializeInstrument() for 162356 INFO BaseInstrumentService [main]: done with initializeInstrument() for 178975 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 178975 INFO PortManager [main]: service started 179100 INFO PortManager [main]: Starting service... 184118 INFO BaseInstrumentService [main]: initializeInstrument() for 184119 INFO BaseInstrumentService [main]: done with initializeInstrument() for 206666 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 206667 INFO PortManager [main]: service started 206897 INFO PortManager [main]: Starting service... 211697 INFO BaseInstrumentService [main]: initializeInstrument() for 211698 INFO BaseInstrumentService [main]: done with initializeInstrument() for 228957 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 228957 INFO PortManager [main]: service started 229105 INFO PortManager [main]: Starting service... 234000 INFO BaseInstrumentService [main]: initializeInstrument() for 234000 INFO BaseInstrumentService [main]: done with initializeInstrument() for 254639 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 254640 INFO PortManager [main]: service started 254729 INFO PortManager [main]: Starting service... 259603 INFO BaseInstrumentService [main]: initializeInstrument() for 259603 INFO BaseInstrumentService [main]: done with initializeInstrument() for 283755 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 283755 INFO PortManager [main]: service started 283869 INFO PortManager [main]: Starting service... 284097 ERROR Turbinator [Thread-75]: dataCallback(): com.rbnb.sapi.SAPIException: Nesting java.lang.StringIndexOutOfBoundsException 288766 INFO BaseInstrumentService [main]: initializeInstrument() for 288767 INFO BaseInstrumentService [main]: done with initializeInstrument() for 305797 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 305798 INFO PortManager [main]: service started 305832 INFO PortManager [main]: Service jar not specified for port /dev/ttyS8 305832 INFO PortManager [main]: Service jar not specified for port /dev/ttyS10 305969 INFO PortManager [main]: Starting service... 307384 INFO BaseInstrumentService [main]: initializeInstrument() for 308568 INFO BaseInstrumentService [main]: done with initializeInstrument() for 334201 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 334201 INFO PortManager [main]: service started 334326 INFO PortManager [main]: Starting service... 346668 INFO BaseInstrumentService [main]: initializeInstrument() for 346669 INFO WorkhorseADCP [main]: Initializing Workhorse... 348638 INFO WorkhorseADCP [main]: initializeInstrument() - Setting Workhorse to NOT log internally. 349141 INFO WorkhorseADCP [main]: initializeInstrument() - Setting Workhorse Coordinate system to 01010 349645 INFO WorkhorseADCP [main]: initializeInstrument() - Setting Workhorse normal sample interval (TE). 350262 INFO WorkhorseADCP [main]: initializeInstrument() - Setting Workhorse normal Pings Per EnSemble (WP). 350597 INFO WorkhorseADCP [main]: initializeInstrument() - Setting Workhorse normal Time Per Ping (TP). 351157 INFO WorkhorseADCP [main]: initializeInstrument() - Saving Workhorse Parameters. 353622 INFO WorkhorseADCP [main]: Initializing completed 353622 INFO BaseInstrumentService [main]: done with initializeInstrument() for 372763 ERROR WorkhorseADCP [main]: getInstrumentMetadata: Rescheduling service for 0 seconds... 372764 ERROR WorkhorseADCP [main]: getInstrumentMetadata: invalid _initialInterval 0 390719 INFO PortManager [main]: service started 390721 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 390739 INFO PortManager [main]: Service jar not specified for port /dev/ttyS7 390824 INFO PortManager [main]: Starting service... 391544 INFO BaseInstrumentService [main]: initializeInstrument() for 391545 INFO BaseInstrumentService [main]: done with initializeInstrument() for 405340 ERROR Turbinator [Thread-95]: dataCallback(): com.rbnb.sapi.SAPIException: Nesting java.lang.StringIndexOutOfBoundsException 422844 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 422844 INFO PortManager [main]: service started 425977 ERROR PortManager [main]: java.net.NoRouteToHostException ESWph java.net.NoRouteToHostException: No route to host at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333) at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195) at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366) at java.net.Socket.connect(Socket.java:520) at java.net.Socket.connect(Socket.java:470) at java.net.Socket.(Socket.java:367) at java.net.Socket.(Socket.java:180) at it.m2.net.telnet.Telnet.setSocket(Telnet.java:198) at it.m2.net.telnet.NVTCom.(NVTCom.java:53) at org.mbari.siam.core.nvt.NVTSerialPort.open(NVTSerialPort.java:87) at org.mbari.siam.core.NVTDevicePort.openComms(NVTDevicePort.java:71) at org.mbari.siam.core.SerialDevicePort.openComms(SerialDevicePort.java:67) at org.mbari.siam.core.PortManager.scanPort(PortManager.java:196) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 425994 ERROR PortManager [main]: scanPorts() Exception on port ESWph java.lang.Exception: ESWph: java.net.NoRouteToHostException: No route to host at org.mbari.siam.core.PortManager.scanPort(PortManager.java:200) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 429006 ERROR PortManager [main]: java.net.NoRouteToHostException ESWpump java.net.NoRouteToHostException: No route to host at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333) at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195) at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366) at java.net.Socket.connect(Socket.java:520) at java.net.Socket.connect(Socket.java:470) at java.net.Socket.(Socket.java:367) at java.net.Socket.(Socket.java:180) at it.m2.net.telnet.Telnet.setSocket(Telnet.java:198) at it.m2.net.telnet.NVTCom.(NVTCom.java:53) at org.mbari.siam.core.nvt.NVTSerialPort.open(NVTSerialPort.java:87) at org.mbari.siam.core.NVTDevicePort.openComms(NVTDevicePort.java:71) at org.mbari.siam.core.SerialDevicePort.openComms(SerialDevicePort.java:67) at org.mbari.siam.core.PortManager.scanPort(PortManager.java:196) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 430736 ERROR PortManager [main]: scanPorts() Exception on port ESWpump java.lang.Exception: ESWpump: java.net.NoRouteToHostException: No route to host at org.mbari.siam.core.PortManager.scanPort(PortManager.java:200) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 431380 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down services 431384 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on 'PMonitor' 431384 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 431384 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 431619 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 431619 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port PMonitor 431636 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 431637 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 431637 INFO NodeManager [Thread-2]: Done with serviceRemoved() 431638 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 431638 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 431640 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 431640 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on 'EMonitor' 431640 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 431640 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 432110 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 432110 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port EMonitor 432137 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 432137 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 432138 INFO NodeManager [Thread-2]: Done with serviceRemoved() 432138 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 432138 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 432139 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 432139 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on 'HMonitor' 432140 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 432140 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 432709 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 432709 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port HMonitor 432717 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 432717 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 432718 INFO NodeManager [Thread-2]: Done with serviceRemoved() 432718 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 432718 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 432719 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 432719 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on 'WMonitor' 432720 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 432720 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 432915 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 432915 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port WMonitor 432921 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 432922 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 432922 INFO NodeManager [Thread-2]: Done with serviceRemoved() 432923 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 432923 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 432924 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 432924 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS4' 432924 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 432925 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 432925 ERROR StopWatch [Thread-40]: wait(...) failed: java.lang.InterruptedException: sleep interrupted 433819 ERROR PortManager [main]: java.net.NoRouteToHostException CO2subsys java.net.NoRouteToHostException: No route to host at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:333) at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:195) at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:182) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366) at java.net.Socket.connect(Socket.java:520) at java.net.Socket.connect(Socket.java:470) at java.net.Socket.(Socket.java:367) at java.net.Socket.(Socket.java:180) at it.m2.net.telnet.Telnet.setSocket(Telnet.java:198) at it.m2.net.telnet.NVTCom.(NVTCom.java:53) at org.mbari.siam.core.nvt.NVTSerialPort.open(NVTSerialPort.java:87) at org.mbari.siam.core.NVTDevicePort.openComms(NVTDevicePort.java:71) at org.mbari.siam.core.SerialDevicePort.openComms(SerialDevicePort.java:67) at org.mbari.siam.core.PortManager.scanPort(PortManager.java:196) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 433836 ERROR PortManager [main]: scanPorts() Exception on port CO2subsys java.lang.Exception: CO2subsys: java.net.NoRouteToHostException: No route to host at org.mbari.siam.core.PortManager.scanPort(PortManager.java:200) at org.mbari.siam.core.PortManager.scanPorts(PortManager.java:605) at org.mbari.siam.core.NodeManager.start(NodeManager.java:256) at org.mbari.siam.core.NodeMain.main(NodeMain.java:112) 433841 INFO PortManager [main]: Service jar not specified for port ControlLoop 433969 INFO PortManager [main]: Starting service... 436693 INFO BaseInstrumentService [main]: initializeInstrument() for 437595 INFO Vector [main]: initializeInstrument() - Getting Aquadopp's attention (Stops any previous logging). 444568 INFO BaseInstrumentService [main]: done with initializeInstrument() for 444580 INFO Aquadopp [main]: Retrieving Aquadopp state Metadata... 467887 INFO PortManager [main]: service started 467890 INFO NodeManager [Thread-2]: serviceInstalled(): invoke remote callbacks 467919 INFO CommsSchedulerTask [Thread-114]: CommsSchedulerTask.run(): Sep 6, 2012 1:30:20 PM 467928 INFO CommsLeaseListener [Thread-114]: leaseEstablishCallback() - Comms manager not enabled 468060 INFO NodeManager [main]: NodeManager "node" started. 474795 ERROR RegistryEntry [Thread-109]: Error parsing packet: java.text.ParseException: Not a Parseable Packet type 475382 ERROR StreamingInstrumentService [Thread-113]: acquire(): 256:port Power on 475383 ERROR StreamingInstrumentService [Thread-113]: 256:port Power on 477137 ERROR Turbinator [Thread-109]: dataCallback(): com.rbnb.sapi.SAPIException: Nesting java.lang.StringIndexOutOfBoundsException 482849 WARN PolledInstrumentService [Thread-40]: Seabird SBE52MP.acquire(): org.mbari.siam.distributed.TimeoutException: readUntil() Timed out after 60011 ms outbuf.len=1000 avail: 0 read: 0 org.mbari.siam.distributed.TimeoutException: readUntil() Timed out after 60011 ms outbuf.len=1000 avail: 0 read: 0 at org.mbari.siam.utils.StreamUtils.readUntil(StreamUtils.java:115) at org.mbari.siam.core.BaseInstrumentService.readSample(BaseInstrumentService.java:1061) at org.mbari.siam.core.PolledInstrumentService.acquire(PolledInstrumentService.java:112) at org.mbari.siam.core.BaseInstrumentService.acquireSample(BaseInstrumentService.java:806) at org.mbari.siam.core.PolledInstrumentService.doScheduledTask(PolledInstrumentService.java:45) at org.mbari.siam.core.ScheduleTaskImpl.execute(ScheduleTaskImpl.java:58) at org.mbari.siam.core.ScheduleTimerTask.run(ScheduleTimerTask.java:54) at org.mbari.siam.core.TimerThread.mainLoop(SiamTimer.java:628) at org.mbari.siam.core.TimerThread.run(SiamTimer.java:573) 482855 WARN PolledInstrumentService [Thread-40]: acquire(): thread interrupted? 482855 INFO BaseInstrumentService [Thread-40]: Didn't remove sampling thread (total of 0 threads) 482856 ERROR PolledInstrumentService [Thread-40]: doScheduledTask: caught NoDataException: org.mbari.siam.distributed.NoDataException: acquire interrupted org.mbari.siam.distributed.NoDataException: acquire interrupted at org.mbari.siam.core.PolledInstrumentService.acquire(PolledInstrumentService.java:178) at org.mbari.siam.core.BaseInstrumentService.acquireSample(BaseInstrumentService.java:806) at org.mbari.siam.core.PolledInstrumentService.doScheduledTask(PolledInstrumentService.java:45) at org.mbari.siam.core.ScheduleTaskImpl.execute(ScheduleTaskImpl.java:58) at org.mbari.siam.core.ScheduleTimerTask.run(ScheduleTimerTask.java:54) at org.mbari.siam.core.TimerThread.mainLoop(SiamTimer.java:628) at org.mbari.siam.core.TimerThread.run(SiamTimer.java:573) 482864 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 482864 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS4 482873 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 482873 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 482873 INFO NodeManager [Thread-2]: Done with serviceRemoved() 482874 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 482874 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 482874 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 482875 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS6' 482875 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 482875 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 482876 ERROR StopWatch [Thread-46]: wait(...) failed: java.lang.InterruptedException: sleep interrupted 518292 WARN PolledInstrumentService [Thread-46]: Seabird SBE52MP.acquire(): org.mbari.siam.distributed.TimeoutException: readUntil() Timed out after 60007 ms outbuf.len=1000 avail: 0 read: 0 org.mbari.siam.distributed.TimeoutException: readUntil() Timed out after 60007 ms outbuf.len=1000 avail: 0 read: 0 at org.mbari.siam.utils.StreamUtils.readUntil(StreamUtils.java:115) at org.mbari.siam.core.BaseInstrumentService.readSample(BaseInstrumentService.java:1061) at org.mbari.siam.core.PolledInstrumentService.acquire(PolledInstrumentService.java:112) at org.mbari.siam.core.BaseInstrumentService.acquireSample(BaseInstrumentService.java:806) at org.mbari.siam.core.PolledInstrumentService.doScheduledTask(PolledInstrumentService.java:45) at org.mbari.siam.core.ScheduleTaskImpl.execute(ScheduleTaskImpl.java:58) at org.mbari.siam.core.ScheduleTimerTask.run(ScheduleTimerTask.java:54) at org.mbari.siam.core.TimerThread.mainLoop(SiamTimer.java:628) at org.mbari.siam.core.TimerThread.run(SiamTimer.java:573) 518294 WARN PolledInstrumentService [Thread-46]: acquire(): thread interrupted? 518294 INFO BaseInstrumentService [Thread-46]: Didn't remove sampling thread (total of 0 threads) 518294 ERROR PolledInstrumentService [Thread-46]: doScheduledTask: caught NoDataException: org.mbari.siam.distributed.NoDataException: acquire interrupted org.mbari.siam.distributed.NoDataException: acquire interrupted at org.mbari.siam.core.PolledInstrumentService.acquire(PolledInstrumentService.java:178) at org.mbari.siam.core.BaseInstrumentService.acquireSample(BaseInstrumentService.java:806) at org.mbari.siam.core.PolledInstrumentService.doScheduledTask(PolledInstrumentService.java:45) at org.mbari.siam.core.ScheduleTaskImpl.execute(ScheduleTaskImpl.java:58) at org.mbari.siam.core.ScheduleTimerTask.run(ScheduleTimerTask.java:54) at org.mbari.siam.core.TimerThread.mainLoop(SiamTimer.java:628) at org.mbari.siam.core.TimerThread.run(SiamTimer.java:573) 518309 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 518309 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS6 518317 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 518317 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 518317 INFO NodeManager [Thread-2]: Done with serviceRemoved() 518318 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 518318 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 518318 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 518319 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS12' 518319 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 518319 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 518472 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 518472 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS12 518478 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 518478 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 518479 INFO NodeManager [Thread-2]: Done with serviceRemoved() 518479 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 518479 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 518480 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 518480 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS13' 518481 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 518481 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 518835 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 518836 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS13 518863 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 518864 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 518864 INFO NodeManager [Thread-2]: Done with serviceRemoved() 518867 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 518867 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 518867 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 518867 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS14' 518868 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 518868 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 519333 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 519333 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS14 519340 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 519340 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 519341 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS15' 519341 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 519341 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 519343 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 519343 INFO NodeManager [Thread-2]: Done with serviceRemoved() 519343 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 519343 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 519855 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 519856 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS15 519931 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 519931 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 519931 INFO NodeManager [Thread-2]: Done with serviceRemoved() 519932 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 519932 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 519933 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 519933 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS16' 519933 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 519934 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 520232 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 520232 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS16 520240 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 520240 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 520240 INFO NodeManager [Thread-2]: Done with serviceRemoved() 520241 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 520241 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 520241 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 520242 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS17' 520242 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 520242 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 520766 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 520767 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS17 520791 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 520791 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 520791 INFO NodeManager [Thread-2]: Done with serviceRemoved() 520792 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 520792 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 520793 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 520793 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS19' 520794 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 520794 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 521335 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 521335 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS19 521345 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 521345 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 521345 INFO NodeManager [Thread-2]: Done with serviceRemoved() 521349 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 521349 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 521349 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 521350 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS9' 521350 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 521350 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 521350 WARN PolledInstrumentService [Thread-117]: acquire(): got InterruptedException 526353 INFO BaseInstrumentService [Thread-117]: Didn't remove sampling thread (total of 0 threads) 526354 ERROR PolledInstrumentService [Thread-117]: doScheduledTask: caught NoDataException: org.mbari.siam.distributed.NoDataException: acquire interrupted org.mbari.siam.distributed.NoDataException: acquire interrupted at org.mbari.siam.core.PolledInstrumentService.acquire(PolledInstrumentService.java:178) at org.mbari.siam.core.BaseInstrumentService.acquireSample(BaseInstrumentService.java:806) at org.mbari.siam.core.PolledInstrumentService.doScheduledTask(PolledInstrumentService.java:45) at org.mbari.siam.core.ScheduleTaskImpl.execute(ScheduleTaskImpl.java:58) at org.mbari.siam.core.ScheduleTimerTask.run(ScheduleTimerTask.java:54) at org.mbari.siam.core.TimerThread.mainLoop(SiamTimer.java:628) at org.mbari.siam.core.TimerThread.run(SiamTimer.java:573) 531303 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 531304 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS9 531308 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 531308 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 531308 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on 'CPUTemp' 531309 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 531309 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 531310 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 531311 INFO NodeManager [Thread-2]: Done with serviceRemoved() 531311 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 531311 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 531449 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 531449 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port CPUTemp 531457 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 531463 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 531463 INFO NodeManager [Thread-2]: Done with serviceRemoved() 531464 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 531464 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 531464 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 531464 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: shutting down service on '/dev/ttyS11' 531464 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() 531466 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: Invoke service.shutdown() 531467 ERROR StopWatch [Thread-113]: wait(...) failed: java.lang.InterruptedException: sleep interrupted 536470 INFO BaseInstrumentService [Thread-113]: Didn't remove sampling thread (total of 0 threads) 538437 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: service.shutdown() complete 538438 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: unexportObject() succeeded for service on port /dev/ttyS11 538442 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - postEvent() 538443 INFO NodeManager [Thread-2]: serviceRemoved(): invoke remote callbacks 538443 INFO NodeManager [Thread-2]: Done with serviceRemoved() 538443 INFO DevicePacketAggregator [Thread-8]: serviceRemoved() 538443 INFO DevicePacketAggregator [Thread-8]: done with serviceRemoved() 538444 INFO PortManager [RMI TCP Connection(8)-127.0.0.1]: removeService() - done 538445 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: application shutdown initiated 538445 INFO NodeService [RMI TCP Connection(8)-127.0.0.1]: SIAM application shutdown in 5 seconds 543459 INFO NodeService [Thread-118]: exiting application now