Return-Path: X-Original-To: apmail-mesos-builds-archive@minotaur.apache.org Delivered-To: apmail-mesos-builds-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 846371811A for ; Fri, 29 Jan 2016 08:34:27 +0000 (UTC) Received: (qmail 37334 invoked by uid 500); 29 Jan 2016 08:34:21 -0000 Delivered-To: apmail-mesos-builds-archive@mesos.apache.org Received: (qmail 37307 invoked by uid 500); 29 Jan 2016 08:34:21 -0000 Mailing-List: contact builds-help@mesos.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: builds@mesos.apache.org Delivered-To: mailing list builds@mesos.apache.org Received: (qmail 37293 invoked by uid 99); 29 Jan 2016 08:34:20 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Fri, 29 Jan 2016 08:34:20 +0000 Received: from crius.apache.org (localhost [127.0.0.1]) by crius.apache.org (ASF Mail Server at crius.apache.org) with ESMTP id 7694F9C028A; Fri, 29 Jan 2016 08:34:14 +0000 (UTC) Date: Fri, 29 Jan 2016 08:34:14 +0000 (UTC) From: Apache Jenkins Server To: builds@mesos.apache.org, joris.van.remoortere@gmail.com, yujie.jay@gmail.com Message-ID: <2065666446.2946.1454056454346.JavaMail.jenkins@crius> In-Reply-To: <559146667.2905.1454049930996.JavaMail.jenkins@crius> References: <559146667.2905.1454049930996.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_Mesos_=C2=BB_?= =?UTF-8?Q?gcc,--verbose_--enable-libevent_-?= =?UTF-8?Q?-enable-ssl,GLOG=5Fv=3D1_MESOS=5FVERBOS?= =?UTF-8?Q?E=3D1,centos:7,docker||Hadoop_#1584?= MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable X-Instance-Identity: MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAkqVKZPv7YyHBB3FvWfV7XQehwe/Ga3aadzSNknt8g382X3uN8A3SOQ+Ixq9HxS+ZlN6XR4TECySmSRy2JN5Rx8svxAD0TjtSF9LuU98dD+LniNDP7Lq6gvRFuJhbMHoS0nuTizDZLsK4X8TW5MyV9w+jFbdoZfRE5O/Mse0fkOeL5uoIS/3Vvu/W+x9QSjDkB7CaU56bPFlQjqqJBl3Cn9r34CkXQZYnLb/NjW4vcpw0+TgMUAPTIVEr5BTPZRshz19g7huwg3zANT5HBIZnzV4hsVY9w4JHkceFdKi/ibNnjPjsFs9pm0HSGJ/RDxjIvSTYT02eH4+m1RAYaj2E9QIDAQAB X-Jenkins-Job: Mesos/COMPILER=gcc,CONFIGURATION=--verbose --enable-libevent --enable-ssl,ENVIRONMENT=GLOG_v=1 MESOS_VERBOSE=1,OS=centos:7,label_exp=docker||Hadoop X-Jenkins-Result: FAILURE See ------------------------------------------ [...truncated 163780 lines...] I0129 08:34:10.752039 2445 status_update_manager.cpp:282] Closing status u= pdate streams for framework 0daa92b4-1ccd-42fc-97b6-8fa74355f9bf-0000 I0129 08:34:10.752109 2445 status_update_manager.cpp:528] Cleaning up stat= us update stream for task 1b5c25c0-b5f0-45ab-8374-aff3c845ce71 of framework= 0daa92b4-1ccd-42fc-97b6-8fa74355f9bf-0000 I0129 08:34:10.752151 2436 gc.cpp:54] Scheduling '/tmp/ContentType_Schedul= erTest_Message_1_Qjch9j/slaves/0daa92b4-1ccd-42fc-97b6-8fa74355f9bf-S0/fram= eworks/0daa92b4-1ccd-42fc-97b6-8fa74355f9bf-0000' for gc 6.99999129600593da= ys in the future [ OK ] ContentType/SchedulerTest.Message/1 (623 ms) [ RUN ] ContentType/SchedulerTest.Request/0 I0129 08:34:10.864192 2417 leveldb.cpp:174] Opened db in 106.672211ms I0129 08:34:10.906321 2417 leveldb.cpp:181] Compacted db in 42.064958ms I0129 08:34:10.906396 2417 leveldb.cpp:196] Created db iterator in 26507ns I0129 08:34:10.906417 2417 leveldb.cpp:202] Seeked to beginning of db in 2= 328ns I0129 08:34:10.906430 2417 leveldb.cpp:271] Iterated through 0 keys in the= db in 410ns I0129 08:34:10.906491 2417 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0129 08:34:10.907312 2440 recover.cpp:447] Starting replica recovery I0129 08:34:10.907670 2440 recover.cpp:473] Replica is in EMPTY status I0129 08:34:10.909075 2449 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14200)@172.17.15.185:59503 I0129 08:34:10.909600 2442 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0129 08:34:10.910158 2449 recover.cpp:564] Updating replica status to STA= RTING I0129 08:34:10.911136 2447 master.cpp:374] Master b3a51456-6854-44e7-81c6-= 2803308f0241 (5942373daf52) started on 172.17.15.185:59503 I0129 08:34:10.911165 2447 master.cpp:376] Flags at startup: --acls=3D"" -= -allocation_interval=3D"1secs" --allocator=3D"HierarchicalDRF" --authentica= te=3D"false" --authenticate_http=3D"true" --authenticate_slaves=3D"true" --= authenticators=3D"crammd5" --authorizers=3D"local" --credentials=3D"/tmp/yi= lTSn/credentials" --framework_sorter=3D"drf" --help=3D"false" --hostname_lo= okup=3D"true" --http_authenticators=3D"basic" --initialize_driver_logging= =3D"true" --log_auto_initialize=3D"true" --logbufsecs=3D"0" --logging_level= =3D"INFO" --max_completed_frameworks=3D"50" --max_completed_tasks_per_frame= work=3D"1000" --max_slave_ping_timeouts=3D"5" --quiet=3D"false" --recovery_= slave_removal_limit=3D"100%" --registry=3D"replicated_log" --registry_fetch= _timeout=3D"1mins" --registry_store_timeout=3D"25secs" --registry_strict=3D= "true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --slave_= reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" --w= ebui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/tmp= /yilTSn/master" --zk_session_timeout=3D"10secs" I0129 08:34:10.911586 2447 master.cpp:423] Master allowing unauthenticated= frameworks to register I0129 08:34:10.911602 2447 master.cpp:426] Master only allowing authentica= ted slaves to register I0129 08:34:10.911612 2447 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/yilTSn/credentials' I0129 08:34:10.912015 2447 master.cpp:466] Using default 'crammd5' authent= icator I0129 08:34:10.912206 2447 master.cpp:535] Using default 'basic' HTTP auth= enticator I0129 08:34:10.912400 2447 master.cpp:569] Authorization enabled I0129 08:34:10.912657 2436 hierarchical.cpp:144] Initialized hierarchical = allocator process I0129 08:34:10.912663 2451 whitelist_watcher.cpp:77] No whitelist given I0129 08:34:10.915237 2448 master.cpp:1710] The newly elected leader is ma= ster@172.17.15.185:59503 with id b3a51456-6854-44e7-81c6-2803308f0241 I0129 08:34:10.915271 2448 master.cpp:1723] Elected as the leading master! I0129 08:34:10.915292 2448 master.cpp:1468] Recovering from registrar I0129 08:34:10.915459 2442 registrar.cpp:307] Recovering registrar I0129 08:34:10.949198 2438 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 38.815888ms I0129 08:34:10.949234 2438 replica.cpp:320] Persisted replica status to ST= ARTING I0129 08:34:10.949503 2439 recover.cpp:473] Replica is in STARTING status I0129 08:34:10.950477 2437 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14202)@172.17.15.185:59503 I0129 08:34:10.950883 2449 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0129 08:34:10.951365 2440 recover.cpp:564] Updating replica status to VOT= ING I0129 08:34:10.982583 2449 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 30.980005ms I0129 08:34:10.982622 2449 replica.cpp:320] Persisted replica status to VO= TING I0129 08:34:10.982748 2445 recover.cpp:578] Successfully joined the Paxos = group I0129 08:34:10.983403 2445 recover.cpp:462] Recover process terminated I0129 08:34:10.983640 2449 log.cpp:659] Attempting to start the writer I0129 08:34:10.984799 2442 replica.cpp:493] Replica received implicit prom= ise request from (14203)@172.17.15.185:59503 with proposal 1 I0129 08:34:11.016059 2442 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 31.223623ms I0129 08:34:11.016098 2442 replica.cpp:342] Persisted promised to 1 I0129 08:34:11.016965 2440 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0129 08:34:11.018302 2438 replica.cpp:388] Replica received explicit prom= ise request from (14204)@172.17.15.185:59503 for position 0 with proposal 2 I0129 08:34:11.049605 2438 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 31.260201ms I0129 08:34:11.049643 2438 replica.cpp:712] Persisted action at 0 I0129 08:34:11.050686 2451 replica.cpp:537] Replica received write request= for position 0 from (14205)@172.17.15.185:59503 I0129 08:34:11.050748 2451 leveldb.cpp:436] Reading position from leveldb = took 28617ns I0129 08:34:11.083077 2451 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 32.285991ms I0129 08:34:11.083119 2451 replica.cpp:712] Persisted action at 0 I0129 08:34:11.083936 2438 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0129 08:34:11.116917 2438 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 32.914962ms I0129 08:34:11.116998 2438 replica.cpp:712] Persisted action at 0 I0129 08:34:11.117033 2438 replica.cpp:697] Replica learned NOP action at = position 0 I0129 08:34:11.117869 2451 log.cpp:675] Writer started with ending positio= n 0 I0129 08:34:11.119047 2441 leveldb.cpp:436] Reading position from leveldb = took 52198ns I0129 08:34:11.119992 2445 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 204.385024ms I0129 08:34:11.120112 2445 registrar.cpp:439] Applied 1 operations in 3472= 1ns; attempting to update the 'registry' I0129 08:34:11.120853 2447 log.cpp:683] Attempting to append 178 bytes to = the log I0129 08:34:11.120965 2440 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0129 08:34:11.121657 2438 replica.cpp:537] Replica received write request= for position 1 from (14206)@172.17.15.185:59503 I0129 08:34:11.159574 2438 leveldb.cpp:341] Persisting action (197 bytes) = to leveldb took 37.877254ms I0129 08:34:11.159610 2438 replica.cpp:712] Persisted action at 1 I0129 08:34:11.160361 2447 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0129 08:34:11.193033 2447 leveldb.cpp:341] Persisting action (199 bytes) = to leveldb took 32.634725ms I0129 08:34:11.193083 2447 replica.cpp:712] Persisted action at 1 I0129 08:34:11.193106 2447 replica.cpp:697] Replica learned APPEND action = at position 1 I0129 08:34:11.194407 2450 registrar.cpp:484] Successfully updated the 're= gistry' in 74.203904ms I0129 08:34:11.194563 2450 registrar.cpp:370] Successfully recovered regis= trar I0129 08:34:11.194622 2444 log.cpp:702] Attempting to truncate the log to = 1 I0129 08:34:11.194792 2443 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0129 08:34:11.195312 2449 master.cpp:1520] Recovered 0 slaves from the Re= gistry (139B) ; allowing 10mins for slaves to re-register I0129 08:34:11.195358 2437 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0129 08:34:11.195720 2439 replica.cpp:537] Replica received write request= for position 2 from (14207)@172.17.15.185:59503 I0129 08:34:11.234916 2439 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 39.157004ms I0129 08:34:11.234953 2439 replica.cpp:712] Persisted action at 2 I0129 08:34:11.235651 2438 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0129 08:34:11.264420 2438 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 28.73605ms I0129 08:34:11.264492 2438 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 38514ns I0129 08:34:11.264514 2438 replica.cpp:712] Persisted action at 2 I0129 08:34:11.264538 2438 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0129 08:34:11.266762 2417 scheduler.cpp:154] Version: 0.28.0 I0129 08:34:11.267458 2437 scheduler.cpp:236] New master detected at maste= r@172.17.15.185:59503 I0129 08:34:11.268553 2440 scheduler.cpp:298] Sending SUBSCRIBE call to ma= ster@172.17.15.185:59503 I0129 08:34:11.270102 2439 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0129 08:34:11.270658 2444 http.cpp:503] HTTP POST for /master/api/v1/sche= duler from 172.17.15.185:60734 I0129 08:34:11.270906 2444 master.cpp:1972] Received subscription request = for HTTP framework 'default' I0129 08:34:11.270982 2444 master.cpp:1749] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0129 08:34:11.271334 2444 master.cpp:2063] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0129 08:34:11.271780 2448 hierarchical.cpp:265] Added framework b3a51456-= 6854-44e7-81c6-2803308f0241-0000 I0129 08:34:11.271863 2448 hierarchical.cpp:1403] No resources available t= o allocate! I0129 08:34:11.271898 2448 hierarchical.cpp:1498] No inverse offers to sen= d out! I0129 08:34:11.271924 2448 hierarchical.cpp:1096] Performed allocation for= 0 slaves in 117563ns I0129 08:34:11.271951 2448 master.hpp:1658] Sending heartbeat to b3a51456-= 6854-44e7-81c6-2803308f0241-0000 I0129 08:34:11.272512 2441 scheduler.cpp:457] Enqueuing event SUBSCRIBED r= eceived from master@172.17.15.185:59503 I0129 08:34:11.273708 2444 scheduler.cpp:457] Enqueuing event HEARTBEAT re= ceived from master@172.17.15.185:59503 I0129 08:34:11.274106 2444 scheduler.cpp:298] Sending REQUEST call to mast= er@172.17.15.185:59503 I0129 08:34:11.275060 2445 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0129 08:34:11.275518 2439 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0129 08:34:11.276037 2437 http.cpp:503] HTTP POST for /master/api/v1/sche= duler from 172.17.15.185:60735 I0129 08:34:11.276198 2437 master.cpp:2717] Processing REQUEST call for fr= amework b3a51456-6854-44e7-81c6-2803308f0241-0000 (default) I0129 08:34:11.276388 2449 hierarchical.cpp:589] Received resource request= from framework b3a51456-6854-44e7-81c6-2803308f0241-0000 I0129 08:34:11.276821 2443 master.cpp:1025] Master terminating I0129 08:34:11.277096 2451 hierarchical.cpp:326] Removed framework b3a5145= 6-6854-44e7-81c6-2803308f0241-0000 E0129 08:34:11.278005 2448 scheduler.cpp:431] End-Of-File received from ma= ster. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/0 (528 ms) [ RUN ] ContentType/SchedulerTest.Request/1 I0129 08:34:11.400167 2417 leveldb.cpp:174] Opened db in 115.064517ms I0129 08:34:11.460362 2417 leveldb.cpp:181] Compacted db in 60.123659ms I0129 08:34:11.460430 2417 leveldb.cpp:196] Created db iterator in 21404ns I0129 08:34:11.460453 2417 leveldb.cpp:202] Seeked to beginning of db in 2= 348ns I0129 08:34:11.460464 2417 leveldb.cpp:271] Iterated through 0 keys in the= db in 415ns I0129 08:34:11.460505 2417 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0129 08:34:11.461024 2449 recover.cpp:447] Starting replica recovery I0129 08:34:11.461659 2448 recover.cpp:473] Replica is in EMPTY status I0129 08:34:11.462765 2441 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14215)@172.17.15.185:59503 I0129 08:34:11.463460 2450 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0129 08:34:11.464073 2443 recover.cpp:564] Updating replica status to STA= RTING I0129 08:34:11.464299 2448 master.cpp:374] Master 889db711-b151-43d9-aef3-= 7c3fa443461a (5942373daf52) started on 172.17.15.185:59503 I0129 08:34:11.464442 2448 master.cpp:376] Flags at startup: --acls=3D"" -= -allocation_interval=3D"1secs" --allocator=3D"HierarchicalDRF" --authentica= te=3D"false" --authenticate_http=3D"true" --authenticate_slaves=3D"true" --= authenticators=3D"crammd5" --authorizers=3D"local" --credentials=3D"/tmp/j1= NeqL/credentials" --framework_sorter=3D"drf" --help=3D"false" --hostname_lo= okup=3D"true" --http_authenticators=3D"basic" --initialize_driver_logging= =3D"true" --log_auto_initialize=3D"true" --logbufsecs=3D"0" --logging_level= =3D"INFO" --max_completed_frameworks=3D"50" --max_completed_tasks_per_frame= work=3D"1000" --max_slave_ping_timeouts=3D"5" --quiet=3D"false" --recovery_= slave_removal_limit=3D"100%" --registry=3D"replicated_log" --registry_fetch= _timeout=3D"1mins" --registry_store_timeout=3D"25secs" --registry_strict=3D= "true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --slave_= reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" --w= ebui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/tmp= /j1NeqL/master" --zk_session_timeout=3D"10secs" I0129 08:34:11.464750 2448 master.cpp:423] Master allowing unauthenticated= frameworks to register I0129 08:34:11.464761 2448 master.cpp:426] Master only allowing authentica= ted slaves to register I0129 08:34:11.464767 2448 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/j1NeqL/credentials' I0129 08:34:11.465068 2448 master.cpp:466] Using default 'crammd5' authent= icator I0129 08:34:11.465240 2448 master.cpp:535] Using default 'basic' HTTP auth= enticator I0129 08:34:11.465389 2448 master.cpp:569] Authorization enabled I0129 08:34:11.465615 2442 hierarchical.cpp:144] Initialized hierarchical = allocator process I0129 08:34:11.465636 2444 whitelist_watcher.cpp:77] No whitelist given I0129 08:34:11.467123 2451 master.cpp:1710] The newly elected leader is ma= ster@172.17.15.185:59503 with id 889db711-b151-43d9-aef3-7c3fa443461a I0129 08:34:11.467218 2451 master.cpp:1723] Elected as the leading master! I0129 08:34:11.467321 2451 master.cpp:1468] Recovering from registrar I0129 08:34:11.467478 2449 registrar.cpp:307] Recovering registrar I0129 08:34:11.493551 2440 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 28.983179ms I0129 08:34:11.493592 2440 replica.cpp:320] Persisted replica status to ST= ARTING I0129 08:34:11.493890 2441 recover.cpp:473] Replica is in STARTING status I0129 08:34:11.494956 2437 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14217)@172.17.15.185:59503 I0129 08:34:11.495503 2443 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0129 08:34:11.495875 2441 recover.cpp:564] Updating replica status to VOT= ING 2016-01-29 08:34:11,511:2417(0x7f15adfdb700):ZOO_ERROR@handle_socket_error_= msg@1697: Socket [127.0.0.1:59757] zk retcode=3D-4, errno=3D111(Connection = refused): server refused to accept the client I0129 08:34:11.518785 2440 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 22.773061ms I0129 08:34:11.518826 2440 replica.cpp:320] Persisted replica status to VO= TING I0129 08:34:11.518955 2438 recover.cpp:578] Successfully joined the Paxos = group I0129 08:34:11.519183 2438 recover.cpp:462] Recover process terminated I0129 08:34:11.519639 2449 log.cpp:659] Attempting to start the writer I0129 08:34:11.520787 2448 replica.cpp:493] Replica received implicit prom= ise request from (14218)@172.17.15.185:59503 with proposal 1 I0129 08:34:11.543902 2448 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 23.084349ms I0129 08:34:11.543933 2448 replica.cpp:342] Persisted promised to 1 I0129 08:34:11.544731 2446 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0129 08:34:11.546231 2443 replica.cpp:388] Replica received explicit prom= ise request from (14219)@172.17.15.185:59503 for position 0 with proposal 2 I0129 08:34:11.569000 2443 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 22.726396ms I0129 08:34:11.569036 2443 replica.cpp:712] Persisted action at 0 I0129 08:34:11.570559 2448 replica.cpp:537] Replica received write request= for position 0 from (14220)@172.17.15.185:59503 I0129 08:34:11.570660 2448 leveldb.cpp:436] Reading position from leveldb = took 54245ns I0129 08:34:11.592545 2448 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 21.831432ms I0129 08:34:11.592586 2448 replica.cpp:712] Persisted action at 0 I0129 08:34:11.593279 2451 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0129 08:34:11.617727 2451 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 24.316299ms I0129 08:34:11.617770 2451 replica.cpp:712] Persisted action at 0 I0129 08:34:11.617794 2451 replica.cpp:697] Replica learned NOP action at = position 0 I0129 08:34:11.618448 2440 log.cpp:675] Writer started with ending positio= n 0 I0129 08:34:11.619772 2450 leveldb.cpp:436] Reading position from leveldb = took 37569ns I0129 08:34:11.620816 2438 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 153.291008ms I0129 08:34:11.621001 2438 registrar.cpp:439] Applied 1 operations in 3909= 9ns; attempting to update the 'registry' I0129 08:34:11.621888 2451 log.cpp:683] Attempting to append 178 bytes to = the log I0129 08:34:11.622069 2447 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0129 08:34:11.622944 2450 replica.cpp:537] Replica received write request= for position 1 from (14221)@172.17.15.185:59503 I0129 08:34:11.642709 2450 leveldb.cpp:341] Persisting action (197 bytes) = to leveldb took 19.712477ms I0129 08:34:11.642751 2450 replica.cpp:712] Persisted action at 1 I0129 08:34:11.643564 2439 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0129 08:34:11.667953 2439 leveldb.cpp:341] Persisting action (199 bytes) = to leveldb took 24.345645ms I0129 08:34:11.667992 2439 replica.cpp:712] Persisted action at 1 I0129 08:34:11.668015 2439 replica.cpp:697] Replica learned APPEND action = at position 1 I0129 08:34:11.669216 2441 registrar.cpp:484] Successfully updated the 're= gistry' in 48.112896ms I0129 08:34:11.669378 2441 registrar.cpp:370] Successfully recovered regis= trar I0129 08:34:11.669534 2439 log.cpp:702] Attempting to truncate the log to = 1 I0129 08:34:11.669967 2451 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0129 08:34:11.669996 2440 master.cpp:1520] Recovered 0 slaves from the Re= gistry (139B) ; allowing 10mins for slaves to re-register I0129 08:34:11.670023 2446 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0129 08:34:11.670938 2443 replica.cpp:537] Replica received write request= for position 2 from (14222)@172.17.15.185:59503 I0129 08:34:11.692996 2443 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 22.013596ms I0129 08:34:11.693035 2443 replica.cpp:712] Persisted action at 2 I0129 08:34:11.693749 2445 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0129 08:34:11.718096 2445 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 24.30634ms I0129 08:34:11.718217 2445 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 76182ns I0129 08:34:11.718261 2445 replica.cpp:712] Persisted action at 2 I0129 08:34:11.718298 2445 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0129 08:34:11.720932 2417 scheduler.cpp:154] Version: 0.28.0 I0129 08:34:11.721592 2445 scheduler.cpp:236] New master detected at maste= r@172.17.15.185:59503 I0129 08:34:11.722816 2436 scheduler.cpp:298] Sending SUBSCRIBE call to ma= ster@172.17.15.185:59503 I0129 08:34:11.725059 2437 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0129 08:34:11.725611 2448 http.cpp:503] HTTP POST for /master/api/v1/sche= duler from 172.17.15.185:60738 I0129 08:34:11.726022 2448 master.cpp:1972] Received subscription request = for HTTP framework 'default' I0129 08:34:11.726099 2448 master.cpp:1749] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0129 08:34:11.726377 2448 master.cpp:2063] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0129 08:34:11.726831 2441 hierarchical.cpp:265] Added framework 889db711-= b151-43d9-aef3-7c3fa443461a-0000 I0129 08:34:11.726907 2441 hierarchical.cpp:1403] No resources available t= o allocate! I0129 08:34:11.726938 2441 hierarchical.cpp:1498] No inverse offers to sen= d out! I0129 08:34:11.726958 2441 hierarchical.cpp:1096] Performed allocation for= 0 slaves in 104390ns I0129 08:34:11.726974 2437 master.hpp:1658] Sending heartbeat to 889db711-= b151-43d9-aef3-7c3fa443461a-0000 I0129 08:34:11.727799 2437 scheduler.cpp:457] Enqueuing event SUBSCRIBED r= eceived from master@172.17.15.185:59503 I0129 08:34:11.728199 2437 scheduler.cpp:457] Enqueuing event HEARTBEAT re= ceived from master@172.17.15.185:59503 I0129 08:34:11.728857 2449 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0129 08:34:11.728895 2437 scheduler.cpp:298] Sending REQUEST call to mast= er@172.17.15.185:59503 I0129 08:34:11.730132 2447 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0129 08:34:11.730590 2440 http.cpp:503] HTTP POST for /master/api/v1/sche= duler from 172.17.15.185:60739 I0129 08:34:11.730877 2440 master.cpp:2717] Processing REQUEST call for fr= amework 889db711-b151-43d9-aef3-7c3fa443461a-0000 (default) I0129 08:34:11.731097 2439 hierarchical.cpp:589] Received resource request= from framework 889db711-b151-43d9-aef3-7c3fa443461a-0000 I0129 08:34:11.731544 2442 master.cpp:1025] Master terminating I0129 08:34:11.732125 2447 hierarchical.cpp:326] Removed framework 889db71= 1-b151-43d9-aef3-7c3fa443461a-0000 E0129 08:34:11.733640 2445 scheduler.cpp:431] End-Of-File received from ma= ster. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/1 (454 ms) [----------] 22 tests from ContentType/SchedulerTest (15557 ms total) [----------] Global test environment tear-down [=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D] 968 tests from 127 test cases ran. (754127= ms total) [ PASSED ] 967 tests. [ FAILED ] 1 test, listed below: [ FAILED ] ShasumTest.SHA512SimpleFile 1 FAILED TEST YOU HAVE 9 DISABLED TESTS make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-0.28.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1454054165-14229 Untagged: mesos-1454054165-14229:latest Deleted: 60fd4f026fbbf826189a13d4ef28b3c69e931406e11025d661d4dbf31a2ff1cc Deleted: a97cb91cd53ac6f2fcc21aab3a3612d67242efe726a4a9ed7ff7bd5ca32bf35c Deleted: ff1d9a78e9e2b25efaa60c320c8f1df11d15e61db6269f6d5208d7caade07900 Deleted: 5dd3eff67e1e7f95d23958715f6308987d984d1f75e4f800ef20bd0c44bbde71 Deleted: 21c2c8ee7a520d956468acaf01f4f2179f4117342aa715d891a2e80daecca221 Deleted: 564f6ce58bbe6c1275da040998584b3b6ec031ce538038342f9e6ab98c1cf0fd Deleted: 333adc8054b3460d34c7b212ca147392854a3186239295b156c6c35c4c82182c Deleted: 022215d3d7f14a0b8ef345efa4f6b5f0f919076834f81d50c3b06ce765960d75 Deleted: 1c302089ae36dfb3fa12097928636ab48bd2f2c7346185a3e2b7609a3f99c639 Deleted: 5e79a4dc9261c174378fdfac855b0f30b92d18843abf45c8bcef8ecd7f3dcb8e Deleted: e2a1d25777185b86fea89ec254530bef8b531ab0a3f9eb5ff6517520449deaa3 Deleted: 08ec3722f83e0b8c2e0ead484ae25ba7495e6dc989023218554d0590e681e699 Deleted: 5212fa5be2c077d07df527c7191f94f65a54e35ada34ca92546732870fd1182a Build step 'Execute shell' marked build as failure