Project

General

Profile

hang2.txt

Anonymous, 06/22/2017 08:39 AM

Download (43.2 KB)

 
1
Updating local copy of the accessors repository.
2
In "/Users/cxh/src/ptII11.0.devel/org/terraswarm/accessor/accessors", about to execute:
3
    svn update --non-interactive --trust-server-cert --accept postpone
4
Updating '.':
5
At revision 1896.
6
All Done
7
Updated accessor repository.
8
JSAccessor: urlSpec is https://accessors.org/net/WebSocketServerIcon.xml, but /Users/cxh/src/ptII11.0.devel/org/terraswarm/accessor/accessors/web/net/WebSocketServerIcon.xml exists, so the latter is being read. (This message is printed once per local file.)
9
JSAccessor: urlSpec is https://accessors.org/net/WebSocketServer.js, but /Users/cxh/src/ptII11.0.devel/org/terraswarm/accessor/accessors/web/net/WebSocketServer.js exists, so the latter is being read. (This message is printed once per local file.)
10
JSAccessor: urlSpec is https://accessors.org/net/WebSocketClientIcon.xml, but /Users/cxh/src/ptII11.0.devel/org/terraswarm/accessor/accessors/web/net/WebSocketClientIcon.xml exists, so the latter is being read. (This message is printed once per local file.)
11
JSAccessor: urlSpec is https://accessors.org/net/WebSocketClient.js, but /Users/cxh/src/ptII11.0.devel/org/terraswarm/accessor/accessors/web/net/WebSocketClient.js exists, so the latter is being read. (This message is printed once per local file.)
12
WebSocketServer message(): edu.berkeley.eecs.testlog, typeof message: string
13
GDPHelper.GDPHelper(edu.berkeley.eecs.testlog, 1, edu.berkeley.eecs.gdp-01.gdplogd): 
14
GDPManager: Using configuration files in /Users/cxh/.ep_adm_params
15
GDPManager: gdp settings:
16
swarm.gdp.routers=gdp-03.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu
17
GDP_GCL.java: newGCL(org.terraswarm.gdp.GDP_NAME@501db7b, 1, org.terraswarm.gdp.GDP_NAME@2837f63d)
18
GDP_GCL.java: GDP_GCL(org.terraswarm.gdp.GDP_NAME@501db7b(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils), RO, org.terraswarm.gdp.GDP_NAME@2837f63d(m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U)
19

    
20
>>> gdp_gcl_open(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils)
21
_gdp_lib_init(NULL)
22
	@(#)libgdp 0.7.2 (2017-06-22 08:19) 0134edaa283e25648edcc26d519ec6e47fcf4dca++
23
My GDP routing name = Ch-Htdgp0WuziX1gRIU51HsXoj2OSsvrEVpxkTvsU9g
24
gdp_lib_init: OK
25
Trying Zeroconf:
26
create_new_simple_poll_client: avahi_simple_poll_get: Daemon not running
27
Failed to create client object: Daemon not running
28
gdp_zc_scan: create_new_simple_poll_client failed: No such file or directory
29
gdp_zc_scan failed
30
_gdp_chan_open(gdp-03.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu)
31
Trying gdp-03.eecs.berkeley.edu
32
_gdp_chan_open: trying host gdp-03.eecs.berkeley.edu port 8007
33
_gdp_chan_open: talking to router at gdp-03.eecs.berkeley.edu:8007
34
gdp_event_loop: starting up I/O base loop
35
Inserted events:
36
  0x7fad913c3aa0 [fd  184] Write Persist
37
  0x7fad913c3a20 [fd  184] Read Persist
38
  0x7fad913c3530 [sig 29] Signal Persist
39
  0x7fad913c37c0 [sig 30] Signal Persist
40
  0x7fad8a10df90 [fd  -1] Persist Timeout=1498145614.042465
41
Active events:
42
_gdp_req_new: allocated new pdu @ 0x7fad8a12a1b0
43
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_ADVERTISE
44
gdp_init: OK
45
_gdp_req_new: allocated new pdu @ 0x7fad8a12a1b0
46

    
47
>>> _gdp_invoke(req=0x7fad8a113a50 rid=1): CMD_OPEN_RO (68), gcl@0x7fad915448e0
48
	datum @ 0x7fad8ebfbdc0: recno -1, len 0, no timestamp
49
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_OPEN_RO
50
_gdp_pdu_in(ACK_SUCCESS) => OK
51

    
52
*** Processing ack/nak 128=ACK_SUCCESS from socket 184
53
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_SUCCESS) gcl 0x7fad915448e0
54
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 1]
55
ack_success: received ACK_SUCCESS for CMD_OPEN_RO
56
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 1]
57
    OK [200 = 0xc8]
58
<<< _gdp_invoke(0x7fad8a113a50 rid=1) CMD_OPEN_RO: OK [200 = 0xc8]
59
Opened GCL T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
60
_gdp_req_new: allocated new pdu @ 0x7fad8a12a1b0
61

    
62
>>> _gdp_invoke(req=0x7fad8a113a50 rid=2): CMD_SUBSCRIBE (72), gcl@0x7fad915448e0
63
	datum @ 0x7fad8ebfbdc0: recno 0, len 4, no timestamp
64
00000000 00 00 00 00
65
         ?  ?  ?  ? 
66
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_SUBSCRIBE
67
_gdp_pdu_in(ACK_SUCCESS) => OK
68

    
69
*** Processing ack/nak 128=ACK_SUCCESS from socket 184
70
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_SUCCESS) gcl 0x7fad915448e0
71
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 1]
72
ack_success: received ACK_SUCCESS for CMD_SUBSCRIBE
73
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 1]
74
    OK [200 = 0xc8]
75
<<< _gdp_invoke(0x7fad8a113a50 rid=2) CMD_SUBSCRIBE: OK [200 = 0xc8]
76
Starting subscription poker thread
77
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
78

    
79
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
80
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
81
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
82
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
83
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
84
    OK [205 = 0xcd]
85
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315221, data=[B@1c0404ea, ts=EP_TIME_SPEC(auto-allocated@0x7fad913c3e10 (16 bytes)) {
86
  long tv_sec@0=594be330
87
  int tv_nsec@8=1ebd3f58
88
  float tv_accuracy@c=0.0
89
}}
90
****** received from GDP: {"device":"TEST","pressure_pascals":71600,"humidity_percent":2,"temperature_celcius":98,"light_lux":20,"battery_percent":98,"sequence_number":2,"time":"2017-06-22T15:32:54.666Z"}
91
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
92

    
93
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
94
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
95
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
96
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
97
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
98
    OK [205 = 0xcd]
99
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315222, data=[B@74dbd953, ts=EP_TIME_SPEC(auto-allocated@0x7fad91555e40 (16 bytes)) {
100
  long tv_sec@0=594be331
101
  int tv_nsec@8=1eda9328
102
  float tv_accuracy@c=0.0
103
}}
104
****** received from GDP: {"device":"TEST","pressure_pascals":71900,"humidity_percent":3,"temperature_celcius":97,"light_lux":30,"battery_percent":97,"sequence_number":3,"time":"2017-06-22T15:32:55.666Z"}
105
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
106

    
107
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
108
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
109
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
110
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
111
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
112
    OK [205 = 0xcd]
113
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315223, data=[B@11d5647f, ts=EP_TIME_SPEC(auto-allocated@0x7fad91557820 (16 bytes)) {
114
  long tv_sec@0=594be332
115
  int tv_nsec@8=1ebd2fb8
116
  float tv_accuracy@c=0.0
117
}}
118
****** received from GDP: {"device":"TEST","pressure_pascals":72200,"humidity_percent":4,"temperature_celcius":96,"light_lux":40,"battery_percent":96,"sequence_number":4,"time":"2017-06-22T15:32:56.665Z"}
119
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
120

    
121
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
122
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
123
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
124
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
125
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
126
    OK [205 = 0xcd]
127
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315224, data=[B@5eecdaf2, ts=EP_TIME_SPEC(auto-allocated@0x7fad913cec10 (16 bytes)) {
128
  long tv_sec@0=594be333
129
  int tv_nsec@8=1ead68a8
130
  float tv_accuracy@c=0.0
131
}}
132
****** received from GDP: {"device":"TEST","pressure_pascals":72500,"humidity_percent":5,"temperature_celcius":95,"light_lux":50,"battery_percent":95,"sequence_number":5,"time":"2017-06-22T15:32:57.665Z"}
133
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
134

    
135
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
136
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
137
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
138
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
139
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
140
    OK [205 = 0xcd]
141
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315225, data=[B@6c3c0d45, ts=EP_TIME_SPEC(auto-allocated@0x7fad8efbe2d0 (16 bytes)) {
142
  long tv_sec@0=594be334
143
  int tv_nsec@8=1ea4fc68
144
  float tv_accuracy@c=0.0
145
}}
146
****** received from GDP: {"device":"TEST","pressure_pascals":72800,"humidity_percent":6,"temperature_celcius":94,"light_lux":60,"battery_percent":94,"sequence_number":6,"time":"2017-06-22T15:32:58.665Z"}
147
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
148

    
149
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
150
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
151
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
152
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
153
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
154
    OK [205 = 0xcd]
