You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/02/23 19:27:38 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1707
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1707/changes>
Changes:
[bmahler] Revert "Cleaned up hierarchical allocator tests."
[bmahler] Used `size_t` instead of `int` to track number of frameworks per role.
------------------------------------------
[...truncated 169639 lines...]
I0223 18:27:35.376461 2277 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_L4Pc40/slaves/d49b2537-72dd-4157-bf5d-7cf737a53e90-S0/frameworks/d49b2537-72dd-4157-bf5d-7cf737a53e90-0000/executors/default' for gc 6.99999565409778days in the future
I0223 18:27:35.376607 2277 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_L4Pc40/slaves/d49b2537-72dd-4157-bf5d-7cf737a53e90-S0/frameworks/d49b2537-72dd-4157-bf5d-7cf737a53e90-0000' for gc 6.99999565067259days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (773 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I0223 18:27:35.521330 2258 leveldb.cpp:174] Opened db in 135.726619ms
I0223 18:27:35.570257 2258 leveldb.cpp:181] Compacted db in 48.836791ms
I0223 18:27:35.570366 2258 leveldb.cpp:196] Created db iterator in 32048ns
I0223 18:27:35.570386 2258 leveldb.cpp:202] Seeked to beginning of db in 3898ns
I0223 18:27:35.570397 2258 leveldb.cpp:271] Iterated through 0 keys in the db in 290ns
I0223 18:27:35.570456 2258 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0223 18:27:35.571717 2285 recover.cpp:447] Starting replica recovery
I0223 18:27:35.572334 2285 recover.cpp:473] Replica is in EMPTY status
I0223 18:27:35.574895 2288 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (14819)@172.17.0.2:35946
I0223 18:27:35.575244 2291 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0223 18:27:35.576375 2288 recover.cpp:564] Updating replica status to STARTING
I0223 18:27:35.579334 2290 master.cpp:376] Master 12f88e19-3873-4917-b5f4-aada80161726 (b14bef2d4d3c) started on 172.17.0.2:35946
I0223 18:27:35.579614 2290 master.cpp:378] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/n1PKW6/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir="/tmp/n1PKW6/master" --zk_session_timeout="10secs"
I0223 18:27:35.580183 2290 master.cpp:425] Master allowing unauthenticated frameworks to register
I0223 18:27:35.580265 2290 master.cpp:428] Master only allowing authenticated slaves to register
I0223 18:27:35.580354 2290 credentials.hpp:35] Loading credentials for authentication from '/tmp/n1PKW6/credentials'
I0223 18:27:35.580821 2290 master.cpp:468] Using default 'crammd5' authenticator
I0223 18:27:35.581084 2290 master.cpp:537] Using default 'basic' HTTP authenticator
I0223 18:27:35.581348 2290 master.cpp:571] Authorization enabled
I0223 18:27:35.582311 2280 hierarchical.cpp:144] Initialized hierarchical allocator process
I0223 18:27:35.582422 2279 whitelist_watcher.cpp:77] No whitelist given
I0223 18:27:35.585829 2289 master.cpp:1712] The newly elected leader is master@172.17.0.2:35946 with id 12f88e19-3873-4917-b5f4-aada80161726
I0223 18:27:35.585901 2289 master.cpp:1725] Elected as the leading master!
I0223 18:27:35.585924 2289 master.cpp:1470] Recovering from registrar
I0223 18:27:35.586107 2279 registrar.cpp:307] Recovering registrar
I0223 18:27:35.615767 2287 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 39.187169ms
I0223 18:27:35.615875 2287 replica.cpp:320] Persisted replica status to STARTING
I0223 18:27:35.616298 2287 recover.cpp:473] Replica is in STARTING status
I0223 18:27:35.618446 2279 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (14821)@172.17.0.2:35946
I0223 18:27:35.619029 2279 recover.cpp:193] Received a recover response from a replica in STARTING status
I0223 18:27:35.620254 2279 recover.cpp:564] Updating replica status to VOTING
I0223 18:27:35.657387 2279 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 36.663229ms
I0223 18:27:35.657475 2279 replica.cpp:320] Persisted replica status to VOTING
I0223 18:27:35.657735 2279 recover.cpp:578] Successfully joined the Paxos group
I0223 18:27:35.657935 2279 recover.cpp:462] Recover process terminated
I0223 18:27:35.658829 2279 log.cpp:659] Attempting to start the writer
I0223 18:27:35.660677 2291 replica.cpp:493] Replica received implicit promise request from (14822)@172.17.0.2:35946 with proposal 1
I0223 18:27:35.704761 2291 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 43.991324ms
I0223 18:27:35.704854 2291 replica.cpp:342] Persisted promised to 1
I0223 18:27:35.705821 2284 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0223 18:27:35.707358 2281 replica.cpp:388] Replica received explicit promise request from (14823)@172.17.0.2:35946 for position 0 with proposal 2
I0223 18:27:35.744385 2281 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 36.944234ms
I0223 18:27:35.744485 2281 replica.cpp:712] Persisted action at 0
I0223 18:27:35.746425 2281 replica.cpp:537] Replica received write request for position 0 from (14824)@172.17.0.2:35946
I0223 18:27:35.746538 2281 leveldb.cpp:436] Reading position from leveldb took 50359ns
I0223 18:27:35.774420 2281 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 27.811473ms
I0223 18:27:35.774519 2281 replica.cpp:712] Persisted action at 0
I0223 18:27:35.775662 2281 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0223 18:27:35.799525 2281 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 23.807018ms
I0223 18:27:35.799619 2281 replica.cpp:712] Persisted action at 0
I0223 18:27:35.799656 2281 replica.cpp:697] Replica learned NOP action at position 0
I0223 18:27:35.808384 2280 log.cpp:675] Writer started with ending position 0
I0223 18:27:35.810099 2280 leveldb.cpp:436] Reading position from leveldb took 69640ns
I0223 18:27:35.811640 2280 registrar.cpp:340] Successfully fetched the registry (0B) in 225.464832ms
I0223 18:27:35.811872 2280 registrar.cpp:439] Applied 1 operations in 42140ns; attempting to update the 'registry'
I0223 18:27:35.813421 2292 log.cpp:683] Attempting to append 170 bytes to the log
I0223 18:27:35.813778 2292 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0223 18:27:35.815016 2292 replica.cpp:537] Replica received write request for position 1 from (14825)@172.17.0.2:35946
I0223 18:27:35.841339 2292 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 26.187874ms
I0223 18:27:35.841437 2292 replica.cpp:712] Persisted action at 1
I0223 18:27:35.842999 2278 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0223 18:27:35.883328 2278 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 40.260937ms
I0223 18:27:35.883426 2278 replica.cpp:712] Persisted action at 1
I0223 18:27:35.883463 2278 replica.cpp:697] Replica learned APPEND action at position 1
I0223 18:27:35.885586 2292 registrar.cpp:484] Successfully updated the 'registry' in 73.583104ms
I0223 18:27:35.885797 2292 registrar.cpp:370] Successfully recovered registrar
I0223 18:27:35.886401 2292 master.cpp:1522] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0223 18:27:35.886661 2292 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0223 18:27:35.887141 2291 log.cpp:702] Attempting to truncate the log to 1
I0223 18:27:35.887415 2291 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0223 18:27:35.888639 2291 replica.cpp:537] Replica received write request for position 2 from (14826)@172.17.0.2:35946
I0223 18:27:35.924888 2291 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 36.18293ms
I0223 18:27:35.924981 2291 replica.cpp:712] Persisted action at 2
I0223 18:27:35.926430 2291 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0223 18:27:35.950003 2291 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 23.518766ms
I0223 18:27:35.950188 2291 leveldb.cpp:399] Deleting ~1 keys from leveldb took 88344ns
I0223 18:27:35.950228 2291 replica.cpp:712] Persisted action at 2
I0223 18:27:35.950270 2291 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0223 18:27:35.960592 2258 scheduler.cpp:154] Version: 0.28.0
I0223 18:27:35.961495 2284 scheduler.cpp:236] New master detected at master@172.17.0.2:35946
I0223 18:27:35.963209 2289 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:35946
I0223 18:27:35.965473 2280 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0223 18:27:35.966140 2280 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:39170
I0223 18:27:35.966480 2280 master.cpp:1974] Received subscription request for HTTP framework 'default'
I0223 18:27:35.966629 2280 master.cpp:1751] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0223 18:27:35.967284 2291 master.cpp:2065] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0223 18:27:35.967912 2291 hierarchical.cpp:265] Added framework 12f88e19-3873-4917-b5f4-aada80161726-0000
I0223 18:27:35.968139 2291 hierarchical.cpp:1434] No resources available to allocate!
I0223 18:27:35.968267 2291 hierarchical.cpp:1529] No inverse offers to send out!
I0223 18:27:35.968389 2291 hierarchical.cpp:1127] Performed allocation for 0 slaves in 319722ns
I0223 18:27:35.967996 2279 master.hpp:1657] Sending heartbeat to 12f88e19-3873-4917-b5f4-aada80161726-0000
I0223 18:27:35.970701 2289 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:35946
I0223 18:27:35.971493 2284 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:35946
I0223 18:27:35.972264 2284 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0223 18:27:35.973592 2284 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:35946
I0223 18:27:35.979287 2283 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0223 18:27:35.979861 2286 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:39172
I0223 18:27:35.980165 2286 master.cpp:2719] Processing REQUEST call for framework 12f88e19-3873-4917-b5f4-aada80161726-0000 (default)
I0223 18:27:35.980556 2286 hierarchical.cpp:589] Received resource request from framework 12f88e19-3873-4917-b5f4-aada80161726-0000
I0223 18:27:35.981950 2258 master.cpp:1027] Master terminating
I0223 18:27:35.982381 2283 hierarchical.cpp:326] Removed framework 12f88e19-3873-4917-b5f4-aada80161726-0000
E0223 18:27:35.986712 2284 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (609 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0223 18:27:36.098789 2258 leveldb.cpp:174] Opened db in 103.908551ms
I0223 18:27:36.123095 2258 leveldb.cpp:181] Compacted db in 24.216226ms
I0223 18:27:36.123199 2258 leveldb.cpp:196] Created db iterator in 31136ns
I0223 18:27:36.123230 2258 leveldb.cpp:202] Seeked to beginning of db in 3842ns
I0223 18:27:36.123247 2258 leveldb.cpp:271] Iterated through 0 keys in the db in 421ns
I0223 18:27:36.123307 2258 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0223 18:27:36.124235 2287 recover.cpp:447] Starting replica recovery
I0223 18:27:36.124972 2278 recover.cpp:473] Replica is in EMPTY status
I0223 18:27:36.126878 2278 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (14834)@172.17.0.2:35946
I0223 18:27:36.127547 2278 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0223 18:27:36.128396 2278 recover.cpp:564] Updating replica status to STARTING
I0223 18:27:36.141350 2282 master.cpp:376] Master b708dd99-a063-4976-9405-9f1df6ed5285 (b14bef2d4d3c) started on 172.17.0.2:35946
I0223 18:27:36.142300 2282 master.cpp:378] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/0A2S4P/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir="/tmp/0A2S4P/master" --zk_session_timeout="10secs"
I0223 18:27:36.143381 2282 master.cpp:425] Master allowing unauthenticated frameworks to register
I0223 18:27:36.143594 2282 master.cpp:428] Master only allowing authenticated slaves to register
I0223 18:27:36.143669 2282 credentials.hpp:35] Loading credentials for authentication from '/tmp/0A2S4P/credentials'
I0223 18:27:36.144251 2282 master.cpp:468] Using default 'crammd5' authenticator
I0223 18:27:36.144661 2282 master.cpp:537] Using default 'basic' HTTP authenticator
I0223 18:27:36.145236 2282 master.cpp:571] Authorization enabled
I0223 18:27:36.146577 2281 hierarchical.cpp:144] Initialized hierarchical allocator process
I0223 18:27:36.147269 2288 whitelist_watcher.cpp:77] No whitelist given
I0223 18:27:36.149832 2282 master.cpp:1712] The newly elected leader is master@172.17.0.2:35946 with id b708dd99-a063-4976-9405-9f1df6ed5285
I0223 18:27:36.150161 2282 master.cpp:1725] Elected as the leading master!
I0223 18:27:36.150344 2282 master.cpp:1470] Recovering from registrar
I0223 18:27:36.150677 2283 registrar.cpp:307] Recovering registrar
I0223 18:27:36.154433 2290 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 25.599285ms
I0223 18:27:36.154922 2290 replica.cpp:320] Persisted replica status to STARTING
I0223 18:27:36.155633 2290 recover.cpp:473] Replica is in STARTING status
I0223 18:27:36.158319 2284 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (14836)@172.17.0.2:35946
I0223 18:27:36.159045 2289 recover.cpp:193] Received a recover response from a replica in STARTING status
I0223 18:27:36.159988 2289 recover.cpp:564] Updating replica status to VOTING
I0223 18:27:36.192323 2292 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 31.827894ms
I0223 18:27:36.192419 2292 replica.cpp:320] Persisted replica status to VOTING
I0223 18:27:36.192706 2292 recover.cpp:578] Successfully joined the Paxos group
I0223 18:27:36.192955 2292 recover.cpp:462] Recover process terminated
I0223 18:27:36.193639 2289 log.cpp:659] Attempting to start the writer
I0223 18:27:36.196347 2292 replica.cpp:493] Replica received implicit promise request from (14837)@172.17.0.2:35946 with proposal 1
I0223 18:27:36.239511 2292 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 43.08121ms
I0223 18:27:36.239605 2292 replica.cpp:342] Persisted promised to 1
I0223 18:27:36.240952 2292 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0223 18:27:36.242867 2292 replica.cpp:388] Replica received explicit promise request from (14838)@172.17.0.2:35946 for position 0 with proposal 2
I0223 18:27:36.290314 2292 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 47.289235ms
I0223 18:27:36.290405 2292 replica.cpp:712] Persisted action at 0
I0223 18:27:36.292119 2292 replica.cpp:537] Replica received write request for position 0 from (14839)@172.17.0.2:35946
I0223 18:27:36.292189 2292 leveldb.cpp:436] Reading position from leveldb took 37718ns
I0223 18:27:36.340319 2292 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 47.944504ms
I0223 18:27:36.340415 2292 replica.cpp:712] Persisted action at 0
I0223 18:27:36.341598 2292 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0223 18:27:36.384261 2292 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 42.609671ms
I0223 18:27:36.384359 2292 replica.cpp:712] Persisted action at 0
I0223 18:27:36.384403 2292 replica.cpp:697] Replica learned NOP action at position 0
I0223 18:27:36.385663 2281 log.cpp:675] Writer started with ending position 0
I0223 18:27:36.387593 2281 leveldb.cpp:436] Reading position from leveldb took 67808ns
I0223 18:27:36.389291 2292 registrar.cpp:340] Successfully fetched the registry (0B) in 238.415104ms
I0223 18:27:36.389456 2292 registrar.cpp:439] Applied 1 operations in 49370ns; attempting to update the 'registry'
I0223 18:27:36.390426 2286 log.cpp:683] Attempting to append 170 bytes to the log
I0223 18:27:36.390686 2286 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0223 18:27:36.391969 2280 replica.cpp:537] Replica received write request for position 1 from (14840)@172.17.0.2:35946
I0223 18:27:36.439991 2280 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 47.812592ms
I0223 18:27:36.440083 2280 replica.cpp:712] Persisted action at 1
I0223 18:27:36.441689 2280 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0223 18:27:36.484483 2280 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 42.741569ms
I0223 18:27:36.484576 2280 replica.cpp:712] Persisted action at 1
I0223 18:27:36.484613 2280 replica.cpp:697] Replica learned APPEND action at position 1
I0223 18:27:36.487216 2286 registrar.cpp:484] Successfully updated the 'registry' in 97.670144ms
I0223 18:27:36.487401 2286 registrar.cpp:370] Successfully recovered registrar
I0223 18:27:36.487926 2287 master.cpp:1522] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0223 18:27:36.488140 2287 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0223 18:27:36.489147 2291 log.cpp:702] Attempting to truncate the log to 1
I0223 18:27:36.489481 2291 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0223 18:27:36.491006 2291 replica.cpp:537] Replica received write request for position 2 from (14841)@172.17.0.2:35946
I0223 18:27:36.548566 2291 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 57.484546ms
I0223 18:27:36.548656 2291 replica.cpp:712] Persisted action at 2
I0223 18:27:36.550191 2291 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0223 18:27:36.593027 2291 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 42.784078ms
I0223 18:27:36.593205 2291 leveldb.cpp:399] Deleting ~1 keys from leveldb took 88081ns
I0223 18:27:36.593250 2291 replica.cpp:712] Persisted action at 2
I0223 18:27:36.593294 2291 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0223 18:27:36.605084 2258 scheduler.cpp:154] Version: 0.28.0
I0223 18:27:36.606001 2283 scheduler.cpp:236] New master detected at master@172.17.0.2:35946
I0223 18:27:36.609405 2277 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:35946
I0223 18:27:36.613586 2289 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0223 18:27:36.614702 2289 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:39185
I0223 18:27:36.615447 2289 master.cpp:1974] Received subscription request for HTTP framework 'default'
I0223 18:27:36.615623 2289 master.cpp:1751] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0223 18:27:36.616394 2289 master.cpp:2065] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0223 18:27:36.617396 2289 hierarchical.cpp:265] Added framework b708dd99-a063-4976-9405-9f1df6ed5285-0000
I0223 18:27:36.617652 2289 hierarchical.cpp:1434] No resources available to allocate!
I0223 18:27:36.617789 2289 hierarchical.cpp:1529] No inverse offers to send out!
I0223 18:27:36.617929 2289 hierarchical.cpp:1127] Performed allocation for 0 slaves in 398499ns
I0223 18:27:36.617393 2278 master.hpp:1657] Sending heartbeat to b708dd99-a063-4976-9405-9f1df6ed5285-0000
I0223 18:27:36.622828 2282 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:35946
I0223 18:27:36.624300 2281 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:35946
I0223 18:27:36.625299 2281 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0223 18:27:36.626374 2282 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:35946
I0223 18:27:36.633985 2289 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0223 18:27:36.635118 2289 http.cpp:501] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:39186
I0223 18:27:36.635682 2289 master.cpp:2719] Processing REQUEST call for framework b708dd99-a063-4976-9405-9f1df6ed5285-0000 (default)
I0223 18:27:36.636123 2291 hierarchical.cpp:589] Received resource request from framework b708dd99-a063-4976-9405-9f1df6ed5285-0000
I0223 18:27:36.638211 2279 master.cpp:1027] Master terminating
I0223 18:27:36.642473 2286 hierarchical.cpp:326] Removed framework b708dd99-a063-4976-9405-9f1df6ed5285-0000
[ OK ] ContentType/SchedulerTest.Request/1 (694 ms)
[----------] 22 tests from ContentType/SchedulerTest (20201 ms total)
[----------] Global test environment tear-down
[==========] 984 tests from 128 test cases ran. (832125 ms total)
[ PASSED ] 983 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] HealthCheckTest.HealthStatusChange
1 FAILED TEST
YOU HAVE 8 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.28.0/_build/src'
make[3]: Leaving directory `/mesos/mesos-0.28.0/_build/src'
make[3]: *** [check-am] Error 2
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.28.0/_build/src'
make[1]: Leaving directory `/mesos/mesos-0.28.0/_build'
make[1]: *** [check-recursive] Error 1
make: *** [distcheck] Error 1
+ docker rmi mesos-1456248733-12522
Untagged: mesos-1456248733-12522:latest
Deleted: 1a045433452502aaf8e9b8d32ca0809e021f9c5125f6cf51e226337930490e12
Deleted: a9ed29b710ec641458251dd3a3eb933af4648c0988f45d7b8fac0966c59173dd
Deleted: db1f52076fb60cba4d4a86ef20e297a6ca275dc08f691b4165a1d70e6dff0ca5
Deleted: 33ba49041c26896823ddfae8e6ac09bd947c282f4d821bf9d8a31243e7789b63
Deleted: 17e483636f1730c1c888a8e590f02606b18a2acaf3cee6c2db2f0078642a3447
Deleted: f93893f4118d2f369c0ccc44bd92e923681bec666ec96b1871458b90c27b9096
Deleted: e66102fb7160af94c9677ff931d7fab0f15f2f92b75913413a0a3da857846ac5
Deleted: eb5f911396f5c7e077e35fb38b50a2246a13a168069d7d847e0dcb7ff3b3ca84
Deleted: e5f77b90c11c51c5f4013fccd83c7a18deccff8cb9c242dd824ec1a78d41c30b
Deleted: 82c300fae7799f2042180944f71225e8f79319eedd37996d8fbc8b5e70d7fc15
Deleted: a87d99babfd9d04d0ce207e63851cccb8aaa6608d872593f1012228e71b460bb
Deleted: 5704df30a42c8089a4e3dcbe2a766b2bb011115c5c0fe04bc1d6e0084a12c351
Deleted: 837e27fba5a9e72874b50504a1a88a7e21071798b335d5bb4894119701fe5d4f
Deleted: 29de64c66956f239758623a1da0ead870527e87b8935173e7035a295d4673da7
Deleted: 9ae7b19b40f8f4c2c72d842b0ec68cc6eeaf2a3f857d237e897f71684fc28ddd
Deleted: 4779931597d996926d8fa742d28ce7b8f4d22b79e8eeaafd3fea9abddf1b5591
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1708
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1708/changes>