-
Notifications
You must be signed in to change notification settings - Fork 3
/
Copy pathOZW_Log.txt
796 lines (796 loc) · 65.4 KB
/
OZW_Log.txt
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
237
238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
269
270
271
272
273
274
275
276
277
278
279
280
281
282
283
284
285
286
287
288
289
290
291
292
293
294
295
296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
317
318
319
320
321
322
323
324
325
326
327
328
329
330
331
332
333
334
335
336
337
338
339
340
341
342
343
344
345
346
347
348
349
350
351
352
353
354
355
356
357
358
359
360
361
362
363
364
365
366
367
368
369
370
371
372
373
374
375
376
377
378
379
380
381
382
383
384
385
386
387
388
389
390
391
392
393
394
395
396
397
398
399
400
401
402
403
404
405
406
407
408
409
410
411
412
413
414
415
416
417
418
419
420
421
422
423
424
425
426
427
428
429
430
431
432
433
434
435
436
437
438
439
440
441
442
443
444
445
446
447
448
449
450
451
452
453
454
455
456
457
458
459
460
461
462
463
464
465
466
467
468
469
470
471
472
473
474
475
476
477
478
479
480
481
482
483
484
485
486
487
488
489
490
491
492
493
494
495
496
497
498
499
500
501
502
503
504
505
506
507
508
509
510
511
512
513
514
515
516
517
518
519
520
521
522
523
524
525
526
527
528
529
530
531
532
533
534
535
536
537
538
539
540
541
542
543
544
545
546
547
548
549
550
551
552
553
554
555
556
557
558
559
560
561
562
563
564
565
566
567
568
569
570
571
572
573
574
575
576
577
578
579
580
581
582
583
584
585
586
587
588
589
590
591
592
593
594
595
596
597
598
599
600
601
602
603
604
605
606
607
608
609
610
611
612
613
614
615
616
617
618
619
620
621
622
623
624
625
626
627
628
629
630
631
632
633
634
635
636
637
638
639
640
641
642
643
644
645
646
647
648
649
650
651
652
653
654
655
656
657
658
659
660
661
662
663
664
665
666
667
668
669
670
671
672
673
674
675
676
677
678
679
680
681
682
683
684
685
686
687
688
689
690
691
692
693
694
695
696
697
698
699
700
701
702
703
704
705
706
707
708
709
710
711
712
713
714
715
716
717
718
719
720
721
722
723
724
725
726
727
728
729
730
731
732
733
734
735
736
737
738
739
740
741
742
743
744
745
746
747
748
749
750
751
752
753
754
755
756
757
758
759
760
761
762
763
764
765
766
767
768
769
770
771
772
773
774
775
776
777
778
779
780
781
782
783
784
785
786
787
788
789
790
791
792
793
794
795
796
2018-07-02 20:47:17.429 Always, OpenZwave Version 1.4.2926 Starting Up
2018-07-02 20:47:47.689 Info, Setting Up Provided Network Key for Secure Communications
2018-07-02 20:47:47.689 Warning, Failed - Network Key Not Set
2018-07-02 20:47:47.690 Info, mgr, Added driver for controller /dev/ttyACM0
2018-07-02 20:47:47.690 Info, Opening controller /dev/ttyACM0
2018-07-02 20:47:47.690 Info, Trying to open serial port /dev/ttyACM0 (attempt 1)
2018-07-02 20:47:47.693 Info, Serial port /dev/ttyACM0 opened (attempt 1)
2018-07-02 20:47:47.694 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2018-07-02 20:47:47.694 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2018-07-02 20:47:47.694 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2018-07-02 20:47:47.694 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2018-07-02 20:47:47.695 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2018-07-02 20:47:47.695 Detail,
2018-07-02 20:47:47.695 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2018-07-02 20:47:47.698 Detail, contrlr, Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x33, 0x2e, 0x39, 0x35, 0x00, 0x01, 0x99
2018-07-02 20:47:47.698 Detail,
2018-07-02 20:47:47.698 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2018-07-02 20:47:47.698 Info, contrlr, Static Controller library, version Z-Wave 3.95
2018-07-02 20:47:47.698 Detail, Node045, Expected reply was received
2018-07-02 20:47:47.698 Detail, Node045, Message transaction complete
2018-07-02 20:47:47.698 Detail,
2018-07-02 20:47:47.698 Detail, contrlr, Removing current message
2018-07-02 20:47:47.699 Detail,
2018-07-02 20:47:47.699 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2018-07-02 20:47:47.702 Detail, contrlr, Received: 0x01, 0x08, 0x01, 0x20, 0xf2, 0x10, 0x9d, 0xfd, 0x01, 0x55
2018-07-02 20:47:47.702 Detail,
2018-07-02 20:47:47.702 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xf2109dfd. Our node ID = 1
2018-07-02 20:47:47.702 Detail, Node016, Expected reply was received
2018-07-02 20:47:47.702 Detail, Node016, Message transaction complete
2018-07-02 20:47:47.703 Detail,
2018-07-02 20:47:47.703 Detail, contrlr, Removing current message
2018-07-02 20:47:47.703 Detail,
2018-07-02 20:47:47.703 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2018-07-02 20:47:47.706 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x05, 0x08, 0xf7
2018-07-02 20:47:47.706 Detail,
2018-07-02 20:47:47.706 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2018-07-02 20:47:47.706 Info, contrlr, There is no SUC ID Server (SIS) in this network.
2018-07-02 20:47:47.706 Info, contrlr, The PC controller is a primary controller.
2018-07-02 20:47:47.706 Detail, Node247, Expected reply was received
2018-07-02 20:47:47.706 Detail, Node247, Message transaction complete
2018-07-02 20:47:47.706 Detail,
2018-07-02 20:47:47.706 Detail, contrlr, Removing current message
2018-07-02 20:47:47.707 Detail,
2018-07-02 20:47:47.707 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2018-07-02 20:47:47.712 Detail, contrlr, Received: 0x01, 0x2b, 0x01, 0x07, 0x01, 0x00, 0x00, 0x86, 0x00, 0x01, 0x00, 0x5a, 0xfe, 0x81, 0xff, 0x88, 0x4f, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x00, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0xfb
2018-07-02 20:47:47.712 Detail,
2018-07-02 20:47:47.712 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2018-07-02 20:47:47.712 Info, contrlr, Serial API Version: 1.0
2018-07-02 20:47:47.712 Info, contrlr, Manufacturer ID: 0x0086
2018-07-02 20:47:47.712 Info, contrlr, Product Type: 0x0001
2018-07-02 20:47:47.712 Info, contrlr, Product ID: 0x005a
2018-07-02 20:47:47.713 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2018-07-02 20:47:47.713 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2018-07-02 20:47:47.713 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2018-07-02 20:47:47.713 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2018-07-02 20:47:47.713 Detail, Expected reply was received
2018-07-02 20:47:47.713 Detail, Message transaction complete
2018-07-02 20:47:47.713 Detail,
2018-07-02 20:47:47.713 Detail, contrlr, Removing current message
2018-07-02 20:47:47.714 Detail,
2018-07-02 20:47:47.714 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2018-07-02 20:47:47.716 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac
2018-07-02 20:47:47.716 Detail,
2018-07-02 20:47:47.716 Info, contrlr, Received reply to GET_SUC_NODE_ID. Node ID = 0
2018-07-02 20:47:47.716 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node
2018-07-02 20:47:47.717 Detail, Node172, Expected reply was received
2018-07-02 20:47:47.717 Detail, Node172, Message transaction complete
2018-07-02 20:47:47.717 Detail,
2018-07-02 20:47:47.717 Detail, contrlr, Removing current message
2018-07-02 20:47:47.717 Detail,
2018-07-02 20:47:47.717 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2018-07-02 20:47:47.773 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0x50, 0x6a, 0xd1, 0x64, 0x13, 0x28, 0xc5, 0xc5, 0xb9, 0x91, 0xda, 0x7f, 0x3d, 0xa4, 0x05, 0x7b, 0xb6, 0xa1, 0xed, 0x20, 0x6f, 0x81, 0xfc, 0x2e, 0x2e, 0x44, 0xa7, 0xe2, 0xd8, 0x80, 0x48, 0x63, 0x82
2018-07-02 20:47:47.773 Detail,
2018-07-02 20:47:47.773 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true
2018-07-02 20:47:47.773 Detail, Node032, Expected reply was received
2018-07-02 20:47:47.773 Detail, Node032, Message transaction complete
2018-07-02 20:47:47.773 Detail,
2018-07-02 20:47:47.773 Detail, contrlr, Removing current message
2018-07-02 20:47:47.773 Detail,
2018-07-02 20:47:47.774 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2018-07-02 20:47:47.874 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x02, 0x05, 0x00, 0x1d, 0x03, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x05, 0x00, 0xc7
2018-07-02 20:47:47.875 Detail,
2018-07-02 20:47:47.875 Info, mgr, Driver with Home ID of 0xf2109dfd is now ready.
2018-07-02 20:47:47.875 Info,
2018-07-02 20:47:47.887 Info, Node002, CentralScene - Created 0
2018-07-02 20:47:47.889 Detail, Node002, Queuing (Controller) Delete All Return Routes
2018-07-02 20:47:47.889 Detail, Node002, Queuing (Controller) Assign Return Route
2018-07-02 20:47:47.893 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
2018-07-02 20:47:47.894 Info, contrlr, Node 001 - Known
2018-07-02 20:47:47.894 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2018-07-02 20:47:47.894 Detail, Node001, QueryStage_CacheLoad
2018-07-02 20:47:47.894 Info, Node001, Node Identity Codes: 0086:0001:005a
2018-07-02 20:47:47.894 Detail, Node001, QueryStage_Associations
2018-07-02 20:47:47.894 Detail, Node001, QueryStage_Neighbors
2018-07-02 20:47:47.894 Detail, contrlr, Requesting routing info (neighbor list) for Node 1
2018-07-02 20:47:47.894 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2018-07-02 20:47:47.894 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
2018-07-02 20:47:47.894 Info, contrlr, Node 002 - Known
2018-07-02 20:47:47.894 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2018-07-02 20:47:47.894 Detail, Node002, QueryStage_CacheLoad
2018-07-02 20:47:47.894 Info, Node002, Node Identity Codes: 010f:0203:1000
2018-07-02 20:47:47.894 Info, Node002, NoOperation::Set - Routing=true
2018-07-02 20:47:47.894 Detail, Node002, Queuing (NoOp) NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xca
2018-07-02 20:47:47.894 Detail, Node002, Queuing (Query) Query Stage Complete (CacheLoad)
2018-07-02 20:47:47.894 Detail, Expected reply was received
2018-07-02 20:47:47.895 Detail, Message transaction complete
2018-07-02 20:47:47.895 Detail,
2018-07-02 20:47:47.895 Detail, contrlr, Removing current message
2018-07-02 20:47:47.895 Detail, Node001, Notification: DriverReady
2018-07-02 20:47:47.992 Detail, Node001, Notification: NodeAdded
2018-07-02 20:47:48.922 Detail, Node001, Notification: NodeProtocolInfo
2018-07-02 20:47:48.928 Detail, Node001, Notification: EssentialNodeQueriesComplete
2018-07-02 20:47:48.928 Detail, Node001, Notification: ValueAdded
2018-07-02 20:47:48.933 Detail, Node001, Notification: NodeNaming
2018-07-02 20:47:48.935 Detail, Node002, Notification: NodeAdded
2018-07-02 20:47:49.029 Detail, Node002, Notification: NodeProtocolInfo
2018-07-02 20:47:49.031 Detail, Node002, Notification: EssentialNodeQueriesComplete
2018-07-02 20:47:49.032 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.073 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.080 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.088 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.094 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.095 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.098 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.102 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.103 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.118 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.120 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.126 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.131 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.134 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.143 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.145 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.148 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.153 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.156 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.162 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.167 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.171 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.219 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.248 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.260 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.272 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.279 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.300 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.316 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.326 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.332 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.341 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.350 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.361 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.368 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.373 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.381 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.388 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.392 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.395 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.396 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.398 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.402 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.404 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.407 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.408 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.412 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.414 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.417 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.419 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.421 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.423 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.425 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.434 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.439 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.440 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.442 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.455 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.462 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.468 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.470 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.478 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.609 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.611 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.617 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.619 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.623 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.626 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.632 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.638 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.640 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.647 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.649 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.669 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.741 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.753 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.779 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.798 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.800 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.802 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.809 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.811 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.814 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.815 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.817 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.819 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.821 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.825 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.828 Detail, Node002, Notification: Group
2018-07-02 20:47:49.829 Detail, Node002, Notification: Group
2018-07-02 20:47:49.829 Detail, Node002, Notification: Group
2018-07-02 20:47:49.830 Detail, Node002, Notification: Group
2018-07-02 20:47:49.831 Detail, Node002, Notification: Group
2018-07-02 20:47:49.831 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.834 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.836 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.838 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.841 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.925 Detail, Node002, Notification: ValueAdded
2018-07-02 20:47:49.929 Detail, Node002, Notification: Group
2018-07-02 20:47:49.936 Detail, Node002, Notification: Group
2018-07-02 20:47:49.939 Detail, Node002, Notification: Group
2018-07-02 20:47:49.940 Detail, Node002, Notification: Group
2018-07-02 20:47:49.940 Detail, Node002, Notification: Group
2018-07-02 20:47:49.940 Detail, Node002, Notification: NodeNaming
2018-07-02 20:47:49.987 Detail,
2018-07-02 20:47:49.987 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2018-07-02 20:47:49.989 Detail, contrlr, Received: 0x01, 0x05, 0x01, 0x06, 0x64, 0x0f, 0x96
2018-07-02 20:47:49.989 Detail,
2018-07-02 20:47:49.989 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
2018-07-02 20:47:49.989 Detail, Node015, Expected reply was received
2018-07-02 20:47:49.989 Detail, Node015, Message transaction complete
2018-07-02 20:47:49.989 Detail,
2018-07-02 20:47:49.989 Detail, contrlr, Removing current message
2018-07-02 20:47:49.990 Detail,
2018-07-02 20:47:49.990 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x00) - FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2018-07-02 20:47:49.991 Detail, contrlr, Removing current message
2018-07-02 20:47:49.991 Detail,
2018-07-02 20:47:49.992 Info, Node001, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2018-07-02 20:47:49.996 Detail, Node001, Received: 0x01, 0x20, 0x01, 0x80, 0x02, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x5c
2018-07-02 20:47:49.996 Detail,
2018-07-02 20:47:49.996 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2018-07-02 20:47:49.996 Info, Node001, Neighbors of this node are:
2018-07-02 20:47:49.997 Info, Node001, Node 2
2018-07-02 20:47:49.997 Detail, Expected reply was received
2018-07-02 20:47:49.997 Detail, Message transaction complete
2018-07-02 20:47:49.997 Detail,
2018-07-02 20:47:49.997 Detail, Node001, Removing current message
2018-07-02 20:47:49.997 Detail,
2018-07-02 20:47:49.997 Info, Node002, Sending (NoOp) message (Callback ID=0x0a, Expected Reply=0x13) - NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xca
2018-07-02 20:47:50.005 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.006 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.021 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0a, 0x00, 0x00, 0x02, 0xe3
2018-07-02 20:47:50.022 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0a received (expected 0x0a)
2018-07-02 20:47:50.022 Info, Node002, Request RTT 25 Average Request RTT 25
2018-07-02 20:47:50.022 Detail, Expected callbackId was received
2018-07-02 20:47:50.022 Detail, Expected reply was received
2018-07-02 20:47:50.022 Detail, Message transaction complete
2018-07-02 20:47:50.022 Detail,
2018-07-02 20:47:50.022 Detail, Node002, Removing current message
2018-07-02 20:47:50.022 Detail, Node002, Notification: Notification - NoOperation
2018-07-02 20:47:50.030 Info, Deleting all return routes from node 2
2018-07-02 20:47:50.030 Detail, Node002, Queuing (Command) ControllerCommand_DeleteAllReturnRoutess (Node=2): 0x01, 0x05, 0x00, 0x47, 0x02, 0x0b, 0xb4
2018-07-02 20:47:50.030 Detail, Notification: ControllerCommand - Starting
2018-07-02 20:47:50.031 Detail,
2018-07-02 20:47:50.031 Info, Node002, Sending (Command) message (Callback ID=0x0b, Expected Reply=0x47) - ControllerCommand_DeleteAllReturnRoutess (Node=2): 0x01, 0x05, 0x00, 0x47, 0x02, 0x0b, 0xb4
2018-07-02 20:47:50.040 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x47, 0x01, 0xbc
2018-07-02 20:47:50.040 Detail,
2018-07-02 20:47:50.040 Info, Node002, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE - command in progress
2018-07-02 20:47:50.040 Detail, Notification: ControllerCommand - InProgress
2018-07-02 20:47:50.188 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x47, 0x0b, 0x00, 0xb6
2018-07-02 20:47:50.188 Detail,
2018-07-02 20:47:50.188 Info, Node002, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE for node 2 - SUCCESS
2018-07-02 20:47:50.188 Detail, Expected callbackId was received
2018-07-02 20:47:50.188 Detail, Expected reply was received
2018-07-02 20:47:50.188 Detail, Message transaction complete
2018-07-02 20:47:50.188 Detail,
2018-07-02 20:47:50.188 Detail, Node002, Removing current message
2018-07-02 20:47:50.189 Detail, Notification: ControllerCommand - Completed
2018-07-02 20:47:50.190 Info, Assigning return route from node 2 to node 1
2018-07-02 20:47:50.190 Detail, Node002, Queuing (Command) ControllerCommand_AssignReturnRoute (Node=2): 0x01, 0x06, 0x00, 0x46, 0x02, 0x01, 0x0c, 0xb0
2018-07-02 20:47:50.190 Detail, Notification: ControllerCommand - Starting
2018-07-02 20:47:50.190 Detail,
2018-07-02 20:47:50.190 Info, Node002, Sending (Command) message (Callback ID=0x0c, Expected Reply=0x46) - ControllerCommand_AssignReturnRoute (Node=2): 0x01, 0x06, 0x00, 0x46, 0x02, 0x01, 0x0c, 0xb0
2018-07-02 20:47:50.202 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x46, 0x01, 0xbd
2018-07-02 20:47:50.202 Detail,
2018-07-02 20:47:50.202 Info, Node002, Received reply to FUNC_ID_ZW_ASSIGN_RETURN_ROUTE - command in progress
2018-07-02 20:47:50.202 Detail, Notification: ControllerCommand - InProgress
2018-07-02 20:47:50.520 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x46, 0x0c, 0x00, 0xb0
2018-07-02 20:47:50.520 Detail,
2018-07-02 20:47:50.520 Info, Node002, Received reply to FUNC_ID_ZW_ASSIGN_RETURN_ROUTE for node 2 - SUCCESS
2018-07-02 20:47:50.520 Detail, Expected callbackId was received
2018-07-02 20:47:50.520 Detail, Expected reply was received
2018-07-02 20:47:50.520 Detail, Message transaction complete
2018-07-02 20:47:50.520 Detail,
2018-07-02 20:47:50.520 Detail, Node002, Removing current message
2018-07-02 20:47:50.520 Detail, Notification: ControllerCommand - Completed
2018-07-02 20:47:50.525 Detail, Node001, Query Stage Complete (Neighbors)
2018-07-02 20:47:50.525 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2018-07-02 20:47:50.525 Detail, Node001, QueryStage_Session
2018-07-02 20:47:50.525 Detail, Node001, QueryStage_Dynamic
2018-07-02 20:47:50.525 Detail, Node001, QueryStage_Configuration
2018-07-02 20:47:50.525 Detail, Node001, QueryStage_Complete
2018-07-02 20:47:50.525 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2018-07-02 20:47:50.525 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
2018-07-02 20:47:50.525 Detail, Node001, Notification: NodeQueriesComplete
2018-07-02 20:47:50.527 Detail, Node002, Query Stage Complete (CacheLoad)
2018-07-02 20:47:50.527 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
2018-07-02 20:47:50.527 Detail, Node002, QueryStage_Associations
2018-07-02 20:47:50.527 Info, Node002, Number of association groups reported for node 2 is 5.
2018-07-02 20:47:50.527 Info, Node002, Get MultiChannelAssociation for group 1 of node 2
2018-07-02 20:47:50.527 Detail, Node002, Queuing (Send) MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x01, 0x25, 0x0d, 0x42
2018-07-02 20:47:50.527 Detail, Node002, Queuing (Query) Query Stage Complete (Associations)
2018-07-02 20:47:50.527 Detail,
2018-07-02 20:47:50.527 Info, Node002, Sending (Send) message (Callback ID=0x0d, Expected Reply=0x04) - MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x01, 0x25, 0x0d, 0x42
2018-07-02 20:47:50.536 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.536 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.553 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0d, 0x00, 0x00, 0x02, 0xe4
2018-07-02 20:47:50.553 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0d received (expected 0x0d)
2018-07-02 20:47:50.553 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:47:50.553 Detail, Expected callbackId was received
2018-07-02 20:47:50.564 Detail, Node002, Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x02, 0x06, 0x8e, 0x03, 0x01, 0x01, 0x00, 0x01, 0x7f
2018-07-02 20:47:50.564 Detail,
2018-07-02 20:47:50.564 Info, Node002, Response RTT 36 Average Response RTT 36
2018-07-02 20:47:50.564 Info, Node002, Received Multi Instance Association report from node 2, group 1
2018-07-02 20:47:50.564 Info, Node002, The group contains:
2018-07-02 20:47:50.564 Info, Node002, Node 1
2018-07-02 20:47:50.564 Info, Node002, Get MultiChannelAssociation for group 2 of node 2
2018-07-02 20:47:50.564 Detail, Node002, Queuing (Send) MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x02, 0x25, 0x0e, 0x42
2018-07-02 20:47:50.565 Detail, Node002, Expected reply and command class was received
2018-07-02 20:47:50.565 Detail, Node002, Message transaction complete
2018-07-02 20:47:50.565 Detail,
2018-07-02 20:47:50.565 Detail, Node002, Removing current message
2018-07-02 20:47:50.565 Detail,
2018-07-02 20:47:50.565 Info, Node002, Sending (Send) message (Callback ID=0x0e, Expected Reply=0x04) - MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x02, 0x25, 0x0e, 0x42
2018-07-02 20:47:50.573 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.573 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.590 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0e, 0x00, 0x00, 0x02, 0xe7
2018-07-02 20:47:50.590 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
2018-07-02 20:47:50.590 Info, Node002, Request RTT 25 Average Request RTT 24
2018-07-02 20:47:50.590 Detail, Expected callbackId was received
2018-07-02 20:47:50.601 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x02, 0x05, 0x8e, 0x03, 0x02, 0x05, 0x00, 0x7d
2018-07-02 20:47:50.601 Detail,
2018-07-02 20:47:50.601 Info, Node002, Response RTT 36 Average Response RTT 36
2018-07-02 20:47:50.601 Info, Node002, Received Multi Instance Association report from node 2, group 2
2018-07-02 20:47:50.601 Info, Node002, The group contains:
2018-07-02 20:47:50.601 Info, Node002, Get MultiChannelAssociation for group 3 of node 2
2018-07-02 20:47:50.602 Detail, Node002, Queuing (Send) MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x03, 0x25, 0x0f, 0x42
2018-07-02 20:47:50.602 Detail, Node002, Expected reply and command class was received
2018-07-02 20:47:50.602 Detail, Node002, Message transaction complete
2018-07-02 20:47:50.602 Detail,
2018-07-02 20:47:50.602 Detail, Node002, Removing current message
2018-07-02 20:47:50.602 Detail, Node002, Notification: Group
2018-07-02 20:47:50.606 Detail,
2018-07-02 20:47:50.606 Info, Node002, Sending (Send) message (Callback ID=0x0f, Expected Reply=0x04) - MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x03, 0x25, 0x0f, 0x42
2018-07-02 20:47:50.614 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.614 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.630 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0f, 0x00, 0x00, 0x02, 0xe6
2018-07-02 20:47:50.631 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0f received (expected 0x0f)
2018-07-02 20:47:50.631 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:47:50.631 Detail, Expected callbackId was received
2018-07-02 20:47:50.642 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x02, 0x05, 0x8e, 0x03, 0x03, 0x05, 0x00, 0x7c
2018-07-02 20:47:50.642 Detail,
2018-07-02 20:47:50.642 Info, Node002, Response RTT 36 Average Response RTT 36
2018-07-02 20:47:50.642 Info, Node002, Received Multi Instance Association report from node 2, group 3
2018-07-02 20:47:50.643 Info, Node002, The group contains:
2018-07-02 20:47:50.643 Info, Node002, Get MultiChannelAssociation for group 4 of node 2
2018-07-02 20:47:50.643 Detail, Node002, Queuing (Send) MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x04, 0x25, 0x10, 0x5a
2018-07-02 20:47:50.643 Detail, Node002, Expected reply and command class was received
2018-07-02 20:47:50.643 Detail, Node002, Message transaction complete
2018-07-02 20:47:50.643 Detail,
2018-07-02 20:47:50.643 Detail, Node002, Removing current message
2018-07-02 20:47:50.643 Detail, Node002, Notification: Group
2018-07-02 20:47:50.669 Detail,
2018-07-02 20:47:50.670 Info, Node002, Sending (Send) message (Callback ID=0x10, Expected Reply=0x04) - MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x04, 0x25, 0x10, 0x5a
2018-07-02 20:47:50.679 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.679 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.694 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x10, 0x00, 0x00, 0x02, 0xf9
2018-07-02 20:47:50.694 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x10 received (expected 0x10)
2018-07-02 20:47:50.694 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:47:50.694 Detail, Expected callbackId was received
2018-07-02 20:47:50.706 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x02, 0x05, 0x8e, 0x03, 0x04, 0x05, 0x00, 0x7b
2018-07-02 20:47:50.706 Detail,
2018-07-02 20:47:50.706 Info, Node002, Response RTT 36 Average Response RTT 36
2018-07-02 20:47:50.706 Info, Node002, Received Multi Instance Association report from node 2, group 4
2018-07-02 20:47:50.706 Info, Node002, The group contains:
2018-07-02 20:47:50.706 Info, Node002, Get MultiChannelAssociation for group 5 of node 2
2018-07-02 20:47:50.707 Detail, Node002, Queuing (Send) MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x05, 0x25, 0x11, 0x5a
2018-07-02 20:47:50.707 Detail, Node002, Expected reply and command class was received
2018-07-02 20:47:50.707 Detail, Node002, Message transaction complete
2018-07-02 20:47:50.707 Detail,
2018-07-02 20:47:50.707 Detail, Node002, Removing current message
2018-07-02 20:47:50.707 Detail, Node002, Notification: Group
2018-07-02 20:47:50.709 Detail,
2018-07-02 20:47:50.709 Info, Node002, Sending (Send) message (Callback ID=0x11, Expected Reply=0x04) - MultiChannelAssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x8e, 0x02, 0x05, 0x25, 0x11, 0x5a
2018-07-02 20:47:50.719 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.719 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.734 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x11, 0x00, 0x00, 0x02, 0xf8
2018-07-02 20:47:50.734 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x11 received (expected 0x11)
2018-07-02 20:47:50.734 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:47:50.734 Detail, Expected callbackId was received
2018-07-02 20:47:50.745 Detail, Node002, Received: 0x01, 0x0b, 0x00, 0x04, 0x00, 0x02, 0x05, 0x8e, 0x03, 0x05, 0x05, 0x00, 0x7a
2018-07-02 20:47:50.745 Detail,
2018-07-02 20:47:50.746 Info, Node002, Response RTT 35 Average Response RTT 35
2018-07-02 20:47:50.746 Info, Node002, Received Multi Instance Association report from node 2, group 5
2018-07-02 20:47:50.746 Info, Node002, The group contains:
2018-07-02 20:47:50.746 Info, Node002, Querying associations for node 2 is complete.
2018-07-02 20:47:50.746 Detail, Node002, Expected reply and command class was received
2018-07-02 20:47:50.746 Detail, Node002, Message transaction complete
2018-07-02 20:47:50.746 Detail,
2018-07-02 20:47:50.746 Detail, Node002, Removing current message
2018-07-02 20:47:50.746 Detail, Node002, Notification: Group
2018-07-02 20:47:50.769 Detail, Node002, Query Stage Complete (Associations)
2018-07-02 20:47:50.769 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Neighbors live=1
2018-07-02 20:47:50.770 Detail, Node002, QueryStage_Neighbors
2018-07-02 20:47:50.770 Detail, Requesting routing info (neighbor list) for Node 2
2018-07-02 20:47:50.770 Detail, Node002, Queuing (Command) Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2018-07-02 20:47:50.770 Detail, Node002, Queuing (Query) Query Stage Complete (Neighbors)
2018-07-02 20:47:50.770 Detail,
2018-07-02 20:47:50.770 Info, Node002, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2018-07-02 20:47:50.775 Detail, Node002, Received: 0x01, 0x20, 0x01, 0x80, 0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x5f
2018-07-02 20:47:50.775 Detail,
2018-07-02 20:47:50.775 Info, Node002, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2018-07-02 20:47:50.775 Info, Node002, Neighbors of this node are:
2018-07-02 20:47:50.775 Info, Node002, Node 1
2018-07-02 20:47:50.775 Detail, Expected reply was received
2018-07-02 20:47:50.775 Detail, Message transaction complete
2018-07-02 20:47:50.775 Detail,
2018-07-02 20:47:50.776 Detail, Node002, Removing current message
2018-07-02 20:47:50.776 Detail, Node002, Query Stage Complete (Neighbors)
2018-07-02 20:47:50.776 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2018-07-02 20:47:50.776 Detail, Node002, QueryStage_Session
2018-07-02 20:47:50.776 Detail, Node002, Queuing (Query) SwitchAllCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x27, 0x02, 0x25, 0x12, 0xf7
2018-07-02 20:47:50.776 Info, Node002, CentralScene RequestState: 2
2018-07-02 20:47:50.776 Info, Node002, CentralScene: Not a StaticRequest
2018-07-02 20:47:50.777 Detail, Node002, Queuing (Query) PowerlevelCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x73, 0x02, 0x25, 0x13, 0xa2
2018-07-02 20:47:50.777 Detail, Node002, Queuing (Query) ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x14, 0xa3
2018-07-02 20:47:50.777 Detail, Node002, Queuing (Query) Query Stage Complete (Session)
2018-07-02 20:47:50.777 Detail,
2018-07-02 20:47:50.777 Info, Node002, Sending (Query) message (Callback ID=0x12, Expected Reply=0x04) - SwitchAllCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x27, 0x02, 0x25, 0x12, 0xf7
2018-07-02 20:47:50.788 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:47:50.788 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:47:50.803 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x12, 0x00, 0x00, 0x02, 0xfb
2018-07-02 20:47:50.803 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x12 received (expected 0x12)
2018-07-02 20:47:50.803 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:47:50.803 Detail, Expected callbackId was received
2018-07-02 20:48:00.780 Error, Node002, ERROR: Dropping command, expected response not received after 1 attempt(s)
2018-07-02 20:48:00.780 Detail, Node002, Removing current message
2018-07-02 20:48:00.780 Detail, Node002, Notification: Notification - TimeOut
2018-07-02 20:48:00.787 Detail,
2018-07-02 20:48:00.788 Info, Node002, Sending (Query) message (Callback ID=0x13, Expected Reply=0x04) - PowerlevelCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x73, 0x02, 0x25, 0x13, 0xa2
2018-07-02 20:48:00.795 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:00.796 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:00.812 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x13, 0x00, 0x00, 0x02, 0xfa
2018-07-02 20:48:00.812 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x13 received (expected 0x13)
2018-07-02 20:48:00.812 Info, Node002, Request RTT 24 Average Request RTT 24
2018-07-02 20:48:00.813 Detail, Expected callbackId was received
2018-07-02 20:48:00.823 Detail, Node002, Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x02, 0x04, 0x73, 0x03, 0x00, 0x00, 0x87
2018-07-02 20:48:00.824 Detail,
2018-07-02 20:48:00.824 Info, Node002, Response RTT 35 Average Response RTT 35
2018-07-02 20:48:00.824 Info, Node002, Received a PowerLevel report: PowerLevel=Normal, Timeout=0
2018-07-02 20:48:00.824 Detail, Node002, Initial read of value
2018-07-02 20:48:00.824 Detail, Node002, Initial read of value
2018-07-02 20:48:00.824 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:00.824 Detail, Node002, Message transaction complete
2018-07-02 20:48:00.824 Detail,
2018-07-02 20:48:00.824 Detail, Node002, Removing current message
2018-07-02 20:48:00.824 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:00.835 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:00.845 Detail,
2018-07-02 20:48:00.845 Info, Node002, Sending (Query) message (Callback ID=0x14, Expected Reply=0x04) - ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x14, 0xa3
2018-07-02 20:48:00.853 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:00.854 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:00.870 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x14, 0x00, 0x00, 0x02, 0xfd
2018-07-02 20:48:01.206 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x14 received (expected 0x14)
2018-07-02 20:48:01.206 Info, Node002, Request RTT 361 Average Request RTT 192
2018-07-02 20:48:01.206 Detail, Expected callbackId was received
2018-07-02 20:48:01.208 Detail, Node002, Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x02, 0x04, 0x75, 0x03, 0x00, 0x00, 0x81
2018-07-02 20:48:01.208 Detail,
2018-07-02 20:48:01.208 Info, Node002, Response RTT 363 Average Response RTT 199
2018-07-02 20:48:01.208 Info, Node002, Received a Protection report: Unprotected
2018-07-02 20:48:01.208 Detail, Node002, Initial read of value
2018-07-02 20:48:01.208 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.208 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.208 Detail,
2018-07-02 20:48:01.208 Detail, Node002, Removing current message
2018-07-02 20:48:01.208 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.219 Detail, Node002, Query Stage Complete (Session)
2018-07-02 20:48:01.219 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
2018-07-02 20:48:01.219 Detail, Node002, QueryStage_Dynamic
2018-07-02 20:48:01.219 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=1): SwitchBinaryCmd_Get (Node=2): 0x01, 0x0d, 0x00, 0x13, 0x02, 0x06, 0x60, 0x0d, 0x01, 0x01, 0x25, 0x02, 0x25, 0x15, 0x9f
2018-07-02 20:48:01.220 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=2): SwitchBinaryCmd_Get (Node=2): 0x01, 0x0d, 0x00, 0x13, 0x02, 0x06, 0x60, 0x0d, 0x01, 0x02, 0x25, 0x02, 0x25, 0x16, 0x9f
2018-07-02 20:48:01.220 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=1): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x01, 0x00, 0x25, 0x17, 0x8b
2018-07-02 20:48:01.220 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=1): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x01, 0x10, 0x25, 0x18, 0x94
2018-07-02 20:48:01.220 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=2): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x02, 0x32, 0x01, 0x00, 0x25, 0x19, 0x86
2018-07-02 20:48:01.220 Detail, Node002, Queuing (Send) MultiChannel Encapsulated (instance=2): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x02, 0x32, 0x01, 0x10, 0x25, 0x1a, 0x95
2018-07-02 20:48:01.220 Info, Node002, CentralScene RequestState: 4
2018-07-02 20:48:01.220 Info, Node002, CentralScene: Not a StaticRequest
2018-07-02 20:48:01.221 Detail, Node002, Queuing (Send) AlarmCmd_Get (Node=2): 0x01, 0x0c, 0x00, 0x13, 0x02, 0x05, 0x71, 0x04, 0x00, 0x04, 0x01, 0x25, 0x1b, 0xa9
2018-07-02 20:48:01.221 Detail, Node002, Queuing (Send) AlarmCmd_Get (Node=2): 0x01, 0x0c, 0x00, 0x13, 0x02, 0x05, 0x71, 0x04, 0x00, 0x08, 0x01, 0x25, 0x1c, 0xa2
2018-07-02 20:48:01.221 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic)
2018-07-02 20:48:01.221 Detail,
2018-07-02 20:48:01.221 Info, Node002, Sending (Send) message (Callback ID=0x15, Expected Reply=0x04) - MultiChannel Encapsulated (instance=1): SwitchBinaryCmd_Get (Node=2): 0x01, 0x0d, 0x00, 0x13, 0x02, 0x06, 0x60, 0x0d, 0x01, 0x01, 0x25, 0x02, 0x25, 0x15, 0x9f
2018-07-02 20:48:01.230 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.230 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.246 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x15, 0x00, 0x00, 0x02, 0xfc
2018-07-02 20:48:01.246 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x15 received (expected 0x15)
2018-07-02 20:48:01.246 Info, Node002, Request RTT 24 Average Request RTT 108
2018-07-02 20:48:01.246 Detail, Expected callbackId was received
2018-07-02 20:48:01.257 Detail, Node002, Received: 0x01, 0x0d, 0x00, 0x04, 0x00, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x01, 0x25, 0x03, 0x00, 0xb8
2018-07-02 20:48:01.257 Detail,
2018-07-02 20:48:01.257 Info, Node002, Response RTT 35 Average Response RTT 117
2018-07-02 20:48:01.257 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 1 for Command Class COMMAND_CLASS_SWITCH_BINARY
2018-07-02 20:48:01.257 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 20:48:01.257 Detail, Node002, Initial read of value
2018-07-02 20:48:01.257 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.257 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.257 Detail,
2018-07-02 20:48:01.257 Detail, Node002, Removing current message
2018-07-02 20:48:01.257 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.269 Detail,
2018-07-02 20:48:01.439 Info, Node002, Sending (Send) message (Callback ID=0x16, Expected Reply=0x04) - MultiChannel Encapsulated (instance=2): SwitchBinaryCmd_Get (Node=2): 0x01, 0x0d, 0x00, 0x13, 0x02, 0x06, 0x60, 0x0d, 0x01, 0x02, 0x25, 0x02, 0x25, 0x16, 0x9f
2018-07-02 20:48:01.448 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.449 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.464 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x16, 0x00, 0x00, 0x02, 0xff
2018-07-02 20:48:01.464 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x16 received (expected 0x16)
2018-07-02 20:48:01.464 Info, Node002, Request RTT 24 Average Request RTT 66
2018-07-02 20:48:01.464 Detail, Expected callbackId was received
2018-07-02 20:48:01.476 Detail, Node002, Received: 0x01, 0x0d, 0x00, 0x04, 0x00, 0x02, 0x07, 0x60, 0x0d, 0x02, 0x01, 0x25, 0x03, 0x00, 0xbb
2018-07-02 20:48:01.476 Detail,
2018-07-02 20:48:01.476 Info, Node002, Response RTT 36 Average Response RTT 76
2018-07-02 20:48:01.476 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 2 for Command Class COMMAND_CLASS_SWITCH_BINARY
2018-07-02 20:48:01.476 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 20:48:01.476 Detail, Node002, Initial read of value
2018-07-02 20:48:01.476 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.476 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.476 Detail,
2018-07-02 20:48:01.476 Detail, Node002, Removing current message
2018-07-02 20:48:01.477 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.488 Detail,
2018-07-02 20:48:01.488 Info, Node002, Sending (Send) message (Callback ID=0x17, Expected Reply=0x04) - MultiChannel Encapsulated (instance=1): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x01, 0x00, 0x25, 0x17, 0x8b
2018-07-02 20:48:01.497 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.498 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.514 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x17, 0x00, 0x00, 0x02, 0xfe
2018-07-02 20:48:01.514 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x17 received (expected 0x17)
2018-07-02 20:48:01.514 Info, Node002, Request RTT 25 Average Request RTT 45
2018-07-02 20:48:01.514 Detail, Expected callbackId was received
2018-07-02 20:48:01.527 Detail, Node002, Received: 0x01, 0x14, 0x00, 0x04, 0x00, 0x02, 0x0e, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x02, 0x21, 0x44, 0x00, 0x00, 0x00, 0x0e, 0x00, 0x00, 0xd5
2018-07-02 20:48:01.527 Detail,
2018-07-02 20:48:01.527 Info, Node002, Response RTT 38 Average Response RTT 57
2018-07-02 20:48:01.527 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 1 for Command Class COMMAND_CLASS_METER
2018-07-02 20:48:01.527 Detail, Node002, Initial read of value
2018-07-02 20:48:01.527 Info, Node002, Received Meter report from node 2: Energy=0.14kWh
2018-07-02 20:48:01.527 Detail, Node002, Initial read of value
2018-07-02 20:48:01.527 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.527 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.527 Detail,
2018-07-02 20:48:01.527 Detail, Node002, Removing current message
2018-07-02 20:48:01.528 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.539 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.551 Detail,
2018-07-02 20:48:01.551 Info, Node002, Sending (Send) message (Callback ID=0x18, Expected Reply=0x04) - MultiChannel Encapsulated (instance=1): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x01, 0x10, 0x25, 0x18, 0x94
2018-07-02 20:48:01.580 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.662 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.663 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x18, 0x00, 0x00, 0x02, 0xf1
2018-07-02 20:48:01.664 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x18 received (expected 0x18)
2018-07-02 20:48:01.664 Info, Node002, Request RTT 112 Average Request RTT 78
2018-07-02 20:48:01.664 Detail, Expected callbackId was received
2018-07-02 20:48:01.666 Detail, Node002, Received: 0x01, 0x12, 0x00, 0x04, 0x00, 0x02, 0x0c, 0x60, 0x0d, 0x01, 0x01, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xa9
2018-07-02 20:48:01.666 Detail,
2018-07-02 20:48:01.666 Info, Node002, Response RTT 114 Average Response RTT 85
2018-07-02 20:48:01.666 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 1 for Command Class COMMAND_CLASS_METER
2018-07-02 20:48:01.666 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 20:48:01.666 Detail, Node002, Changes to this value are not verified
2018-07-02 20:48:01.666 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 20:48:01.666 Detail, Node002, Initial read of value
2018-07-02 20:48:01.666 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.666 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.666 Detail,
2018-07-02 20:48:01.667 Detail, Node002, Removing current message
2018-07-02 20:48:01.667 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.701 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.742 Detail,
2018-07-02 20:48:01.833 Info, Node002, Sending (Send) message (Callback ID=0x19, Expected Reply=0x04) - MultiChannel Encapsulated (instance=2): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x02, 0x32, 0x01, 0x00, 0x25, 0x19, 0x86
2018-07-02 20:48:01.842 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.842 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.858 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x19, 0x00, 0x00, 0x03, 0xf1
2018-07-02 20:48:01.859 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x19 received (expected 0x19)
2018-07-02 20:48:01.859 Info, Node002, Request RTT 25 Average Request RTT 51
2018-07-02 20:48:01.859 Detail, Expected callbackId was received
2018-07-02 20:48:01.871 Detail, Node002, Received: 0x01, 0x14, 0x00, 0x04, 0x00, 0x02, 0x0e, 0x60, 0x0d, 0x02, 0x01, 0x32, 0x02, 0x21, 0x44, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0xd8
2018-07-02 20:48:01.871 Detail,
2018-07-02 20:48:01.871 Info, Node002, Response RTT 38 Average Response RTT 61
2018-07-02 20:48:01.872 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 2 for Command Class COMMAND_CLASS_METER
2018-07-02 20:48:01.872 Detail, Node002, Initial read of value
2018-07-02 20:48:01.872 Info, Node002, Received Meter report from node 2: Energy=0.00kWh
2018-07-02 20:48:01.872 Detail, Node002, Initial read of value
2018-07-02 20:48:01.872 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.872 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.872 Detail,
2018-07-02 20:48:01.872 Detail, Node002, Removing current message
2018-07-02 20:48:01.872 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.883 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.889 Detail,
2018-07-02 20:48:01.889 Info, Node002, Sending (Send) message (Callback ID=0x1a, Expected Reply=0x04) - MultiChannel Encapsulated (instance=2): MeterCmd_Get (Node=2): 0x01, 0x0e, 0x00, 0x13, 0x02, 0x07, 0x60, 0x0d, 0x01, 0x02, 0x32, 0x01, 0x10, 0x25, 0x1a, 0x95
2018-07-02 20:48:01.898 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.898 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.914 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1a, 0x00, 0x00, 0x02, 0xf3
2018-07-02 20:48:01.914 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1a received (expected 0x1a)
2018-07-02 20:48:01.914 Info, Node002, Request RTT 24 Average Request RTT 37
2018-07-02 20:48:01.914 Detail, Expected callbackId was received
2018-07-02 20:48:01.927 Detail, Node002, Received: 0x01, 0x12, 0x00, 0x04, 0x00, 0x02, 0x0c, 0x60, 0x0d, 0x02, 0x01, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xaa
2018-07-02 20:48:01.927 Detail,
2018-07-02 20:48:01.927 Info, Node002, Response RTT 37 Average Response RTT 49
2018-07-02 20:48:01.927 Info, Node002, Received a MultiChannelEncap from node 2, endpoint 2 for Command Class COMMAND_CLASS_METER
2018-07-02 20:48:01.927 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 20:48:01.927 Detail, Node002, Changes to this value are not verified
2018-07-02 20:48:01.927 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 20:48:01.927 Detail, Node002, Initial read of value
2018-07-02 20:48:01.927 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.927 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.927 Detail,
2018-07-02 20:48:01.927 Detail, Node002, Removing current message
2018-07-02 20:48:01.928 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.941 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:01.955 Detail,
2018-07-02 20:48:01.955 Info, Node002, Sending (Send) message (Callback ID=0x1b, Expected Reply=0x04) - AlarmCmd_Get (Node=2): 0x01, 0x0c, 0x00, 0x13, 0x02, 0x05, 0x71, 0x04, 0x00, 0x04, 0x01, 0x25, 0x1b, 0xa9
2018-07-02 20:48:01.963 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:01.964 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:01.980 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1b, 0x00, 0x00, 0x02, 0xf2
2018-07-02 20:48:01.980 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1b received (expected 0x1b)
2018-07-02 20:48:01.980 Info, Node002, Request RTT 25 Average Request RTT 31
2018-07-02 20:48:01.980 Detail, Expected callbackId was received
2018-07-02 20:48:01.992 Detail, Node002, Received: 0x01, 0x0f, 0x00, 0x04, 0x00, 0x02, 0x09, 0x71, 0x05, 0x00, 0x00, 0x32, 0xff, 0x04, 0xfe, 0x00, 0xbc
2018-07-02 20:48:01.992 Detail,
2018-07-02 20:48:01.992 Info, Node002, Response RTT 36 Average Response RTT 42
2018-07-02 20:48:01.992 Info, Node002, Received Alarm report: type=0, level=0, sensorSrcID=50, type:Heat event:254, status=255
2018-07-02 20:48:01.992 Detail, Node002, Initial read of value
2018-07-02 20:48:01.992 Detail, Node002, Initial read of value
2018-07-02 20:48:01.992 Detail, Node002, Initial read of value
2018-07-02 20:48:01.992 Detail, Node002, Initial read of value
2018-07-02 20:48:01.992 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:01.992 Detail, Node002, Message transaction complete
2018-07-02 20:48:01.992 Detail,
2018-07-02 20:48:01.992 Detail, Node002, Removing current message
2018-07-02 20:48:01.992 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.010 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.027 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.170 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.199 Detail,
2018-07-02 20:48:02.199 Info, Node002, Sending (Send) message (Callback ID=0x1c, Expected Reply=0x04) - AlarmCmd_Get (Node=2): 0x01, 0x0c, 0x00, 0x13, 0x02, 0x05, 0x71, 0x04, 0x00, 0x08, 0x01, 0x25, 0x1c, 0xa2
2018-07-02 20:48:02.208 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2018-07-02 20:48:02.208 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2018-07-02 20:48:02.223 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1c, 0x00, 0x00, 0x02, 0xf5
2018-07-02 20:48:02.224 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1c received (expected 0x1c)
2018-07-02 20:48:02.224 Info, Node002, Request RTT 24 Average Request RTT 27
2018-07-02 20:48:02.224 Detail, Expected callbackId was received
2018-07-02 20:48:02.236 Detail, Node002, Received: 0x01, 0x0f, 0x00, 0x04, 0x00, 0x02, 0x09, 0x71, 0x05, 0x00, 0x00, 0x32, 0xff, 0x08, 0xfe, 0x00, 0xb0
2018-07-02 20:48:02.236 Detail,
2018-07-02 20:48:02.236 Info, Node002, Response RTT 37 Average Response RTT 39
2018-07-02 20:48:02.236 Info, Node002, Received Alarm report: type=0, level=0, sensorSrcID=50, type:Power Management event:254, status=255
2018-07-02 20:48:02.237 Detail, Node002, Refreshed Value: old value=0, new value=0, type=byte
2018-07-02 20:48:02.237 Detail, Node002, Changes to this value are not verified
2018-07-02 20:48:02.237 Detail, Node002, Refreshed Value: old value=0, new value=0, type=byte
2018-07-02 20:48:02.237 Detail, Node002, Changes to this value are not verified
2018-07-02 20:48:02.237 Detail, Node002, Refreshed Value: old value=50, new value=50, type=byte
2018-07-02 20:48:02.237 Detail, Node002, Changes to this value are not verified
2018-07-02 20:48:02.237 Detail, Node002, Initial read of value
2018-07-02 20:48:02.237 Detail, Node002, Expected reply and command class was received
2018-07-02 20:48:02.237 Detail, Node002, Message transaction complete
2018-07-02 20:48:02.237 Detail,
2018-07-02 20:48:02.237 Detail, Node002, Removing current message
2018-07-02 20:48:02.237 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.243 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.249 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.256 Detail, Node002, Notification: ValueChanged
2018-07-02 20:48:02.262 Detail, Node002, Query Stage Complete (Dynamic)
2018-07-02 20:48:02.262 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Configuration live=1
2018-07-02 20:48:02.262 Detail, Node002, QueryStage_Configuration
2018-07-02 20:48:02.262 Detail, Node002, QueryStage_Complete
2018-07-02 20:48:02.262 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2018-07-02 20:48:02.262 Warning, CheckCompletedNodeQueries all=1, deadFound=0 sleepingOnly=1
2018-07-02 20:48:02.262 Info, Node query processing complete.
2018-07-02 20:48:02.262 Detail, Node002, Notification: NodeQueriesComplete
2018-07-02 20:48:02.266 Detail, contrlr, Notification: AllNodesQueried
2018-07-02 21:00:40.746 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2018-07-02 21:00:40.746 Detail,
2018-07-02 21:00:40.746 Info, Node002, Received SwitchBinary report from node 2: level=On
2018-07-02 21:00:40.746 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2018-07-02 21:00:40.747 Detail, Node002, Changes to this value are not verified
2018-07-02 21:00:40.747 Detail, Node002, Notification: ValueChanged
2018-07-02 21:00:43.297 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x41, 0x00, 0x00, 0x9d
2018-07-02 21:00:43.297 Detail,
2018-07-02 21:00:43.297 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:00:43.297 Detail, Node002, Changes to this value are not verified
2018-07-02 21:00:43.297 Info, Node002, Received Meter report from node 2: Power=6.5W
2018-07-02 21:00:43.297 Detail, Node002, Refreshed Value: old value=0.0, new value=6.5, type=decimal
2018-07-02 21:00:43.297 Detail, Node002, Changes to this value are not verified
2018-07-02 21:00:43.298 Detail, Node002, Notification: ValueChanged
2018-07-02 21:00:43.309 Detail, Node002, Notification: ValueChanged
2018-07-02 21:02:42.516 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2018-07-02 21:02:42.516 Detail,
2018-07-02 21:02:42.517 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 21:02:42.517 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2018-07-02 21:02:42.517 Detail, Node002, Changes to this value are not verified
2018-07-02 21:02:42.517 Detail, Node002, Notification: ValueChanged
2018-07-02 21:02:43.298 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xdc
2018-07-02 21:02:43.298 Detail,
2018-07-02 21:02:43.298 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:02:43.298 Detail, Node002, Changes to this value are not verified
2018-07-02 21:02:43.298 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 21:02:43.298 Detail, Node002, Refreshed Value: old value=6.5, new value=0.0, type=decimal
2018-07-02 21:02:43.298 Detail, Node002, Changes to this value are not verified
2018-07-02 21:02:43.299 Detail, Node002, Notification: ValueChanged
2018-07-02 21:02:43.310 Detail, Node002, Notification: ValueChanged
2018-07-02 21:16:45.010 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2018-07-02 21:16:45.011 Detail,
2018-07-02 21:16:45.011 Info, Node002, Received SwitchBinary report from node 2: level=On
2018-07-02 21:16:45.011 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2018-07-02 21:16:45.011 Detail, Node002, Changes to this value are not verified
2018-07-02 21:16:45.011 Detail, Node002, Notification: ValueChanged
2018-07-02 21:16:47.302 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x41, 0x00, 0x00, 0x9d
2018-07-02 21:16:47.303 Detail,
2018-07-02 21:16:47.303 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:16:47.303 Detail, Node002, Changes to this value are not verified
2018-07-02 21:16:47.303 Info, Node002, Received Meter report from node 2: Power=6.5W
2018-07-02 21:16:47.303 Detail, Node002, Refreshed Value: old value=0.0, new value=6.5, type=decimal
2018-07-02 21:16:47.303 Detail, Node002, Changes to this value are not verified
2018-07-02 21:16:47.303 Detail, Node002, Notification: ValueChanged
2018-07-02 21:16:47.316 Detail, Node002, Notification: ValueChanged
2018-07-02 21:18:37.941 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2018-07-02 21:19:41.329 Detail,
2018-07-02 21:19:41.329 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 21:19:41.329 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2018-07-02 21:19:41.329 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.330 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.337 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2018-07-02 21:19:41.338 Detail,
2018-07-02 21:19:41.338 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 21:19:41.338 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.338 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.338 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.344 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2018-07-02 21:19:41.344 Detail,
2018-07-02 21:19:41.344 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 21:19:41.344 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.344 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.344 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.350 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2018-07-02 21:19:41.351 Detail,
2018-07-02 21:19:41.351 Info, Node002, Received SwitchBinary report from node 2: level=Off
2018-07-02 21:19:41.351 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.351 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.351 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.358 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xdc
2018-07-02 21:19:41.358 Detail,
2018-07-02 21:19:41.358 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.359 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.359 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 21:19:41.359 Detail, Node002, Refreshed Value: old value=6.5, new value=0.0, type=decimal
2018-07-02 21:19:41.359 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.359 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.365 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.373 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xdc
2018-07-02 21:19:41.373 Detail,
2018-07-02 21:19:41.373 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.373 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.373 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 21:19:41.374 Detail, Node002, Refreshed Value: old value=0.0, new value=0.0, type=decimal
2018-07-02 21:19:41.374 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.374 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.380 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.388 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xdc
2018-07-02 21:19:41.388 Detail,
2018-07-02 21:19:41.388 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.388 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.388 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 21:19:41.388 Detail, Node002, Refreshed Value: old value=0.0, new value=0.0, type=decimal
2018-07-02 21:19:41.388 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.388 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.394 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.402 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x32, 0x02, 0x21, 0x32, 0x00, 0x00, 0x00, 0x00, 0xdc
2018-07-02 21:19:41.402 Detail,
2018-07-02 21:19:41.402 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:19:41.402 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.402 Info, Node002, Received Meter report from node 2: Power=0.0W
2018-07-02 21:19:41.402 Detail, Node002, Refreshed Value: old value=0.0, new value=0.0, type=decimal
2018-07-02 21:19:41.402 Detail, Node002, Changes to this value are not verified
2018-07-02 21:19:41.403 Detail, Node002, Notification: ValueChanged
2018-07-02 21:19:41.408 Detail, Node002, Notification: ValueChanged
2018-07-02 21:23:54.334 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x32, 0x02, 0x21, 0x44, 0x00, 0x00, 0x00, 0x0e, 0x00, 0x00, 0xb8
2018-07-02 21:23:54.334 Detail,
2018-07-02 21:23:54.334 Detail, Node002, Refreshed Value: old value=false, new value=false, type=bool
2018-07-02 21:23:54.334 Detail, Node002, Changes to this value are not verified
2018-07-02 21:23:54.334 Info, Node002, Received Meter report from node 2: Energy=0.14kWh
2018-07-02 21:23:54.334 Detail, Node002, Refreshed Value: old value=0.14, new value=0.14, type=decimal
2018-07-02 21:23:54.334 Detail, Node002, Changes to this value are not verified
2018-07-02 21:23:54.335 Detail, Node002, Notification: ValueChanged
2018-07-02 21:23:54.348 Detail, Node002, Notification: ValueChanged