155
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315226, data=[B@76391a3, ts=EP_TIME_SPEC(auto-allocated@0x7fad8874f390 (16 bytes)) {
156
  long tv_sec@0=594be335
157
  int tv_nsec@8=1eb1e130
158
  float tv_accuracy@c=0.0
159
}}
160
****** received from GDP: {"device":"TEST","pressure_pascals":73100,"humidity_percent":7,"temperature_celcius":93,"light_lux":70,"battery_percent":93,"sequence_number":7,"time":"2017-06-22T15:32:59.665Z"}
161
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
162

    
163
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
164
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
165
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
166
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
167
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
168
    OK [205 = 0xcd]
169
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315227, data=[B@3fe0e0f7, ts=EP_TIME_SPEC(auto-allocated@0x7fad8e91ea80 (16 bytes)) {
170
  long tv_sec@0=594be336
171
  int tv_nsec@8=1ea9c6f8
172
  float tv_accuracy@c=0.0
173
}}
174
****** received from GDP: {"device":"TEST","pressure_pascals":73400,"humidity_percent":8,"temperature_celcius":92,"light_lux":80,"battery_percent":92,"sequence_number":8,"time":"2017-06-22T15:33:00.665Z"}
175
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
176

    
177
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
178
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
179
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
180
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
181
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
182
    OK [205 = 0xcd]
183
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315228, data=[B@6a2ec14e, ts=EP_TIME_SPEC(auto-allocated@0x7fad91559780 (16 bytes)) {
184
  long tv_sec@0=594be337
185
  int tv_nsec@8=1eaadc50
186
  float tv_accuracy@c=0.0
187
}}
188
****** received from GDP: {"device":"TEST","pressure_pascals":73700,"humidity_percent":9,"temperature_celcius":91,"light_lux":90,"battery_percent":91,"sequence_number":9,"time":"2017-06-22T15:33:01.665Z"}
189
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
190

    
191
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
192
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
193
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
194
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
195
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
196
    OK [205 = 0xcd]
197
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315229, data=[B@6674bf6b, ts=EP_TIME_SPEC(auto-allocated@0x7fad8edb1790 (16 bytes)) {
198
  long tv_sec@0=594be338
199
  int tv_nsec@8=1ec0dd20
200
  float tv_accuracy@c=0.0
201
}}
202
****** received from GDP: {"device":"TEST","pressure_pascals":74000,"humidity_percent":10,"temperature_celcius":90,"light_lux":100,"battery_percent":90,"sequence_number":10,"time":"2017-06-22T15:33:02.665Z"}
203
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
204

    
205
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
206
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
207
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
208
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
209
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
210
    OK [205 = 0xcd]
211
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315230, data=[B@7d81d48f, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ea686f0 (16 bytes)) {
212
  long tv_sec@0=594be339
213
  int tv_nsec@8=1ea615a8
214
  float tv_accuracy@c=0.0
215
}}
216
****** received from GDP: {"device":"TEST","pressure_pascals":74300,"humidity_percent":11,"temperature_celcius":89,"light_lux":110,"battery_percent":89,"sequence_number":11,"time":"2017-06-22T15:33:03.665Z"}
217
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
218

    
219
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
220
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
221
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
222
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
223
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
224
    OK [205 = 0xcd]
225
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315231, data=[B@45de6490, ts=EP_TIME_SPEC(auto-allocated@0x7fad91374700 (16 bytes)) {
226
  long tv_sec@0=594be33a
227
  int tv_nsec@8=1eb26dd0
228
  float tv_accuracy@c=0.0
229
}}
230
****** received from GDP: {"device":"TEST","pressure_pascals":74600,"humidity_percent":12,"temperature_celcius":88,"light_lux":120,"battery_percent":88,"sequence_number":12,"time":"2017-06-22T15:33:04.665Z"}
231
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
232

    
233
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
234
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
235
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
236
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
237
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
238
    OK [205 = 0xcd]
239
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315232, data=[B@1aaa9a64, ts=EP_TIME_SPEC(auto-allocated@0x7fad913ba830 (16 bytes)) {
240
  long tv_sec@0=594be33b
241
  int tv_nsec@8=1ea32f78
242
  float tv_accuracy@c=0.0
243
}}
244
****** received from GDP: {"device":"TEST","pressure_pascals":74900,"humidity_percent":13,"temperature_celcius":87,"light_lux":130,"battery_percent":87,"sequence_number":13,"time":"2017-06-22T15:33:05.665Z"}
245
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
246

    
247
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
248
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
249
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
250
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
251
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
252
    OK [205 = 0xcd]
253
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315233, data=[B@69fc1012, ts=EP_TIME_SPEC(auto-allocated@0x7fad913cd740 (16 bytes)) {
254
  long tv_sec@0=594be33c
255
  int tv_nsec@8=1ea0f910
256
  float tv_accuracy@c=0.0
257
}}
258
****** received from GDP: {"device":"TEST","pressure_pascals":75200,"humidity_percent":14,"temperature_celcius":86,"light_lux":140,"battery_percent":86,"sequence_number":14,"time":"2017-06-22T15:33:06.665Z"}
259
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
260

    
261
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
262
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
263
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
264
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
265
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
266
    OK [205 = 0xcd]
267
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315234, data=[B@3176e922, ts=EP_TIME_SPEC(auto-allocated@0x7fad91375fe0 (16 bytes)) {
268
  long tv_sec@0=594be33e
269
  int tv_nsec@8=255674d8
270
  float tv_accuracy@c=0.0
271
}}
272
****** received from GDP: {"device":"TEST","pressure_pascals":71300,"humidity_percent":1,"temperature_celcius":99,"light_lux":10,"battery_percent":99,"sequence_number":1,"time":"2017-06-22T15:33:08.760Z"}
273
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
274

    
275
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
276
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
277
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
278
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
279
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
280
    OK [205 = 0xcd]
281
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315235, data=[B@2f78e31f, ts=EP_TIME_SPEC(auto-allocated@0x7fad913d2f80 (16 bytes)) {
282
  long tv_sec@0=594be33f
283
  int tv_nsec@8=243bc1c0
284
  float tv_accuracy@c=0.0
285
}}
286
****** received from GDP: {"device":"TEST","pressure_pascals":71600,"humidity_percent":2,"temperature_celcius":98,"light_lux":20,"battery_percent":98,"sequence_number":2,"time":"2017-06-22T15:33:09.758Z"}
287
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
288

    
289
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
290
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
291
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
292
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
293
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
294
    OK [205 = 0xcd]
295
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315236, data=[B@9b0209c, ts=EP_TIME_SPEC(auto-allocated@0x7fad913c3e80 (16 bytes)) {
296
  long tv_sec@0=594be340
297
  int tv_nsec@8=24605cd8
298
  float tv_accuracy@c=0.0
299
}}
300
****** received from GDP: {"device":"TEST","pressure_pascals":71900,"humidity_percent":3,"temperature_celcius":97,"light_lux":30,"battery_percent":97,"sequence_number":3,"time":"2017-06-22T15:33:10.757Z"}
301
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
302

    
303
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
304
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
305
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
306
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
307
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
308
    OK [205 = 0xcd]
309
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315237, data=[B@41ded928, ts=EP_TIME_SPEC(auto-allocated@0x7fad91368b60 (16 bytes)) {
310
  long tv_sec@0=594be341
311
  int tv_nsec@8=24263238
312
  float tv_accuracy@c=0.0
313
}}
314
****** received from GDP: {"device":"TEST","pressure_pascals":72200,"humidity_percent":4,"temperature_celcius":96,"light_lux":40,"battery_percent":96,"sequence_number":4,"time":"2017-06-22T15:33:11.757Z"}
315
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
316

    
317
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
318
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
319
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
320
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
321
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
322
    OK [205 = 0xcd]
323
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315238, data=[B@74638393, ts=EP_TIME_SPEC(auto-allocated@0x7fad8eaac950 (16 bytes)) {
324
  long tv_sec@0=594be342
325
  int tv_nsec@8=242dd358
326
  float tv_accuracy@c=0.0
327
}}
328
****** received from GDP: {"device":"TEST","pressure_pascals":72500,"humidity_percent":5,"temperature_celcius":95,"light_lux":50,"battery_percent":95,"sequence_number":5,"time":"2017-06-22T15:33:12.757Z"}
329
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
330

    
331
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
332
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
333
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
334
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
335
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
336
    OK [205 = 0xcd]
337
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315239, data=[B@4f9d5116, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ef69990 (16 bytes)) {
338
  long tv_sec@0=594be343
339
  int tv_nsec@8=242caa78
340
  float tv_accuracy@c=0.0
341
}}
342
****** received from GDP: {"device":"TEST","pressure_pascals":72800,"humidity_percent":6,"temperature_celcius":94,"light_lux":60,"battery_percent":94,"sequence_number":6,"time":"2017-06-22T15:33:13.757Z"}
343
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
344

    
345
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
346
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
347
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
348
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
349
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
350
    OK [205 = 0xcd]
351
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315240, data=[B@1fc15bc7, ts=EP_TIME_SPEC(auto-allocated@0x7fad942228b0 (16 bytes)) {
352
  long tv_sec@0=594be344
353
  int tv_nsec@8=242aca00
354
  float tv_accuracy@c=0.0
355
}}
356
****** received from GDP: {"device":"TEST","pressure_pascals":73100,"humidity_percent":7,"temperature_celcius":93,"light_lux":70,"battery_percent":93,"sequence_number":7,"time":"2017-06-22T15:33:14.757Z"}
357
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
358

    
359
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
360
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
361
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
362
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
363
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
364
    OK [205 = 0xcd]
365
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315241, data=[B@4473e4a0, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ed85010 (16 bytes)) {
366
  long tv_sec@0=594be345
367
  int tv_nsec@8=242eb9d0
368
  float tv_accuracy@c=0.0
369
}}
370
****** received from GDP: {"device":"TEST","pressure_pascals":73400,"humidity_percent":8,"temperature_celcius":92,"light_lux":80,"battery_percent":92,"sequence_number":8,"time":"2017-06-22T15:33:15.757Z"}
371
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
372

    
373
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
374
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
375
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
376
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
377
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
378
    OK [205 = 0xcd]
379
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315242, data=[B@2c6488a6, ts=EP_TIME_SPEC(auto-allocated@0x7fad8e909b90 (16 bytes)) {
380
  long tv_sec@0=594be346
381
  int tv_nsec@8=242e40b8
382
  float tv_accuracy@c=0.0
383
}}
384
****** received from GDP: {"device":"TEST","pressure_pascals":73700,"humidity_percent":9,"temperature_celcius":91,"light_lux":90,"battery_percent":91,"sequence_number":9,"time":"2017-06-22T15:33:16.757Z"}
385
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
386

    
387
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
388
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
389
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
390
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
391
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
392
    OK [205 = 0xcd]
393
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315243, data=[B@9d479dd, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ee9a380 (16 bytes)) {
394
  long tv_sec@0=594be347
395
  int tv_nsec@8=24402aa8
396
  float tv_accuracy@c=0.0
397
}}
398
****** received from GDP: {"device":"TEST","pressure_pascals":74000,"humidity_percent":10,"temperature_celcius":90,"light_lux":100,"battery_percent":90,"sequence_number":10,"time":"2017-06-22T15:33:17.757Z"}
399
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
400

    
401
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
402
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
403
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
404
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
405
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
406
    OK [205 = 0xcd]
407
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315244, data=[B@1c5e1443, ts=EP_TIME_SPEC(auto-allocated@0x7fad8edb2660 (16 bytes)) {
408
  long tv_sec@0=594be348
409
  int tv_nsec@8=243610b8
410
  float tv_accuracy@c=0.0
411
}}
412
****** received from GDP: {"device":"TEST","pressure_pascals":74300,"humidity_percent":11,"temperature_celcius":89,"light_lux":110,"battery_percent":89,"sequence_number":11,"time":"2017-06-22T15:33:18.757Z"}
413
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
414

    
415
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
416
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
417
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
418
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
419
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
420
    OK [205 = 0xcd]
421
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315245, data=[B@47d3a58c, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ef59150 (16 bytes)) {
422
  long tv_sec@0=594be349
423
  int tv_nsec@8=242f7938
424
  float tv_accuracy@c=0.0
425
}}
426
****** received from GDP: {"device":"TEST","pressure_pascals":74600,"humidity_percent":12,"temperature_celcius":88,"light_lux":120,"battery_percent":88,"sequence_number":12,"time":"2017-06-22T15:33:19.757Z"}
427
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
428

    
429
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
430
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
431
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
432
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
433
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
434
    OK [205 = 0xcd]
435
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315246, data=[B@4ffa2468, ts=EP_TIME_SPEC(auto-allocated@0x7fad8efbe2e0 (16 bytes)) {
436
  long tv_sec@0=594be34a
437
  int tv_nsec@8=242f1790
438
  float tv_accuracy@c=0.0
439
}}
440
****** received from GDP: {"device":"TEST","pressure_pascals":74900,"humidity_percent":13,"temperature_celcius":87,"light_lux":130,"battery_percent":87,"sequence_number":13,"time":"2017-06-22T15:33:20.757Z"}
441
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
442

    
443
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
444
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
445
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
446
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
447
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
448
    OK [205 = 0xcd]
449
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315247, data=[B@9da5a2d, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ed66c20 (16 bytes)) {
450
  long tv_sec@0=594be34b
451
  int tv_nsec@8=242deeb0
452
  float tv_accuracy@c=0.0
453
}}
454
****** received from GDP: {"device":"TEST","pressure_pascals":75200,"humidity_percent":14,"temperature_celcius":86,"light_lux":140,"battery_percent":86,"sequence_number":14,"time":"2017-06-22T15:33:21.757Z"}
455
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
456

    
457
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
458
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
459
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
460
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
461
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
462
    OK [205 = 0xcd]
463
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315248, data=[B@537f615f, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ed67ea0 (16 bytes)) {
464
  long tv_sec@0=594be34d
465
  int tv_nsec@8=2afce9d0
466
  float tv_accuracy@c=0.0
467
}}
468
****** received from GDP: {"device":"TEST","pressure_pascals":71300,"humidity_percent":1,"temperature_celcius":99,"light_lux":10,"battery_percent":99,"sequence_number":1,"time":"2017-06-22T15:33:23.853Z"}
469
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
470

    
471
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
472
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
473
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
474
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
475
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
476
    OK [205 = 0xcd]
