1) Give a description of the problem
I am having issues duplicating a piston I had working in Core that is now not working correctly in WebCore Door is unlocked by user code, light comes on.
2) What is the expected behavior?
When the door is unlocked by user code, a light should come on.
3) What is happening/not happening?
Anytime the door is unlocked the light comes on, either by user code or manual unlock. Smartthings sees the information come in as manual unlock vs code based unlock.
**4) Post a Green Snapshot of the piston!
5) Attach any logs (From ST IDE and by turning logging level to Full)
916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:25:00 PM: info ╔ Event processed successfully (364ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:24:59 PM: info ╚ Received event [2nd Floor Motion].motion = active with a delay of 108ms 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:25:00 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:25:00 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:25:00 PM: debug partition: 1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:25:00 PM: debug getChildDevices(false), children=12 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:24:59 PM: debug sending smart home monitor: off for status: forceready 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:25:00 PM: debug Partition: forceready for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:25:00 PM: debug Partition: forceready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:25:00 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:24:59 PM: debug motionOrContactHandler(2nd Floor Motion motion:active) 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:24:59 PM: debug Not in day/time window 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:24:59 PM: debug startTime: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500, t0: Wed Oct 25 02:24:59 UTC 2017 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:24:59 PM: trace motionActiveHandler(motion: active), timeOfDay: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:24:59 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:24:59 PM: debug zone: device 2nd Floor Motion at dsczone3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:24:59 PM: debug zone: 3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:24:59 PM: debug getChildDevices(false), children=12 94bad519-7f31-4149-8e0c-4ebd64fa6e79 10:24:54 PM: debug Parse returned [Nursery Fan is off] 94bad519-7f31-4149-8e0c-4ebd64fa6e79 10:24:54 PM: trace SwitchMultilevelReport 94bad519-7f31-4149-8e0c-4ebd64fa6e79 10:24:54 PM: trace doCreateEvent c8a1a85d-2e32-41a1-805e-a713d1494fa0 10:24:53 PM: debug description is on/off: 1 71006024-a6f0-4c71-b577-84d5109fd377 10:24:52 PM: debug description is on/off: 1 a5fedac9-3aa0-4736-a53f-dbf453e71c14 10:24:52 PM: debug Device data: (192.168.2.52:80) - reporting data: (192.168.2.52:80). a5fedac9-3aa0-4736-a53f-dbf453e71c14 10:24:50 PM: debug Device data: (192.168.2.129:80) - reporting data: (192.168.2.129:80). a5fedac9-3aa0-4736-a53f-dbf453e71c14 10:24:49 PM: debug Device data: (192.168.2.56:80) - reporting data: (192.168.2.56:80). d95cdda2-bd53-479b-8ec2-2fb5d3e59114 10:23:50 PM: debug getChildDevices(false), children=0 d95cdda2-bd53-479b-8ec2-2fb5d3e59114 10:23:50 PM: debug detecting status for f3925f13-a506-46a8-8697-0b3c452f1352 : false d95cdda2-bd53-479b-8ec2-2fb5d3e59114 10:23:50 PM: trace in ssdpDiscover 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:37 PM: info ╔ Event processed successfully (236ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:37 PM: info ║ Setting up scheduled job for Tue, Oct 24 2017 @ 10:28:37 PM EDT (in 299.997s) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:37 PM: info ╚ Received event [2nd Floor Motion].motion = inactive with a delay of 100ms 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug partition: 1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug getChildDevices(false), children=12 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug sending smart home monitor: off for status: ready 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:23:37 PM: debug Partition: ready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:37 PM: debug motionOrContactHandler(2nd Floor Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug zone: device 2nd Floor Motion at dsczone3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug zone: 3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:37 PM: debug getChildDevices(false), children=12 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:23:31 PM: debug updating TS 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:23:31 PM: debug event from: Dining Room Light, value: off, source: DEVICE, description: null d4bc1aa4-2037-4917-81ed-58029bdb2654 10:23:29 PM: warn ║ Piston waited at a semaphore for 260ms a5cd7705-1115-4b72-8cf1-baaa4539e744 10:23:29 PM: info smartapp_pause called by smartAppName=webCoRE, value=250, smartAppVersionId=af156e13-94fe-4360-ad08-835e5a36b188 f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: info ╔ Event processed successfully (225ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: info ║ Setting up scheduled job for Tue, Oct 24 2017 @ 10:28:29 PM EDT (in 299.996s) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: trace ║╔ Execution stage complete. (29ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: trace ║║ Requesting a wake up for Tue, Oct 24 2017 @ 10:28:29 PM EDT (in 300.0s) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: trace ║║ Executed virtual command [Dining Room Light].wait (0ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: trace ║╚ Execution stage started f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: trace ║ Runtime (41467 bytes) successfully initialized in 77ms (v0.2.0fa.20171011) (176ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:29 PM: info ╚ Received event [Dining Rm Motion].motion = inactive with a delay of 121ms d4bc1aa4-2037-4917-81ed-58029bdb2654 10:23:29 PM: warn ║ Piston waited at a semaphore for 260ms a5cd7705-1115-4b72-8cf1-baaa4539e744 10:23:28 PM: info smartapp_pause called by smartAppName=webCoRE, value=250, smartAppVersionId=af156e13-94fe-4360-ad08-835e5a36b188 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:29 PM: info ╔ Event processed successfully (307ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:28 PM: info ╚ Received event [2nd Floor Motion].motion = active with a delay of 168ms 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:29 PM: debug motionOrContactHandler(Dining Rm Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:29 PM: debug Dining%20Rm%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:29 PM: debug zone: device Dining Rm Motion at dsczone2 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:29 PM: debug zone: 2 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:29 PM: debug getChildDevices(false), children=12 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:28 PM: info ╔ Event processed successfully (249ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:28 PM: info ╚ Received event [2nd Floor Motion].motion = inactive with a delay of 112ms 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:28 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:28 PM: debug motionOrContactHandler(2nd Floor Motion motion:active) 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:28 PM: debug Not in day/time window 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:28 PM: debug startTime: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500, t0: Wed Oct 25 02:23:28 UTC 2017 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:28 PM: trace motionActiveHandler(motion: active), timeOfDay: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug zone: device 2nd Floor Motion at dsczone3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug zone: 3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:23:28 PM: debug Zone: open d4bc1aa4-2037-4917-81ed-58029bdb2654 10:23:28 PM: warn ║ Piston waited at a semaphore for 259ms a5cd7705-1115-4b72-8cf1-baaa4539e744 10:23:27 PM: info smartapp_pause called by smartAppName=webCoRE, value=250, smartAppVersionId=af156e13-94fe-4360-ad08-835e5a36b188 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:28 PM: info ╔ Event processed successfully (504ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:27 PM: info ╚ Received event [2nd Floor Motion].motion = active with a delay of 139ms 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:28 PM: debug motionOrContactHandler(2nd Floor Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug zone: device 2nd Floor Motion at dsczone3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug zone: 3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:28 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:23:28 PM: debug Zone: closed f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: info ╔ Event processed successfully (209ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║╔ Execution stage complete. (51ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║║ Executed [Dining Room Light].on (3ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║║ Executed [Dining Room Light].setLevel (6ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║║ Executed virtual command [Dining Room Light].setVariable (3ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║╚ Execution stage started f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:28 PM: trace ║ Runtime (41465 bytes) successfully initialized in 55ms (v0.2.0fa.20171011) (150ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:23:27 PM: info ╚ Received event [Dining Rm Motion].motion = active with a delay of 92ms 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:23:28 PM: debug Partition: forceready for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:23:28 PM: debug Partition: forceready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:27 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:27 PM: debug motionOrContactHandler(Dining Rm Motion motion:active) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug Dining%20Rm%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug zone: device Dining Rm Motion at dsczone2 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug zone: 2 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug getChildDevices(false), children=12 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:27 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:27 PM: debug motionOrContactHandler(2nd Floor Motion motion:active) 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:27 PM: debug Not in day/time window 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:27 PM: debug startTime: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500, t0: Wed Oct 25 02:23:27 UTC 2017 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:27 PM: trace motionActiveHandler(motion: active), timeOfDay: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug zone: device 2nd Floor Motion at dsczone3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug zone: 3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:27 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:23:27 PM: debug Zone: open 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:27 PM: info ╔ Event processed successfully (263ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:26 PM: info ║ Setting up scheduled job for Tue, Oct 24 2017 @ 10:28:26 PM EDT (in 299.997s) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:26 PM: info ╚ Received event [2nd Floor Motion].motion = inactive with a delay of 110ms 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug partition: 1 is ready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug getChildDevices(false), children=12 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug sending smart home monitor: off for status: ready 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:23:26 PM: debug Partition: ready for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:23:26 PM: debug Partition: ready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:26 PM: debug motionOrContactHandler(2nd Floor Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug zone: device 2nd Floor Motion at dsczone3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug zone: 3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:26 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:23:26 PM: debug Zone: closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug partition: 1 is forceready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug getChildDevices(false), children=12 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug sending smart home monitor: off for status: forceready 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:23:24 PM: debug Partition: forceready for partition: 1 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:24 PM: info ╔ Event processed successfully (259ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:23:24 PM: info ╚ Received event [2nd Floor Motion].motion = active with a delay of 151ms 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:23:24 PM: debug Partition: forceready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:24 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:24 PM: debug motionOrContactHandler(2nd Floor Motion motion:active) 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:24 PM: debug Not in day/time window 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:24 PM: debug startTime: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500, t0: Wed Oct 25 02:23:24 UTC 2017 678912f7-1246-4d5c-bd0b-aee9374c3e3b 10:23:24 PM: trace motionActiveHandler(motion: active), timeOfDay: 2017-09-18T07:00:00.000-0400, endTime: 2016-11-18T10:00:00.000-0500 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug zone: device 2nd Floor Motion at dsczone3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug zone: 3 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:24 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:23:24 PM: debug Zone: open 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: info ╔ Event processed successfully (201ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: trace ║╔ Execution stage complete. (15ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║║ Condition group #1 evaluated false (state changed) (8ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║║ Cancelling condition #1's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║║ Condition #4 evaluated false (7ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║║ Cancelling condition #4's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║║ Comparison (enum) locked gets (string) unlocked = false (1ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: trace ║╚ Execution stage started 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: trace ║ Runtime (37251 bytes) successfully initialized in 79ms (v0.2.0fa.20171011) (176ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: debug ║ RunTime Analysis CS > 14ms > PS > 79ms > PE > 74ms > CE 81bac530-4566-47c1-8062-185f7bb875a8 10:23:17 PM: info ╚ Received event [Front Door Lock].lock = locked with a delay of 2529ms 513164bf-3e58-4782-9c53-3c3b2684b24b 10:23:17 PM: debug updating TS 513164bf-3e58-4782-9c53-3c3b2684b24b 10:23:17 PM: debug event from: Front Door Lock, value: locked, source: DEVICE, description: zw device: 07, command: 9881, payload: 00 71 05 15 01 34a6a7a2-e509-497b-8891-b5d20f4c7d84 10:23:17 PM: error java.lang.NullPointerException: Cannot invoke method isNumber() on null object @ line 359 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:23:15 PM: debug Parsed to ['name':'lock', 'value':'locked', 'descriptionText':Front Door Lock was manually locked, 'data':['type':'manual'], 'isStateChange':true, 'displayed':true, 'linkText':'Front Door Lock'] 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:23:15 PM: debug AlarmReport AlarmReport(alarmLevel: 1, alarmType: 21, eventParameter: [], numberOfEventParameters: 0, zensorNetSourceNodeId: 0, zwaveAlarmEvent: 0, zwaveAlarmStatus: 0, zwaveAlarmType: 0) 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:23:12 PM: debug Partition: ready for partition: 1 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug partition: 1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug getChildDevices(false), children=12 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:23:12 PM: debug Partition: led for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:23:12 PM: debug Partition: led for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:23:12 PM: debug motionOrContactHandler(Front Door contact:closed) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug Front%20Door 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug zone: device Front Door at dsczone17 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug zone: 17 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:23:12 PM: debug getChildDevices(false), children=12 34f1e800-6e53-4869-aac1-317598f19e66 10:23:12 PM: debug Zone: closed 81bac530-4566-47c1-8062-185f7bb875a8 10:23:08 PM: info ╔ Event processed successfully (231ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:23:08 PM: debug ║║ Cancelling condition #4's schedules... 513164bf-3e58-4782-9c53-3c3b2684b24b 10:23:08 PM: debug updating TS 513164bf-3e58-4782-9c53-3c3b2684b24b 10:23:08 PM: debug event from: Front Door Lock, value: unlocked, source: DEVICE, description: zw device: 07, command: 9881, payload: 00 71 05 13 01 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: info ╔ Event processed successfully (214ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: trace ║╔ Execution stage complete. (18ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║║ Condition group #1 evaluated false (state changed) (10ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║║ Cancelling condition #1's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║║ Condition #4 evaluated false (7ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║║ Cancelling condition #4's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║║ Comparison (enum) locked gets (string) unlocked = false (1ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: trace ║╚ Execution stage started 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: trace ║ Runtime (37251 bytes) successfully initialized in 78ms (v0.2.0fa.20171011) (183ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: debug ║ RunTime Analysis CS > 15ms > PS > 78ms > PE > 84ms > CE 81bac530-4566-47c1-8062-185f7bb875a8 10:22:57 PM: info ╚ Received event [Front Door Lock].lock = locked with a delay of 2216ms 513164bf-3e58-4782-9c53-3c3b2684b24b 10:22:57 PM: debug updating TS 513164bf-3e58-4782-9c53-3c3b2684b24b 10:22:57 PM: debug event from: Front Door Lock, value: locked, source: DEVICE, description: zw device: 07, command: 9881, payload: 00 71 05 15 01 34a6a7a2-e509-497b-8891-b5d20f4c7d84 10:22:57 PM: error java.lang.NullPointerException: Cannot invoke method isNumber() on null object @ line 359 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:22:55 PM: debug Parsed to ['name':'lock', 'value':'locked', 'descriptionText':Front Door Lock was manually locked, 'data':['type':'manual'], 'isStateChange':true, 'displayed':true, 'linkText':'Front Door Lock'] 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:22:55 PM: debug AlarmReport AlarmReport(alarmLevel: 1, alarmType: 21, eventParameter: [], numberOfEventParameters: 0, zensorNetSourceNodeId: 0, zwaveAlarmEvent: 0, zwaveAlarmStatus: 0, zwaveAlarmType: 0) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is notready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is notready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: 1 is notready 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug getChildDevices(false), children=12 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug sending smart home monitor: off for status: notready 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:22:54 PM: debug Partition: notready for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:22:54 PM: debug Partition: notready for partition: 1 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: Away Panel device: DSC Away Panel 1 at dscaway1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: Stay Panel device: DSC Stay Panel 1 at dscstay1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug partition: 1 is led 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:54 PM: debug getChildDevices(false), children=12 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:22:54 PM: debug Partition: led for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:22:54 PM: debug Partition: led for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:54 PM: info SHM isActiveSensor(contact:open, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:54 PM: debug motionOrContactHandler(Front Door contact:open) 34f1e800-6e53-4869-aac1-317598f19e66 10:22:54 PM: debug Zone: open 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: trace ║╔ Execution stage complete. (308ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Executed physical command [Living Room Lights].on() (250ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Comparison (time) 80566007 is_between (time) 1508883360000 .. (time) 1508844480000 = true (4ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Condition group #1 evaluated true (state changed) (43ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Cancelling condition #1's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Time restriction check passed 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Condition #4 evaluated true (7ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Cancelling condition #4's schedules... 81bac530-4566-47c1-8062-185f7bb875a8 10:22:45 PM: trace ║╚ Execution stage started 81bac530-4566-47c1-8062-185f7bb875a8 10:22:46 PM: debug ║║ Comparison (enum) unlocked gets (string) unlocked = true (1ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:45 PM: trace ║ Runtime (37256 bytes) successfully initialized in 77ms (v0.2.0fa.20171011) (169ms) 81bac530-4566-47c1-8062-185f7bb875a8 10:22:45 PM: debug ║ RunTime Analysis CS > 15ms > PS > 77ms > PE > 69ms > CE 81bac530-4566-47c1-8062-185f7bb875a8 10:22:45 PM: info ╚ Received event [Front Door Lock].lock = unlocked with a delay of 1968ms 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:22:43 PM: debug Parsed to ['name':'lock', 'value':'unlocked', 'descriptionText':Front Door Lock was manually unlocked, 'data':['type':'manual'], 'isStateChange':true, 'displayed':true, 'linkText':'Front Door Lock'] 4f123a8c-5089-41e3-83be-67fa86f85a2e 10:22:43 PM: debug AlarmReport AlarmReport(alarmLevel: 1, alarmType: 22, eventParameter: [], numberOfEventParameters: 0, zensorNetSourceNodeId: 0, zwaveAlarmEvent: 0, zwaveAlarmStatus: 0, zwaveAlarmType: 0) 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:22:40 PM: debug updating TS 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:22:40 PM: debug event from: Dining Room Light, value: on, source: DEVICE, description: null 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:22:38 PM: info ╔ Event processed successfully (289ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:22:38 PM: info ║ Setting up scheduled job for Tue, Oct 24 2017 @ 10:27:38 PM EDT (in 299.997s) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:22:37 PM: info ╚ Received event [2nd Floor Motion].motion = inactive with a delay of 203ms 23fd0da1-fd1d-449e-a686-0c47d9009ded 10:22:37 PM: debug Partition: ready for partition: 1 025d16a7-55fb-4cf7-9d11-37da7287d3d8 10:22:37 PM: debug Partition: ready for partition: 1 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:37 PM: debug motionOrContactHandler(2nd Floor Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:37 PM: debug 2nd%20Floor%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:37 PM: debug zone: device 2nd Floor Motion at dsczone3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:37 PM: debug zone: 3 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:37 PM: debug getChildDevices(false), children=12 f6f42f7c-8f2d-4c5e-9169-64e980e826ae 10:22:37 PM: debug Zone: closed f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: info ╔ Event processed successfully (274ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: info ║ Setting up scheduled job for Tue, Oct 24 2017 @ 10:27:36 PM EDT (in 299.996s) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: trace ║╔ Execution stage complete. (30ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: trace ║║ Requesting a wake up for Tue, Oct 24 2017 @ 10:27:36 PM EDT (in 300.0s) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: trace ║║ Executed virtual command [Dining Room Light].wait (0ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: trace ║╚ Execution stage started f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: trace ║ Runtime (41468 bytes) successfully initialized in 66ms (v0.2.0fa.20171011) (223ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:36 PM: info ╚ Received event [Dining Rm Motion].motion = inactive with a delay of 96ms 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:36 PM: debug motionOrContactHandler(Dining Rm Motion motion:inactive) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:36 PM: debug Dining%20Rm%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:36 PM: debug zone: device Dining Rm Motion at dsczone2 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:36 PM: debug zone: 2 is closed 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:36 PM: debug getChildDevices(false), children=12 b80a8747-d904-4719-98d6-ce4a87fed0d7 10:22:36 PM: debug Zone: closed f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:35 PM: info ╔ Event processed successfully (290ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:35 PM: trace ║╔ Execution stage complete. (100ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: trace ║║ Executed [Dining Room Light].on (4ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: trace ║║ Executed [Dining Room Light].setLevel (46ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: trace ║║ Executed virtual command [Dining Room Light].setVariable (3ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: trace ║╚ Execution stage started f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: trace ║ Runtime (41467 bytes) successfully initialized in 81ms (v0.2.0fa.20171011) (178ms) f8c33c83-eefc-42aa-a348-ca32c85c087f 10:22:34 PM: info ╚ Received event [Dining Rm Motion].motion = active with a delay of 120ms 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:22:35 PM: debug updating TS 8e3d6b76-057e-4cc3-8f6a-dba3c71fa325 10:22:35 PM: debug event from: Dining Room Light, value: on, source: DEVICE, description: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:34 PM: info SHM isActiveSensor(motion:active, app: off, location: off) = false, locationId: a8944a16-f15a-4f2c-8179-df353d88e0ec, ISA: 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 1ee23fa1-442b-4a84-a9a7-073e5c2b4ded 10:22:34 PM: debug motionOrContactHandler(Dining Rm Motion motion:active) 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:34 PM: debug Dining%20Rm%20Motion 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:34 PM: debug zone: device Dining Rm Motion at dsczone2 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:34 PM: debug zone: 2 is open 9f536a9c-dbc6-4bbc-8040-a22b4155bf32 10:22:34 PM: debug getChildDevices(false), children=12 b80a8747-d904-4719-98d6-ce4a87fed0d7 10:22:34 PM: debug Zone: open 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:22:27 PM: info ╔ Event processed successfully (245ms) 916449d7-46b3-4ed7-980b-5210d2e4b5e0 10:22:26 PM: info ╚ Received event [2nd Floor Motion].motion = active with a delay of 253ms
Screenshot from Smartthings App:
Old Piston in CORE: