[dss-buildreports] Build failed in Hudson: dss-git #13516

[dss-buildreports at forum.digitalstrom.org]

See <http://192.168.1.244:8080/job/dss-git/13516/changes>

Changes:

[Sergey 'Jin' Bostandzhyan]     Values are now returned in result, not message
    
    i.e.: {"ok":true,"result":{"version":"DSS v0.9-dev"}}

[Patrick Stählin]     Fixed indexed access to properties

[Sergey 'Jin' Bostandzhyan]     Removed obsolete ping script
    
    Sending dS485 frames via JS is no longer possible, this script became
    obsolete.

[Johannes Winkelmann]     Merge branch 'integration'

[Sergey 'Jin' Bostandzhyan]     Merge commit 'refs/merge-requests/200' of git://gitorious.digitalstrom.org/dss/dss-mainline into integration

------------------------------------------
[...truncated 1071 lines...]
[2010-11-13 13:20:01][Debug][System] Finalizing ScriptLogger
[2010-11-13 13:20:01][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:01][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:01][Debug][System] kraah
[2010-11-13 13:20:01][Debug][System] Finalizing ScriptLogger
[2010-11-13 13:20:01][Debug][System] Destroying logger with filename: blalog
[2010-11-13 13:20:01][Debug][System] Finalizing ScriptLogger
[2010-11-13 13:20:01][Info][System] EventQueue: New event 'SIGNAL' in queue...
[2010-11-13 13:20:01][Info][System] EventInterpreter: Got event from queue: 'SIGNAL'
[2010-11-13 13:20:01][Debug][System] EventInterpreter:  Parameter 'signum' = '10'
[2010-11-13 13:20:01][Debug][System] EventInterpreter: Subscription 'SIGNAL_internal_relay' matches event
[2010-11-13 13:20:01][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:01][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:01][Info][System] EventInterpreter: Done processing event 'SIGNAL'
[2010-11-13 13:20:01][Debug][System] kraah
[2010-11-13 13:20:01][Debug][System] Finalizing ScriptLogger
[2010-11-13 13:20:01][Debug][System] Destroying logger with filename: blalog
[2010-11-13 13:20:01][Debug][System] Finalizing ScriptLogger
[2010-11-13 13:20:01][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:02][Debug][System] SeriesReader::readFromXML: could not open file: 'idontexistandneverwill.xml'
[2010-11-13 13:20:02][Debug][System] JS: 10
[2010-11-13 13:20:02][Debug][System] JS: 100
....................................................................................................
[2010-11-13 13:20:02][Error][System] PropertySystem::loadFromXML: Could not open file idontexistandneverwill.xml
[2010-11-13 13:20:02][Debug][System] Device 000000000000000000000001 (bus: 65535, zone: 0) is already in group 1
[2010-11-13 13:20:02][Debug][System] Device 000000000000000000000001 (bus: 65535, zone: 0) is already in group 2
[2010-11-13 13:20:02][Debug][System] creating thread for "Apartment"
[2010-11-13 13:20:02][Info][Apartment] ModelMaintenance::execute: Interface is ready, enumerating model
[2010-11-13 13:20:02][Warning][Apartment] Received metering data for unknown meter, discarding
[2010-11-13 13:20:02][Warning][Apartment] Received metering data for unknown meter, discarding
[2010-11-13 13:20:02][Info][Apartment] ******** Finished loading model from dSM(s)...
[2010-11-13 13:20:02][Debug][System] Destroying thread: Apartment
[2010-11-13 13:20:02][Debug][System] creating thread for "Apartment"
[2010-11-13 13:20:02][Info][Apartment] ModelMaintenance::execute: Interface is ready, enumerating model
[2010-11-13 13:20:02][Info][Apartment] ******** Finished loading model from dSM(s)...
[2010-11-13 13:20:02][Debug][System] Destroying thread: Apartment
[2010-11-13 13:20:02][Warning][System] JS: set_by_group: Group not found
[2010-11-13 13:20:02][Warning][System] JS: set_by_zone: Zone not found
[2010-11-13 13:20:02][Warning][System] JS: set_by_group: Group not found
[2010-11-13 13:20:02][Debug][System] JS: dev1
[2010-11-13 13:20:02][Debug][System] JS: lastCalledScene: 0
[2010-11-13 13:20:02][Debug][System] JS: dev2
[2010-11-13 13:20:02][Debug][System] JS: lastCalledScene: 0
[2010-11-13 13:20:02][Info][System] EventQueue: New event 'test' in queue...
[2010-11-13 13:20:02][Debug][System] different nodes
[2010-11-13 13:20:02][Debug][System] creating thread for "TestThreadingThread"
[2010-11-13 13:20:02][Debug][System] creating thread for "TestThreadingThread"
[2010-11-13 13:20:03][Debug][System] thread terminating
[2010-11-13 13:20:03][Debug][System] thread terminating
[2010-11-13 13:20:03][Debug][System] Destroying thread: TestThreadingThread
[2010-11-13 13:20:03][Debug][System] Destroying thread: TestThreadingThread
[2010-11-13 13:20:03][Debug][System] same node
[2010-11-13 13:20:03][Debug][System] creating thread for "TestThreadingThread"
[2010-11-13 13:20:03][Debug][System] creating thread for "TestThreadingThread"
[2010-11-13 13:20:04][Debug][System] thread terminating
[2010-11-13 13:20:04][Debug][System] Destroying thread: TestThreadingThread
[2010-11-13 13:20:04][Debug][System] thread terminating
[2010-11-13 13:20:04][Debug][System] Destroying thread: TestThreadingThread
[2010-11-13 13:20:05][Fatal][System] JS: Property.construct: Could not get/create node 'testing'
[2010-11-13 13:20:05][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event1' in queue...
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'event1'
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'event1'
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event2' in queue...
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'event2'
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'event2'
[2010-11-13 13:20:05][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:05][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:05][Debug][System] RaiseEvent: setting property test2 to defaults to that
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event1' in queue...
[2010-11-13 13:20:05][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'event1'
[2010-11-13 13:20:05][Debug][System] EventInterpreter:  Parameter 'test2' = 'defaults to that'
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'event1'
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event2' in queue...
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'event2'
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'event2'
[2010-11-13 13:20:05][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Loading subscriptions from '/tmp//testsubscriptions_empty.xml'
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Loading subscriptions from 'data/iwillnever_be_a_subscription.xml'
[2010-11-13 13:20:05][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Loading subscriptions from '/tmp//testsubscriptions.xml'
[2010-11-13 13:20:05][Warning][System] EventInterpreter::loadSubscription: could not find plugin for handler-name 'nonexisting'
[2010-11-13 13:20:05][Warning][System] EventInterpreter::loadSubscription: Still generating a subscription but w/o inner parameter
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event1' in queue...
[2010-11-13 13:20:05][Info][System] EventInterpreter: Got event from queue: 'event1'
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Subscription 'event1_raise_event' matches event
[2010-11-13 13:20:05][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:05][Debug][System] RaiseEvent: Event has time
[2010-11-13 13:20:05][Info][System] EventQueue: New event 'event2' in queue...
[2010-11-13 13:20:05][Info][System] EventQueue::scheduleFromEvent: Event has a valid time, rescheduling at 2010-11-13 12:20:06
[2010-11-13 13:20:05][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:05][Info][System] EventInterpreter: Done processing event 'event1'
[2010-11-13 13:20:05][Debug][System] EventRunner: *********
[2010-11-13 13:20:05][Debug][System] number in queue: 1
[2010-11-13 13:20:05][Debug][System] next:   2010-11-13 12:20:06
[2010-11-13 13:20:05][Debug][System] result: 2020-11-13 12:20:05
[2010-11-13 13:20:05][Debug][System] chosen: 2010-11-13 12:20:06
[2010-11-13 13:20:06][Debug][System] vNow:    2010-11-13 12:20:05
[2010-11-13 13:20:06][Debug][System] nextOcc: 2010-11-13 12:20:06; diff:    1
[2010-11-13 13:20:06][Info][System] EventQueue: New event 'event2' in queue...
[2010-11-13 13:20:06][Info][System] EventInterpreter: Got event from queue: 'event2'
[2010-11-13 13:20:06][Info][System] EventInterpreter: Done processing event 'event2'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Loading subscriptions from '/tmp//testsubscriptions_DS485.xml'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'brighter' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'brighter'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'brighter'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] EventInterpreterPluginJavascript::handleEvent: running script idontexistandneverwill.js
[2010-11-13 13:20:07][Error][System] EventInterpreterPluginJavascript::handleEvent:Caught event while running/parsing script 'idontexistandneverwill.js'. Message: Could not open script-file: 'idontexistandneverwill.js'
[2010-11-13 13:20:07][Info][System] Terminating all scripts...
[2010-11-13 13:20:07][Debug][System] All scripts Terminated
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'event1' in queue...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'event1'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'event1'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_other_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue::scheduleFromEvent: Event has a valid time, rescheduling at 2010-11-13 12:20:09
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventQueue::scheduleFromEvent: Event has a valid time, rescheduling at 2010-11-13 12:20:09
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'event2' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'event2'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'event2'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'one' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'one'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'one_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'one'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'one' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'one'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'one_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'one'
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'two' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'two'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'two_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'two'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'reraised_event' in queue...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'reraised_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'reraised_event_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'reraised_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter:  Parameter 'test' = 'bla'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:07][Debug][System] RaiseEvent: setting property test to always testing
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'reraised_event' in queue...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'reraised_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter:  Parameter 'test' = 'always testing'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'reraised_event_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'reraised_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter:  Parameter 'test' = 'bla'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:07][Debug][System] RaiseEvent: setting property test to always testing
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'reraised_event' in queue...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'reraised_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter:  Parameter 'test' = 'bla'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'reraised_event_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'reraised_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] creating thread for "EventInterpreter"
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'my_event' in queue...
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'my_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'my_event_raise_event' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'raise_event' calling...
[2010-11-13 13:20:07][Debug][System] RaiseEvent: setting property test to always testing
[2010-11-13 13:20:07][Info][System] EventQueue: New event 'reraised_event' in queue...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'my_event'
[2010-11-13 13:20:07][Info][System] EventInterpreter: Got event from queue: 'reraised_event'
[2010-11-13 13:20:07][Debug][System] EventInterpreter:  Parameter 'test' = 'always testing'
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Subscription 'reraised_event_internal_relay' matches event
[2010-11-13 13:20:07][Debug][System] EventInterpreter: Found handler 'internal_relay' calling...
[2010-11-13 13:20:07][Debug][System] EventInterpreter: called.
[2010-11-13 13:20:07][Info][System] EventInterpreter: Done processing event 'reraised_event'
[2010-11-13 13:20:07][Debug][System] Destroying thread: EventInterpreter
[2010-11-13 13:20:07][Debug][System] EventInterpreterPluginJavascript::handleEvent: running script /tmp/s1.js
[2010-11-13 13:20:07][Debug][System] EventInterpreterPluginJavascript::handleEvent: running script /tmp/s2.js
[2010-11-13 13:20:07][Debug][System] JS: [NICE]: kraaah!
[2010-11-13 13:20:07][Info][System] Terminating all scripts...
[2010-11-13 13:20:07][Debug][System] All scripts Terminated

*** 1 failure detected in test suite "Master Test Suite"