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/03/22 18:48:25 UTC
Build failed in Jenkins: Mesos » clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1844
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1844/changes>
Changes:
[yujie.jay] Added normalize method to registry puller.
[yujie.jay] Added test for registry puller normalize.
[yujie.jay] Add agent flags for specifying CNI plugin and config directories.
------------------------------------------
[...truncated 172212 lines...]
I0322 17:48:20.529992 32086 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 1.227392ms
I0322 17:48:20.530030 32086 replica.cpp:320] Persisted replica status to STARTING
I0322 17:48:20.530243 32086 recover.cpp:473] Replica is in STARTING status
I0322 17:48:20.529502 32091 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/IJglhW/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.29.0/_inst/share/mesos/webui" --work_dir="/tmp/IJglhW/master" --zk_session_timeout="10secs"
I0322 17:48:20.531278 32091 master.cpp:425] Master allowing unauthenticated frameworks to register
I0322 17:48:20.531424 32091 master.cpp:428] Master only allowing authenticated slaves to register
I0322 17:48:20.531600 32091 credentials.hpp:35] Loading credentials for authentication from '/tmp/IJglhW/credentials'
I0322 17:48:20.531632 32086 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (15635)@172.17.0.1:53521
I0322 17:48:20.532265 32086 recover.cpp:193] Received a recover response from a replica in STARTING status
I0322 17:48:20.532718 32082 recover.cpp:564] Updating replica status to VOTING
I0322 17:48:20.532876 32091 master.cpp:468] Using default 'crammd5' authenticator
I0322 17:48:20.533224 32091 master.cpp:537] Using default 'basic' HTTP authenticator
I0322 17:48:20.533596 32091 master.cpp:571] Authorization enabled
I0322 17:48:20.533869 32087 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 730659ns
I0322 17:48:20.533898 32087 replica.cpp:320] Persisted replica status to VOTING
I0322 17:48:20.534027 32087 hierarchical.cpp:144] Initialized hierarchical allocator process
I0322 17:48:20.534132 32095 recover.cpp:578] Successfully joined the Paxos group
I0322 17:48:20.534713 32081 whitelist_watcher.cpp:77] No whitelist given
I0322 17:48:20.534811 32095 recover.cpp:462] Recover process terminated
I0322 17:48:20.537628 32082 master.cpp:1806] The newly elected leader is master@172.17.0.1:53521 with id 20b159b0-e6ca-4b7f-af27-23d224be810d
I0322 17:48:20.537667 32082 master.cpp:1819] Elected as the leading master!
I0322 17:48:20.537684 32082 master.cpp:1508] Recovering from registrar
I0322 17:48:20.537798 32092 registrar.cpp:307] Recovering registrar
I0322 17:48:20.538661 32092 log.cpp:659] Attempting to start the writer
I0322 17:48:20.540187 32088 replica.cpp:493] Replica received implicit promise request from (15637)@172.17.0.1:53521 with proposal 1
I0322 17:48:20.540683 32088 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 471801ns
I0322 17:48:20.540709 32088 replica.cpp:342] Persisted promised to 1
I0322 17:48:20.541366 32088 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0322 17:48:20.543216 32089 replica.cpp:388] Replica received explicit promise request from (15638)@172.17.0.1:53521 for position 0 with proposal 2
I0322 17:48:20.543679 32089 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 401724ns
I0322 17:48:20.543715 32089 replica.cpp:712] Persisted action at 0
I0322 17:48:20.545042 32085 replica.cpp:537] Replica received write request for position 0 from (15639)@172.17.0.1:53521
I0322 17:48:20.545109 32085 leveldb.cpp:436] Reading position from leveldb took 46337ns
I0322 17:48:20.545439 32085 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 292463ns
I0322 17:48:20.545461 32085 replica.cpp:712] Persisted action at 0
I0322 17:48:20.546115 32085 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0322 17:48:20.546486 32085 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 350953ns
I0322 17:48:20.546510 32085 replica.cpp:712] Persisted action at 0
I0322 17:48:20.546532 32085 replica.cpp:697] Replica learned NOP action at position 0
I0322 17:48:20.547024 32086 log.cpp:675] Writer started with ending position 0
I0322 17:48:20.548185 32084 leveldb.cpp:436] Reading position from leveldb took 92591ns
I0322 17:48:20.549223 32084 registrar.cpp:340] Successfully fetched the registry (0B) in 11.331072ms
I0322 17:48:20.549373 32084 registrar.cpp:439] Applied 1 operations in 77847ns; attempting to update the 'registry'
I0322 17:48:20.550127 32088 log.cpp:683] Attempting to append 170 bytes to the log
I0322 17:48:20.550256 32084 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0322 17:48:20.551029 32090 replica.cpp:537] Replica received write request for position 1 from (15640)@172.17.0.1:53521
I0322 17:48:20.551934 32090 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 874371ns
I0322 17:48:20.551962 32090 replica.cpp:712] Persisted action at 1
I0322 17:48:20.552633 32095 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0322 17:48:20.552978 32095 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 329969ns
I0322 17:48:20.553001 32095 replica.cpp:712] Persisted action at 1
I0322 17:48:20.553019 32095 replica.cpp:697] Replica learned APPEND action at position 1
I0322 17:48:20.554078 32080 registrar.cpp:484] Successfully updated the 'registry' in 4.603136ms
I0322 17:48:20.554265 32080 registrar.cpp:370] Successfully recovered registrar
I0322 17:48:20.554384 32092 log.cpp:702] Attempting to truncate the log to 1
I0322 17:48:20.554744 32085 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0322 17:48:20.555321 32089 master.cpp:1616] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0322 17:48:20.555349 32085 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0322 17:48:20.555613 32081 replica.cpp:537] Replica received write request for position 2 from (15641)@172.17.0.1:53521
I0322 17:48:20.556043 32081 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 399797ns
I0322 17:48:20.556079 32081 replica.cpp:712] Persisted action at 2
I0322 17:48:20.556633 32088 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0322 17:48:20.557140 32088 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 490985ns
I0322 17:48:20.557204 32088 leveldb.cpp:399] Deleting ~1 keys from leveldb took 45594ns
I0322 17:48:20.557229 32088 replica.cpp:712] Persisted action at 2
I0322 17:48:20.557252 32088 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0322 17:48:20.565825 32062 scheduler.cpp:172] Version: 0.29.0
I0322 17:48:20.566872 32081 scheduler.cpp:437] New master detected at master@172.17.0.1:53521
I0322 17:48:20.568799 32080 scheduler.cpp:337] Connected with the master at http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.570068 32080 scheduler.cpp:230] Sending SUBSCRIBE call to http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.571508 32084 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0322 17:48:20.572156 32084 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:50883
I0322 17:48:20.572432 32084 master.cpp:2068] Received subscription request for HTTP framework 'default'
I0322 17:48:20.572458 32084 master.cpp:1845] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0322 17:48:20.573252 32084 master.cpp:2159] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0322 17:48:20.573801 32087 hierarchical.cpp:265] Added framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000
I0322 17:48:20.573905 32087 hierarchical.cpp:1453] No resources available to allocate!
I0322 17:48:20.573946 32087 hierarchical.cpp:1548] No inverse offers to send out!
I0322 17:48:20.573964 32091 master.hpp:1715] Sending heartbeat to 20b159b0-e6ca-4b7f-af27-23d224be810d-0000
I0322 17:48:20.573973 32087 hierarchical.cpp:1130] Performed allocation for 0 slaves in 146636ns
I0322 17:48:20.575450 32080 scheduler.cpp:612] Enqueuing event SUBSCRIBED received from http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.576963 32087 scheduler.cpp:230] Sending REQUEST call to http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.577196 32087 scheduler.cpp:612] Enqueuing event HEARTBEAT received from http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.578148 32087 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0322 17:48:20.578537 32088 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:50884
I0322 17:48:20.578694 32088 master.cpp:2765] Processing REQUEST call for framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default)
I0322 17:48:20.578917 32092 hierarchical.cpp:589] Received resource request from framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000
I0322 17:48:20.581019 32092 master.cpp:1251] Framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default) disconnected
I0322 17:48:20.581171 32092 master.cpp:2622] Disconnecting framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default)
I0322 17:48:20.581317 32092 master.cpp:2646] Deactivating framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default)
I0322 17:48:20.581452 32092 master.cpp:1275] Giving framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default) 0ns to failover
I0322 17:48:20.581511 32095 hierarchical.cpp:375] Deactivated framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000
I0322 17:48:20.582931 32089 master.cpp:5340] Framework failover timeout, removing framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default)
I0322 17:48:20.582967 32089 master.cpp:6073] Removing framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000 (default)
I0322 17:48:20.583245 32089 hierarchical.cpp:326] Removed framework 20b159b0-e6ca-4b7f-af27-23d224be810d-0000
I0322 17:48:20.592191 32062 master.cpp:1065] Master terminating
[ OK ] ContentType/SchedulerTest.Request/0 (89 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0322 17:48:20.606706 32062 cluster.cpp:139] Creating default 'local' authorizer
I0322 17:48:20.614327 32062 leveldb.cpp:174] Opened db in 7.38195ms
I0322 17:48:20.618171 32062 leveldb.cpp:181] Compacted db in 3.79394ms
I0322 17:48:20.618278 32062 leveldb.cpp:196] Created db iterator in 41954ns
I0322 17:48:20.618301 32062 leveldb.cpp:202] Seeked to beginning of db in 11470ns
I0322 17:48:20.618314 32062 leveldb.cpp:271] Iterated through 0 keys in the db in 7548ns
I0322 17:48:20.618368 32062 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0322 17:48:20.619199 32084 recover.cpp:447] Starting replica recovery
I0322 17:48:20.619510 32084 recover.cpp:473] Replica is in EMPTY status
I0322 17:48:20.621053 32082 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (15649)@172.17.0.1:53521
I0322 17:48:20.622054 32084 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0322 17:48:20.622681 32083 recover.cpp:564] Updating replica status to STARTING
I0322 17:48:20.624878 32084 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 1.977595ms
I0322 17:48:20.625031 32084 replica.cpp:320] Persisted replica status to STARTING
I0322 17:48:20.625442 32084 recover.cpp:473] Replica is in STARTING status
I0322 17:48:20.626893 32090 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (15650)@172.17.0.1:53521
I0322 17:48:20.627532 32084 recover.cpp:193] Received a recover response from a replica in STARTING status
I0322 17:48:20.629101 32084 recover.cpp:564] Updating replica status to VOTING
I0322 17:48:20.629989 32084 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 534367ns
I0322 17:48:20.630098 32084 replica.cpp:320] Persisted replica status to VOTING
I0322 17:48:20.630306 32084 recover.cpp:578] Successfully joined the Paxos group
I0322 17:48:20.630648 32084 recover.cpp:462] Recover process terminated
I0322 17:48:20.631855 32084 master.cpp:376] Master 8a9035c7-7140-443d-8cb2-b8d064904aec (69a5804f656b) started on 172.17.0.1:53521
I0322 17:48:20.631969 32084 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/844j4E/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.29.0/_inst/share/mesos/webui" --work_dir="/tmp/844j4E/master" --zk_session_timeout="10secs"
I0322 17:48:20.632807 32084 master.cpp:425] Master allowing unauthenticated frameworks to register
I0322 17:48:20.632992 32084 master.cpp:428] Master only allowing authenticated slaves to register
I0322 17:48:20.633112 32084 credentials.hpp:35] Loading credentials for authentication from '/tmp/844j4E/credentials'
I0322 17:48:20.634882 32084 master.cpp:468] Using default 'crammd5' authenticator
I0322 17:48:20.635418 32084 master.cpp:537] Using default 'basic' HTTP authenticator
I0322 17:48:20.635713 32084 master.cpp:571] Authorization enabled
I0322 17:48:20.636080 32088 hierarchical.cpp:144] Initialized hierarchical allocator process
I0322 17:48:20.636873 32087 whitelist_watcher.cpp:77] No whitelist given
I0322 17:48:20.642400 32084 master.cpp:1806] The newly elected leader is master@172.17.0.1:53521 with id 8a9035c7-7140-443d-8cb2-b8d064904aec
I0322 17:48:20.642751 32084 master.cpp:1819] Elected as the leading master!
I0322 17:48:20.643010 32084 master.cpp:1508] Recovering from registrar
I0322 17:48:20.644080 32084 registrar.cpp:307] Recovering registrar
I0322 17:48:20.645745 32090 log.cpp:659] Attempting to start the writer
I0322 17:48:20.647284 32091 replica.cpp:493] Replica received implicit promise request from (15652)@172.17.0.1:53521 with proposal 1
I0322 17:48:20.648870 32091 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 1.551634ms
I0322 17:48:20.648924 32091 replica.cpp:342] Persisted promised to 1
I0322 17:48:20.649750 32091 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0322 17:48:20.651454 32082 replica.cpp:388] Replica received explicit promise request from (15653)@172.17.0.1:53521 for position 0 with proposal 2
I0322 17:48:20.652894 32082 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 1.329419ms
I0322 17:48:20.652942 32082 replica.cpp:712] Persisted action at 0
I0322 17:48:20.654598 32085 replica.cpp:537] Replica received write request for position 0 from (15654)@172.17.0.1:53521
I0322 17:48:20.654692 32085 leveldb.cpp:436] Reading position from leveldb took 58527ns
I0322 17:48:20.656874 32085 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 2.145082ms
I0322 17:48:20.656929 32085 replica.cpp:712] Persisted action at 0
I0322 17:48:20.657902 32082 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0322 17:48:20.658390 32082 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 466233ns
I0322 17:48:20.658419 32082 replica.cpp:712] Persisted action at 0
I0322 17:48:20.658450 32082 replica.cpp:697] Replica learned NOP action at position 0
I0322 17:48:20.660882 32092 log.cpp:675] Writer started with ending position 0
I0322 17:48:20.662355 32084 leveldb.cpp:436] Reading position from leveldb took 92648ns
I0322 17:48:20.663444 32093 registrar.cpp:340] Successfully fetched the registry (0B) in 19.23584ms
I0322 17:48:20.663595 32093 registrar.cpp:439] Applied 1 operations in 49653ns; attempting to update the 'registry'
I0322 17:48:20.664499 32093 log.cpp:683] Attempting to append 170 bytes to the log
I0322 17:48:20.664628 32088 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0322 17:48:20.665483 32088 replica.cpp:537] Replica received write request for position 1 from (15655)@172.17.0.1:53521
I0322 17:48:20.666873 32088 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 1.355738ms
I0322 17:48:20.666928 32088 replica.cpp:712] Persisted action at 1
I0322 17:48:20.668094 32095 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0322 17:48:20.669873 32095 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 1.756024ms
I0322 17:48:20.669925 32095 replica.cpp:712] Persisted action at 1
I0322 17:48:20.669953 32095 replica.cpp:697] Replica learned APPEND action at position 1
I0322 17:48:20.671947 32093 log.cpp:702] Attempting to truncate the log to 1
I0322 17:48:20.672157 32089 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0322 17:48:20.671946 32088 registrar.cpp:484] Successfully updated the 'registry' in 8.262912ms
I0322 17:48:20.672984 32088 registrar.cpp:370] Successfully recovered registrar
I0322 17:48:20.673583 32087 replica.cpp:537] Replica received write request for position 2 from (15656)@172.17.0.1:53521
I0322 17:48:20.673959 32080 master.cpp:1616] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0322 17:48:20.674262 32089 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0322 17:48:20.674898 32087 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 1.28135ms
I0322 17:48:20.674937 32087 replica.cpp:712] Persisted action at 2
I0322 17:48:20.676939 32080 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0322 17:48:20.677412 32080 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 439971ns
I0322 17:48:20.677477 32080 leveldb.cpp:399] Deleting ~1 keys from leveldb took 45740ns
I0322 17:48:20.677505 32080 replica.cpp:712] Persisted action at 2
I0322 17:48:20.677537 32080 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0322 17:48:20.685330 32062 scheduler.cpp:172] Version: 0.29.0
I0322 17:48:20.688108 32080 scheduler.cpp:437] New master detected at master@172.17.0.1:53521
I0322 17:48:20.692067 32095 scheduler.cpp:337] Connected with the master at http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.693462 32095 scheduler.cpp:230] Sending SUBSCRIBE call to http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.694778 32094 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0322 17:48:20.695494 32084 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:50885
I0322 17:48:20.695991 32084 master.cpp:2068] Received subscription request for HTTP framework 'default'
I0322 17:48:20.696017 32084 master.cpp:1845] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0322 17:48:20.696367 32084 master.cpp:2159] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0322 17:48:20.696939 32088 hierarchical.cpp:265] Added framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000
I0322 17:48:20.697053 32088 hierarchical.cpp:1453] No resources available to allocate!
I0322 17:48:20.697103 32088 hierarchical.cpp:1548] No inverse offers to send out!
I0322 17:48:20.697132 32088 hierarchical.cpp:1130] Performed allocation for 0 slaves in 172148ns
I0322 17:48:20.697247 32080 master.hpp:1715] Sending heartbeat to 8a9035c7-7140-443d-8cb2-b8d064904aec-0000
I0322 17:48:20.698308 32091 scheduler.cpp:612] Enqueuing event SUBSCRIBED received from http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.698767 32091 scheduler.cpp:612] Enqueuing event HEARTBEAT received from http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.699657 32091 scheduler.cpp:230] Sending REQUEST call to http://172.17.0.1:53521/master/api/v1/scheduler
I0322 17:48:20.700791 32082 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0322 17:48:20.701364 32083 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:50886
I0322 17:48:20.701666 32083 master.cpp:2765] Processing REQUEST call for framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default)
I0322 17:48:20.701856 32088 hierarchical.cpp:589] Received resource request from framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000
I0322 17:48:20.704366 32087 master.cpp:1251] Framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default) disconnected
I0322 17:48:20.704406 32087 master.cpp:2622] Disconnecting framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default)
I0322 17:48:20.704435 32087 master.cpp:2646] Deactivating framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default)
I0322 17:48:20.704537 32087 master.cpp:1275] Giving framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default) 0ns to failover
I0322 17:48:20.704576 32082 hierarchical.cpp:375] Deactivated framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000
I0322 17:48:20.705945 32090 master.cpp:5340] Framework failover timeout, removing framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default)
I0322 17:48:20.705978 32090 master.cpp:6073] Removing framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000 (default)
I0322 17:48:20.706287 32088 hierarchical.cpp:326] Removed framework 8a9035c7-7140-443d-8cb2-b8d064904aec-0000
I0322 17:48:20.715004 32081 master.cpp:1065] Master terminating
[ OK ] ContentType/SchedulerTest.Request/1 (121 ms)
[----------] 26 tests from ContentType/SchedulerTest (5644 ms total)
[----------] Global test environment tear-down
E0322 17:48:21.063262 32062 environment.cpp:778] Failed to remove '/tmp/LogZooKeeperTest_WriteRead_eIxUvW': No such file or directory
E0322 17:48:21.063357 32062 environment.cpp:778] Failed to remove '/tmp/LogZooKeeperTest_LostZooKeeper_ItNEes': No such file or directory
[==========] 1033 tests from 131 test cases ran. (358710 ms total)
[ PASSED ] 1032 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ContainerLoggerTest.LOGROTATE_RotateInSandbox
1 FAILED TEST
YOU HAVE 6 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1458667030-23773
Untagged: mesos-1458667030-23773:latest
Deleted: 5440f11c69a92484b3758bf114d731811b2d99298f2f54283bc564544e7db35e
Deleted: 7b8fbbda9a3e5dd6c89fa48275ed3f660371b8ca6b38606cb360911db3229c20
Deleted: e38485772cdac46ad22e79fa5d8dddc25b95bb5f8f5d868c8dff31009ec354cc
Deleted: 0fb1b4c434562180e7eaf4893fced4d718445852c6d611de4304fd5c09641ccb
Deleted: 3fa31942ea6d5b072328a75c3a26c0b1e0cc471310845f4f9a3cbd4d825aa352
Deleted: 44d51aa93fdc7f7b01c19b809791ac94b2ed1be6925dbc6babdf66d60fac272f
Deleted: dbc08086b370e8c2cd3fae24b93467efc987433e87f64cbc02e5d55ae6b389be
Deleted: aa1ec14d4bd8e3ff02cee7f51a77256c2632d57a099e828e723ac25f31720aec
Deleted: 3a524c8b64ea1c4d9846f91e54faeaffefa5bb31c19d210b417016a1890b2462
Deleted: b350674b287ab3e9e1ad69e340b64f8f88d72174aab96670a9e99459b1d1392f
Deleted: 305b2cf303178b84c831d4acbf8226be6ad80d1afa6ef8c2d3e6c33c5f85249d
Deleted: 5470eca3161b7506690a1898fde78de73a8754f11de651b47498fb1d9ff6cd5b
Deleted: 0a5ac171d80353c3aa9771b87d77d38cf928b77df174498a2b095ad3a9db9381
Deleted: 08b99e3ea9a210e1b6c636f122ecf1e00f7f67b15a77c46165f1ab4823f095ef
Deleted: da20acf18d0c69b359472f4f2249735307d63dfa66e4c0725b471c2bc0b86458
Deleted: e40c6a36f9ed2b272f9cc058d1cb4651d7ba8125bdcccbe776bf93621a4a8066
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1845
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1845/changes>