Project

General

Profile

gdp600Message.txt

gdp-01 fails - Anonymous, 10/04/2016 09:30 AM

Download (7.93 KB)

 
1
Updating local copy of the accessors repository.
2
In "/Users/cxh/ptII/org/terraswarm/accessor/accessors", about to execute:
3
    svn update --non-interactive --trust-server-cert --accept postpone
4
Updating '.':
5
At revision 969.
6
All Done
7
Updated accessor repository.
8
GDPLogAppend: GDPLogAppend.js: setup() (Thread[AWT-EventQueue-0,6,main])
9
GDPLogAppend: GDPLogAppend.js: setup() (Thread[AWT-EventQueue-0,6,main])
10
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
11
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
12
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
13
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
14
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
15
GDPLogAppend: GDPLogAppend.js: initialize() (Thread[GDPLogCreateAppendReadJS,1,main])
16
GDPLogCreate: GDPLogCreate.js: initialize() (Thread[GDPLogCreateAppendReadJS,1,main])
17
JavaScriptGDPLogName: JavaScriptGDPLogName: ptolemy.actor.lib.jjs.modules.gdp.test.auto.GDPLogSubscribeJS.0.13624060898914003 (Thread[GDPLogCreateAppendReadJS,1,main])
18
GDPLogCreate: GDPLogCreate.js: create() Start. (Thread[GDPLogCreateAppendReadJS,1,main])
19
GDPHelper.GDPHelper(ptolemy.actor.lib.jjs.modules.gdp.test.auto.GDPLogSubscribeJS.0.13624060898914003, 3, edu.berkeley.eecs.gdp-01.gdplogd): 
20
GDPManager: Using configuration files in /Users/cxh/.ep_adm_params
21
GDPManager: gdp settings:
22
swarm.gdp.routers=gdp-03.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu
23
GDP_GCL.java: newGCL(org.terraswarm.gdp.GDP_NAME@155f3ea8, 3, org.terraswarm.gdp.GDP_NAME@29eec46c)
24
GDP_GCL.java: GDP_GCL(org.terraswarm.gdp.GDP_NAME@155f3ea8(hopjOV_O7mDfY32aG1N2e283CXzJF_lwg0TtMuqPKTc), RA, org.terraswarm.gdp.GDP_NAME@29eec46c(m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U)
25
_gdp_lib_init(NULL)
26
	@(#)libgdp 0.7.2 (2016-10-04 09:03) 67898fe70492992960cfa5de8df77645258aa997++
27
My GDP routing name = LQxaGrh44jRIgWuAkQ3J5AJAnzjOOk4odq0X2x3VxKc
28
gdp_lib_init: OK
29
Trying Zeroconf:
30
create_new_simple_poll_client: avahi_simple_poll_get: Daemon not running
31
Failed to create client object: Daemon not running
32
gdp_zc_scan: create_new_simple_poll_client failed: No such file or directory
33
gdp_zc_scan failed
34
_gdp_chan_open(gdp-03.eecs.berkeley.edu; gdp-02.eecs.berkeley.edu)
35
Trying gdp-03.eecs.berkeley.edu
36
_gdp_chan_open: trying host gdp-03.eecs.berkeley.edu port 8007
37
_gdp_chan_open: talking to router at gdp-03.eecs.berkeley.edu:8007
38
_gdp_pdu_out, fd = 121, basemd = 0x0: CMD_ADVERTISE
39
gdp_event_loop: starting up I/O base loop
40
_gdp_advertise => OK
41
Inserted events:
42
gdp_init: OK
43
  0x7fa7798e50c8 [fd 116] Read Persist
44

    
45
>>> _gdp_invoke(req=0x7fa779f0c310 rid=1): CMD_OPEN_RA (75), gcl@0x7fa779689100
46
  0x7fa7798e54e0 [fd 121] Read Persist
47
	  0x7fa7798e5568 [fd 121] Write Persist
48
datum @ 0x7fa779f0c420: recno -1, len 0, no timestamp
49
_gdp_pdu_out, fd = 121, basemd = 0x0: CMD_OPEN_RA
50
_gdp_pdu_in(NAK_R_NOROUTE) => OK
51

    
52
*** Processing ack/nak 240=NAK_R_NOROUTE from socket 121
53
gdp_pdu_proc_resp(0x7fa779f0c530 NAK_R_NOROUTE) gcl 0x7fa779689100
54
_gdp_req_dispatch >>> NAK_R_NOROUTE (240) [gcl->refcnt 2]
55
nak_router: received NAK_R_NOROUTE for CMD_OPEN_RA
56
_gdp_req_dispatch <<< NAK_R_NOROUTE [gcl->refcnt 2]
57
    ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
58
<<< _gdp_invoke(0x7fa779f0c310 rid=1) CMD_OPEN_RA: ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
59
Couldn't open GCL hopjOV_O7mDfY32aG1N2e283CXzJF_lwg0TtMuqPKTc:
60
	ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
61
GDP_GCL: gdp_gcl_open() failed, trying to create the log and call gdp_gcl_open() again.
62
GDP_GCL.java: create(org.terraswarm.gdp.GDP_NAME@155f3ea8, , org.terraswarm.gdp.GDP_NAME@29eec46c, {})
63
_gdp_gcl_create: gcl=hopjOV_O7mDfY32aG1N2e283CXzJF_lwg0TtMuqPKTc
64
	logd=m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U
65

    
66
>>> _gdp_invoke(req=0x7fa779f0c310 rid=2): CMD_CREATE (66), gcl@0x7fa779f0c630
67
	datum @ 0x7fa779f0c5b0: recno -1, len 34, no timestamp
68
00000000 86 8a 63 39 5f ce ee 60 df 63 7d 9a 1b 53 76 7b
69
         ?  ?  c  9  _  ?  ?  `  ?  c  }  ?  ?  S  v  { 
70
00000010 6f 37 09 7c c9 17 f9 70 83 44 ed 32 ea 8f 29 37
71
         o  7  ?  |  ?  ?  ?  p  ?  D  ?  2  ?  ?  )  7 
72
00000020 00 00
73
         ?  ? 
74
_gdp_pdu_out, fd = 121, basemd = 0x0: CMD_CREATE
75
_gdp_pdu_in(NAK_R_NOROUTE) => OK
76

    
77
*** Processing ack/nak 240=NAK_R_NOROUTE from socket 121
78
gdp_pdu_proc_resp(0x7fa779f0c1f0 NAK_R_NOROUTE) gcl 0x7fa779f0c630
79
_gdp_req_dispatch >>> NAK_R_NOROUTE (240) [gcl->refcnt 2]
80
nak_router: received NAK_R_NOROUTE for CMD_CREATE
81
_gdp_req_dispatch <<< NAK_R_NOROUTE [gcl->refcnt 2]
82
    ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
83
_gdp_req_unsend: req@0x7fa779f0c310:
84
    nextrec=0, numrecs=0, chan=0x7fa7798e5420
85
    postproc=0x0, sub_cb=0x0, udata=0x0
86
    state=ACTIVE, stat=ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
87
    act_ts=2016-10-04T16:27:05.366737000Z
88
    flags=0x143<ASYNCIO,DONE,ALLOC_RID,ON_CHAN_LIST>
89
    GCL@0x7fa779f0c630: m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U
90
	iomode = 0, refcnt = 2, reqs = 0x0, nrecs = 0
91
	flags = 0xa<INCACHE,INUSE>
92
    PDU@0x7fa779f0c1f0: 
93
	v=2, ttl=0, rsvd1=0, cmd=240=NAK_R_NOROUTE
94
	dst=LQxaGrh44jRIgWuAkQ3J5AJAnzjOOk4odq0X2x3VxKc
95
	src=m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U
96
	rid=2, olen=0, chan=0x7fa7798e5420, seqno=0
97
	flags=0
98
	datum=0x7fa779f0c730, recno=(none), dbuf=0x7fa779f0c7b0, dlen=0
99
		ts=(none)
100
	sigmdalg=0x0, siglen=0, sig=0x0
101
	total header=80
102
_gdp_req_unsend: req 0x7fa779f0c310 not on GCL list
103
_gdp_pdu_out, fd = 121, basemd = 0x0: NAK_R_NOROUTE
104
_gdp_pdu_in(NAK_R_NOROUTE) => OK
105

    
106
*** Processing ack/nak 240=NAK_R_NOROUTE from socket 121
107
gdp_pdu_proc_resp(0x7fa779f0c530 NAK_R_NOROUTE) gcl 0x7fa779f0c630
108
_gdp_req_dispatch >>> NAK_R_NOROUTE (240) [gcl->refcnt 3]
109
nak_router: received NAK_R_NOROUTE for NAK_R_NOROUTE
110
_gdp_req_dispatch <<< NAK_R_NOROUTE [gcl->refcnt 3]
111
    ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
112
_gdp_req_unsend: req@0x7fa779f0c310:
113
    nextrec=0, numrecs=0, chan=0x7fa7798e5420
114
    postproc=0x0, sub_cb=0x0, udata=0x0
115
    state=ACTIVE, stat=ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
116
    act_ts=2016-10-04T16:27:10.396390000Z
117
    flags=0x143<ASYNCIO,DONE,ALLOC_RID,ON_CHAN_LIST>
118
    GCL@0x7fa779f0c630: m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U
119
	iomode = 0, refcnt = 3, reqs = 0x0, nrecs = 0
120
	flags = 0xa<INCACHE,INUSE>
121
    PDU@0x7fa779f0c530: 
122
	v=2, ttl=0, rsvd1=0, cmd=240=NAK_R_NOROUTE
123
	dst=LQxaGrh44jRIgWuAkQ3J5AJAnzjOOk4odq0X2x3VxKc
124
	src=m5FiAV65ufV8Oe3SinfrOZPcbzXtlNOG-lmD-KSsE1U
125
	rid=2, olen=0, chan=0x7fa7798e5420, seqno=0
126
	flags=0
127
	datum=0x7fa77968eed0, recno=(none), dbuf=0x7fa77998eda0, dlen=0
128
		ts=(none)
129
	sigmdalg=0x0, siglen=0, sig=0x0
130
	total header=80
131
_gdp_req_unsend: req 0x7fa779f0c310 not on GCL list
132
_gdp_pdu_out, fd = 121, basemd = 0x0: NAK_R_NOROUTE
133
_gdp_pdu_in(NAK_R_NOROUTE) => OK
134

    
135
*** Processing ack/nak 240=NAK_R_NOROUTE from socket 121
136
gdp_pdu_proc_resp(0x7fa779f0c1f0 NAK_R_NOROUTE) gcl 0x7fa779f0c630
137
_gdp_req_dispatch >>> NAK_R_NOROUTE (240) [gcl->refcnt 4]
138
nak_router: received NAK_R_NOROUTE for NAK_R_NOROUTE
139
_gdp_req_dispatch <<< NAK_R_NOROUTE [gcl->refcnt 4]
140
    ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
141
<<< _gdp_invoke(0x7fa779f0c310 rid=2) CMD_CREATE: ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
142
Could not create GCL: ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
143
<<< gdp_gcl_create: ERROR: 600 no route available [Berkeley:Swarm-GDP:600]
144
WARNING: TestSpontaneous: Model stopped before executing actions (e.g. producing outputs) scheduled for execution at times [1.0]
145
WARNING: TestSpontaneous2: Model stopped before executing actions (e.g. producing outputs) scheduled for execution at times [1.0]
146
14512 ms. Memory: 541696K Free: 400042K (74%)
147
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
148
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
149
GDPLogAppend: GDPLogAppend.js: setup() (Thread[GDPLogCreateAppendReadJS,1,main])
150
Assertion failed at gdp_gcl_ops.c:453: require:
151
	(gcl) != NULL && EP_UT_BITSET(GCLF_INUSE, (gcl)->flags)