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 2015/12/10 02:45:52 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1340
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1340/>
------------------------------------------
[...truncated 155252 lines...]
I1210 01:45:46.254145 31789 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Kbhc67/slaves/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-S0/frameworks/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000/executors/default/runs/d61ade87-c10c-4239-a2c1-cb1ebaca20ae' for gc 6.9999970598163days in the future
I1210 01:45:46.254278 31796 slave.cpp:3947] Cleaning up framework f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000
I1210 01:45:46.254384 31789 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Kbhc67/slaves/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-S0/frameworks/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000/executors/default' for gc 6.99999705762667days in the future
I1210 01:45:46.254544 31791 status_update_manager.cpp:282] Closing status update streams for framework f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000
I1210 01:45:46.254588 31789 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Kbhc67/slaves/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-S0/frameworks/f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000' for gc 6.99999705582222days in the future
I1210 01:45:46.254608 31791 status_update_manager.cpp:528] Cleaning up status update stream for task 6f4026e0-e4a1-4fe2-b4c8-a8b2e98446f9 of framework f6bafb49-44eb-4916-bc40-fa24e0a6c21f-0000
[ OK ] ContentType/SchedulerTest.Message/1 (701 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1210 01:45:46.407541 31768 leveldb.cpp:174] Opened db in 130.159695ms
I1210 01:45:46.441076 31768 leveldb.cpp:181] Compacted db in 33.378312ms
I1210 01:45:46.441298 31768 leveldb.cpp:196] Created db iterator in 26161ns
I1210 01:45:46.441416 31768 leveldb.cpp:202] Seeked to beginning of db in 3270ns
I1210 01:45:46.441500 31768 leveldb.cpp:271] Iterated through 0 keys in the db in 346ns
I1210 01:45:46.441627 31768 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1210 01:45:46.442515 31799 recover.cpp:447] Starting replica recovery
I1210 01:45:46.442883 31799 recover.cpp:473] Replica is in EMPTY status
I1210 01:45:46.444094 31794 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11505)@172.17.0.5:41709
I1210 01:45:46.444604 31789 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1210 01:45:46.445214 31799 recover.cpp:564] Updating replica status to STARTING
I1210 01:45:46.447002 31798 master.cpp:365] Master fc914c9c-0269-4078-b906-bdbae1a03740 (093d27726dbc) started on 172.17.0.5:41709
I1210 01:45:46.447029 31798 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/rHBpHA/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui" --work_dir="/tmp/rHBpHA/master" --zk_session_timeout="10secs"
I1210 01:45:46.447543 31798 master.cpp:414] Master allowing unauthenticated frameworks to register
I1210 01:45:46.447562 31798 master.cpp:417] Master only allowing authenticated slaves to register
I1210 01:45:46.447572 31798 credentials.hpp:35] Loading credentials for authentication from '/tmp/rHBpHA/credentials'
I1210 01:45:46.447903 31798 master.cpp:456] Using default 'crammd5' authenticator
I1210 01:45:46.448055 31798 master.cpp:493] Authorization enabled
I1210 01:45:46.449107 31800 hierarchical.cpp:163] Initialized hierarchical allocator process
I1210 01:45:46.449203 31793 whitelist_watcher.cpp:77] No whitelist given
I1210 01:45:46.450505 31793 master.cpp:1637] The newly elected leader is master@172.17.0.5:41709 with id fc914c9c-0269-4078-b906-bdbae1a03740
I1210 01:45:46.450542 31793 master.cpp:1650] Elected as the leading master!
I1210 01:45:46.450563 31793 master.cpp:1395] Recovering from registrar
I1210 01:45:46.450827 31790 registrar.cpp:307] Recovering registrar
I1210 01:45:46.489259 31789 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 43.011202ms
I1210 01:45:46.489337 31789 replica.cpp:321] Persisted replica status to STARTING
I1210 01:45:46.489644 31791 recover.cpp:473] Replica is in STARTING status
I1210 01:45:46.490815 31789 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11506)@172.17.0.5:41709
I1210 01:45:46.491096 31791 recover.cpp:193] Received a recover response from a replica in STARTING status
I1210 01:45:46.491715 31798 recover.cpp:564] Updating replica status to VOTING
I1210 01:45:46.532929 31789 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 41.002624ms
I1210 01:45:46.533007 31789 replica.cpp:321] Persisted replica status to VOTING
I1210 01:45:46.533259 31789 recover.cpp:578] Successfully joined the Paxos group
I1210 01:45:46.533442 31789 recover.cpp:462] Recover process terminated
I1210 01:45:46.534076 31789 log.cpp:659] Attempting to start the writer
I1210 01:45:46.535662 31793 replica.cpp:494] Replica received implicit promise request from (11507)@172.17.0.5:41709 with proposal 1
I1210 01:45:46.574679 31793 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 38.966739ms
I1210 01:45:46.574755 31793 replica.cpp:343] Persisted promised to 1
I1210 01:45:46.575547 31790 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1210 01:45:46.577330 31799 replica.cpp:389] Replica received explicit promise request from (11508)@172.17.0.5:41709 for position 0 with proposal 2
I1210 01:45:46.633200 31799 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 55.792737ms
I1210 01:45:46.633271 31799 replica.cpp:713] Persisted action at 0
I1210 01:45:46.634671 31787 replica.cpp:538] Replica received write request for position 0 from (11509)@172.17.0.5:41709
I1210 01:45:46.634748 31787 leveldb.cpp:436] Reading position from leveldb took 37995ns
I1210 01:45:46.675021 31787 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 40.207771ms
I1210 01:45:46.675210 31787 replica.cpp:713] Persisted action at 0
I1210 01:45:46.675952 31792 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1210 01:45:46.717267 31792 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 41.264686ms
I1210 01:45:46.717365 31792 replica.cpp:713] Persisted action at 0
I1210 01:45:46.717402 31792 replica.cpp:698] Replica learned NOP action at position 0
I1210 01:45:46.718399 31792 log.cpp:675] Writer started with ending position 0
I1210 01:45:46.719781 31787 leveldb.cpp:436] Reading position from leveldb took 58258ns
I1210 01:45:46.720955 31801 registrar.cpp:340] Successfully fetched the registry (0B) in 270.081024ms
I1210 01:45:46.721122 31801 registrar.cpp:439] Applied 1 operations in 43236ns; attempting to update the 'registry'
I1210 01:45:46.722385 31801 log.cpp:683] Attempting to append 170 bytes to the log
I1210 01:45:46.722637 31801 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1210 01:45:46.723776 31798 replica.cpp:538] Replica received write request for position 1 from (11510)@172.17.0.5:41709
I1210 01:45:46.766991 31798 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 43.150603ms
I1210 01:45:46.767081 31798 replica.cpp:713] Persisted action at 1
I1210 01:45:46.768358 31798 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1210 01:45:46.809465 31798 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 41.057288ms
I1210 01:45:46.809559 31798 replica.cpp:713] Persisted action at 1
I1210 01:45:46.809597 31798 replica.cpp:698] Replica learned APPEND action at position 1
I1210 01:45:46.811568 31798 registrar.cpp:484] Successfully updated the 'registry' in 90.376192ms
I1210 01:45:46.811702 31798 registrar.cpp:370] Successfully recovered registrar
I1210 01:45:46.811954 31798 log.cpp:702] Attempting to truncate the log to 1
I1210 01:45:46.812469 31794 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1210 01:45:46.812556 31800 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1210 01:45:46.812726 31792 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1210 01:45:46.814237 31797 replica.cpp:538] Replica received write request for position 2 from (11511)@172.17.0.5:41709
I1210 01:45:46.850872 31797 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 36.54045ms
I1210 01:45:46.850962 31797 replica.cpp:713] Persisted action at 2
I1210 01:45:46.852162 31792 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1210 01:45:46.875742 31792 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 23.492748ms
I1210 01:45:46.875902 31792 leveldb.cpp:399] Deleting ~1 keys from leveldb took 74693ns
I1210 01:45:46.875927 31792 replica.cpp:713] Persisted action at 2
I1210 01:45:46.875962 31792 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1210 01:45:46.885273 31768 scheduler.cpp:154] Version: 0.27.0
I1210 01:45:46.886065 31796 scheduler.cpp:236] New master detected at master@172.17.0.5:41709
I1210 01:45:46.889300 31793 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.5:41709
I1210 01:45:46.891988 31796 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1210 01:45:46.892051 31796 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:39060
I1210 01:45:46.892256 31796 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1210 01:45:46.892323 31796 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1210 01:45:46.892634 31790 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1210 01:45:46.893153 31790 hierarchical.cpp:267] Added framework fc914c9c-0269-4078-b906-bdbae1a03740-0000
I1210 01:45:46.893229 31790 hierarchical.cpp:1317] No resources available to allocate!
I1210 01:45:46.893259 31790 hierarchical.cpp:1410] No inverse offers to send out!
I1210 01:45:46.893280 31790 hierarchical.cpp:1063] Performed allocation for 0 slaves in 95548ns
I1210 01:45:46.893839 31790 master.hpp:1583] Sending heartbeat to fc914c9c-0269-4078-b906-bdbae1a03740-0000
I1210 01:45:46.895198 31793 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.5:41709
I1210 01:45:46.895738 31793 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.5:41709
I1210 01:45:46.896719 31793 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.5:41709
I1210 01:45:46.897384 31797 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1210 01:45:46.899233 31790 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1210 01:45:46.899375 31790 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:39061
I1210 01:45:46.899490 31790 master.cpp:2646] Processing REQUEST call for framework fc914c9c-0269-4078-b906-bdbae1a03740-0000 (default)
I1210 01:45:46.899773 31799 hierarchical.cpp:562] Received resource request from framework fc914c9c-0269-4078-b906-bdbae1a03740-0000
I1210 01:45:46.900259 31768 master.cpp:938] Master terminating
I1210 01:45:46.900871 31800 hierarchical.cpp:308] Removed framework fc914c9c-0269-4078-b906-bdbae1a03740-0000
E1210 01:45:46.904103 31797 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (632 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1210 01:45:47.019688 31768 leveldb.cpp:174] Opened db in 110.038941ms
I1210 01:45:47.059931 31768 leveldb.cpp:181] Compacted db in 40.161973ms
I1210 01:45:47.060024 31768 leveldb.cpp:196] Created db iterator in 26529ns
I1210 01:45:47.060045 31768 leveldb.cpp:202] Seeked to beginning of db in 3043ns
I1210 01:45:47.060057 31768 leveldb.cpp:271] Iterated through 0 keys in the db in 257ns
I1210 01:45:47.060117 31768 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1210 01:45:47.060699 31799 recover.cpp:447] Starting replica recovery
I1210 01:45:47.060920 31799 recover.cpp:473] Replica is in EMPTY status
I1210 01:45:47.061956 31791 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11516)@172.17.0.5:41709
I1210 01:45:47.062775 31788 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1210 01:45:47.063235 31791 recover.cpp:564] Updating replica status to STARTING
I1210 01:45:47.064136 31801 master.cpp:365] Master 6e577dc4-50be-47e9-80c7-6d0e2e4407c5 (093d27726dbc) started on 172.17.0.5:41709
I1210 01:45:47.064204 31801 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/7V0y9L/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui" --work_dir="/tmp/7V0y9L/master" --zk_session_timeout="10secs"
I1210 01:45:47.064537 31801 master.cpp:414] Master allowing unauthenticated frameworks to register
I1210 01:45:47.064558 31801 master.cpp:417] Master only allowing authenticated slaves to register
I1210 01:45:47.064570 31801 credentials.hpp:35] Loading credentials for authentication from '/tmp/7V0y9L/credentials'
I1210 01:45:47.064883 31801 master.cpp:456] Using default 'crammd5' authenticator
I1210 01:45:47.065027 31801 master.cpp:493] Authorization enabled
I1210 01:45:47.066218 31788 whitelist_watcher.cpp:77] No whitelist given
I1210 01:45:47.066359 31787 hierarchical.cpp:163] Initialized hierarchical allocator process
I1210 01:45:47.067006 31795 master.cpp:1637] The newly elected leader is master@172.17.0.5:41709 with id 6e577dc4-50be-47e9-80c7-6d0e2e4407c5
I1210 01:45:47.067070 31795 master.cpp:1650] Elected as the leading master!
I1210 01:45:47.067088 31795 master.cpp:1395] Recovering from registrar
I1210 01:45:47.067216 31793 registrar.cpp:307] Recovering registrar
I1210 01:45:47.101599 31802 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 38.178054ms
I1210 01:45:47.101691 31802 replica.cpp:321] Persisted replica status to STARTING
I1210 01:45:47.102022 31794 recover.cpp:473] Replica is in STARTING status
I1210 01:45:47.104033 31794 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11517)@172.17.0.5:41709
I1210 01:45:47.104490 31794 recover.cpp:193] Received a recover response from a replica in STARTING status
I1210 01:45:47.105227 31796 recover.cpp:564] Updating replica status to VOTING
I1210 01:45:47.143393 31794 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 37.954035ms
I1210 01:45:47.143483 31794 replica.cpp:321] Persisted replica status to VOTING
I1210 01:45:47.143754 31794 recover.cpp:578] Successfully joined the Paxos group
I1210 01:45:47.143966 31794 recover.cpp:462] Recover process terminated
I1210 01:45:47.144650 31794 log.cpp:659] Attempting to start the writer
I1210 01:45:47.146316 31796 replica.cpp:494] Replica received implicit promise request from (11518)@172.17.0.5:41709 with proposal 1
I1210 01:45:47.185189 31796 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 38.795652ms
I1210 01:45:47.185276 31796 replica.cpp:343] Persisted promised to 1
I1210 01:45:47.186159 31796 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1210 01:45:47.187798 31793 replica.cpp:389] Replica received explicit promise request from (11519)@172.17.0.5:41709 for position 0 with proposal 2
I1210 01:45:47.227007 31793 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 39.141138ms
I1210 01:45:47.227094 31793 replica.cpp:713] Persisted action at 0
I1210 01:45:47.228745 31793 replica.cpp:538] Replica received write request for position 0 from (11520)@172.17.0.5:41709
I1210 01:45:47.228816 31793 leveldb.cpp:436] Reading position from leveldb took 36711ns
I1210 01:45:47.268806 31793 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 39.92797ms
I1210 01:45:47.268896 31793 replica.cpp:713] Persisted action at 0
I1210 01:45:47.269863 31793 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1210 01:45:47.310636 31793 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 40.718466ms
I1210 01:45:47.310719 31793 replica.cpp:713] Persisted action at 0
I1210 01:45:47.310753 31793 replica.cpp:698] Replica learned NOP action at position 0
I1210 01:45:47.311825 31793 log.cpp:675] Writer started with ending position 0
I1210 01:45:47.313177 31793 leveldb.cpp:436] Reading position from leveldb took 46628ns
I1210 01:45:47.314401 31797 registrar.cpp:340] Successfully fetched the registry (0B) in 247136us
I1210 01:45:47.314751 31797 registrar.cpp:439] Applied 1 operations in 95578ns; attempting to update the 'registry'
I1210 01:45:47.315654 31797 log.cpp:683] Attempting to append 170 bytes to the log
I1210 01:45:47.315896 31789 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1210 01:45:47.316781 31795 replica.cpp:538] Replica received write request for position 1 from (11521)@172.17.0.5:41709
I1210 01:45:47.358242 31795 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 41.400517ms
I1210 01:45:47.358337 31795 replica.cpp:713] Persisted action at 1
I1210 01:45:47.359725 31796 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1210 01:45:47.402632 31796 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 42.846486ms
I1210 01:45:47.402724 31796 replica.cpp:713] Persisted action at 1
I1210 01:45:47.402761 31796 replica.cpp:698] Replica learned APPEND action at position 1
I1210 01:45:47.404814 31796 registrar.cpp:484] Successfully updated the 'registry' in 89.945088ms
I1210 01:45:47.404947 31796 registrar.cpp:370] Successfully recovered registrar
I1210 01:45:47.405385 31796 log.cpp:702] Attempting to truncate the log to 1
I1210 01:45:47.405761 31790 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1210 01:45:47.405918 31799 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1210 01:45:47.406677 31799 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1210 01:45:47.407941 31799 replica.cpp:538] Replica received write request for position 2 from (11522)@172.17.0.5:41709
I1210 01:45:47.450202 31799 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 42.185346ms
I1210 01:45:47.450290 31799 replica.cpp:713] Persisted action at 2
I1210 01:45:47.451638 31799 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1210 01:45:47.494603 31799 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 42.911346ms
I1210 01:45:47.494753 31799 leveldb.cpp:399] Deleting ~1 keys from leveldb took 70117ns
I1210 01:45:47.494778 31799 replica.cpp:713] Persisted action at 2
I1210 01:45:47.494812 31799 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1210 01:45:47.500551 31768 scheduler.cpp:154] Version: 0.27.0
I1210 01:45:47.501281 31791 scheduler.cpp:236] New master detected at master@172.17.0.5:41709
I1210 01:45:47.502437 31791 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.5:41709
I1210 01:45:47.505146 31791 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1210 01:45:47.505226 31791 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:39062
I1210 01:45:47.505532 31791 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1210 01:45:47.505591 31791 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1210 01:45:47.505836 31791 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1210 01:45:47.506217 31790 hierarchical.cpp:267] Added framework 6e577dc4-50be-47e9-80c7-6d0e2e4407c5-0000
I1210 01:45:47.506285 31790 hierarchical.cpp:1317] No resources available to allocate!
I1210 01:45:47.506319 31790 hierarchical.cpp:1410] No inverse offers to send out!
I1210 01:45:47.506347 31790 hierarchical.cpp:1063] Performed allocation for 0 slaves in 106544ns
I1210 01:45:47.506376 31790 master.hpp:1583] Sending heartbeat to 6e577dc4-50be-47e9-80c7-6d0e2e4407c5-0000
I1210 01:45:47.507904 31791 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.5:41709
I1210 01:45:47.508419 31791 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.5:41709
I1210 01:45:47.509035 31796 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1210 01:45:47.509286 31792 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.5:41709
I1210 01:45:47.510773 31787 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1210 01:45:47.510838 31787 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.5:39063
I1210 01:45:47.511045 31787 master.cpp:2646] Processing REQUEST call for framework 6e577dc4-50be-47e9-80c7-6d0e2e4407c5-0000 (default)
I1210 01:45:47.511206 31800 hierarchical.cpp:562] Received resource request from framework 6e577dc4-50be-47e9-80c7-6d0e2e4407c5-0000
I1210 01:45:47.511494 31787 master.cpp:938] Master terminating
I1210 01:45:47.511732 31802 hierarchical.cpp:308] Removed framework 6e577dc4-50be-47e9-80c7-6d0e2e4407c5-0000
E1210 01:45:47.512843 31800 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (609 ms)
[----------] 22 tests from ContentType/SchedulerTest (17029 ms total)
[----------] Global test environment tear-down
[==========] 886 tests from 116 test cases ran. (777870 ms total)
[ PASSED ] 885 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] HealthCheckTest.CheckCommandTimeout
1 FAILED TEST
YOU HAVE 7 DISABLED TESTS
make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[4]: *** [check-local] Error 1
make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[3]: *** [check-am] Error 2
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.27.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1449708120-8272
Untagged: mesos-1449708120-8272:latest
Deleted: 6ad9d45c6bda4b64a381dc9703da43b5a619757e2b397bb0867e48f710e0f4b0
Deleted: e18e08c449930f4ebe3b46424d099df35e56613b78e88cbdb9078b4a5fe15a4d
Deleted: f911910bb78581981555800c0ada0ebfe8a40d9a148bf0d3c99f712f298011af
Deleted: a4999d1dc063e6e5f3955e0feb17ec24b62721f833882081bd5c11814ed1c38e
Deleted: dba0f235cc0cf426b42a98f94faf70f99c269a10383691e05e54da1f1b88aeab
Deleted: bdd9e71d603160c55182c46d104d437c8242ab39571f512c0ef1f106295ffe16
Deleted: 89a7446d53a8e4f8ed9d377d6cfa20658e8135bf95cd8ab2d21672a06fa8f08c
Deleted: 5b11cdebf124bf325888a1149918ddc23c30b31453ea8ff0edd667a4ac142519
Deleted: 87bb33c02bac884ccf32446c947256f443f06620adece2dfd1a3849e62125659
Deleted: c9fc0122301a2d90a77d00c6157a340631a6d7ac81ceecdae7e06e3e6d9953ef
Deleted: f28c89586e46ea6573d9b3f68caa2790b1365cf7b4e282d779c126ef7dd318e1
Deleted: 3b6aa7304f9d29be0170ca46f67a190c241d841fceb2afab0d89a7e95c2fd1b3
Deleted: d8c00382b727bd952222d05f0448086b295ad20d57e48ce875ce01e53fe886e4
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1341
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,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1341/changes>