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/01/20 00:53:30 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,centos:7,docker||Hadoop #1512
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=centos%3A7,label_exp=docker%7C%7CHadoop/1512/changes>
Changes:
[vinodkone] Removed incorrect recovery checks in slave/http.cpp.
------------------------------------------
[...truncated 155108 lines...]
I0119 23:53:38.470682 1865 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_WqoM33/slaves/8709604d-2a6c-4789-8d0e-e81c4f9271f6-S0/frameworks/8709604d-2a6c-4789-8d0e-e81c4f9271f6-0000/executors/default' for gc 6.99999455358815days in the future
I0119 23:53:38.470746 1866 status_update_manager.cpp:282] Closing status update streams for framework 8709604d-2a6c-4789-8d0e-e81c4f9271f6-0000
I0119 23:53:38.470811 1866 status_update_manager.cpp:528] Cleaning up status update stream for task 1aa4d0e3-a5fe-4d71-b943-f62d95e28983 of framework 8709604d-2a6c-4789-8d0e-e81c4f9271f6-0000
I0119 23:53:38.470845 1873 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_WqoM33/slaves/8709604d-2a6c-4789-8d0e-e81c4f9271f6-S0/frameworks/8709604d-2a6c-4789-8d0e-e81c4f9271f6-0000' for gc 6.99999455149333days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (113 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I0119 23:53:38.479015 1840 leveldb.cpp:174] Opened db in 2.605189ms
I0119 23:53:38.479794 1840 leveldb.cpp:181] Compacted db in 733444ns
I0119 23:53:38.479846 1840 leveldb.cpp:196] Created db iterator in 20030ns
I0119 23:53:38.479871 1840 leveldb.cpp:202] Seeked to beginning of db in 2012ns
I0119 23:53:38.479887 1840 leveldb.cpp:271] Iterated through 0 keys in the db in 487ns
I0119 23:53:38.479935 1840 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0119 23:53:38.480437 1859 recover.cpp:447] Starting replica recovery
I0119 23:53:38.480986 1859 recover.cpp:473] Replica is in EMPTY status
I0119 23:53:38.482233 1862 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (13743)@172.17.0.2:47701
I0119 23:53:38.482659 1864 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0119 23:53:38.483062 1863 recover.cpp:564] Updating replica status to STARTING
I0119 23:53:38.483783 1871 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 512203ns
I0119 23:53:38.483898 1871 replica.cpp:320] Persisted replica status to STARTING
I0119 23:53:38.484174 1871 recover.cpp:473] Replica is in STARTING status
I0119 23:53:38.484829 1863 master.cpp:374] Master 03a0a47f-c64f-46ff-95e2-a93b291b02b1 (b773fb19feb6) started on 172.17.0.2:47701
I0119 23:53:38.484848 1863 master.cpp:376] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/8sJ4rc/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="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/8sJ4rc/master" --zk_session_timeout="10secs"
I0119 23:53:38.485165 1863 master.cpp:423] Master allowing unauthenticated frameworks to register
I0119 23:53:38.485180 1863 master.cpp:426] Master only allowing authenticated slaves to register
I0119 23:53:38.485193 1863 credentials.hpp:35] Loading credentials for authentication from '/tmp/8sJ4rc/credentials'
I0119 23:53:38.485535 1863 master.cpp:466] Using default 'crammd5' authenticator
I0119 23:53:38.485541 1859 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (13744)@172.17.0.2:47701
I0119 23:53:38.485894 1863 master.cpp:535] Using default 'basic' HTTP authenticator
I0119 23:53:38.486090 1863 master.cpp:569] Authorization enabled
I0119 23:53:38.486271 1873 hierarchical.cpp:145] Initialized hierarchical allocator process
I0119 23:53:38.486279 1874 recover.cpp:193] Received a recover response from a replica in STARTING status
I0119 23:53:38.486342 1873 whitelist_watcher.cpp:77] No whitelist given
I0119 23:53:38.486786 1859 recover.cpp:564] Updating replica status to VOTING
I0119 23:53:38.487350 1859 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 345958ns
I0119 23:53:38.487375 1859 replica.cpp:320] Persisted replica status to VOTING
I0119 23:53:38.487664 1874 recover.cpp:578] Successfully joined the Paxos group
I0119 23:53:38.487887 1874 recover.cpp:462] Recover process terminated
I0119 23:53:38.488709 1870 master.cpp:1710] The newly elected leader is master@172.17.0.2:47701 with id 03a0a47f-c64f-46ff-95e2-a93b291b02b1
I0119 23:53:38.489040 1870 master.cpp:1723] Elected as the leading master!
I0119 23:53:38.489411 1870 master.cpp:1468] Recovering from registrar
I0119 23:53:38.489823 1859 registrar.cpp:307] Recovering registrar
I0119 23:53:38.490516 1869 log.cpp:659] Attempting to start the writer
I0119 23:53:38.491646 1866 replica.cpp:493] Replica received implicit promise request from (13746)@172.17.0.2:47701 with proposal 1
I0119 23:53:38.492125 1866 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 343768ns
I0119 23:53:38.492147 1866 replica.cpp:342] Persisted promised to 1
I0119 23:53:38.492905 1873 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0119 23:53:38.494132 1861 replica.cpp:388] Replica received explicit promise request from (13747)@172.17.0.2:47701 for position 0 with proposal 2
I0119 23:53:38.494504 1861 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 328367ns
I0119 23:53:38.494534 1861 replica.cpp:712] Persisted action at 0
I0119 23:53:38.495765 1866 replica.cpp:537] Replica received write request for position 0 from (13748)@172.17.0.2:47701
I0119 23:53:38.495836 1866 leveldb.cpp:436] Reading position from leveldb took 33312ns
I0119 23:53:38.496203 1866 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 311830ns
I0119 23:53:38.496234 1866 replica.cpp:712] Persisted action at 0
I0119 23:53:38.497277 1867 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0119 23:53:38.497611 1867 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 299215ns
I0119 23:53:38.497655 1867 replica.cpp:712] Persisted action at 0
I0119 23:53:38.497681 1867 replica.cpp:697] Replica learned NOP action at position 0
I0119 23:53:38.498590 1867 log.cpp:675] Writer started with ending position 0
I0119 23:53:38.499853 1865 leveldb.cpp:436] Reading position from leveldb took 32494ns
I0119 23:53:38.500789 1874 registrar.cpp:340] Successfully fetched the registry (0B) in 10.921984ms
I0119 23:53:38.501085 1874 registrar.cpp:439] Applied 1 operations in 37874ns; attempting to update the 'registry'
I0119 23:53:38.501948 1862 log.cpp:683] Attempting to append 170 bytes to the log
I0119 23:53:38.502101 1866 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0119 23:53:38.502856 1869 replica.cpp:537] Replica received write request for position 1 from (13749)@172.17.0.2:47701
I0119 23:53:38.503303 1869 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 407952ns
I0119 23:53:38.503329 1869 replica.cpp:712] Persisted action at 1
I0119 23:53:38.504187 1866 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0119 23:53:38.504669 1866 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 375373ns
I0119 23:53:38.504703 1866 replica.cpp:712] Persisted action at 1
I0119 23:53:38.504729 1866 replica.cpp:697] Replica learned APPEND action at position 1
I0119 23:53:38.505785 1860 registrar.cpp:484] Successfully updated the 'registry' in 4.624896ms
I0119 23:53:38.505934 1860 registrar.cpp:370] Successfully recovered registrar
I0119 23:53:38.506081 1870 log.cpp:702] Attempting to truncate the log to 1
I0119 23:53:38.506208 1874 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0119 23:53:38.507063 1864 replica.cpp:537] Replica received write request for position 2 from (13750)@172.17.0.2:47701
I0119 23:53:38.507350 1874 hierarchical.cpp:172] Skipping recovery of hierarchical allocator: nothing to recover
I0119 23:53:38.507375 1867 master.cpp:1520] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0119 23:53:38.507524 1864 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 345297ns
I0119 23:53:38.507551 1864 replica.cpp:712] Persisted action at 2
I0119 23:53:38.508522 1867 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0119 23:53:38.509032 1867 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 273149ns
I0119 23:53:38.509132 1867 leveldb.cpp:399] Deleting ~1 keys from leveldb took 73260ns
I0119 23:53:38.509162 1867 replica.cpp:712] Persisted action at 2
I0119 23:53:38.509241 1867 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0119 23:53:38.518232 1840 scheduler.cpp:154] Version: 0.27.0
I0119 23:53:38.519016 1863 scheduler.cpp:236] New master detected at master@172.17.0.2:47701
I0119 23:53:38.520210 1860 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:47701
I0119 23:53:38.521975 1861 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0119 23:53:38.522472 1873 http.cpp:504] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47518
I0119 23:53:38.522680 1873 master.cpp:1972] Received subscription request for HTTP framework 'default'
I0119 23:53:38.522764 1873 master.cpp:1749] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0119 23:53:38.523018 1873 master.cpp:2063] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0119 23:53:38.523442 1874 hierarchical.cpp:266] Added framework 03a0a47f-c64f-46ff-95e2-a93b291b02b1-0000
I0119 23:53:38.523489 1873 master.hpp:1658] Sending heartbeat to 03a0a47f-c64f-46ff-95e2-a93b291b02b1-0000
I0119 23:53:38.523512 1874 hierarchical.cpp:1338] No resources available to allocate!
I0119 23:53:38.523545 1874 hierarchical.cpp:1432] No inverse offers to send out!
I0119 23:53:38.523572 1874 hierarchical.cpp:1086] Performed allocation for 0 slaves in 101796ns
I0119 23:53:38.524682 1864 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:47701
I0119 23:53:38.525142 1864 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:47701
I0119 23:53:38.525822 1864 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0119 23:53:38.525987 1859 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:47701
I0119 23:53:38.527499 1869 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0119 23:53:38.528012 1872 http.cpp:504] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47519
I0119 23:53:38.528177 1872 master.cpp:2717] Processing REQUEST call for framework 03a0a47f-c64f-46ff-95e2-a93b291b02b1-0000 (default)
I0119 23:53:38.528376 1863 hierarchical.cpp:586] Received resource request from framework 03a0a47f-c64f-46ff-95e2-a93b291b02b1-0000
I0119 23:53:38.528744 1840 master.cpp:1025] Master terminating
I0119 23:53:38.529286 1869 hierarchical.cpp:327] Removed framework 03a0a47f-c64f-46ff-95e2-a93b291b02b1-0000
E0119 23:53:38.531432 1870 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (62 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0119 23:53:38.541182 1840 leveldb.cpp:174] Opened db in 2.384852ms
I0119 23:53:38.541829 1840 leveldb.cpp:181] Compacted db in 611363ns
I0119 23:53:38.541877 1840 leveldb.cpp:196] Created db iterator in 19234ns
I0119 23:53:38.541901 1840 leveldb.cpp:202] Seeked to beginning of db in 2030ns
I0119 23:53:38.541918 1840 leveldb.cpp:271] Iterated through 0 keys in the db in 299ns
I0119 23:53:38.541967 1840 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0119 23:53:38.542409 1870 recover.cpp:447] Starting replica recovery
I0119 23:53:38.542724 1872 recover.cpp:473] Replica is in EMPTY status
I0119 23:53:38.543879 1862 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (13758)@172.17.0.2:47701
I0119 23:53:38.544284 1873 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0119 23:53:38.544800 1868 recover.cpp:564] Updating replica status to STARTING
I0119 23:53:38.545238 1865 master.cpp:374] Master 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773 (b773fb19feb6) started on 172.17.0.2:47701
I0119 23:53:38.545460 1870 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 540603ns
I0119 23:53:38.545500 1870 replica.cpp:320] Persisted replica status to STARTING
I0119 23:53:38.545261 1865 master.cpp:376] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/9AAbbA/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="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/9AAbbA/master" --zk_session_timeout="10secs"
I0119 23:53:38.545651 1865 master.cpp:423] Master allowing unauthenticated frameworks to register
I0119 23:53:38.545670 1865 master.cpp:426] Master only allowing authenticated slaves to register
I0119 23:53:38.545682 1865 credentials.hpp:35] Loading credentials for authentication from '/tmp/9AAbbA/credentials'
I0119 23:53:38.545850 1874 recover.cpp:473] Replica is in STARTING status
I0119 23:53:38.546028 1865 master.cpp:466] Using default 'crammd5' authenticator
I0119 23:53:38.546162 1865 master.cpp:535] Using default 'basic' HTTP authenticator
I0119 23:53:38.546655 1865 master.cpp:569] Authorization enabled
I0119 23:53:38.546828 1872 whitelist_watcher.cpp:77] No whitelist given
I0119 23:53:38.546928 1864 hierarchical.cpp:145] Initialized hierarchical allocator process
I0119 23:53:38.546852 1860 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (13760)@172.17.0.2:47701
I0119 23:53:38.547376 1870 recover.cpp:193] Received a recover response from a replica in STARTING status
I0119 23:53:38.547961 1860 recover.cpp:564] Updating replica status to VOTING
I0119 23:53:38.548486 1870 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 376885ns
I0119 23:53:38.548513 1870 replica.cpp:320] Persisted replica status to VOTING
I0119 23:53:38.548666 1860 recover.cpp:578] Successfully joined the Paxos group
I0119 23:53:38.548946 1868 master.cpp:1710] The newly elected leader is master@172.17.0.2:47701 with id 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773
I0119 23:53:38.548981 1868 master.cpp:1723] Elected as the leading master!
I0119 23:53:38.549005 1868 master.cpp:1468] Recovering from registrar
I0119 23:53:38.549150 1865 registrar.cpp:307] Recovering registrar
I0119 23:53:38.549691 1860 recover.cpp:462] Recover process terminated
I0119 23:53:38.549818 1864 log.cpp:659] Attempting to start the writer
I0119 23:53:38.551023 1870 replica.cpp:493] Replica received implicit promise request from (13761)@172.17.0.2:47701 with proposal 1
I0119 23:53:38.551350 1870 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 296235ns
I0119 23:53:38.551373 1870 replica.cpp:342] Persisted promised to 1
I0119 23:53:38.551929 1860 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0119 23:53:38.553032 1861 replica.cpp:388] Replica received explicit promise request from (13762)@172.17.0.2:47701 for position 0 with proposal 2
I0119 23:53:38.553405 1861 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 327131ns
I0119 23:53:38.553427 1861 replica.cpp:712] Persisted action at 0
I0119 23:53:38.554383 1864 replica.cpp:537] Replica received write request for position 0 from (13763)@172.17.0.2:47701
I0119 23:53:38.554461 1864 leveldb.cpp:436] Reading position from leveldb took 42190ns
I0119 23:53:38.554973 1864 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 355017ns
I0119 23:53:38.554996 1864 replica.cpp:712] Persisted action at 0
I0119 23:53:38.555552 1874 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0119 23:53:38.555745 1874 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 163399ns
I0119 23:53:38.555776 1874 replica.cpp:712] Persisted action at 0
I0119 23:53:38.555804 1874 replica.cpp:697] Replica learned NOP action at position 0
I0119 23:53:38.556447 1865 log.cpp:675] Writer started with ending position 0
I0119 23:53:38.557653 1866 leveldb.cpp:436] Reading position from leveldb took 47284ns
I0119 23:53:38.558665 1859 registrar.cpp:340] Successfully fetched the registry (0B) in 9.377024ms
I0119 23:53:38.558797 1859 registrar.cpp:439] Applied 1 operations in 36634ns; attempting to update the 'registry'
I0119 23:53:38.559566 1861 log.cpp:683] Attempting to append 170 bytes to the log
I0119 23:53:38.559799 1865 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0119 23:53:38.560636 1874 replica.cpp:537] Replica received write request for position 1 from (13764)@172.17.0.2:47701
I0119 23:53:38.561070 1874 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 392040ns
I0119 23:53:38.561100 1874 replica.cpp:712] Persisted action at 1
I0119 23:53:38.561800 1870 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0119 23:53:38.562171 1870 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 335494ns
I0119 23:53:38.562203 1870 replica.cpp:712] Persisted action at 1
I0119 23:53:38.562239 1870 replica.cpp:697] Replica learned APPEND action at position 1
I0119 23:53:38.563292 1868 registrar.cpp:484] Successfully updated the 'registry' in 4.427008ms
I0119 23:53:38.563446 1868 registrar.cpp:370] Successfully recovered registrar
I0119 23:53:38.563573 1861 log.cpp:702] Attempting to truncate the log to 1
I0119 23:53:38.563777 1874 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0119 23:53:38.564242 1861 master.cpp:1520] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0119 23:53:38.564359 1871 hierarchical.cpp:172] Skipping recovery of hierarchical allocator: nothing to recover
I0119 23:53:38.565198 1872 replica.cpp:537] Replica received write request for position 2 from (13765)@172.17.0.2:47701
I0119 23:53:38.565590 1872 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 350594ns
I0119 23:53:38.565634 1872 replica.cpp:712] Persisted action at 2
I0119 23:53:38.566216 1872 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0119 23:53:38.566560 1872 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 313986ns
I0119 23:53:38.566642 1872 leveldb.cpp:399] Deleting ~1 keys from leveldb took 57687ns
I0119 23:53:38.566670 1872 replica.cpp:712] Persisted action at 2
I0119 23:53:38.566697 1872 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0119 23:53:38.575150 1840 scheduler.cpp:154] Version: 0.27.0
I0119 23:53:38.575886 1869 scheduler.cpp:236] New master detected at master@172.17.0.2:47701
I0119 23:53:38.577005 1872 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:47701
I0119 23:53:38.578729 1874 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0119 23:53:38.579241 1874 http.cpp:504] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47520
I0119 23:53:38.579681 1874 master.cpp:1972] Received subscription request for HTTP framework 'default'
I0119 23:53:38.579761 1874 master.cpp:1749] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0119 23:53:38.580060 1874 master.cpp:2063] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0119 23:53:38.580591 1863 hierarchical.cpp:266] Added framework 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773-0000
I0119 23:53:38.580690 1863 hierarchical.cpp:1338] No resources available to allocate!
I0119 23:53:38.580754 1863 hierarchical.cpp:1432] No inverse offers to send out!
I0119 23:53:38.580802 1863 hierarchical.cpp:1086] Performed allocation for 0 slaves in 164040ns
I0119 23:53:38.580809 1864 master.hpp:1658] Sending heartbeat to 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773-0000
I0119 23:53:38.581907 1870 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:47701
I0119 23:53:38.582370 1870 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:47701
I0119 23:53:38.582911 1870 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0119 23:53:38.582943 1866 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:47701
I0119 23:53:38.584589 1870 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0119 23:53:38.585005 1868 http.cpp:504] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47521
I0119 23:53:38.585314 1868 master.cpp:2717] Processing REQUEST call for framework 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773-0000 (default)
I0119 23:53:38.585499 1865 hierarchical.cpp:586] Received resource request from framework 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773-0000
I0119 23:53:38.585885 1840 master.cpp:1025] Master terminating
I0119 23:53:38.586292 1871 hierarchical.cpp:327] Removed framework 8ad9c4b9-bf69-46a0-9196-2d5a2da9e773-0000
E0119 23:53:38.587040 1874 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (54 ms)
[----------] 22 tests from ContentType/SchedulerTest (4266 ms total)
[----------] Global test environment tear-down
[==========] 939 tests from 125 test cases ran. (355923 ms total)
[ PASSED ] 938 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] RegistryClientTest.BadTokenServerAddress
1 FAILED TEST
YOU HAVE 7 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
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-1453246050-8450
Untagged: mesos-1453246050-8450:latest
Deleted: 346ea5bdec58b7e11cf214f0ab22c3711e64a46a45de035cfef69e6d7008f2c8
Deleted: 1b499abc70781cffcc9e7d325fa42875bb90bdc4d24635fd263db765976e7b36
Deleted: ba7eb1f717e46e69510bc11ebea2b725c194c3f349361c994cc181f57b6302b0
Deleted: 1552d2885114f4083e4e668c111d5380d299e34891c6128ae3b0a1b4a861d56d
Deleted: ff52ae9c30f4aea17e2442c53df1cdbd083ba8624a146da970402e6e4914a6e8
Deleted: 8db13763c384194bad4367d2bbf187c9adc1995e8bea3d057ebcc5f8aad41144
Deleted: 9528b5571ce075eeb4309ed1634bd11c630fbfed20ba2d3bc7f50838b657a17c
Deleted: b37c60a374783b4e87fe58ff222bf28eedcde28c6f72ca714f63cbf75c26e0cf
Deleted: 4a7950bee308dffef2f28ee2042719cf1afdebf4dd3c54adc8e9e4e8239faf01
Deleted: b48a63240e61b03cd2a5b15dbf21c42684f535fe92ecb579fab30e00a505729b
Deleted: 2b7a46042dcb4f78a931d4c654fcf7f6f08c163dbd670e08e26af3b8f7d88938
Deleted: 5941d69d1500ae69f28c68e8b91125aa97a2ba03ec4ef80a9e00bae7361f99f3
Deleted: ff02282b71ab2b570a357321acebab5f9ca14b78994905bdb9c7dd0949dad4fe
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,centos:7,docker||Hadoop #1513
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=centos%3A7,label_exp=docker%7C%7CHadoop/1513/changes>