477
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315249, data=[B@4db8d63c, ts=EP_TIME_SPEC(auto-allocated@0x7fad88625220 (16 bytes)) {
478
  long tv_sec@0=594be34e
479
  int tv_nsec@8=29d1e6f0
480
  float tv_accuracy@c=0.0
481
}}
482
****** received from GDP: {"device":"TEST","pressure_pascals":71600,"humidity_percent":2,"temperature_celcius":98,"light_lux":20,"battery_percent":98,"sequence_number":2,"time":"2017-06-22T15:33:24.851Z"}
483
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
484

    
485
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
486
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
487
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
488
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
489
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
490
    OK [205 = 0xcd]
491
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315250, data=[B@7d74cd3e, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ea92010 (16 bytes)) {
492
  long tv_sec@0=594be34f
493
  int tv_nsec@8=29dbc648
494
  float tv_accuracy@c=0.0
495
}}
496
****** received from GDP: {"device":"TEST","pressure_pascals":71900,"humidity_percent":3,"temperature_celcius":97,"light_lux":30,"battery_percent":97,"sequence_number":3,"time":"2017-06-22T15:33:25.850Z"}
497
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
498

    
499
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
500
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
501
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
502
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
503
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
504
    OK [205 = 0xcd]
505
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315251, data=[B@e79039d, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ee34120 (16 bytes)) {
506
  long tv_sec@0=594be350
507
  int tv_nsec@8=29d80d28
508
  float tv_accuracy@c=0.0
509
}}
510
****** received from GDP: {"device":"TEST","pressure_pascals":72200,"humidity_percent":4,"temperature_celcius":96,"light_lux":40,"battery_percent":96,"sequence_number":4,"time":"2017-06-22T15:33:26.850Z"}
511
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
512

    
513
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
514
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
515
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
516
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
517
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
518
    OK [205 = 0xcd]
519
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315252, data=[B@5fb2d58, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ee84cd0 (16 bytes)) {
520
  long tv_sec@0=594be351
521
  int tv_nsec@8=29cb0538
522
  float tv_accuracy@c=0.0
523
}}
524
****** received from GDP: {"device":"TEST","pressure_pascals":72500,"humidity_percent":5,"temperature_celcius":95,"light_lux":50,"battery_percent":95,"sequence_number":5,"time":"2017-06-22T15:33:27.850Z"}
525
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
526

    
527
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
528
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
529
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
530
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
531
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
532
    OK [205 = 0xcd]
533
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315253, data=[B@5ebd0de4, ts=EP_TIME_SPEC(auto-allocated@0x7fad88403d60 (16 bytes)) {
534
  long tv_sec@0=594be352
535
  int tv_nsec@8=29b71b90
536
  float tv_accuracy@c=0.0
537
}}
538
****** received from GDP: {"device":"TEST","pressure_pascals":72800,"humidity_percent":6,"temperature_celcius":94,"light_lux":60,"battery_percent":94,"sequence_number":6,"time":"2017-06-22T15:33:28.850Z"}
539
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
540

    
541
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
542
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
543
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
544
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
545
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
546
    OK [205 = 0xcd]
547
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315254, data=[B@5f446d2f, ts=EP_TIME_SPEC(auto-allocated@0x7fad8efb1780 (16 bytes)) {
548
  long tv_sec@0=594be353
549
  int tv_nsec@8=29bd16d0
550
  float tv_accuracy@c=0.0
551
}}
552
****** received from GDP: {"device":"TEST","pressure_pascals":73100,"humidity_percent":7,"temperature_celcius":93,"light_lux":70,"battery_percent":93,"sequence_number":7,"time":"2017-06-22T15:33:29.850Z"}
553
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
554

    
555
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
556
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
557
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
558
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
559
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
560
    OK [205 = 0xcd]
561
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315255, data=[B@1967e8b1, ts=EP_TIME_SPEC(auto-allocated@0x7fad8ecf4690 (16 bytes)) {
562
  long tv_sec@0=594be354
563
  int tv_nsec@8=29c53108
564
  float tv_accuracy@c=0.0
565
}}
566
****** received from GDP: {"device":"TEST","pressure_pascals":73400,"humidity_percent":8,"temperature_celcius":92,"light_lux":80,"battery_percent":92,"sequence_number":8,"time":"2017-06-22T15:33:30.851Z"}
567
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
568

    
569
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
570
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
571
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
572
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
573
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
574
    OK [205 = 0xcd]
