Skip to content

Instantly share code, notes, and snippets.

@jamwt
Created July 15, 2015 20:06
Show Gist options
  • Save jamwt/cd30899dccee31d20545 to your computer and use it in GitHub Desktop.
Save jamwt/cd30899dccee31d20545 to your computer and use it in GitHub Desktop.
I0715 20:02:48.521234 04193 common.go:198] MP version: HEAD
=== RUN Test
I0715 20:02:48.521927 04193 all_test.go:37] Using seed: 1436990568521926197
I0715 20:02:49.451336 04193 osd2.go:48] Using tmp dir: /tmp/osd2-tests633816670
I0715 20:02:49.496960 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:02:49.497218 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:02:49.499978 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:02:49.502291 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:02:49.505049 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests633816670/disk>
I0715 20:02:49.508170 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:02:49.511486 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:02:49.513517 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:02:49.516096 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:02:49.518114 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:02:49.519489 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:02:49.709220 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:02:49.712757 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:50.028624 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S93fc14ae1bdaa9451007b30f9f96aa88", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-5418016517722506055", phase: Live, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None }
I0715 20:02:50.029876 04193 acid_1.go:94] Successfully created live extent: acid-1-5418016517722506055
I0715 20:02:50.029946 04193 acid_1.go:99] Put block 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e
I0715 20:02:50.040597 <none> src/runtime.rs:252] Put <Block hash=7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e md5=d9774b4a5e3967a2d2755392f6aecf8d size=1877KiB> -> acid-1-5418016517722506055
I0715 20:02:50.046629 04193 acid_1.go:99] Put block ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7
I0715 20:02:50.068226 <none> src/runtime.rs:252] Put <Block hash=ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7 md5=3008c0845d1581e66a8888542986b08d size=3019KiB> -> acid-1-5418016517722506055
I0715 20:02:50.075668 04193 acid_1.go:99] Put block 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29
I0715 20:02:50.083462 <none> src/runtime.rs:252] Put <Block hash=7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29 md5=3ebf047c8c2d7cdebd95975b78bec8ab size=1215KiB> -> acid-1-5418016517722506055
I0715 20:02:50.088319 04193 acid_1.go:99] Put block 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434
I0715 20:02:50.092688 <none> src/runtime.rs:252] Put <Block hash=69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434 md5=6136ce6300d15914ec2f6b07f25f5776 size=610KiB> -> acid-1-5418016517722506055
I0715 20:02:50.095119 04193 acid_1.go:99] Put block 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115
I0715 20:02:50.124016 <none> src/runtime.rs:252] Put <Block hash=47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115 md5=90522f5c060b2a194dff296100bbd2d8 size=4170KiB> -> acid-1-5418016517722506055
I0715 20:02:50.134198 04193 acid_1.go:114] Get block 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e
I0715 20:02:50.140077 <none> src/runtime.rs:283] Get 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e (1877KiB) from acid-1-5418016517722506055
I0715 20:02:50.146995 04193 acid_1.go:114] Get block ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7
I0715 20:02:50.149531 <none> src/runtime.rs:283] Get ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7 (3019KiB) from acid-1-5418016517722506055
I0715 20:02:50.164094 04193 acid_1.go:114] Get block 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29
I0715 20:02:50.166028 <none> src/runtime.rs:283] Get 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29 (1215KiB) from acid-1-5418016517722506055
I0715 20:02:50.170805 04193 acid_1.go:114] Get block 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434
I0715 20:02:50.171798 <none> src/runtime.rs:283] Get 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434 (610KiB) from acid-1-5418016517722506055
I0715 20:02:50.174425 04193 acid_1.go:114] Get block 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115
I0715 20:02:50.177111 <none> src/runtime.rs:283] Get 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115 (4170KiB) from acid-1-5418016517722506055
I0715 20:02:50.195082 04193 acid_1.go:128] Get block 00477a6329c7722aa7622fcac21270221d1ddac3a290aef2a72ae77373d14e57
I0715 20:02:50.459200 04193 acid_1.go:128] Get block b212c93114684b5cb45fba930c7ef1a0176393db3f636331087fdcb7e91b3adb
I0715 20:02:50.459872 04193 acid_1.go:128] Get block d3ca1e3efddcf9d86fec8a78fa38229977076518b78e67e99a47b7e5632e183b
I0715 20:02:50.460564 04193 acid_1.go:128] Get block 9aacc17598fbc19aaaa549519689c2d4be422df8c58115a38bb9634940288a13
I0715 20:02:50.461208 04193 acid_1.go:128] Get block 648ae61a37b0ebdf5341a84beb1379b740f363c45eb35e27540913b810f40abd
I0715 20:02:50.461799 04193 acid_1.go:137] Closing extent named acid-1-5418016517722506055
I0715 20:02:50.462260 <none> src/runtime.rs:222] Close acid-1-5418016517722506055
I0715 20:02:50.622396 <main> src/storage/real.rs:124] Loaded 4 headers (with 3 free zones)
W0715 20:02:50.623119 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:50.974538 04193 acid_1.go:114] Get block 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e
I0715 20:02:50.976608 <none> src/runtime.rs:283] Get 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e (1877KiB) from acid-1-5418016517722506055
I0715 20:02:50.984157 04193 acid_1.go:114] Get block ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7
I0715 20:02:50.987014 <none> src/runtime.rs:283] Get ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7 (3019KiB) from acid-1-5418016517722506055
I0715 20:02:51.000425 04193 acid_1.go:114] Get block 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29
I0715 20:02:51.002274 <none> src/runtime.rs:283] Get 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29 (1215KiB) from acid-1-5418016517722506055
I0715 20:02:51.008584 04193 acid_1.go:114] Get block 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434
I0715 20:02:51.011104 <none> src/runtime.rs:283] Get 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434 (610KiB) from acid-1-5418016517722506055
I0715 20:02:51.013637 04193 acid_1.go:114] Get block 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115
I0715 20:02:51.016849 <none> src/runtime.rs:283] Get 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115 (4170KiB) from acid-1-5418016517722506055
I0715 20:02:51.035281 04193 acid_1.go:128] Get block 00477a6329c7722aa7622fcac21270221d1ddac3a290aef2a72ae77373d14e57
I0715 20:02:52.122451 04193 acid_1.go:128] Get block b212c93114684b5cb45fba930c7ef1a0176393db3f636331087fdcb7e91b3adb
I0715 20:02:52.123734 04193 acid_1.go:128] Get block d3ca1e3efddcf9d86fec8a78fa38229977076518b78e67e99a47b7e5632e183b
I0715 20:02:52.124681 04193 acid_1.go:128] Get block 9aacc17598fbc19aaaa549519689c2d4be422df8c58115a38bb9634940288a13
I0715 20:02:52.125649 04193 acid_1.go:128] Get block 648ae61a37b0ebdf5341a84beb1379b740f363c45eb35e27540913b810f40abd
I0715 20:02:52.127576 <none> src/runtime.rs:206] Importing ExtentHeader { name: "Sedb1c57d0033363a93f6d125bc6e56cb", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-5000943058434929420", phase: Live, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None }
I0715 20:02:52.128911 04193 acid_1.go:94] Successfully created live extent: acid-1-5000943058434929420
I0715 20:02:52.128988 04193 acid_1.go:99] Put block 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16
I0715 20:02:52.152516 <none> src/runtime.rs:252] Put <Block hash=6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16 md5=c1174d462fa635d280e8d62cb76425d0 size=3873KiB> -> acid-1-5000943058434929420
I0715 20:02:52.162314 04193 acid_1.go:99] Put block 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823
I0715 20:02:52.185672 <none> src/runtime.rs:252] Put <Block hash=6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823 md5=d2a3983bf8313ccc0e8612619c0bbd09 size=3688KiB> -> acid-1-5000943058434929420
I0715 20:02:52.194019 04193 acid_1.go:99] Put block c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b
I0715 20:02:52.219633 <none> src/runtime.rs:252] Put <Block hash=c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b md5=cdc8e87cefd2a9b146d5f8bf7db9a15b size=3478KiB> -> acid-1-5000943058434929420
I0715 20:02:52.227805 04193 acid_1.go:99] Put block 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56
I0715 20:02:52.231332 <none> src/runtime.rs:252] Put <Block hash=6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56 md5=ae19183cd2d58c17c3b5299f575090e8 size=439KiB> -> acid-1-5000943058434929420
I0715 20:02:52.233797 04193 acid_1.go:99] Put block 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46
I0715 20:02:52.244405 <none> src/runtime.rs:252] Put <Block hash=400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46 md5=9dc5c0e6e305c1e195832306e4002813 size=1745KiB> -> acid-1-5000943058434929420
I0715 20:02:52.251309 04193 acid_1.go:114] Get block 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16
I0715 20:02:52.256889 <none> src/runtime.rs:283] Get 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16 (3873KiB) from acid-1-5000943058434929420
I0715 20:02:52.272801 04193 acid_1.go:114] Get block 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823
I0715 20:02:52.275930 <none> src/runtime.rs:283] Get 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823 (3688KiB) from acid-1-5000943058434929420
I0715 20:02:52.290769 04193 acid_1.go:114] Get block c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b
I0715 20:02:52.293509 <none> src/runtime.rs:283] Get c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b (3478KiB) from acid-1-5000943058434929420
I0715 20:02:52.306946 04193 acid_1.go:114] Get block 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56
I0715 20:02:52.308184 <none> src/runtime.rs:283] Get 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56 (439KiB) from acid-1-5000943058434929420
I0715 20:02:52.313187 04193 acid_1.go:114] Get block 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46
I0715 20:02:52.314903 <none> src/runtime.rs:283] Get 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46 (1745KiB) from acid-1-5000943058434929420
I0715 20:02:52.486291 <main> src/storage/real.rs:124] Loaded 4 headers (with 2 free zones)
W0715 20:02:52.488673 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:52.831529 04193 acid_1.go:114] Get block 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16
I0715 20:02:52.834943 <none> src/runtime.rs:283] Get 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16 (3873KiB) from acid-1-5000943058434929420
I0715 20:02:52.852897 04193 acid_1.go:114] Get block 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823
I0715 20:02:52.856160 <none> src/runtime.rs:283] Get 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823 (3688KiB) from acid-1-5000943058434929420
I0715 20:02:52.875576 04193 acid_1.go:114] Get block c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b
I0715 20:02:52.879167 <none> src/runtime.rs:283] Get c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b (3478KiB) from acid-1-5000943058434929420
I0715 20:02:52.891923 04193 acid_1.go:114] Get block 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56
I0715 20:02:52.894616 <none> src/runtime.rs:283] Get 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56 (439KiB) from acid-1-5000943058434929420
I0715 20:02:52.896821 04193 acid_1.go:114] Get block 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46
I0715 20:02:52.899001 <none> src/runtime.rs:283] Get 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46 (1745KiB) from acid-1-5000943058434929420
I0715 20:02:52.907258 04193 acid_1.go:99] Put block 5a9173778e9df4dfabdea1a79ce156a14337f6dfaab8f8d7582839fd8bf395c4
I0715 20:02:52.923795 <none> src/runtime.rs:252] Put <Block hash=5a9173778e9df4dfabdea1a79ce156a14337f6dfaab8f8d7582839fd8bf395c4 md5=45b042f9e6f82b1c41391030adb9af4a size=3011KiB> -> acid-1-5000943058434929420
I0715 20:02:52.930241 04193 acid_1.go:99] Put block f2d174667e095dc0888570e323526a67573b07dc9c5dbb6d668682b59fcb1e94
I0715 20:02:52.950792 <none> src/runtime.rs:252] Put <Block hash=f2d174667e095dc0888570e323526a67573b07dc9c5dbb6d668682b59fcb1e94 md5=784ed53f1c4b0dc3ca9cd8b1b4bba27d size=3240KiB> -> acid-1-5000943058434929420
I0715 20:02:52.957257 04193 acid_1.go:99] Put block eed447af2145d369c6e6739bc64a6bb7836ad0d648cd950d5163bd8982870e02
I0715 20:02:52.982657 <none> src/runtime.rs:252] Put <Block hash=eed447af2145d369c6e6739bc64a6bb7836ad0d648cd950d5163bd8982870e02 md5=9017493a6f48af2184c49cbbf07726e9 size=4130KiB> -> acid-1-5000943058434929420
I0715 20:02:52.999018 04193 acid_1.go:99] Put block 0f8e689bf92cd9ec259e4268bcdab4d448d80051dc85d7e1f34ae0676b3d1276
I0715 20:02:53.012496 <none> src/runtime.rs:252] Put <Block hash=0f8e689bf92cd9ec259e4268bcdab4d448d80051dc85d7e1f34ae0676b3d1276 md5=20a69c567b5eded28b9029b755fec69f size=2171KiB> -> acid-1-5000943058434929420
I0715 20:02:53.021122 04193 acid_1.go:99] Put block b335812643e199a72e816de907b5c144cc52e63e993d2724ebfbb39881ee0bb2
I0715 20:02:53.038609 <none> src/runtime.rs:252] Put <Block hash=b335812643e199a72e816de907b5c144cc52e63e993d2724ebfbb39881ee0bb2 md5=851697c58b20d56db30d20b61e78af48 size=2416KiB> -> acid-1-5000943058434929420
I0715 20:02:53.044006 04193 acid_1.go:137] Closing extent named acid-1-5000943058434929420
I0715 20:02:53.044492 <none> src/runtime.rs:222] Close acid-1-5000943058434929420
I0715 20:02:53.213981 <main> src/storage/real.rs:124] Loaded 4 headers (with 2 free zones)
W0715 20:02:53.214823 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:53.558943 04193 acid_1.go:114] Get block 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e
I0715 20:02:53.560977 <none> src/runtime.rs:283] Get 7afd8c4d1d65ac3cba48026e76c0645106127cbdf1aed1ebefc647664b35d65e (1877KiB) from acid-1-5418016517722506055
I0715 20:02:53.569537 04193 acid_1.go:114] Get block ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7
I0715 20:02:53.572236 <none> src/runtime.rs:283] Get ab2fdaa31f8729431201e1deb62369fd89309f6fbde03e12863d8b9be75325f7 (3019KiB) from acid-1-5418016517722506055
I0715 20:02:53.587969 04193 acid_1.go:114] Get block 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29
I0715 20:02:53.589605 <none> src/runtime.rs:283] Get 7b1881feaf1dcaa5d25f4d4d7200a9858eb795055dfe4816704c66b988ab9e29 (1215KiB) from acid-1-5418016517722506055
I0715 20:02:53.597346 04193 acid_1.go:114] Get block 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434
I0715 20:02:53.598577 <none> src/runtime.rs:283] Get 69ec7418dbb0c497e342ca39ac819f95d9589c43b7a17ab90f9960af49b88434 (610KiB) from acid-1-5418016517722506055
I0715 20:02:53.602419 04193 acid_1.go:114] Get block 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115
I0715 20:02:53.605313 <none> src/runtime.rs:283] Get 47da53abc9d1ffa4c2e096f20711ff3fe98e8a2c34a04249a67e2ee2a8636115 (4170KiB) from acid-1-5418016517722506055
I0715 20:02:53.627189 04193 acid_1.go:114] Get block 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16
I0715 20:02:53.630939 <none> src/runtime.rs:283] Get 6262dd8d75c2a12fb40aae7e6fa69220289834834cad2738e653378e84a1fc16 (3873KiB) from acid-1-5000943058434929420
I0715 20:02:53.646103 04193 acid_1.go:114] Get block 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823
I0715 20:02:53.648990 <none> src/runtime.rs:283] Get 6e982c4dcf629f47508d51f97f810287af3ba4b37d6fcbc4dc049197de43a823 (3688KiB) from acid-1-5000943058434929420
I0715 20:02:53.667608 04193 acid_1.go:114] Get block c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b
I0715 20:02:53.670443 <none> src/runtime.rs:283] Get c415bb4130cddc0840ef325c8ccd9adbef56c68045bd60f4eda904454737db3b (3478KiB) from acid-1-5000943058434929420
I0715 20:02:53.684802 04193 acid_1.go:114] Get block 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56
I0715 20:02:53.686522 <none> src/runtime.rs:283] Get 6bcd85f700b90a03f2137ba6e6128cab30da83dfd66af744b2094916a0a9ec56 (439KiB) from acid-1-5000943058434929420
I0715 20:02:53.689602 04193 acid_1.go:114] Get block 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46
I0715 20:02:53.691555 <none> src/runtime.rs:283] Get 400d289031ed4702490769a82d2cf02e42682e9b8225133795cd8aa2fa8b8d46 (1745KiB) from acid-1-5000943058434929420
I0715 20:02:53.699450 04193 acid_1.go:114] Get block 5a9173778e9df4dfabdea1a79ce156a14337f6dfaab8f8d7582839fd8bf395c4
I0715 20:02:53.703031 <none> src/runtime.rs:283] Get 5a9173778e9df4dfabdea1a79ce156a14337f6dfaab8f8d7582839fd8bf395c4 (3011KiB) from acid-1-5000943058434929420
I0715 20:02:53.716054 04193 acid_1.go:114] Get block f2d174667e095dc0888570e323526a67573b07dc9c5dbb6d668682b59fcb1e94
I0715 20:02:53.718901 <none> src/runtime.rs:283] Get f2d174667e095dc0888570e323526a67573b07dc9c5dbb6d668682b59fcb1e94 (3240KiB) from acid-1-5000943058434929420
I0715 20:02:53.735199 04193 acid_1.go:114] Get block eed447af2145d369c6e6739bc64a6bb7836ad0d648cd950d5163bd8982870e02
I0715 20:02:53.738652 <none> src/runtime.rs:283] Get eed447af2145d369c6e6739bc64a6bb7836ad0d648cd950d5163bd8982870e02 (4130KiB) from acid-1-5000943058434929420
I0715 20:02:53.758940 04193 acid_1.go:114] Get block 0f8e689bf92cd9ec259e4268bcdab4d448d80051dc85d7e1f34ae0676b3d1276
I0715 20:02:53.760899 <none> src/runtime.rs:283] Get 0f8e689bf92cd9ec259e4268bcdab4d448d80051dc85d7e1f34ae0676b3d1276 (2171KiB) from acid-1-5000943058434929420
I0715 20:02:53.773409 04193 acid_1.go:114] Get block b335812643e199a72e816de907b5c144cc52e63e993d2724ebfbb39881ee0bb2
I0715 20:02:53.775345 <none> src/runtime.rs:283] Get b335812643e199a72e816de907b5c144cc52e63e993d2724ebfbb39881ee0bb2 (2416KiB) from acid-1-5000943058434929420
I0715 20:02:53.798506 04193 osd2.go:48] Using tmp dir: /tmp/osd2-tests198882341
I0715 20:02:53.840086 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:02:53.840400 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:02:53.843742 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:02:53.843959 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:02:53.845004 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests198882341/disk>
I0715 20:02:53.845183 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:02:53.846215 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:02:53.846348 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:02:53.847513 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:02:53.848684 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:02:53.850116 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:02:54.004961 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:02:54.005232 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:54.404206 <none> src/runtime.rs:294] PutStripe 0 -> S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.411675 <none> src/runtime.rs:294] PutStripe 1 -> S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.421469 <none> src/runtime.rs:283] Get f1d5bd97ff1b9884fdf3bdc42d886177430abf5b790371a9fd3ae6502f2df45e (3148KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.436940 <none> src/runtime.rs:283] Get 557547b6d64cdab57ed496fbabfed0d16c5a3f75156993faac259dec5c98468b (24KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.438837 <none> src/runtime.rs:283] Get 5cbb4769fc3859433a137c7cedff1506971da1a11aac69963859eab410633536 (214KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.441365 <none> src/runtime.rs:283] Get db33f2785396a0a6037b16007786e550022da241486dd7624a6bcc16a7a1029b (456KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.444534 <none> src/runtime.rs:283] Get a14281c65f0e017e07a2079e45e81307b6c35db58fb23f9fa4f009c0bbb40d66 (229KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.446795 <none> src/runtime.rs:283] Get 308aeb7d0d5de4752c6aec943cf5c3eeeeebd7b077850c0da4f7b0afdcd3f6c7 (6846B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.447578 <none> src/runtime.rs:283] Get d15ac19ea2101e8606d83d34f417235190befedef2afd4cd0ede6dd199f58d82 (12KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.449766 <none> src/runtime.rs:283] Get 748a4979d4b1815798fa70d711491f3fa76f9e4147916e13ba570d837778089e (2364B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.452201 <none> src/runtime.rs:283] Get e0c20f05baf86d0e1b51f5068caea9164d2000d544ad4b9276cd888f242c6b2a (210B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.453007 <none> src/runtime.rs:283] Get c6cdbce1dfd3d7a467379028200789fc47adfad4414d271b0eed5c071f05c614 (318B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.453893 <none> src/runtime.rs:283] Get f171eacd951f2140adf6160fa5e433cb927dcc704085027dff451b4c8d7366ce (3B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.454751 <none> src/runtime.rs:283] Get 8ef30b9edf5664d22ff8332173ad724592e3b69d1894ea02dc5c601075ef5e9b (0B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.455408 <none> src/runtime.rs:283] Get 50c7c236f20a0200da07228448776a2d10b46a8d595fe079124b7346adb756b7 (0B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.456096 <none> src/runtime.rs:283] Get 2f1d37925ffc0a332dc172b4c334a1079f40ccabda64bba67b02838be6f9ae01 (0B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.456760 <none> src/runtime.rs:283] Get 0c887b192ec36cd88da785a863b7225738fc88bdf56b05f029373efdd47849c1 (0B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.457438 <none> src/runtime.rs:283] Get 669bcb2ae298e85ab508406eee949da31b64e67ddd055ba8efa035b3b9c27e60 (0B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.458042 <none> src/runtime.rs:283] Get 176560cbaaae9aa34611bf860272413801f20258f97878c9ee770fb80e734817 (1B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:54.460597 <none> src/runtime.rs:222] Close S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.596146 <none> src/runtime.rs:283] Get f1d5bd97ff1b9884fdf3bdc42d886177430abf5b790371a9fd3ae6502f2df45e (3148KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.610090 <none> src/runtime.rs:283] Get 557547b6d64cdab57ed496fbabfed0d16c5a3f75156993faac259dec5c98468b (24KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.611111 <none> src/runtime.rs:283] Get 5cbb4769fc3859433a137c7cedff1506971da1a11aac69963859eab410633536 (214KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.613015 <none> src/runtime.rs:283] Get db33f2785396a0a6037b16007786e550022da241486dd7624a6bcc16a7a1029b (456KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.615537 <none> src/runtime.rs:283] Get a14281c65f0e017e07a2079e45e81307b6c35db58fb23f9fa4f009c0bbb40d66 (229KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.617138 <none> src/runtime.rs:283] Get 308aeb7d0d5de4752c6aec943cf5c3eeeeebd7b077850c0da4f7b0afdcd3f6c7 (6846B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.617929 <none> src/runtime.rs:283] Get d15ac19ea2101e8606d83d34f417235190befedef2afd4cd0ede6dd199f58d82 (12KiB) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.620953 <none> src/runtime.rs:283] Get 748a4979d4b1815798fa70d711491f3fa76f9e4147916e13ba570d837778089e (2364B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.623738 <none> src/runtime.rs:283] Get e0c20f05baf86d0e1b51f5068caea9164d2000d544ad4b9276cd888f242c6b2a (210B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.624567 <none> src/runtime.rs:283] Get c6cdbce1dfd3d7a467379028200789fc47adfad4414d271b0eed5c071f05c614 (318B) from S9fdb77773a7c7d5ebf867055b19a38ec
I0715 20:02:55.627401 <none> src/runtime.rs:283] Get f171eacd951f2140adf6160fa5e433cb927dcc704085027dff451b4c8d7366ce (3B) from S9fdb77773a7c7d5ebf867055b19a38ec
----------------------------------------------------------------------
FAIL: /srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:24: Acid2Suite.TestCoded
/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:94:
c.Assert(err, IsNil)
... value *errors.DropboxBaseError = &errors.DropboxBaseError{Msg:"O(localhost:127.0.0.1:8000): Error on RPC: Key not found: 8ef30b9edf5664d22ff8332173ad724592e3b69d1894ea02dc5c601075ef5e9b", Stack:"goroutine 130 [running]:\ndropbox/mp/osd/client.(*osdClient).wrapError(0xc208005e00, 0x7f8397d112d8, 0xc2080a0a30, 0x0, 0x0)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:239 +0x187\ndropbox/mp/osd/client.(*osdClient).GetBlock(0xc208005e00, 0x0, 0x0, 0xc2090d0a80, 0x21, 0xc208a2ba00, 0x20, 0x20, 0xc2080a0df0, 0x10, ...)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:621 +0x2e8\ndropbox/mp/osd/tests/acid_tests.(*Acid2Suite).TestCoded(0xecb330, 0xc2080940f0)\n\t/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:93 +0x1a06\nreflect.Value.call(0x9559c0, 0xecb330, 0x0, 0x138, 0x9cc890, 0x4, 0xc208a2a760, 0x1, 0x1, 0x0, ...)\n\t/usr/local/go/src/pkg/reflect/value.go:563 +0x1210\nreflect.Value.Call(0x9559c0, 0xecb330, 0x0, 0x138, 0xc208a2a760, 0x1, 0x1, 0x0, 0x0, 0x0)\n\t/usr/local/go/src/pkg/reflect/value.go:411 +0xd7\ngopkg.in/check%2ev1.func·003(0xc2080940f0)\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:761 +0x3f3\ngopkg.in/check%2ev1.func·001()\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:655 +0x8f\ncreated by gopkg.in/check%2ev1.(*suiteRunner).forkCall\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:656 +0x272\n", Context:"", inner:?reflect.Value?} ("ERROR:\nO(localhost:127.0.0.1:8000): Error on RPC: Key not found: 8ef30b9edf5664d22ff8332173ad724592e3b69d1894ea02dc5c601075ef5e9b\n\nORIGINAL STACK TRACE:\ngoroutine 130 [running]:\ndropbox/mp/osd/client.(*osdClient).wrapError(0xc208005e00, 0x7f8397d112d8, 0xc2080a0a30, 0x0, 0x0)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:239 +0x187\ndropbox/mp/osd/client.(*osdClient).GetBlock(0xc208005e00, 0x0, 0x0, 0xc2090d0a80, 0x21, 0xc208a2ba00, 0x20, 0x20, 0xc2080a0df0, 0x10, ...)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:621 +0x2e8\ndropbox/mp/osd/tests/acid_tests.(*Acid2Suite).TestCoded(0xecb330, 0xc2080940f0)\n\t/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:93 +0x1a06\nreflect.Value.call(0x9559c0, 0xecb330, 0x0, 0x138, 0x9cc890, 0x4, 0xc208a2a760, 0x1, 0x1, 0x0, ...)\n\t/usr/local/go/src/pkg/reflect/value.go:563 +0x1210\nreflect.Value.Call(0x9559c0, 0xecb330, 0x0, 0x138, 0xc208a2a760, 0x1, 0x1, 0x0, 0x0, 0x0)\n\t/usr/local/go/src/pkg/reflect/value.go:411 +0xd7\ngopkg.in/check%2ev1.func·003(0xc2080940f0)\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:761 +0x3f3\ngopkg.in/check%2ev1.func·001()\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:655 +0x8f\ncreated by gopkg.in/check%2ev1.(*suiteRunner).forkCall\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:656 +0x272\n")
I0715 20:02:55.634534 04193 osd2.go:48] Using tmp dir: /tmp/osd2-tests282784064
I0715 20:02:55.678490 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:02:55.678847 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:02:55.681370 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:02:55.681515 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:02:55.682527 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests282784064/disk>
I0715 20:02:55.682689 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:02:55.683851 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:02:55.683995 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:02:55.685084 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:02:55.686238 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:02:55.687406 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:02:55.847761 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:02:55.849829 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:56.199765 <none> src/runtime.rs:252] Put <Block hash=ea146602cf5f7226addf2b6f22302486d6f00619423c02ac697db4de8a384166 md5=c8cf72c5478622d5655bb4e29e5f4ebb size=1694B> -> S456a4f3a30ff37cc6e658a54860c4ca3
I0715 20:02:56.202807 <none> src/runtime.rs:347] Deleting scratch extent S456a4f3a30ff37cc6e658a54860c4ca3
W0715 20:02:56.452458 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Extent S456a4f3a30ff37cc6e658a54860c4ca3 not found
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::extent::manager::ExtentManager<S>::expect
File "src/runtime.rs", line 267, in mp_osd2::runtime::OsdRuntime<S>::get_block
File "src/rpc_service.rs", line 140, in mp_osd2::rpc_service::OsdRpcService<S>::GetBlock
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:02:56.456584 <none> src/runtime.rs:252] Put <Block hash=ea146602cf5f7226addf2b6f22302486d6f00619423c02ac697db4de8a384166 md5=c8cf72c5478622d5655bb4e29e5f4ebb size=1694B> -> S863c9029ac22468c259c23520aababc8
I0715 20:02:56.459692 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S34321d75b656b5959d8172c4d28b08d8", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None } -> ExtentHeader { name: "clobberme", phase: Live, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None }
W0715 20:02:56.461316 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Can't import scratch extent without newer generation: 0 vs. 0
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::runtime::OsdRuntime<S>::import
File "src/rpc_service.rs", line 248, in mp_osd2::rpc_service::OsdRpcService<S>::Import
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:02:56.462722 <none> src/runtime.rs:186] Moving old generation ExtentHeader { name: "clobberme", phase: Live, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None } to trash
I0715 20:02:56.463509 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S863c9029ac22468c259c23520aababc8", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } -> ExtentHeader { name: "clobberme", phase: Live, generation: 1, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None }
I0715 20:02:56.464878 <none> src/runtime.rs:283] Get ea146602cf5f7226addf2b6f22302486d6f00619423c02ac697db4de8a384166 (1694B) from clobberme
W0715 20:02:56.465556 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Generation gap: 1 vs. 0
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::extent::manager::ManagedExtent<S>::check_generation
File "src/extent/manager.rs", line 241, in mp_osd2::extent::manager::ManagedExtent<S>::begin_transition
File "src/runtime.rs", line 332, in mp_osd2::runtime::OsdRuntime<S>::delete
File "src/rpc_service.rs", line 263, in mp_osd2::rpc_service::OsdRpcService<S>::ExtentDelete
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:02:56.466487 <none> src/runtime.rs:338] Moving ExtentHeader { name: "clobberme", phase: Live, generation: 1, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } to trash
W0715 20:02:56.467804 <none> src/extent/manager.rs:111] Trash clobbered extent: clobberme
I0715 20:02:56.509529 04193 osd2.go:48] Using tmp dir: /tmp/osd2-tests555231135
I0715 20:02:56.551729 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:02:56.552234 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:02:56.555072 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:02:56.555248 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:02:56.556334 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests555231135/disk>
I0715 20:02:56.556529 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:02:56.557690 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:02:56.557877 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:02:56.559139 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:02:56.560354 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:02:56.561594 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:02:56.718389 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:02:56.718711 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:02:57.070026 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S3304aa3b07e2f05bef5073eb1024b4f5", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-7473883310583311051", phase: Live, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None }
I0715 20:02:57.071361 04193 acid_1.go:94] Successfully created live extent: acid-1-7473883310583311051
I0715 20:02:57.071443 04193 acid_1.go:99] Put block 5276115089797f27af181086f5dfd8ad11af93a2d8f090bf062de88490c1d879
I0715 20:02:57.088819 <none> src/runtime.rs:252] Put <Block hash=5276115089797f27af181086f5dfd8ad11af93a2d8f090bf062de88490c1d879 md5=2765c22661e10a06e095f3a23bc509bd size=3036KiB> -> acid-1-7473883310583311051
I0715 20:02:57.097764 04193 acid_1.go:99] Put block 8aae4d1f06bbe76a5a34cbab8906440dd7f18209403de2876f85ef2a77f2c6f4
I0715 20:02:57.123899 <none> src/runtime.rs:252] Put <Block hash=8aae4d1f06bbe76a5a34cbab8906440dd7f18209403de2876f85ef2a77f2c6f4 md5=9851662a9e1bfb8b4a225e426289408c size=4170KiB> -> acid-1-7473883310583311051
I0715 20:02:57.135644 04193 acid_1.go:99] Put block fb882ee80d4d204fc64a69d73f7cc8838ae7a9feb37f94f07c821a2df8dddce6
I0715 20:02:57.167729 <none> src/runtime.rs:252] Put <Block hash=fb882ee80d4d204fc64a69d73f7cc8838ae7a9feb37f94f07c821a2df8dddce6 md5=2b85a9188ca8950c1501237b02ac58cb size=4193KiB> -> acid-1-7473883310583311051
I0715 20:02:57.181477 04193 acid_1.go:99] Put block c192536e943b30fdac8057135bc7b0b70716c7b2fcdd915ee8c36f5aee31647b
I0715 20:02:57.217406 <none> src/runtime.rs:252] Put <Block hash=c192536e943b30fdac8057135bc7b0b70716c7b2fcdd915ee8c36f5aee31647b md5=d888bcab5bf941f69debc68530fb3264 size=4140KiB> -> acid-1-7473883310583311051
I0715 20:02:57.227828 04193 acid_1.go:99] Put block 8a1742d006ed9fedb687276a592af67ee49bc5ac2e63a5b9ea7e9c796853828d
I0715 20:02:57.228717 <none> src/runtime.rs:252] Put <Block hash=8a1742d006ed9fedb687276a592af67ee49bc5ac2e63a5b9ea7e9c796853828d md5=af5e4624dc4c81fc698a61b75f7c8359 size=7337B> -> acid-1-7473883310583311051
I0715 20:02:57.236037 04193 acid_1.go:99] Put block b71323d3d8c26624e31bfe8a37585aaa6cccf13359662542c15eba2f10cdea5c
I0715 20:02:57.252821 <none> src/runtime.rs:252] Put <Block hash=b71323d3d8c26624e31bfe8a37585aaa6cccf13359662542c15eba2f10cdea5c md5=b529b59868441aaaf871dfa3a8164963 size=2967KiB> -> acid-1-7473883310583311051
I0715 20:02:57.258576 04193 acid_1.go:99] Put block 085c42e821de0c094a7f6df60925a9893776a7e127e3851c51b6e951e0a2e912
I0715 20:02:57.264601 <none> src/runtime.rs:252] Put <Block hash=085c42e821de0c094a7f6df60925a9893776a7e127e3851c51b6e951e0a2e912 md5=1b5b490263ad17bca8be391f2ba3e1fc size=688KiB> -> acid-1-7473883310583311051
I0715 20:02:57.269537 04193 acid_1.go:99] Put block 9f8290adc6bb2b955ee83a2558e9aba0edb00f23f2448f4fe9e916fcf188f212
I0715 20:02:57.286280 <none> src/runtime.rs:252] Put <Block hash=9f8290adc6bb2b955ee83a2558e9aba0edb00f23f2448f4fe9e916fcf188f212 md5=8c58bebccf42b176e1ff6e1659b72c61 size=3094KiB> -> acid-1-7473883310583311051
I0715 20:02:57.296362 04193 acid_1.go:99] Put block 201d272bd7eae5645bbbc5e1c3d8c6d46d52c05f511851fca5b4b7a1507c0900
I0715 20:02:57.296889 <none> src/runtime.rs:252] Put <Block hash=201d272bd7eae5645bbbc5e1c3d8c6d46d52c05f511851fca5b4b7a1507c0900 md5=2a314becfcc3ded1a7ac83d92044806c size=3470B> -> acid-1-7473883310583311051
I0715 20:02:57.300193 04193 acid_1.go:99] Put block 0ec26c5cd3aa0dce0a1e9f7ddd828b0aa27e724c3197f78d082f1487e656c308
I0715 20:02:57.316993 <none> src/runtime.rs:252] Put <Block hash=0ec26c5cd3aa0dce0a1e9f7ddd828b0aa27e724c3197f78d082f1487e656c308 md5=6349ba61bea656392a80db639b439562 size=2655KiB> -> acid-1-7473883310583311051
I0715 20:02:57.326343 04193 acid_1.go:137] Closing extent named acid-1-7473883310583311051
I0715 20:02:57.326894 <none> src/runtime.rs:222] Close acid-1-7473883310583311051
close delta is: 0
OOPS: 3 passed, 1 FAILED
--- FAIL: Test (9.15 seconds)
FAIL
exit status 1
FAIL dropbox/mp/osd/tests/acid_tests 9.174s
vagrant@dbdev:/srv/server/go/src/dropbox/mp/osd/tests/acid_tests$ ^C
vagrant@dbdev:/srv/server/go/src/dropbox/mp/osd/tests/acid_tests$ go test -v -tags rust
I0715 20:03:31.505392 04331 common.go:198] MP version: HEAD
=== RUN Test
I0715 20:03:31.505615 04331 all_test.go:37] Using seed: 1436990611505614027
I0715 20:03:32.432789 04331 osd2.go:48] Using tmp dir: /tmp/osd2-tests072333837
I0715 20:03:32.472828 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:03:32.473148 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:03:32.476142 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:03:32.476321 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:03:32.477332 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests072333837/disk>
I0715 20:03:32.477505 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:03:32.479185 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:03:32.479325 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:03:32.480638 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:03:32.481801 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:03:32.482958 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:03:32.637089 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:03:32.637331 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:32.990516 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S4c9cab6696535d2dc76d554acfba8f2d", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-5618950159977600026", phase: Live, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None }
I0715 20:03:33.004948 04331 acid_1.go:94] Successfully created live extent: acid-1-5618950159977600026
I0715 20:03:33.005020 04331 acid_1.go:99] Put block b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e
I0715 20:03:33.027372 <none> src/runtime.rs:252] Put <Block hash=b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e md5=87cbad2d77976aa0df9b346fc7addc3e size=4135KiB> -> acid-1-5618950159977600026
I0715 20:03:33.038372 04331 acid_1.go:99] Put block ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad
I0715 20:03:33.057556 <none> src/runtime.rs:252] Put <Block hash=ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad md5=f1f24a63ce5d281c899d1d846ff79e7e size=2949KiB> -> acid-1-5618950159977600026
I0715 20:03:33.064718 04331 acid_1.go:99] Put block d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae
I0715 20:03:33.065669 <none> src/runtime.rs:252] Put <Block hash=d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae md5=35fee7a4559c78c2995bb200d9ddfc46 size=515B> -> acid-1-5618950159977600026
I0715 20:03:33.069806 04331 acid_1.go:99] Put block 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe
I0715 20:03:33.095392 <none> src/runtime.rs:252] Put <Block hash=6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe md5=51758cfe9666830dcd34650769085027 size=4150KiB> -> acid-1-5618950159977600026
I0715 20:03:33.105925 04331 acid_1.go:99] Put block 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c
I0715 20:03:33.128311 <none> src/runtime.rs:252] Put <Block hash=327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c md5=f2378702e757dee8c6ad676d9d991ffd size=4163KiB> -> acid-1-5618950159977600026
I0715 20:03:33.136785 04331 acid_1.go:114] Get block b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e
I0715 20:03:33.143582 <none> src/runtime.rs:283] Get b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e (4135KiB) from acid-1-5618950159977600026
I0715 20:03:33.167406 04331 acid_1.go:114] Get block ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad
I0715 20:03:33.170116 <none> src/runtime.rs:283] Get ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad (2949KiB) from acid-1-5618950159977600026
I0715 20:03:33.184878 04331 acid_1.go:114] Get block d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae
I0715 20:03:33.186365 <none> src/runtime.rs:283] Get d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae (515B) from acid-1-5618950159977600026
I0715 20:03:33.188992 04331 acid_1.go:114] Get block 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe
I0715 20:03:33.191560 <none> src/runtime.rs:283] Get 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe (4150KiB) from acid-1-5618950159977600026
I0715 20:03:33.208650 04331 acid_1.go:114] Get block 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c
I0715 20:03:33.211842 <none> src/runtime.rs:283] Get 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c (4163KiB) from acid-1-5618950159977600026
I0715 20:03:33.231454 04331 acid_1.go:128] Get block 77913fbf663ecea14365fed74eadcede08776fa4e47efb521a88de3cf369b886
I0715 20:03:33.474654 04331 acid_1.go:128] Get block 5ae24eab1652c216deadc865a18fc2b75cd40be0132fffdd7b59a673fc6f49e9
I0715 20:03:33.475611 04331 acid_1.go:128] Get block 3f384c6f38626e9683fbd450b47030e97bf76028ef71ca1c54b018b514b7961e
I0715 20:03:33.476346 04331 acid_1.go:128] Get block 86385a73c48aed7f842930866c7eb98897f94cd4733df03d3d61a986eb6c55c3
I0715 20:03:33.476934 04331 acid_1.go:128] Get block e472a474e90338b39e936f84ef12d504f0e0d1777f9da9e8d92041a4553f228f
I0715 20:03:33.477721 04331 acid_1.go:137] Closing extent named acid-1-5618950159977600026
I0715 20:03:33.480150 <none> src/runtime.rs:222] Close acid-1-5618950159977600026
I0715 20:03:33.647936 <main> src/storage/real.rs:124] Loaded 4 headers (with 3 free zones)
W0715 20:03:33.650031 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:33.991941 04331 acid_1.go:114] Get block b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e
I0715 20:03:33.996069 <none> src/runtime.rs:283] Get b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e (4135KiB) from acid-1-5618950159977600026
I0715 20:03:34.021987 04331 acid_1.go:114] Get block ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad
I0715 20:03:34.024457 <none> src/runtime.rs:283] Get ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad (2949KiB) from acid-1-5618950159977600026
I0715 20:03:34.040172 04331 acid_1.go:114] Get block d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae
I0715 20:03:34.041213 <none> src/runtime.rs:283] Get d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae (515B) from acid-1-5618950159977600026
I0715 20:03:34.043695 04331 acid_1.go:114] Get block 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe
I0715 20:03:34.046620 <none> src/runtime.rs:283] Get 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe (4150KiB) from acid-1-5618950159977600026
I0715 20:03:34.065193 04331 acid_1.go:114] Get block 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c
I0715 20:03:34.068495 <none> src/runtime.rs:283] Get 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c (4163KiB) from acid-1-5618950159977600026
I0715 20:03:34.088254 04331 acid_1.go:128] Get block 77913fbf663ecea14365fed74eadcede08776fa4e47efb521a88de3cf369b886
I0715 20:03:35.155490 04331 acid_1.go:128] Get block 5ae24eab1652c216deadc865a18fc2b75cd40be0132fffdd7b59a673fc6f49e9
I0715 20:03:35.156852 04331 acid_1.go:128] Get block 3f384c6f38626e9683fbd450b47030e97bf76028ef71ca1c54b018b514b7961e
I0715 20:03:35.157923 04331 acid_1.go:128] Get block 86385a73c48aed7f842930866c7eb98897f94cd4733df03d3d61a986eb6c55c3
I0715 20:03:35.159024 04331 acid_1.go:128] Get block e472a474e90338b39e936f84ef12d504f0e0d1777f9da9e8d92041a4553f228f
I0715 20:03:35.160943 <none> src/runtime.rs:206] Importing ExtentHeader { name: "Scc09c7ed8e9537aae7c7ca8f6759374f", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 1, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-1662842299231709283", phase: Live, generation: 0, capacity: 1073741824, zone_number: 1, stripe_size: None, extent_state: None }
I0715 20:03:35.162259 04331 acid_1.go:94] Successfully created live extent: acid-1-1662842299231709283
I0715 20:03:35.162342 04331 acid_1.go:99] Put block e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec
I0715 20:03:35.171407 <none> src/runtime.rs:252] Put <Block hash=e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec md5=9e27e0c55d32941eccfe96686f31e159 size=792KiB> -> acid-1-1662842299231709283
I0715 20:03:35.175548 04331 acid_1.go:99] Put block 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912
I0715 20:03:35.195576 <none> src/runtime.rs:252] Put <Block hash=7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912 md5=30894f824fd6682aafad7f020cd2cc97 size=2632KiB> -> acid-1-1662842299231709283
I0715 20:03:35.203441 04331 acid_1.go:99] Put block 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9
I0715 20:03:35.229879 <none> src/runtime.rs:252] Put <Block hash=4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9 md5=244d93f992027d5b63c1efe65c58ef69 size=4141KiB> -> acid-1-1662842299231709283
I0715 20:03:35.237708 04331 acid_1.go:99] Put block cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5
I0715 20:03:35.259832 <none> src/runtime.rs:252] Put <Block hash=cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5 md5=a3bb2d0394260c32131a747286bf2033 size=3841KiB> -> acid-1-1662842299231709283
I0715 20:03:35.269169 04331 acid_1.go:99] Put block 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229
I0715 20:03:35.286159 <none> src/runtime.rs:252] Put <Block hash=969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229 md5=236c115958d44de56b5ea4c3540b751b size=2691KiB> -> acid-1-1662842299231709283
I0715 20:03:35.294715 04331 acid_1.go:114] Get block e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec
I0715 20:03:35.298379 <none> src/runtime.rs:283] Get e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec (792KiB) from acid-1-1662842299231709283
I0715 20:03:35.301734 04331 acid_1.go:114] Get block 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912
I0715 20:03:35.303956 <none> src/runtime.rs:283] Get 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912 (2632KiB) from acid-1-1662842299231709283
I0715 20:03:35.315242 04331 acid_1.go:114] Get block 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9
I0715 20:03:35.319044 <none> src/runtime.rs:283] Get 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9 (4141KiB) from acid-1-1662842299231709283
I0715 20:03:35.336840 04331 acid_1.go:114] Get block cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5
I0715 20:03:35.340095 <none> src/runtime.rs:283] Get cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5 (3841KiB) from acid-1-1662842299231709283
I0715 20:03:35.354740 04331 acid_1.go:114] Get block 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229
I0715 20:03:35.357145 <none> src/runtime.rs:283] Get 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229 (2691KiB) from acid-1-1662842299231709283
I0715 20:03:35.528417 <main> src/storage/real.rs:124] Loaded 4 headers (with 2 free zones)
W0715 20:03:35.528963 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:35.879337 04331 acid_1.go:114] Get block e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec
I0715 20:03:35.880896 <none> src/runtime.rs:283] Get e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec (792KiB) from acid-1-1662842299231709283
I0715 20:03:35.884886 04331 acid_1.go:114] Get block 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912
I0715 20:03:35.887355 <none> src/runtime.rs:283] Get 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912 (2632KiB) from acid-1-1662842299231709283
I0715 20:03:35.899249 04331 acid_1.go:114] Get block 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9
I0715 20:03:35.903220 <none> src/runtime.rs:283] Get 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9 (4141KiB) from acid-1-1662842299231709283
I0715 20:03:35.921891 04331 acid_1.go:114] Get block cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5
I0715 20:03:35.925141 <none> src/runtime.rs:283] Get cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5 (3841KiB) from acid-1-1662842299231709283
I0715 20:03:35.945881 04331 acid_1.go:114] Get block 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229
I0715 20:03:35.949023 <none> src/runtime.rs:283] Get 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229 (2691KiB) from acid-1-1662842299231709283
I0715 20:03:35.963013 04331 acid_1.go:99] Put block e4316717231df37ac583c66c6ba16baab982471c9ad1cbdce83ce3d0e044b076
I0715 20:03:35.967203 <none> src/runtime.rs:252] Put <Block hash=e4316717231df37ac583c66c6ba16baab982471c9ad1cbdce83ce3d0e044b076 md5=0ba0b099d363126a18e651c3e709d993 size=525KiB> -> acid-1-1662842299231709283
I0715 20:03:35.970211 04331 acid_1.go:99] Put block 8d978e31846e4e178020a1c62c3680fc04f2fce005179d4439de7dbe04d8888a
I0715 20:03:35.974225 <none> src/runtime.rs:252] Put <Block hash=8d978e31846e4e178020a1c62c3680fc04f2fce005179d4439de7dbe04d8888a md5=00365238b9ce5314e4591f4d00d8a451 size=436KiB> -> acid-1-1662842299231709283
I0715 20:03:35.976421 04331 acid_1.go:99] Put block a8eb2ba8a39b43827e96c6c38d64478ec9c906abf455bbbe8b5eb513df7dcf74
I0715 20:03:35.992206 <none> src/runtime.rs:252] Put <Block hash=a8eb2ba8a39b43827e96c6c38d64478ec9c906abf455bbbe8b5eb513df7dcf74 md5=64de6e1ac2f2239910860b39a4d72c89 size=2674KiB> -> acid-1-1662842299231709283
I0715 20:03:35.997643 04331 acid_1.go:99] Put block 553b485e74ff1bf4d4b5d9666db9e152ce517626c121164459ae14ea7cfe4db2
I0715 20:03:36.023726 <none> src/runtime.rs:252] Put <Block hash=553b485e74ff1bf4d4b5d9666db9e152ce517626c121164459ae14ea7cfe4db2 md5=bdd3cb0493c57ae83fd1be2bfb57b1cd size=2771KiB> -> acid-1-1662842299231709283
I0715 20:03:36.030082 04331 acid_1.go:99] Put block 79ac02abaf77256b490bc5df1efc45bc0e669001c7ba170b1a8fe1ffc4c8389b
I0715 20:03:36.034119 <none> src/runtime.rs:252] Put <Block hash=79ac02abaf77256b490bc5df1efc45bc0e669001c7ba170b1a8fe1ffc4c8389b md5=a977eb98b523ae70378337cbf08d3d3f size=407KiB> -> acid-1-1662842299231709283
I0715 20:03:36.036524 04331 acid_1.go:137] Closing extent named acid-1-1662842299231709283
I0715 20:03:36.037024 <none> src/runtime.rs:222] Close acid-1-1662842299231709283
I0715 20:03:36.197623 <main> src/storage/real.rs:124] Loaded 4 headers (with 2 free zones)
W0715 20:03:36.198454 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:36.548565 04331 acid_1.go:114] Get block b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e
I0715 20:03:36.552137 <none> src/runtime.rs:283] Get b3d54a221d943b04c7f3e4ce5e64d2d2d488fabce17c1ccd3520c77e5ac84a0e (4135KiB) from acid-1-5618950159977600026
I0715 20:03:36.574513 04331 acid_1.go:114] Get block ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad
I0715 20:03:36.577512 <none> src/runtime.rs:283] Get ca346434303d79399318b60635a55d6fd1d5f6e14743475da45bc655ab0953ad (2949KiB) from acid-1-5618950159977600026
I0715 20:03:36.590048 04331 acid_1.go:114] Get block d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae
I0715 20:03:36.591337 <none> src/runtime.rs:283] Get d3a99cc8d19dff42817f8e2c79821bcb433637b356261862bcfa17b7b633d2ae (515B) from acid-1-5618950159977600026
I0715 20:03:36.591687 04331 acid_1.go:114] Get block 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe
I0715 20:03:36.594691 <none> src/runtime.rs:283] Get 6b80d65e09b7e76714657bd90c61eef1b385b26e8e0ee84d58b2f3d2168411fe (4150KiB) from acid-1-5618950159977600026
I0715 20:03:36.613874 04331 acid_1.go:114] Get block 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c
I0715 20:03:36.618764 <none> src/runtime.rs:283] Get 327a7c1eabd958f1bcac130d947e4e79d8fabb5fbc58321ff7cfd411fb97df1c (4163KiB) from acid-1-5618950159977600026
I0715 20:03:36.638517 04331 acid_1.go:114] Get block e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec
I0715 20:03:36.640222 <none> src/runtime.rs:283] Get e00e3b09616628b809da08def30d3e7f7ec74928751c6b75ac1d725dc4e653ec (792KiB) from acid-1-1662842299231709283
I0715 20:03:36.644459 04331 acid_1.go:114] Get block 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912
I0715 20:03:36.647450 <none> src/runtime.rs:283] Get 7a1db01782ac9b1251c0bccf0bd6402cc76531533e98238d8d4888a4cf974912 (2632KiB) from acid-1-1662842299231709283
I0715 20:03:36.658318 04331 acid_1.go:114] Get block 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9
I0715 20:03:36.661852 <none> src/runtime.rs:283] Get 4456bf441e993f6257f579a30bd7f927c95cf98d87ec8839fd34d2c11fce3fd9 (4141KiB) from acid-1-1662842299231709283
I0715 20:03:36.680128 04331 acid_1.go:114] Get block cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5
I0715 20:03:36.683778 <none> src/runtime.rs:283] Get cf66c91c6bd48935a731fa69ec2914137b11435964fbb054f31e7a78eeb9e6b5 (3841KiB) from acid-1-1662842299231709283
I0715 20:03:36.698263 04331 acid_1.go:114] Get block 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229
I0715 20:03:36.700519 <none> src/runtime.rs:283] Get 969aa0bb95797a6cc3b59dd0fe3cc5dd42ed55d81c1e199c8ec176e880763229 (2691KiB) from acid-1-1662842299231709283
I0715 20:03:36.714405 04331 acid_1.go:114] Get block e4316717231df37ac583c66c6ba16baab982471c9ad1cbdce83ce3d0e044b076
I0715 20:03:36.715464 <none> src/runtime.rs:283] Get e4316717231df37ac583c66c6ba16baab982471c9ad1cbdce83ce3d0e044b076 (525KiB) from acid-1-1662842299231709283
I0715 20:03:36.719157 04331 acid_1.go:114] Get block 8d978e31846e4e178020a1c62c3680fc04f2fce005179d4439de7dbe04d8888a
I0715 20:03:36.719917 <none> src/runtime.rs:283] Get 8d978e31846e4e178020a1c62c3680fc04f2fce005179d4439de7dbe04d8888a (436KiB) from acid-1-1662842299231709283
I0715 20:03:36.721889 04331 acid_1.go:114] Get block a8eb2ba8a39b43827e96c6c38d64478ec9c906abf455bbbe8b5eb513df7dcf74
I0715 20:03:36.724067 <none> src/runtime.rs:283] Get a8eb2ba8a39b43827e96c6c38d64478ec9c906abf455bbbe8b5eb513df7dcf74 (2674KiB) from acid-1-1662842299231709283
I0715 20:03:36.737143 04331 acid_1.go:114] Get block 553b485e74ff1bf4d4b5d9666db9e152ce517626c121164459ae14ea7cfe4db2
I0715 20:03:36.739780 <none> src/runtime.rs:283] Get 553b485e74ff1bf4d4b5d9666db9e152ce517626c121164459ae14ea7cfe4db2 (2771KiB) from acid-1-1662842299231709283
I0715 20:03:36.750656 04331 acid_1.go:114] Get block 79ac02abaf77256b490bc5df1efc45bc0e669001c7ba170b1a8fe1ffc4c8389b
I0715 20:03:36.751622 <none> src/runtime.rs:283] Get 79ac02abaf77256b490bc5df1efc45bc0e669001c7ba170b1a8fe1ffc4c8389b (407KiB) from acid-1-1662842299231709283
I0715 20:03:36.761217 04331 osd2.go:48] Using tmp dir: /tmp/osd2-tests049761800
I0715 20:03:36.805973 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:03:36.806238 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:03:36.808819 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:03:36.808965 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:03:36.810052 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests049761800/disk>
I0715 20:03:36.810259 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:03:36.811486 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:03:36.811625 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:03:36.812787 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:03:36.813981 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:03:36.815151 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:03:36.968314 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:03:36.968616 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:37.376086 <none> src/runtime.rs:294] PutStripe 0 -> Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.384899 <none> src/runtime.rs:294] PutStripe 1 -> Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.397686 <none> src/runtime.rs:283] Get 83f8a7ea4cde7f63a93f139665699d8f90cd6e1336c89e91a30be05d02882a95 (1311KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.443269 <none> src/runtime.rs:283] Get 2c55d826abdb5771bae8dc713bbfc2a2413092972cb360b1dae27d8647b3cdd8 (2116KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.454441 <none> src/runtime.rs:283] Get e058fba2160bc426bf9d31e8911a232233ea5158556cdb578fdcdfe61edee568 (287KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.456619 <none> src/runtime.rs:283] Get 951f896aff3db85527b0e0eaba68daaf9cf47b0ebcd8d53324bfa7e7a714e264 (309KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.458949 <none> src/runtime.rs:283] Get a484e8d1c5b6b12a56b1e0d6f50219f4ae4e75f804ddbf9863a87369bc185a3f (40KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.460040 <none> src/runtime.rs:283] Get e7af7de6d7b1deed4fb0d7fe6a518947e4c3ec342c4dbf1e4e5df94edcf607e8 (14KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.460871 <none> src/runtime.rs:283] Get 2a302705f6503141ddf4cec5837b080f3a11626157d09fbf9febb85d7d5193e2 (6851B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.463456 <none> src/runtime.rs:283] Get 61c376959859d0c7f45fe3b62d01d8ba2c5e82b4a55789e9f545a503fb52f59b (3794B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.464281 <none> src/runtime.rs:283] Get a5cb09c8908813a61cefaca7e1cc8253b895f3384f6eb7fde5f0d29e246f13ce (4894B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.466365 <none> src/runtime.rs:283] Get 9280915344872e288d00be5349fd18f51c8c1696ee1c9e43e10d07a5e9f07b01 (35B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.466970 <none> src/runtime.rs:283] Get becb8b99c6a716d4786ab11f11477729a9d85fd92288a63ae3ce09970f4e6bb2 (112B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.467602 <none> src/runtime.rs:283] Get dc37e9c463072bb013e2003414c7968346f346d628c5251fb397fa4a3963ebeb (2B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.470123 <none> src/runtime.rs:283] Get 97b461db95af2d80795fef213c98f1fb5d22fa4103ae05950c25d08e47a49529 (19B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.470837 <none> src/runtime.rs:283] Get 2c0b97b253c9ce415966685b7423a12d38adc7b9e56ed6aec1517aff8cb9a3de (0B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.471537 <none> src/runtime.rs:283] Get 7ec9d6e7803654cb3fb15b3d5541ed879f3d11cab701f39589ce959da89dafa3 (0B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.472253 <none> src/runtime.rs:283] Get 5b5cd7edc9636ce456d71957a84eb67581d9a970bff079d644d4031d4c28bfa2 (1B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.473035 <none> src/runtime.rs:283] Get 391886b4a6f2c77dd32b83598eb5eac6351e863849a1506aee1bb3e29027eba4 (1B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:37.475741 <none> src/runtime.rs:222] Close Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.676215 <none> src/runtime.rs:283] Get 83f8a7ea4cde7f63a93f139665699d8f90cd6e1336c89e91a30be05d02882a95 (1311KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.683090 <none> src/runtime.rs:283] Get 2c55d826abdb5771bae8dc713bbfc2a2413092972cb360b1dae27d8647b3cdd8 (2116KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.695521 <none> src/runtime.rs:283] Get e058fba2160bc426bf9d31e8911a232233ea5158556cdb578fdcdfe61edee568 (287KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.698006 <none> src/runtime.rs:283] Get 951f896aff3db85527b0e0eaba68daaf9cf47b0ebcd8d53324bfa7e7a714e264 (309KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.701666 <none> src/runtime.rs:283] Get a484e8d1c5b6b12a56b1e0d6f50219f4ae4e75f804ddbf9863a87369bc185a3f (40KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.703902 <none> src/runtime.rs:283] Get e7af7de6d7b1deed4fb0d7fe6a518947e4c3ec342c4dbf1e4e5df94edcf607e8 (14KiB) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.704971 <none> src/runtime.rs:283] Get 2a302705f6503141ddf4cec5837b080f3a11626157d09fbf9febb85d7d5193e2 (6851B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.708443 <none> src/runtime.rs:283] Get 61c376959859d0c7f45fe3b62d01d8ba2c5e82b4a55789e9f545a503fb52f59b (3794B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.709241 <none> src/runtime.rs:283] Get a5cb09c8908813a61cefaca7e1cc8253b895f3384f6eb7fde5f0d29e246f13ce (4894B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.710483 <none> src/runtime.rs:283] Get 9280915344872e288d00be5349fd18f51c8c1696ee1c9e43e10d07a5e9f07b01 (35B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.711420 <none> src/runtime.rs:283] Get becb8b99c6a716d4786ab11f11477729a9d85fd92288a63ae3ce09970f4e6bb2 (112B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.712145 <none> src/runtime.rs:283] Get dc37e9c463072bb013e2003414c7968346f346d628c5251fb397fa4a3963ebeb (2B) from Sdd4e83d84598fda77b4f6b8405170482
I0715 20:03:38.715663 <none> src/runtime.rs:283] Get 97b461db95af2d80795fef213c98f1fb5d22fa4103ae05950c25d08e47a49529 (19B) from Sdd4e83d84598fda77b4f6b8405170482
----------------------------------------------------------------------
FAIL: /srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:24: Acid2Suite.TestCoded
/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:94:
c.Assert(err, IsNil)
... value *errors.DropboxBaseError = &errors.DropboxBaseError{Msg:"O(localhost:127.0.0.1:8000): Error on RPC: Key not found: 2c0b97b253c9ce415966685b7423a12d38adc7b9e56ed6aec1517aff8cb9a3de", Stack:"goroutine 130 [running]:\ndropbox/mp/osd/client.(*osdClient).wrapError(0xc208e56c00, 0x7f5825fa10c0, 0xc20820d870, 0x0, 0x0)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:239 +0x187\ndropbox/mp/osd/client.(*osdClient).GetBlock(0xc208e56c00, 0x0, 0x0, 0xc208e4d470, 0x21, 0xc208205cc0, 0x20, 0x20, 0xc208094f80, 0x10, ...)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:621 +0x2e8\ndropbox/mp/osd/tests/acid_tests.(*Acid2Suite).TestCoded(0xecb330, 0xc20808a0f0)\n\t/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:93 +0x1a06\nreflect.Value.call(0x9559c0, 0xecb330, 0x0, 0x138, 0x9cc890, 0x4, 0xc2082059c0, 0x1, 0x1, 0x0, ...)\n\t/usr/local/go/src/pkg/reflect/value.go:563 +0x1210\nreflect.Value.Call(0x9559c0, 0xecb330, 0x0, 0x138, 0xc2082059c0, 0x1, 0x1, 0x0, 0x0, 0x0)\n\t/usr/local/go/src/pkg/reflect/value.go:411 +0xd7\ngopkg.in/check%2ev1.func·003(0xc20808a0f0)\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:761 +0x3f3\ngopkg.in/check%2ev1.func·001()\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:655 +0x8f\ncreated by gopkg.in/check%2ev1.(*suiteRunner).forkCall\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:656 +0x272\n", Context:"", inner:?reflect.Value?} ("ERROR:\nO(localhost:127.0.0.1:8000): Error on RPC: Key not found: 2c0b97b253c9ce415966685b7423a12d38adc7b9e56ed6aec1517aff8cb9a3de\n\nORIGINAL STACK TRACE:\ngoroutine 130 [running]:\ndropbox/mp/osd/client.(*osdClient).wrapError(0xc208e56c00, 0x7f5825fa10c0, 0xc20820d870, 0x0, 0x0)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:239 +0x187\ndropbox/mp/osd/client.(*osdClient).GetBlock(0xc208e56c00, 0x0, 0x0, 0xc208e4d470, 0x21, 0xc208205cc0, 0x20, 0x20, 0xc208094f80, 0x10, ...)\n\t/srv/go-server/src/dropbox/mp/osd/client/client.go:621 +0x2e8\ndropbox/mp/osd/tests/acid_tests.(*Acid2Suite).TestCoded(0xecb330, 0xc20808a0f0)\n\t/srv/go-server/src/dropbox/mp/osd/tests/acid_tests/acid_2.go:93 +0x1a06\nreflect.Value.call(0x9559c0, 0xecb330, 0x0, 0x138, 0x9cc890, 0x4, 0xc2082059c0, 0x1, 0x1, 0x0, ...)\n\t/usr/local/go/src/pkg/reflect/value.go:563 +0x1210\nreflect.Value.Call(0x9559c0, 0xecb330, 0x0, 0x138, 0xc2082059c0, 0x1, 0x1, 0x0, 0x0, 0x0)\n\t/usr/local/go/src/pkg/reflect/value.go:411 +0xd7\ngopkg.in/check%2ev1.func·003(0xc20808a0f0)\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:761 +0x3f3\ngopkg.in/check%2ev1.func·001()\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:655 +0x8f\ncreated by gopkg.in/check%2ev1.(*suiteRunner).forkCall\n\t/srv/thirdparty/edgestore-stage/go/src/gopkg.in/check.v1/check.go:656 +0x272\n")
I0715 20:03:38.723839 04331 osd2.go:48] Using tmp dir: /tmp/osd2-tests164246471
I0715 20:03:38.769258 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:03:38.769604 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:03:38.771868 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:03:38.773709 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:03:38.776184 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests164246471/disk>
I0715 20:03:38.777961 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:03:38.779719 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:03:38.779876 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:03:38.781149 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:03:38.782364 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:03:38.783545 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:03:38.941165 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:03:38.943360 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:39.321103 <none> src/runtime.rs:252] Put <Block hash=e281fa9c06a57522ae65f7d05d6817a99bfc91cabf5ef1564fbbc07298261427 md5=212a48dbb42715e3f0037fd96b688663 size=4178KiB> -> Sabdcf0b6e97f4909f85fdcb85287dcd1
I0715 20:03:39.331254 <none> src/runtime.rs:347] Deleting scratch extent Sabdcf0b6e97f4909f85fdcb85287dcd1
W0715 20:03:39.582260 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Extent Sabdcf0b6e97f4909f85fdcb85287dcd1 not found
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::extent::manager::ExtentManager<S>::expect
File "src/runtime.rs", line 267, in mp_osd2::runtime::OsdRuntime<S>::get_block
File "src/rpc_service.rs", line 140, in mp_osd2::rpc_service::OsdRpcService<S>::GetBlock
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:03:39.609121 <none> src/runtime.rs:252] Put <Block hash=e281fa9c06a57522ae65f7d05d6817a99bfc91cabf5ef1564fbbc07298261427 md5=212a48dbb42715e3f0037fd96b688663 size=4178KiB> -> S123bae805f29f4f25265e8de1ab10141
I0715 20:03:39.625244 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S9a12a25c2d9a16212f138fd5da6973d9", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 2, stripe_size: None, extent_state: None } -> ExtentHeader { name: "clobberme", phase: Live, generation: 0, capacity: 1073741824, zone_number: 2, stripe_size: None, extent_state: None }
W0715 20:03:39.627315 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Can't import scratch extent without newer generation: 0 vs. 0
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::runtime::OsdRuntime<S>::import
File "src/rpc_service.rs", line 248, in mp_osd2::rpc_service::OsdRpcService<S>::Import
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:03:39.628919 <none> src/runtime.rs:186] Moving old generation ExtentHeader { name: "clobberme", phase: Live, generation: 0, capacity: 1073741824, zone_number: 2, stripe_size: None, extent_state: None } to trash
I0715 20:03:39.629601 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S123bae805f29f4f25265e8de1ab10141", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } -> ExtentHeader { name: "clobberme", phase: Live, generation: 1, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None }
I0715 20:03:39.633342 <none> src/runtime.rs:283] Get e281fa9c06a57522ae65f7d05d6817a99bfc91cabf5ef1564fbbc07298261427 (4178KiB) from clobberme
W0715 20:03:39.657178 <none> /srv/rust-server/dropbox/exclog/src/receiver.rs:127] EXCLOG: reporting error:
Generation gap: 1 vs. 0
Traceback:
File "/srv/rust-server/dropbox/exclog/src/errors.rs", line 100, in mp_osd2::errors::DropboxError.From<E>::from
File "/srv/rust-server/mp/osd2/<exclog macros>", line 2, in mp_osd2::extent::manager::ManagedExtent<S>::check_generation
File "src/extent/manager.rs", line 241, in mp_osd2::extent::manager::ManagedExtent<S>::begin_transition
File "src/runtime.rs", line 332, in mp_osd2::runtime::OsdRuntime<S>::delete
File "src/rpc_service.rs", line 263, in mp_osd2::rpc_service::OsdRpcService<S>::ExtentDelete
File "src/rpc_service.rs", line 330, in fnfn
File "/srv/rust-server/dropbox/rpc/src/server.rs", line 106, in rpc::server::ArcRpcServer.HttpRequestHandler::handle
File "/srv/rust-server/dropbox/http/src/engine.rs", line 118, in rpc::engine::HttpRequestJob<H>.Task::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 447, in rpc::thread_pool::Worker<T, Q>::run
File "/srv/rust-server/.fyre/syncbox/src/thread_pool.rs", line 402, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
File "../src/libstd/rt/unwind/mod.rs", line 130, in rpc::rt::unwind::try<closure>
File "../src/libstd/thread/mod.rs", line 349, in fnfn
File "../src/liballoc/boxed.rs", line 396, in rpc::boxed::F.FnBox<A>::call_box
I0715 20:03:39.658273 <none> src/runtime.rs:338] Moving ExtentHeader { name: "clobberme", phase: Live, generation: 1, capacity: 1073741824, zone_number: 4, stripe_size: None, extent_state: None } to trash
W0715 20:03:39.659452 <none> src/extent/manager.rs:111] Trash clobbered extent: clobberme
I0715 20:03:39.691718 04331 osd2.go:48] Using tmp dir: /tmp/osd2-tests270853754
I0715 20:03:39.734769 <main> src/bin/osd2_init.rs:50] Creating cache file
I0715 20:03:39.735279 <main> src/bin/osd2_init.rs:55] Wrapping cache with an allocator
I0715 20:03:39.738125 <main> src/bin/osd2_init.rs:86] Setting up disk with 1GB seq zone size
I0715 20:03:39.738265 <main> src/bin/osd2_init.rs:88] Creating disk backed by file medium of size 5368709120
I0715 20:03:39.739254 <main> src/bin/osd2_init.rs:95] Device info: <ZonedDevice block-size=4096B device-size=5120MiB zones=5> on <FileMedium /tmp/osd2-tests270853754/disk>
I0715 20:03:39.739459 <main> src/bin/osd2_init.rs:105] Found conventional zone 0, initializing a dynamic allocator around it
I0715 20:03:39.740704 <main> src/bin/osd2_init.rs:111] Write ExtentHeader for each sequential zone
I0715 20:03:39.740844 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 1
I0715 20:03:39.741939 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 2
I0715 20:03:39.743184 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 3
I0715 20:03:39.744356 <main> src/bin/osd2_init.rs:132] Writing ExtentHeader for zone num: 4
I0715 20:03:39.896764 <main> src/storage/real.rs:124] Loaded 4 headers (with 4 free zones)
W0715 20:03:39.897005 <main> /srv/rust-server/dropbox/http/src/server.rs:49] Started HttpListener at V4(0.0.0.0:8000)
I0715 20:03:40.253582 <none> src/runtime.rs:206] Importing ExtentHeader { name: "S260d54e0d2da078a55a2632c6413866b", phase: Scratch, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None } -> ExtentHeader { name: "acid-1-4322880466636963880", phase: Live, generation: 0, capacity: 1073741824, zone_number: 3, stripe_size: None, extent_state: None }
I0715 20:03:40.254728 04331 acid_1.go:94] Successfully created live extent: acid-1-4322880466636963880
I0715 20:03:40.254797 04331 acid_1.go:99] Put block 45354e687d8de11b75568c4a9fbdbfc4483083bb878bbf0f42fd68b356154d1a
I0715 20:03:40.261220 <none> src/runtime.rs:252] Put <Block hash=45354e687d8de11b75568c4a9fbdbfc4483083bb878bbf0f42fd68b356154d1a md5=41a443cad8615fdd8e63d0e3291c47b0 size=1087KiB> -> acid-1-4322880466636963880
I0715 20:03:40.267950 04331 acid_1.go:99] Put block b2594b105a65617f8e905c04d6bfbe58a6cfb072f581b3097969f5b7b6df4b5b
I0715 20:03:40.294259 <none> src/runtime.rs:252] Put <Block hash=b2594b105a65617f8e905c04d6bfbe58a6cfb072f581b3097969f5b7b6df4b5b md5=7ece58f069e0765ad0f687b98f0a068d size=4161KiB> -> acid-1-4322880466636963880
I0715 20:03:40.306462 04331 acid_1.go:99] Put block 68712a4a823a5f76082923906bb448fb3522e4ee3c1e63369956ee6291ace5d6
I0715 20:03:40.334736 <none> src/runtime.rs:252] Put <Block hash=68712a4a823a5f76082923906bb448fb3522e4ee3c1e63369956ee6291ace5d6 md5=c1ea583b2e7237ed608919a973488e93 size=3798KiB> -> acid-1-4322880466636963880
I0715 20:03:40.344183 04331 acid_1.go:99] Put block 5d0af00098e9e957ab58a421b19bd38117f315a168826352bd7d2a5033b0784a
I0715 20:03:40.350483 <none> src/runtime.rs:252] Put <Block hash=5d0af00098e9e957ab58a421b19bd38117f315a168826352bd7d2a5033b0784a md5=c9222434e362270b5ccc3a94ee5ee2b2 size=800KiB> -> acid-1-4322880466636963880
I0715 20:03:40.356109 04331 acid_1.go:99] Put block ab3aab25bb3d9c04670c68abf3ce5e95402abf6650688d8dac55360c45220d85
I0715 20:03:40.360776 <none> src/runtime.rs:252] Put <Block hash=ab3aab25bb3d9c04670c68abf3ce5e95402abf6650688d8dac55360c45220d85 md5=cee153ddf7b3220ae65f09d3a4ed9764 size=522KiB> -> acid-1-4322880466636963880
I0715 20:03:40.363931 04331 acid_1.go:99] Put block 60b112e9ca2d88f845f8fe8d73eb2a32b7a3b4650b7021c23c9a86b8f1712f20
I0715 20:03:40.380587 <none> src/runtime.rs:252] Put <Block hash=60b112e9ca2d88f845f8fe8d73eb2a32b7a3b4650b7021c23c9a86b8f1712f20 md5=313bd5e139def43d376a4c9b22e6b4b5 size=2751KiB> -> acid-1-4322880466636963880
I0715 20:03:40.386519 04331 acid_1.go:99] Put block 22ef83c97cb49b6baab98bb9998e4784b3b2cc45ec53a23013a4011f3415dc6e
I0715 20:03:40.393509 <none> src/runtime.rs:252] Put <Block hash=22ef83c97cb49b6baab98bb9998e4784b3b2cc45ec53a23013a4011f3415dc6e md5=e6d793179369895d36b29756fe024d2d size=957KiB> -> acid-1-4322880466636963880
I0715 20:03:40.396870 04331 acid_1.go:99] Put block b846bec79751c7fa5fc8fe6a84ecbc740bf4124a5b8d6cb92bb7fb67e0def334
I0715 20:03:40.406212 <none> src/runtime.rs:252] Put <Block hash=b846bec79751c7fa5fc8fe6a84ecbc740bf4124a5b8d6cb92bb7fb67e0def334 md5=55b638c9630fb87dda12d8c2eb336482 size=1309KiB> -> acid-1-4322880466636963880
I0715 20:03:40.411931 04331 acid_1.go:99] Put block a389fca9394b64a191cb833c517bc30f7df9fa4ea328b47289aa76cc45dadd63
I0715 20:03:40.428832 <none> src/runtime.rs:252] Put <Block hash=a389fca9394b64a191cb833c517bc30f7df9fa4ea328b47289aa76cc45dadd63 md5=3688979acc7fa6c0e9035f796829145e size=2627KiB> -> acid-1-4322880466636963880
I0715 20:03:40.434162 04331 acid_1.go:99] Put block a71b911b571fbcd64dc25bc608e39d524d5b77fd5da0d0c65c68d211f30bf1f2
I0715 20:03:40.440853 <none> src/runtime.rs:252] Put <Block hash=a71b911b571fbcd64dc25bc608e39d524d5b77fd5da0d0c65c68d211f30bf1f2 md5=a4e7bc9545e347d835a3c06246aab51d size=910KiB> -> acid-1-4322880466636963880
I0715 20:03:40.444225 04331 acid_1.go:137] Closing extent named acid-1-4322880466636963880
I0715 20:03:40.444847 <none> src/runtime.rs:222] Close acid-1-4322880466636963880
close delta is: 0
OOPS: 3 passed, 1 FAILED
--- FAIL: Test (9.22 seconds)
FAIL
exit status 1
FAIL dropbox/mp/osd/tests/acid_tests 9.242s
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment