56 | | |
| 56 | 11:48:29 INFO : Configured logging from file /home/lnevers/gcf-2.8/src/gcf/stitcher_logging.conf |
| 57 | 11:48:30 INFO : Reading slice IG-ST-1 credential... |
| 58 | 11:48:30 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-1 expires on 2015-02-18 16:48:13 UTC |
| 59 | 11:48:30 INFO : Calling SCS... |
| 60 | 11:48:32 INFO : Multi-AM reservation will include resources from these aggregates: |
| 61 | 11:48:32 INFO : <Aggregate utc-ig> |
| 62 | 11:48:32 INFO : <Aggregate gpo-ig> |
| 63 | 11:48:32 INFO : <Aggregate al2s> |
| 64 | 11:48:32 INFO : <Aggregate ion> |
| 65 | 11:48:32 INFO : Stitcher doing createsliver at <Aggregate utc-ig>... |
| 66 | 11:48:50 INFO : ... Allocation at <Aggregate utc-ig> complete. |
| 67 | 11:48:50 INFO : Stitcher doing createsliver at <Aggregate gpo-ig>... |
| 68 | 11:49:05 INFO : ... Allocation at <Aggregate gpo-ig> complete. |
| 69 | 11:49:05 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
| 70 | 11:49:09 INFO : ... Allocation at <Aggregate al2s> complete. |
| 71 | 11:49:09 INFO : Stitcher doing createsliver at <Aggregate ion>... |
| 72 | 11:49:53 INFO : DCN AM <Aggregate ion>: must wait for status ready.... |
| 73 | 11:49:53 INFO : Pausing 30 seconds to let circuit become ready... |
| 74 | 11:50:31 INFO : Pausing 30 seconds to let circuit become ready... |
| 75 | 11:51:09 WARNING : sliverstatus: 153231 is (still) failed at <Aggregate ion>. Delete and retry. |
| 76 | 11:51:09 INFO : Doing deletesliver at <Aggregate ion>... |
| 77 | 11:51:14 WARNING : <Aggregate ion> says requested VLAN was unavailable at <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.newy:et-5/0/0:gpo-ig' on path u'link'> |
| 78 | 11:51:14 INFO : Deleting some reservations to retry, avoiding failed VLAN... |
| 79 | 11:51:14 INFO : Doing deletesliver at <Aggregate gpo-ig>... |
| 80 | 11:52:42 ERROR : {'output': 'start/restart in progress; try again later', 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+85ad8828d76050e327e1bd90d32c7a79', 'am_type': 'protogeni', 'geni_code': 14, 'am_code': 14, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=85ad8828d76050e327e1bd90d32c7a79'}, 'value': 0} |
| 81 | 11:52:52 INFO : ... aggregate was busy, will retry ... |
| 82 | 11:54:20 ERROR : {'output': 'start/restart in progress; try again later', 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+26af6c895a56890fa91b35c8b9002ef8', 'am_type': 'protogeni', 'geni_code': 14, 'am_code': 14, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=26af6c895a56890fa91b35c8b9002ef8'}, 'value': 0} |
| 83 | 11:54:30 INFO : ... aggregate was busy, will retry ... |
| 84 | 11:55:58 INFO : ... done. |
| 85 | 11:55:58 INFO : Will put <Aggregate ion> back in the pool to allocate. Got: Retrying reservations at earlier AMs to avoid unavailable VLAN tag at <Aggregate ion>.... |
| 86 | 11:55:58 INFO : Pausing for 30 seconds for Aggregates to free up resources... |
| 87 | |
| 88 | |
| 89 | 11:56:29 INFO : Checking that prior reservation at <Aggregate gpo-ig> has been cleared up.... |
| 90 | 11:56:30 ERROR : {'output': 'No slice or aggregate here', 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+b915d01503bf764d3451c0dff22b9f75', 'am_type': 'protogeni', 'geni_code': 12, 'am_code': 12, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=b915d01503bf764d3451c0dff22b9f75'}, 'value': 0} |
| 91 | 11:56:30 INFO : ... it is, so can try a new reservation. |
| 92 | 11:56:30 INFO : Stitcher doing createsliver at <Aggregate gpo-ig>... |
| 93 | 11:57:10 INFO : ... Allocation at <Aggregate gpo-ig> complete. |
| 94 | 11:57:10 INFO : Stitcher doing createsliver at <Aggregate ion>... |
| 95 | 11:57:55 INFO : DCN AM <Aggregate ion>: must wait for status ready.... |
| 96 | 11:57:55 INFO : Pausing 30 seconds to let circuit become ready... |
| 97 | 11:58:32 INFO : Pausing 30 seconds to let circuit become ready... |
| 98 | 11:59:10 INFO : DCN circuit 153251 is ready at <Aggregate ion> |
| 99 | 11:59:17 INFO : ... Allocation at <Aggregate ion> complete. |
| 100 | 11:59:17 INFO : All aggregates are complete. |
| 101 | 11:59:17 INFO : Your resources expire at 2015-02-17T16:38:32 (UTC). |
| 102 | 11:59:17 INFO : Saved combined reservation RSpec at 4 AMs to file '/home/lnevers/gcf-test/stitch-test/UTC/IG-ST-1-manifest-rspec-multiam-combined.xml' |
| 103 | Success: Reserved resources in slice IG-ST-1 at 4 Aggregates (including 2 intermediate aggregate(s) not in the original request), creating 1 stitched link(s). |
73 | | |
74 | | }}} |
75 | | |
76 | | __Five Clients__ |
77 | | {{{ |
78 | | |
79 | | }}} |
80 | | |
81 | | __Ten Clients__ |
82 | | {{{ |
83 | | |
| 127 | [ ID] Interval Transfer Bandwidth |
| 128 | [ 3] 0.0-60.1 sec 142 MBytes 19.8 Mbits/sec |
| 129 | }}} |
| 130 | |
| 131 | __Five Clients__ |
| 132 | {{{ |
| 133 | [ ID] Interval Transfer Bandwidth |
| 134 | [ 4] 0.0-60.3 sec 26.1 MBytes 3.63 Mbits/sec |
| 135 | [ 5] 0.0-60.4 sec 23.2 MBytes 3.23 Mbits/sec |
| 136 | [ 3] 0.0-60.5 sec 36.2 MBytes 5.03 Mbits/sec |
| 137 | [ 7] 0.0-60.6 sec 33.2 MBytes 4.60 Mbits/sec |
| 138 | [ 6] 0.0-60.7 sec 25.8 MBytes 3.56 Mbits/sec |
| 139 | [SUM] 0.0-60.7 sec 145 MBytes 20.0 Mbits/sec |
| 140 | }}} |
| 141 | |
| 142 | __Ten Clients__ |
| 143 | {{{ |
| 144 | [ ID] Interval Transfer Bandwidth |
| 145 | [ 5] 0.0-59.6 sec 11.2 MBytes 1.58 Mbits/sec |
| 146 | [ 7] 0.0-60.3 sec 17.8 MBytes 2.47 Mbits/sec |
| 147 | [ 10] 0.0-60.3 sec 13.1 MBytes 1.83 Mbits/sec |
| 148 | [ 12] 0.0-60.4 sec 15.9 MBytes 2.21 Mbits/sec |
| 149 | [ 4] 0.0-60.7 sec 17.6 MBytes 2.44 Mbits/sec |
| 150 | [ 6] 0.0-60.9 sec 13.1 MBytes 1.81 Mbits/sec |
| 151 | [ 8] 0.0-61.0 sec 12.8 MBytes 1.75 Mbits/sec |
| 152 | [ 3] 0.0-61.1 sec 10.1 MBytes 1.39 Mbits/sec |
| 153 | [ 11] 0.0-61.2 sec 15.8 MBytes 2.16 Mbits/sec |
| 154 | [ 9] 0.0-62.0 sec 18.9 MBytes 2.55 Mbits/sec |
| 155 | [SUM] 0.0-62.0 sec 146 MBytes 19.8 Mbits/sec |
99 | | ''Collected: 2015-01-XX'' |
100 | | |
101 | | __One Client_ |
102 | | {{{ |
103 | | |
104 | | }}} |
105 | | |
106 | | __Five Clients__ |
107 | | {{{ |
108 | | |
109 | | }}} |
110 | | |
111 | | __Ten Clients__ |
112 | | {{{ |
113 | | |
| 176 | ''Collected: 2015-02-XX'' |
| 177 | |
| 178 | __One Client__ |
| 179 | {{{ |
| 180 | [ ID] Interval Transfer Bandwidth |
| 181 | [ 3] 0.0-60.1 sec 142 MBytes 19.8 Mbits/sec |
| 182 | }}} |
| 183 | |
| 184 | __Five Clients__ |
| 185 | {{{ |
| 186 | [ ID] Interval Transfer Bandwidth |
| 187 | [ 7] 0.0-60.3 sec 29.4 MBytes 4.09 Mbits/sec |
| 188 | [ 4] 0.0-60.3 sec 34.6 MBytes 4.82 Mbits/sec |
| 189 | [ 3] 0.0-60.4 sec 25.5 MBytes 3.54 Mbits/sec |
| 190 | [ 5] 0.0-60.8 sec 25.2 MBytes 3.49 Mbits/sec |
| 191 | [ 6] 0.0-60.8 sec 29.5 MBytes 4.07 Mbits/sec |
| 192 | [SUM] 0.0-60.8 sec 144 MBytes 19.9 Mbits/sec |
| 193 | }}} |
| 194 | |
| 195 | __Ten Clients__ |
| 196 | {{{ |
| 197 | [ ID] Interval Transfer Bandwidth |
| 198 | [ 5] 0.0-60.1 sec 14.6 MBytes 2.04 Mbits/sec |
| 199 | [ 8] 0.0-60.2 sec 13.9 MBytes 1.93 Mbits/sec |
| 200 | [ 6] 0.0-60.3 sec 14.9 MBytes 2.07 Mbits/sec |
| 201 | [ 11] 0.0-60.3 sec 13.9 MBytes 1.93 Mbits/sec |
| 202 | [ 3] 0.0-60.6 sec 14.1 MBytes 1.96 Mbits/sec |
| 203 | [ 7] 0.0-60.7 sec 13.4 MBytes 1.85 Mbits/sec |
| 204 | [ 9] 0.0-60.9 sec 13.9 MBytes 1.91 Mbits/sec |
| 205 | [ 10] 0.0-60.9 sec 12.1 MBytes 1.67 Mbits/sec |
| 206 | [ 4] 0.0-61.3 sec 12.1 MBytes 1.66 Mbits/sec |
| 207 | [ 12] 0.0-62.6 sec 22.4 MBytes 3.00 Mbits/sec |
| 208 | [SUM] 0.0-62.6 sec 145 MBytes 19.5 Mbits/sec |