Project

General

Profile

SwarmBox_2.txt

Nima Mousavi, 10/09/2016 10:07 AM

Download (21.4 KB)

 
1
sbuser@unassigned-hostname:~/src/gdp$ apps/gdp-reader -n 1 -D50 edu.berkeley.cs.eric.test.00
2
_gdp_lib_init(NULL)
3
        @(#)libgdp 0.7.2 (2016-10-06 09:17) a69835f590b8b1e2c9c947dee51d22419d035fc5
4
My GDP routing name = 4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
5
gdp_lib_init: OK
6
_gdp_chan_open(gdp-01.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu; gdp-03.eecs.berkeley.edu)
7
Trying gdp-01.eecs.berkeley.edu
8
_gdp_chan_open: trying host gdp-01.eecs.berkeley.edu port 8007
9
successful connect
10
_gdp_chan_open: talking to router at gdp-01.eecs.berkeley.edu:8007
11
_gdp_advertise(1):
12
gdp_datum_new => 0x1000f90
13
_gdp_pdu_new => 0x1000f10
14
_gdp_req_new(gcl=(nil), cmd=CMD_ADVERTISE) => 0x1000e10 (rid=0)
15
_gdp_req_send: req@0x1000e10:
16
    nextrec=0, numrecs=0, chan=0xffedc0
17
    postproc=(nil), sub_cb=(nil), udata=(nil)
18
    state=ACTIVE, stat=OK
19
    act_ts=1970-01-01T00:00:00.000000000Z
20
    flags=0x100<ON_CHAN_LIST>
21
    GCL@(nil): NULL
22
    PDU@0x1000f10:
23
        v=3, ttl=15, rsvd1=0, cmd=1=CMD_ADVERTISE
24
        dst=_wD_AP8A_wD_AP8A_wD_AP8A_wD_AP8A_wD_AP8A_wA
25
        src=(none)
26
        rid=0, olen=0, chan=(nil), seqno=0
27
        flags=0
28
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
29
                ts=(none)
30
        sigmdalg=0x0, siglen=0, sig=(nil)
31
        total header=80
32
_gdp_pdu_out, fd = 7, basemd = (nil):
33
    PDU@0x1000f10:
34
        v=3, ttl=15, rsvd1=0, cmd=1=CMD_ADVERTISE
35
        dst=_wD_AP8A_wD_AP8A_wD_AP8A_wD_AP8A_wD_AP8A_wA
36
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
37
        rid=0, olen=0, chan=(nil), seqno=0
38
        flags=0
39
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
40
                ts=(none)
41
        sigmdalg=0x0, siglen=0, sig=(nil)
42
        total header=80
43
_gdp_pdu_out: sending PDU:
44
00000000 03 0f 00 01 ff 00 ff 00 ff 00 ff 00 ff 00 ff 00
45
00000010 ff 00 ff 00 ff 00 ff 00 ff 00 ff 00 ff 00 ff 00
46
00000020 ff 00 ff 00 e0 8a c9 5e 37 2e e5 50 a1 bb 8d 02
47
00000030 89 71 cc 65 13 b9 e8 ec 0f f5 44 9f 9e 99 5f 21
48
00000040 44 7f 33 da 00 00 00 00 00 00 00 00 00 00 00 00
49
_gdp_req_free(0x1000e10)  state=1, gcl=(nil)
50
_gdp_pdu_free(0x1000f10)
51
gdp_datum_free(0x1000f90)
52
  ... draining 0 bytes
53
_gdp_advertise => OK
54
gdp_init: OK
55
gdp_event_loop: starting up I/O base loop
56
Inserted events:
57
  0xffe9d0 [fd 6] Read Persist
58
  0xffee70 [fd 7] Read Persist
59
  0xffeef8 [fd 7] Write Persist
60
Reading GCL gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
61

    
62
>>> gdp_gcl_open
63
gdp_gcl_cache_get: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM => NULL
64
_gdp_gcl_newhandle => 0x1001120 (gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM)
65
gdp_datum_new => 0x1000f90
66
_gdp_pdu_new => 0x1000f10
67
_gdp_req_new(gcl=0x1001120, cmd=CMD_OPEN_RO) => 0x1000e10 (rid=1)
68

    
69
>>> _gdp_invoke(req=0x1000e10 rid=1): CMD_OPEN_RO (68), gcl@0x1001120
70
        datum @ 0x1000f90: recno -1, len 0, no timestamp
71
_gdp_invoke: sending 68, retries=2
72
_gdp_req_send: req@0x1000e10:
73
    nextrec=0, numrecs=0, chan=0xffedc0
74
    postproc=(nil), sub_cb=(nil), udata=(nil)
75
    state=ACTIVE, stat=OK
76
    act_ts=1970-01-01T00:00:00.000000000Z
77
    flags=0x540<ALLOC_RID,ON_CHAN_LIST,ROUTEFAIL>
78
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
79
        iomode = 1, refcnt = 1, reqs = (nil), nrecs = 0
80
        flags = 0x8<INUSE>
81
    PDU@0x1000f10:
82
        v=3, ttl=15, rsvd1=0, cmd=68=CMD_OPEN_RO
83
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
84
        src=(none)
85
        rid=1, olen=0, chan=(nil), seqno=0
86
        flags=0
87
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
88
                ts=(none)
89
        sigmdalg=0x0, siglen=0, sig=(nil)
90
        total header=80
91
_gdp_gcl_cache_add: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM => 0x1001120
92
_gdp_pdu_out, fd = 7, basemd = (nil):
93
    PDU@0x1000f10:
94
        v=3, ttl=15, rsvd1=0, cmd=68=CMD_OPEN_RO
95
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
96
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
97
        rid=1, olen=0, chan=(nil), seqno=0
98
        flags=0
99
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
100
                ts=(none)
101
        sigmdalg=0x0, siglen=0, sig=(nil)
102
        total header=80
103
_gdp_pdu_out: sending PDU:
104
00000000 03 0f 00 44 80 95 83 56 0f e2 e2 04 a5 95 89 a3
105
00000010 c1 1e 1c 9c e8 f3 d6 08 78 f4 3a ac fe 8a 3c 3f
106
00000020 f1 c1 54 23 e0 8a c9 5e 37 2e e5 50 a1 bb 8d 02
107
00000030 89 71 cc 65 13 b9 e8 ec 0f f5 44 9f 9e 99 5f 21
108
00000040 44 7f 33 da 00 00 00 01 00 00 00 00 00 00 00 00
109
_gdp_invoke: waiting on 0x1000e10
110
gdp_read_cb: fd 7, 201 bytes
111
gdp_datum_new => 0x7f00ac000e30
112
_gdp_pdu_new => 0x7f00ac000db0
113

    
114
        >>>>>  _gdp_pdu_in  >>>>>
115
_gdp_pdu_in: read PDU header:
116
00000000 03 0f 00 80 e0 8a c9 5e 37 2e e5 50 a1 bb 8d 02
117
00000010 89 71 cc 65 13 b9 e8 ec 0f f5 44 9f 9e 99 5f 21
118
00000020 44 7f 33 da 80 95 83 56 0f e2 e2 04 a5 95 89 a3
119
00000030 c1 1e 1c 9c e8 f3 d6 08 78 f4 3a ac fe 8a 3c 3f
120
00000040 f1 c1 54 23 00 00 00 01 00 00 02 02 00 00 00 71
121
00000050 00 00 00 00 00 00 00 01
122
_gdp_pdu_in: reading 113 data bytes (113 available)
123
00000058                         00 03 00 43 54 4d 00 00
124
                                 ?  ?  ?  C  T  M  ?  ?
125
00000060 00 1e 00 43 49 44 00 00 00 1d 00 58 49 44 00 00
126
         ?  ?  ?  C  I  D  ?  ?  ?  ?  ?  X  I  D  ?  ?
127
00000070 00 1c 32 30 31 36 2d 31 30 2d 30 36 54 31 33 3a
128
         ?  ?  2  0  1  6  -  1  0  -  0  6  T  1  3  :
129
00000080 35 34 3a 33 31 2e 37 34 34 36 32 39 30 30 30 5a
130
         5  4  :  3  1  .  7  4  4  6  2  9  0  0  0  Z
131
00000090 65 72 69 63 40 67 64 70 2d 30 34 2e 65 65 63 73
132
         e  r  i  c  @  g  d  p  -  0  4  .  e  e  c  s
133
000000a0 2e 62 65 72 6b 65 6c 65 79 2e 65 64 75 65 64 75
134
         .  b  e  r  k  e  l  e  y  .  e  d  u  e  d  u
135
000000b0 2e 62 65 72 6b 65 6c 65 79 2e 63 73 2e 65 72 69
136
         .  b  e  r  k  e  l  e  y  .  c  s  .  e  r  i
137
000000c0 63 2e 74 65 73 74 2e 30 30
138
         c  .  t  e  s  t  .  0  0
139
_gdp_pdu_in(ACK_SUCCESS) => OK
140
PDU@0x7f00ac000db0:
141
        v=3, ttl=15, rsvd1=0, cmd=128=ACK_SUCCESS
142
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
143
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
144
        rid=1, olen=8, chan=0xffedc0, seqno=0
145
        flags=0x2<HAS_RECNO>
146
        datum=0x7f00ac000e30, recno=1, dbuf=0x7f00ac000ea0, dlen=113
147
                ts=(none)
148
        sigmdalg=0x0, siglen=0, sig=(nil)
149
        total header=96
150

    
151
*** Processing ack/nak 128=ACK_SUCCESS from socket 7
152
_gdp_gcl_touch(0x1001120)
153
gdp_gcl_cache_get: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM =>
154
        0x1001120 refcnt 2
155
gdp_pdu_proc_resp(0x7f00ac000db0 ACK_SUCCESS) gcl 0x1001120
156
gdp_pdu_proc_resp: searching gcl 0x1001120 for rid 1
157
_gdp_req_find(gcl=0x1001120, rid=1)
158
_gdp_req_find(gcl=0x1001120, rid=1) => 0x1000e10, state WAITING
159
gdp_pdu_proc_resp: req@0x1000e10:
160
    nextrec=0, numrecs=0, chan=0xffedc0
161
    postproc=(nil), sub_cb=(nil), udata=(nil)
162
    state=WAITING, stat=OK
163
    act_ts=1970-01-01T00:00:00.000000000Z
164
    flags=0x540<ALLOC_RID,ON_CHAN_LIST,ROUTEFAIL>
165
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
166
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 0
167
        flags = 0xa<INCACHE,INUSE>
168
    PDU@0x1000f10:
169
        v=3, ttl=15, rsvd1=0, cmd=68=CMD_OPEN_RO
170
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
171
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
172
        rid=1, olen=0, chan=(nil), seqno=0
173
        flags=0
174
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
175
                ts=(none)
176
        sigmdalg=0x0, siglen=0, sig=(nil)
177
        total header=80
178
    rPDU@0x7f00ac000db0:
179
        v=3, ttl=15, rsvd1=0, cmd=128=ACK_SUCCESS
180
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
181
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
182
        rid=1, olen=8, chan=0xffedc0, seqno=0
183
        flags=0x2<HAS_RECNO>
184
        datum=0x7f00ac000e30, recno=1, dbuf=0x7f00ac000ea0, dlen=113
185
                ts=(none)
186
        sigmdalg=0x0, siglen=0, sig=(nil)
187
        total header=96
188
_gdp_req_dispatch >>> ACK_SUCCESS (128) [gcl->refcnt 2], req@0x1000e10:
189
    nextrec=0, numrecs=0, chan=0xffedc0
190
    postproc=(nil), sub_cb=(nil), udata=(nil)
191
    state=WAITING, stat=OK
192
    act_ts=2016-10-09T17:06:03.140312000Z
193
    flags=0x540<ALLOC_RID,ON_CHAN_LIST,ROUTEFAIL>
194
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
195
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 0
196
        flags = 0xa<INCACHE,INUSE>
197
    PDU@0x1000f10:
198
        v=3, ttl=15, rsvd1=0, cmd=68=CMD_OPEN_RO
199
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
200
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
201
        rid=1, olen=0, chan=(nil), seqno=0
202
        flags=0
203
        datum=0x1000f90, recno=(none), dbuf=0x1001000, dlen=0
204
                ts=(none)
205
        sigmdalg=0x0, siglen=0, sig=(nil)
206
        total header=80
207
    rPDU@0x7f00ac000db0:
208
        v=3, ttl=15, rsvd1=0, cmd=128=ACK_SUCCESS
209
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
210
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
211
        rid=1, olen=8, chan=0xffedc0, seqno=0
212
        flags=0x2<HAS_RECNO>
213
        datum=0x7f00ac000e30, recno=1, dbuf=0x7f00ac000ea0, dlen=113
214
                ts=(none)
215
        sigmdalg=0x0, siglen=0, sig=(nil)
216
        total header=96
217
ack_success: received ACK_SUCCESS for CMD_OPEN_RO
218
ack_success: reusing old datum for req 0x1000e10
219
   datum @ 0x1000f90: recno -1, len 0, no timestamp
220
gdp_datum_free(0x7f00ac000e30)
221
_gdp_pdu_free(0x1000f10)
222
_gdp_req_dispatch <<< ACK_SUCCESS [gcl->refcnt 2]
223
    OK [67896520 = 0x40c04c8]
224
acknak_from_estat: OK [67896520 = 0x40c04c8] ->
225
        ACK_SUCCESS
226
gdp_pdu_proc_resp(ACK_SUCCESS for CMD_OPEN_RO): OK [67896520 = 0x40c04c8]
227
gdp_pdu_proc_resp: signaling req@0x1000e10:
228
    nextrec=0, numrecs=0, chan=0xffedc0
229
    postproc=(nil), sub_cb=(nil), udata=(nil)
230
    state=WAITING, stat=OK [67896520 = 0x40c04c8]
231
    act_ts=2016-10-09T17:06:03.141038000Z
232
    flags=0x542<DONE,ALLOC_RID,ON_CHAN_LIST,ROUTEFAIL>
233
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
234
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 0
235
        flags = 0xa<INCACHE,INUSE>
236
    PDU@0x7f00ac000db0:
237
        v=3, ttl=15, rsvd1=0, cmd=128=ACK_SUCCESS
238
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
239
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
240
        rid=1, olen=8, chan=0xffedc0, seqno=0
241
        flags=0x2<HAS_RECNO>
242
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=113
243
                ts=(none)
244
        sigmdalg=0x0, siglen=0, sig=(nil)
245
        total header=96
246
gdp_pdu_proc_resp <<< done
247
_gdp_event_trigger_pending(0x1000ef8): empty
248
<<< _gdp_invoke(0x1000e10 rid=1) CMD_OPEN_RO: OK [67896520 = 0x40c04c8]
249
  req@0x1000e10:
250
    nextrec=0, numrecs=0, chan=0xffedc0
251
    postproc=(nil), sub_cb=(nil), udata=(nil)
252
    state=ACTIVE, stat=OK [67896520 = 0x40c04c8]
253
    act_ts=2016-10-09T17:06:03.141038000Z
254
    flags=0x543<ASYNCIO,DONE,ALLOC_RID,ON_CHAN_LIST,ROUTEFAIL>
255
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
256
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 0
257
        flags = 0xa<INCACHE,INUSE>
258
    PDU@0x7f00ac000db0:
259
        v=3, ttl=15, rsvd1=0, cmd=128=ACK_SUCCESS
260
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
261
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
262
        rid=1, olen=8, chan=0xffedc0, seqno=0
263
        flags=0x2<HAS_RECNO>
264
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=113
265
                ts=(none)
266
        sigmdalg=0x0, siglen=0, sig=(nil)
267
        total header=96
268

    
269
_gdp_gclmd_deserialize:
270
  GCLMD@0x1001210: nalloc = 3, nused = 3, databuf = 0x1001290
271
    flags = 0x1<READONLY>
272
    mds = 0x1001240
273
        id = 0043544d, len = 30, flags = 0
274
00000000 32 30 31 36 2d 31 30 2d 30 36 54 31 33 3a 35 34
275
         2  0  1  6  -  1  0  -  0  6  T  1  3  :  5  4
276
00000010 3a 33 31 2e 37 34 34 36 32 39 30 30 30 5a
277
         :  3  1  .  7  4  4  6  2  9  0  0  0  Z
278
        id = 00434944, len = 29, flags = 0
279
00000000 65 72 69 63 40 67 64 70 2d 30 34 2e 65 65 63 73
280
         e  r  i  c  @  g  d  p  -  0  4  .  e  e  c  s
281
00000010 2e 62 65 72 6b 65 6c 65 79 2e 65 64 75
282
         .  b  e  r  k  e  l  e  y  .  e  d  u
283
        id = 00584944, len = 28, flags = 0
284
00000000 65 64 75 2e 62 65 72 6b 65 6c 65 79 2e 63 73 2e
285
         e  d  u  .  b  e  r  k  e  l  e  y  .  c  s  .
286
00000010 65 72 69 63 2e 74 65 73 74 2e 30 30
287
         e  r  i  c  .  t  e  s  t  .  0  0
288
_gdp_req_free(0x1000e10)  state=1, gcl=(nil)
289
_gdp_pdu_free(0x7f00ac000db0)
290
gdp_datum_free(0x1000f90)
291
  ... draining 0 bytes
292
Opened GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
293
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 1
294
        flags = 0xa<INCACHE,INUSE>
295
        freefunc = (nil), gclmd = 0x1001210, digest = (nil)
296
        utime = 2016-10-09 17:06:03, x = (nil)
297
gdp_datum_new => 0x1000f90
298

    
299
>>> gdp_gcl_read
300
gdp_datum_new => 0x7f00ac000e30
301
_gdp_pdu_new => 0x7f00ac000db0
302
_gdp_req_new(gcl=0x1001120, cmd=CMD_READ) => 0x1000e10 (rid=0)
303
gdp_datum_free(0x7f00ac000e30)
304
  ... draining 0 bytes
305

    
306
>>> _gdp_invoke(req=0x1000e10 rid=0): CMD_READ (70), gcl@0x1001120
307
        datum @ 0x1000f90: recno 1, len 0, no timestamp
308
_gdp_invoke: sending 70, retries=2
309
_gdp_req_send: req@0x1000e10:
310
    nextrec=0, numrecs=0, chan=0xffedc0
311
    postproc=(nil), sub_cb=(nil), udata=(nil)
312
    state=ACTIVE, stat=OK
313
    act_ts=2016-10-09T17:06:03.141038000Z
314
    flags=0x100<ON_CHAN_LIST>
315
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
316
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 1
317
        flags = 0xa<INCACHE,INUSE>
318
    PDU@0x7f00ac000db0:
319
        v=3, ttl=15, rsvd1=0, cmd=70=CMD_READ
320
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
321
        src=(none)
322
        rid=0, olen=0, chan=(nil), seqno=0
323
        flags=0
324
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=0
325
                ts=(none)
326
        sigmdalg=0x0, siglen=0, sig=(nil)
327
        total header=88
328
_gdp_gcl_cache_add(0x1001120): already cached
329
_gdp_pdu_out, fd = 7, basemd = (nil):
330
    PDU@0x7f00ac000db0:
331
        v=3, ttl=15, rsvd1=0, cmd=70=CMD_READ
332
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
333
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
334
        rid=0, olen=0, chan=(nil), seqno=0
335
        flags=0
336
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=0
337
                ts=(none)
338
        sigmdalg=0x0, siglen=0, sig=(nil)
339
        total header=88
340
_gdp_pdu_out: sending PDU:
341
00000000 03 0f 00 46 80 95 83 56 0f e2 e2 04 a5 95 89 a3
342
00000010 c1 1e 1c 9c e8 f3 d6 08 78 f4 3a ac fe 8a 3c 3f
343
00000020 f1 c1 54 23 e0 8a c9 5e 37 2e e5 50 a1 bb 8d 02
344
00000030 89 71 cc 65 13 b9 e8 ec 0f f5 44 9f 9e 99 5f 21
345
00000040 44 7f 33 da 00 00 00 00 00 00 02 02 00 00 00 00
346
00000050 00 00 00 00 00 00 00 01
347
_gdp_invoke: waiting on 0x1000e10
348
gdp_read_cb: fd 7, 107 bytes
349
gdp_datum_new => 0x7f00ac000e30
350
_gdp_pdu_new => 0x1000f10
351

    
352
        >>>>>  _gdp_pdu_in  >>>>>
353
_gdp_pdu_in: read PDU header:
354
00000000 03 0f 00 85 e0 8a c9 5e 37 2e e5 50 a1 bb 8d 02
355
00000010 89 71 cc 65 13 b9 e8 ec 0f f5 44 9f 9e 99 5f 21
356
00000020 44 7f 33 da 80 95 83 56 0f e2 e2 04 a5 95 89 a3
357
00000030 c1 1e 1c 9c e8 f3 d6 08 78 f4 3a ac fe 8a 3c 3f
358
00000040 f1 c1 54 23 00 00 00 00 00 00 06 0a 00 00 00 03
359
00000050 00 00 00 00 00 00 00 01 00 00 00 00 57 f6 57 b6
360
00000060 2b 65 9a 98 00 00 00 00
361
_gdp_pdu_in: reading 3 data bytes (3 available)
362
00000068                         6f 6e 65
363
                                 o  n  e
364
_gdp_pdu_in(ACK_DATA_CONTENT) => OK
365
PDU@0x1000f10:
366
        v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
367
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
368
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
369
        rid=0, olen=24, chan=0xffedc0, seqno=0
370
        flags=0xa<HAS_RECNO,HAS_TS>
371
        datum=0x7f00ac000e30, recno=1, dbuf=0x1002a30, dlen=3
372
                ts=2016-10-06T13:55:02.728079000Z
373
        sigmdalg=0x0, siglen=0, sig=(nil)
374
        total header=128
375

    
376
*** Processing ack/nak 133=ACK_DATA_CONTENT from socket 7
377
_gdp_gcl_touch(0x1001120)
378
gdp_gcl_cache_get: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM =>
379
        0x1001120 refcnt 3
380
gdp_pdu_proc_resp(0x1000f10 ACK_DATA_CONTENT) gcl 0x1001120
381
gdp_pdu_proc_resp: searching gcl 0x1001120 for rid 0
382
_gdp_req_find(gcl=0x1001120, rid=0)
383
_gdp_req_find(gcl=0x1001120, rid=0) => 0x1000e10, state WAITING
384
gdp_pdu_proc_resp: req@0x1000e10:
385
    nextrec=0, numrecs=0, chan=0xffedc0
386
    postproc=(nil), sub_cb=(nil), udata=(nil)
387
    state=WAITING, stat=OK
388
    act_ts=2016-10-09T17:06:03.141038000Z
389
    flags=0x100<ON_CHAN_LIST>
390
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
391
        iomode = 1, refcnt = 3, reqs = (nil), nrecs = 1
392
        flags = 0xa<INCACHE,INUSE>
393
    PDU@0x7f00ac000db0:
394
        v=3, ttl=15, rsvd1=0, cmd=70=CMD_READ
395
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
396
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
397
        rid=0, olen=0, chan=(nil), seqno=0
398
        flags=0
399
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=0
400
                ts=(none)
401
        sigmdalg=0x0, siglen=0, sig=(nil)
402
        total header=88
403
    rPDU@0x1000f10:
404
        v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
405
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
406
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
407
        rid=0, olen=24, chan=0xffedc0, seqno=0
408
        flags=0xa<HAS_RECNO,HAS_TS>
409
        datum=0x7f00ac000e30, recno=1, dbuf=0x1002a30, dlen=3
410
                ts=2016-10-06T13:55:02.728079000Z
411
        sigmdalg=0x0, siglen=0, sig=(nil)
412
        total header=128
413
_gdp_req_dispatch >>> ACK_DATA_CONTENT (133) [gcl->refcnt 3], req@0x1000e10:
414
    nextrec=0, numrecs=0, chan=0xffedc0
415
    postproc=(nil), sub_cb=(nil), udata=(nil)
416
    state=WAITING, stat=OK
417
    act_ts=2016-10-09T17:06:03.159382000Z
418
    flags=0x100<ON_CHAN_LIST>
419
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
420
        iomode = 1, refcnt = 3, reqs = (nil), nrecs = 1
421
        flags = 0xa<INCACHE,INUSE>
422
    PDU@0x7f00ac000db0:
423
        v=3, ttl=15, rsvd1=0, cmd=70=CMD_READ
424
        dst=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
425
        src=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
426
        rid=0, olen=0, chan=(nil), seqno=0
427
        flags=0
428
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=0
429
                ts=(none)
430
        sigmdalg=0x0, siglen=0, sig=(nil)
431
        total header=88
432
    rPDU@0x1000f10:
433
        v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
434
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
435
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
436
        rid=0, olen=24, chan=0xffedc0, seqno=0
437
        flags=0xa<HAS_RECNO,HAS_TS>
438
        datum=0x7f00ac000e30, recno=1, dbuf=0x1002a30, dlen=3
439
                ts=2016-10-06T13:55:02.728079000Z
440
        sigmdalg=0x0, siglen=0, sig=(nil)
441
        total header=128
442
ack_success: received ACK_DATA_CONTENT for CMD_READ
443
ack_success: reusing old datum for req 0x1000e10
444
   datum @ 0x1000f90: recno 1, len 0, no timestamp
445
gdp_datum_free(0x7f00ac000e30)
446
_gdp_pdu_free(0x7f00ac000db0)
447
_gdp_req_dispatch <<< ACK_DATA_CONTENT [gcl->refcnt 3]
448
    OK [67896525 = 0x40c04cd]
449
acknak_from_estat: OK [67896525 = 0x40c04cd] ->
450
        ACK_DATA_CONTENT
451
gdp_pdu_proc_resp(ACK_DATA_CONTENT for CMD_READ): OK [67896525 = 0x40c04cd]
452
gdp_pdu_proc_resp: signaling req@0x1000e10:
453
    nextrec=0, numrecs=0, chan=0xffedc0
454
    postproc=(nil), sub_cb=(nil), udata=(nil)
455
    state=WAITING, stat=OK [67896525 = 0x40c04cd]
456
    act_ts=2016-10-09T17:06:03.159569000Z
457
    flags=0x102<DONE,ON_CHAN_LIST>
458
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
459
        iomode = 1, refcnt = 3, reqs = (nil), nrecs = 1
460
        flags = 0xa<INCACHE,INUSE>
461
    PDU@0x1000f10:
462
        v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
463
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
464
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
465
        rid=0, olen=24, chan=0xffedc0, seqno=0
466
        flags=0xa<HAS_RECNO,HAS_TS>
467
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=3
468
                ts=2016-10-06T13:55:02.728079000Z
469
        sigmdalg=0x0, siglen=0, sig=(nil)
470
        total header=128
471
gdp_pdu_proc_resp <<< done
472
_gdp_event_trigger_pending(0x1000ef8): empty
473
<<< _gdp_invoke(0x1000e10 rid=0) CMD_READ: OK [67896525 = 0x40c04cd]
474
  req@0x1000e10:
475
    nextrec=0, numrecs=0, chan=0xffedc0
476
    postproc=(nil), sub_cb=(nil), udata=(nil)
477
    state=ACTIVE, stat=OK [67896525 = 0x40c04cd]
478
    act_ts=2016-10-09T17:06:03.159569000Z
479
    flags=0x103<ASYNCIO,DONE,ON_CHAN_LIST>
480
    GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
481
        iomode = 1, refcnt = 3, reqs = (nil), nrecs = 1
482
        flags = 0xa<INCACHE,INUSE>
483
    PDU@0x1000f10:
484
        v=3, ttl=15, rsvd1=0, cmd=133=ACK_DATA_CONTENT
485
        dst=4IrJXjcu5VChu40CiXHMZRO56OwP9USfnplfIUR_M9o
486
        src=gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
487
        rid=0, olen=24, chan=0xffedc0, seqno=0
488
        flags=0xa<HAS_RECNO,HAS_TS>
489
        datum=0x1000f90, recno=1, dbuf=0x1001000, dlen=3
490
                ts=2016-10-06T13:55:02.728079000Z
491
        sigmdalg=0x0, siglen=0, sig=(nil)
492
        total header=128
493

    
494
_gdp_req_free(0x1000e10)  state=1, gcl=0x1001120
495
_gdp_pdu_free(0x1000f10)
496
 >>> recno 1, len 3, ts 2016-10-06T13:55:02.728079000Z
497
00000000 6f 6e 65
498
         o  n  e
499
gdp_datum_free(0x1000f90)
500
  ... draining 3 bytes
501

    
502
>>> gdp_gcl_close
503
_gdp_gcl_close: GCL@0x1001120: gJWDVg_i4gSllYmjwR4cnOjz1gh49Dqs_oo8P_HBVCM
504
        iomode = 1, refcnt = 2, reqs = (nil), nrecs = 1
505
        flags = 0xa<INCACHE,INUSE>
506
        freefunc = (nil), gclmd = 0x1001210, digest = (nil)
507
        utime = 2016-10-09 17:06:03, x = (nil)
508
exiting after 1 records with status OK [67896525 = 0x40c04cd]