575
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315256, data=[B@734e7044, ts=EP_TIME_SPEC(auto-allocated@0x7fad9422eb60 (16 bytes)) {
576
  long tv_sec@0=594be355
577
  int tv_nsec@8=29b9e280
578
  float tv_accuracy@c=0.0
579
}}
580
****** received from GDP: {"device":"TEST","pressure_pascals":73700,"humidity_percent":9,"temperature_celcius":91,"light_lux":90,"battery_percent":91,"sequence_number":9,"time":"2017-06-22T15:33:31.850Z"}
581
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
582

    
583
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
584
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
585
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
586
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
587
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
588
    OK [205 = 0xcd]
589
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315257, data=[B@f1f4617, ts=EP_TIME_SPEC(auto-allocated@0x7fad885d8870 (16 bytes)) {
590
  long tv_sec@0=594be356
591
  int tv_nsec@8=29cbe3e0
592
  float tv_accuracy@c=0.0
593
}}
594
****** received from GDP: {"device":"TEST","pressure_pascals":74000,"humidity_percent":10,"temperature_celcius":90,"light_lux":100,"battery_percent":90,"sequence_number":10,"time":"2017-06-22T15:33:32.850Z"}
595
WebSocketClient: Connection closed because model is no longer running. (Thread[TestGDPToWebSocket,1,main])
596
41989 ms. Memory: 662016K Free: 589378K (89%)
597

    
598
>>> gdp_gcl_close(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils)
599
_gdp_req_new: allocated new pdu @ 0x7fad8eff9c20
600

    
601
>>> _gdp_invoke(req=0x7fad8ee22890 rid=0): CMD_CLOSE (69), gcl@0x7fad915448e0
602
	datum @ 0x7fad8eff9ca0: recno -1, len 0, no timestamp
603
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_CLOSE
604
_gdp_pdu_in(ACK_SUCCESS) => OK
605

    
606
*** Processing ack/nak 128=ACK_SUCCESS from socket 184
607
gdp_pdu_proc_resp(0x7fad8ed700e0 ACK_SUCCESS) gcl 0x7fad915448e0
608
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 1]
609
ack_success: received ACK_SUCCESS for CMD_CLOSE
610
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 1]
611
    OK [200 = 0xc8]
612
<<< _gdp_invoke(0x7fad8ee22890 rid=0) CMD_CLOSE: OK [200 = 0xc8]
613
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
614

    
615
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
616
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
617
find_req_in_channel_list: searching
618
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
619
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
620
47610 ms. Memory: 662016K Free: 580106K (88%)
621
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
622

    
623
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
624
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
625
find_req_in_channel_list: searching
626
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
627
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
628
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
629

    
630
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
631
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
632
find_req_in_channel_list: searching
633
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
634
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
635
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
636

    
637
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
638
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
639
find_req_in_channel_list: searching
640
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
641
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
642
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
643

    
644
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
645
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
646
find_req_in_channel_list: searching
647
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
648
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
649
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
650

    
651
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
652
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
653
find_req_in_channel_list: searching
654
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
655
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
656
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
657

    
658
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
659
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
660
find_req_in_channel_list: searching
661
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
662
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
663
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
664

    
665
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
666
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
667
find_req_in_channel_list: searching
668
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
669
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
670
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
671

    
672
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
673
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
674
find_req_in_channel_list: searching
675
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
676
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
677
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
678

    
679
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
680
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
681
find_req_in_channel_list: searching
682
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
683
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
684
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
685

    
686
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
687
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
688
find_req_in_channel_list: searching
689
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
690
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
691
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
692

    
693
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
694
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
695
find_req_in_channel_list: searching
696
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
697
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
698
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
699

    
700
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
701
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
702
find_req_in_channel_list: searching
703
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
704
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
705
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
706

    
707
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
708
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
709
find_req_in_channel_list: searching
710
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
711
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
712
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
713

    
714
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
715
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
716
find_req_in_channel_list: searching
717
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
718
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
719
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
720

    
721
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
722
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
723
find_req_in_channel_list: searching
724
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
725
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
726
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
727

    
728
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
729
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
730
find_req_in_channel_list: searching
731
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
732
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
733
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
734

    
735
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
736
gdp_pdu_proc_resp(0x7fad8a12a1b0 ACK_DATA_CONTENT) gcl 0x0
737
find_req_in_channel_list: searching
738
gdp_pdu_proc_resp: discarding 133 (ACK_DATA_CONTENT) PDU for unknown GCL
739
    T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
740
WebSocketServer message(): edu.berkeley.eecs.testlog, typeof message: string
741
GDPHelper.GDPHelper(edu.berkeley.eecs.testlog, 1, edu.berkeley.eecs.gdp-01.gdplogd): 
742
GDPManager: Using configuration files in /Users/cxh/.ep_adm_params
743
GDPManager: gdp settings:
744
swarm.gdp.routers=gdp-03.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu
745
GDP_GCL.java: newGCL(org.terraswarm.gdp.GDP_NAME@5961f77f, 1, org.terraswarm.gdp.GDP_NAME@4f9602fd)
746
GDP_GCL.java: GDP_GCL(org.terraswarm.gdp.GDP_NAME@5961f77f(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils), RO, org.terraswarm.gdp.GDP_NAME@4f9602fd(m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U)
747

    
748
>>> gdp_gcl_open(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils)
749
_gdp_req_new: allocated new pdu @ 0x7fad8a12a1b0
750

    
751
>>> _gdp_invoke(req=0x7fad8a113a50 rid=3): CMD_OPEN_RO (68), gcl@0x7fad915448e0
752
	datum @ 0x7fad8eff9ca0: recno -1, len 0, no timestamp
753
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_OPEN_RO
754
_gdp_pdu_in(ACK_SUCCESS) => OK
755

    
756
*** Processing ack/nak 128=ACK_SUCCESS from socket 184
757
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_SUCCESS) gcl 0x7fad915448e0
758
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 1]
759
ack_success: received ACK_SUCCESS for CMD_OPEN_RO
760
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 1]
761
    OK [200 = 0xc8]
762
<<< _gdp_invoke(0x7fad8a113a50 rid=3) CMD_OPEN_RO: OK [200 = 0xc8]
763
Opened GCL T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
764
_gdp_req_new: allocated new pdu @ 0x7fad8a12a1b0
765

    
766
>>> _gdp_invoke(req=0x7fad8a113a50 rid=4): CMD_SUBSCRIBE (72), gcl@0x7fad915448e0
767
	datum @ 0x7fad8eff9ca0: recno 0, len 4, no timestamp
768
00000000 00 00 00 00
769
         ?  ?  ?  ? 
770
_gdp_pdu_out, fd = 184, basemd = 0x0: CMD_SUBSCRIBE
771
_gdp_pdu_in(ACK_SUCCESS) => OK
772

    
773
*** Processing ack/nak 128=ACK_SUCCESS from socket 184
774
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_SUCCESS) gcl 0x7fad915448e0
775
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 1]
776
ack_success: received ACK_SUCCESS for CMD_SUBSCRIBE
777
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 1]
778
    OK [200 = 0xc8]
779
<<< _gdp_invoke(0x7fad8a113a50 rid=4) CMD_SUBSCRIBE: OK [200 = 0xc8]
780
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
781

    
782
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
783
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
784
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 1]
785
ack_success: received ACK_DATA_CONTENT for CMD_SUBSCRIBE
786
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 1]
787
    OK [205 = 0xcd]
788
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
789

    
790
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
791
gdp_pdu_proc_resp(0x7fad8eff9c20 ACK_DATA_CONTENT) gcl 0x7fad915448e0
792
gdp_pdu_proc_resp: no req for incoming response
793
PDU@0x7fad8eff9c20: 
794
	v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
795
	dst=Ch-Htdgp0WuziX1gRIU51HsXoj2OSsvrEVpxkTvsU9g
796
	src=T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
797
	rid=2, olen=24, chan=0x7fad913c3950, seqno=0
798
	flags=0xa<HAS_RECNO,HAS_TS>
799
	datum=0x7fad8ebfbdc0, recno=315276, dbuf=0x7fad913f7410, dlen=178
800
GDPHelper.subscribe(): about to call _notifyIncoming {recno=315276, data=[B@5eeca243, ts=EP_TIME_SPEC(auto-allocated@0x7fad913f75e0 (16 bytes)) {
801
  long tv_sec@0=594be36b
802
  int tv_nsec@8=3602f338
803
  float tv_accuracy@c=0.0
804
}}
805
		ts=2017-06-22 15:34:03.906163000Z
806
	sigmdalg=0x0, siglen=0, sig=0x0
807
	total header=128
808
GCL@0x7fad915448e0: T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils
809
	iomode = 1, refcnt = 2, reqs = 0x7fad8a113a50, nrecs = 315276
810
	flags = 0xe<INCACHE,ISLOCKED,INUSE>
811
	freefunc = 0x0, gclmd = 0x0, digest = 0x0
812
	utime = 2017-06-22 15:34:03, x = 0x0
813
****** received from GDP: {"device":"TEST","pressure_pascals":71300,"humidity_percent":1,"temperature_celcius":99,"light_lux":10,"battery_percent":99,"sequence_number":1,"time":"2017-06-22T15:33:54.038Z"}
814
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
815

    
816
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 184
817
WebSocketClient: Connection closed because model is no longer running. (Thread[TestGDPToWebSocket,1,main])
818
47990 ms. Memory: 769024K Free: 567386K (74%)
819

    
820
>>> gdp_gcl_close(T2bu1EV7VRFDM3Ao5ybbtWS8uxPrCOyJngCv0JMcils)