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 E0F32174A4 for ; Thu, 3 Mar 2016 03:03:39 +0000 (UTC) Received: (qmail 96402 invoked by uid 500); 3 Mar 2016 03:03:39 -0000 Delivered-To: apmail-mesos-builds-archive@mesos.apache.org Received: (qmail 96369 invoked by uid 500); 3 Mar 2016 03:03:39 -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 96355 invoked by uid 99); 3 Mar 2016 03:03:39 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 03 Mar 2016 03:03:39 +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 543C59C0045; Thu, 3 Mar 2016 03:03:34 +0000 (UTC) Date: Thu, 3 Mar 2016 03:03:33 +0000 (UTC) From: Apache Jenkins Server To: builds@mesos.apache.org, joris.van.remoortere@gmail.com, yujie.jay@gmail.com, vinodkone@gmail.com Message-ID: <1083727789.2029.1456974214223.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_Mesos_=C2=BB_gcc,-?= =?UTF-8?Q?-verbose_--enable-libevent_--enable-ss?= =?UTF-8?Q?l,GLOG=5Fv=3D1_MESOS=5FVERBOSE=3D1,ubuntu:14.0?= =?UTF-8?Q?4,(docker||Hadoop)&&(!ubuntu-us1)_#1763?= 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=ubuntu:14.04,label_exp=(docker||Hadoop)&&(!ubuntu-us1) X-Jenkins-Result: FAILURE See Changes: [joris.van.remoortere] Fixed updating slave's version after re-registering. [yujie.jay] Introduced copy fetcher plugin for file URIs. [yujie.jay] Added support for file URI in Appc fetcher. [yujie.jay] Added test for Appc image fetcher. [vinodkone] Removed 'Subscribe.force' field from v1 Scheduler API. [vinodkone] Updated master to ignore 'Subscribe.force' for HTTP framework. [vinodkone] Updated the CHANGELOG and doc about 'subscribe.force' field rem= oval. ------------------------------------------ [...truncated 166703 lines...] I0303 03:03:32.679903 2242 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 583050ns I0303 03:03:32.679935 2242 replica.cpp:320] Persisted replica status to ST= ARTING I0303 03:03:32.680127 2239 master.cpp:375] Master 5f59f17b-0266-444c-b496-= b1dc64c4c269 (fc440fe31c7f) started on 172.17.0.1:35854 I0303 03:03:32.680258 2243 recover.cpp:473] Replica is in STARTING status I0303 03:03:32.680174 2239 master.cpp:377] 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/av= aGdx/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"100secs" --registry_strict= =3D"true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --sla= ve_reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" = --webui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/= tmp/avaGdx/master" --zk_session_timeout=3D"10secs" I0303 03:03:32.680639 2239 master.cpp:424] Master allowing unauthenticated= frameworks to register I0303 03:03:32.680656 2239 master.cpp:427] Master only allowing authentica= ted slaves to register I0303 03:03:32.680670 2239 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/avaGdx/credentials' I0303 03:03:32.681334 2239 master.cpp:467] Using default 'crammd5' authent= icator I0303 03:03:32.681512 2238 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14997)@172.17.0.1:35854 I0303 03:03:32.681534 2239 master.cpp:536] Using default 'basic' HTTP auth= enticator I0303 03:03:32.681795 2239 master.cpp:570] Authorization enabled I0303 03:03:32.681882 2238 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0303 03:03:32.682082 2235 whitelist_watcher.cpp:77] No whitelist given I0303 03:03:32.682093 2248 hierarchical.cpp:144] Initialized hierarchical = allocator process I0303 03:03:32.682477 2237 recover.cpp:564] Updating replica status to VOT= ING I0303 03:03:32.683146 2236 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 411408ns I0303 03:03:32.683181 2236 replica.cpp:320] Persisted replica status to VO= TING I0303 03:03:32.683362 2236 recover.cpp:578] Successfully joined the Paxos = group I0303 03:03:32.683732 2236 recover.cpp:462] Recover process terminated I0303 03:03:32.685107 2239 master.cpp:1711] The newly elected leader is ma= ster@172.17.0.1:35854 with id 5f59f17b-0266-444c-b496-b1dc64c4c269 I0303 03:03:32.685834 2239 master.cpp:1724] Elected as the leading master! I0303 03:03:32.686003 2239 master.cpp:1469] Recovering from registrar I0303 03:03:32.686338 2244 registrar.cpp:307] Recovering registrar I0303 03:03:32.687657 2243 log.cpp:659] Attempting to start the writer I0303 03:03:32.692991 2243 replica.cpp:493] Replica received implicit prom= ise request from (14999)@172.17.0.1:35854 with proposal 1 I0303 03:03:32.694012 2243 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 943545ns I0303 03:03:32.694054 2243 replica.cpp:342] Persisted promised to 1 I0303 03:03:32.694890 2237 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0303 03:03:32.696403 2248 replica.cpp:388] Replica received explicit prom= ise request from (15000)@172.17.0.1:35854 for position 0 with proposal 2 I0303 03:03:32.696929 2248 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 380048ns I0303 03:03:32.696972 2248 replica.cpp:712] Persisted action at 0 I0303 03:03:32.698278 2245 replica.cpp:537] Replica received write request= for position 0 from (15001)@172.17.0.1:35854 I0303 03:03:32.698381 2245 leveldb.cpp:436] Reading position from leveldb = took 45439ns I0303 03:03:32.698909 2245 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 362921ns I0303 03:03:32.699009 2245 replica.cpp:712] Persisted action at 0 I0303 03:03:32.699707 2236 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0303 03:03:32.700994 2236 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 1.253708ms I0303 03:03:32.701045 2236 replica.cpp:712] Persisted action at 0 I0303 03:03:32.701071 2236 replica.cpp:697] Replica learned NOP action at = position 0 I0303 03:03:32.702013 2237 log.cpp:675] Writer started with ending positio= n 0 I0303 03:03:32.704443 2247 leveldb.cpp:436] Reading position from leveldb = took 46082ns I0303 03:03:32.705842 2235 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 19.453952ms I0303 03:03:32.706200 2235 registrar.cpp:439] Applied 1 operations in 3525= 3ns; attempting to update the 'registry' I0303 03:03:32.707415 2249 log.cpp:683] Attempting to append 170 bytes to = the log I0303 03:03:32.707543 2235 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0303 03:03:32.708688 2243 replica.cpp:537] Replica received write request= for position 1 from (15002)@172.17.0.1:35854 I0303 03:03:32.709230 2243 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 432732ns I0303 03:03:32.709316 2243 replica.cpp:712] Persisted action at 1 I0303 03:03:32.710376 2243 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0303 03:03:32.710909 2243 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 286262ns I0303 03:03:32.711005 2243 replica.cpp:712] Persisted action at 1 I0303 03:03:32.711124 2243 replica.cpp:697] Replica learned APPEND action = at position 1 I0303 03:03:32.712258 2242 registrar.cpp:484] Successfully updated the 're= gistry' in 5.939968ms I0303 03:03:32.712376 2242 registrar.cpp:370] Successfully recovered regis= trar I0303 03:03:32.712426 2237 log.cpp:702] Attempting to truncate the log to = 1 I0303 03:03:32.712535 2235 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0303 03:03:32.712807 2236 master.cpp:1521] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0303 03:03:32.712867 2241 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0303 03:03:32.713385 2241 replica.cpp:537] Replica received write request= for position 2 from (15003)@172.17.0.1:35854 I0303 03:03:32.713701 2241 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 280450ns I0303 03:03:32.713724 2241 replica.cpp:712] Persisted action at 2 I0303 03:03:32.714222 2243 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0303 03:03:32.714527 2243 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 275951ns I0303 03:03:32.714586 2243 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 33577ns I0303 03:03:32.714610 2243 replica.cpp:712] Persisted action at 2 I0303 03:03:32.714638 2243 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0303 03:03:32.723759 2215 scheduler.cpp:172] Version: 0.28.0 I0303 03:03:32.724457 2245 scheduler.cpp:432] New master detected at maste= r@172.17.0.1:35854 I0303 03:03:32.726435 2234 scheduler.cpp:332] Connected with the master at= http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.728152 2238 scheduler.cpp:230] Sending SUBSCRIBE call to ht= tp://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.729503 2237 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 03:03:32.730160 2245 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.1:54800 I0303 03:03:32.730392 2245 master.cpp:1973] Received subscription request = for HTTP framework 'default' I0303 03:03:32.730464 2245 master.cpp:1750] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0303 03:03:32.730764 2245 master.cpp:2064] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0303 03:03:32.731360 2243 hierarchical.cpp:265] Added framework 5f59f17b-= 0266-444c-b496-b1dc64c4c269-0000 I0303 03:03:32.731418 2246 master.hpp:1657] Sending heartbeat to 5f59f17b-= 0266-444c-b496-b1dc64c4c269-0000 I0303 03:03:32.731535 2243 hierarchical.cpp:1453] No resources available t= o allocate! I0303 03:03:32.731588 2243 hierarchical.cpp:1548] No inverse offers to sen= d out! I0303 03:03:32.731631 2243 hierarchical.cpp:1130] Performed allocation for= 0 slaves in 167586ns I0303 03:03:32.733409 2239 scheduler.cpp:602] Enqueuing event SUBSCRIBED r= eceived from http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.734021 2239 scheduler.cpp:602] Enqueuing event HEARTBEAT re= ceived from http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.734874 2234 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0303 03:03:32.735275 2239 scheduler.cpp:230] Sending REQUEST call to http= ://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.736063 2246 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 03:03:32.736528 2240 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.1:54801 I0303 03:03:32.736634 2240 master.cpp:2670] Processing REQUEST call for fr= amework 5f59f17b-0266-444c-b496-b1dc64c4c269-0000 (default) I0303 03:03:32.736794 2247 hierarchical.cpp:589] Received resource request= from framework 5f59f17b-0266-444c-b496-b1dc64c4c269-0000 I0303 03:03:32.737164 2244 master.cpp:1026] Master terminating I0303 03:03:32.737417 2234 hierarchical.cpp:326] Removed framework 5f59f17= b-0266-444c-b496-b1dc64c4c269-0000 E0303 03:03:32.738067 2245 scheduler.cpp:575] End-Of-File received from ma= ster. The master closed the event stream I0303 03:03:32.739310 2248 scheduler.cpp:414] Re-detecting master I0303 03:03:32.739998 2248 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 03:03:32.740099 2248 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 03:03:32.741209 2248 scheduler.cpp:432] New master detected at maste= r@172.17.0.1:35854 I0303 03:03:32.743201 2237 scheduler.cpp:332] Connected with the master at= http://172.17.0.1:35854/master/api/v1/scheduler [ OK ] ContentType/SchedulerTest.Request/0 (75 ms) [ RUN ] ContentType/SchedulerTest.Request/1 I0303 03:03:32.749924 2215 leveldb.cpp:174] Opened db in 2.469579ms I0303 03:03:32.752315 2215 leveldb.cpp:181] Compacted db in 2.333189ms I0303 03:03:32.752382 2215 leveldb.cpp:196] Created db iterator in 27688ns I0303 03:03:32.752409 2215 leveldb.cpp:202] Seeked to beginning of db in 2= 840ns I0303 03:03:32.752426 2215 leveldb.cpp:271] Iterated through 0 keys in the= db in 346ns I0303 03:03:32.752488 2215 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0303 03:03:32.753316 2245 recover.cpp:447] Starting replica recovery I0303 03:03:32.753839 2245 recover.cpp:473] Replica is in EMPTY status I0303 03:03:32.755586 2243 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (15011)@172.17.0.1:35854 I0303 03:03:32.756119 2245 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0303 03:03:32.756494 2246 master.cpp:375] Master 39096cfe-22f7-4521-8f7f-= 5190fdde430e (fc440fe31c7f) started on 172.17.0.1:35854 I0303 03:03:32.756851 2245 recover.cpp:564] Updating replica status to STA= RTING I0303 03:03:32.756522 2246 master.cpp:377] 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/Rb= Leym/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"100secs" --registry_strict= =3D"true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --sla= ve_reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" = --webui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/= tmp/RbLeym/master" --zk_session_timeout=3D"10secs" I0303 03:03:32.757170 2246 master.cpp:424] Master allowing unauthenticated= frameworks to register I0303 03:03:32.757186 2246 master.cpp:427] Master only allowing authentica= ted slaves to register I0303 03:03:32.757196 2246 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/RbLeym/credentials' I0303 03:03:32.757606 2246 master.cpp:467] Using default 'crammd5' authent= icator I0303 03:03:32.757766 2246 master.cpp:536] Using default 'basic' HTTP auth= enticator I0303 03:03:32.757910 2246 master.cpp:570] Authorization enabled I0303 03:03:32.758106 2245 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 837432ns I0303 03:03:32.758214 2245 replica.cpp:320] Persisted replica status to ST= ARTING I0303 03:03:32.758460 2245 whitelist_watcher.cpp:77] No whitelist given I0303 03:03:32.758636 2244 recover.cpp:473] Replica is in STARTING status I0303 03:03:32.758493 2243 hierarchical.cpp:144] Initialized hierarchical = allocator process I0303 03:03:32.759546 2236 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (15013)@172.17.0.1:35854 I0303 03:03:32.760164 2237 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0303 03:03:32.760663 2234 recover.cpp:564] Updating replica status to VOT= ING I0303 03:03:32.761270 2245 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 355660ns I0303 03:03:32.761380 2245 replica.cpp:320] Persisted replica status to VO= TING I0303 03:03:32.761620 2234 recover.cpp:578] Successfully joined the Paxos = group I0303 03:03:32.761714 2246 master.cpp:1711] The newly elected leader is ma= ster@172.17.0.1:35854 with id 39096cfe-22f7-4521-8f7f-5190fdde430e I0303 03:03:32.761744 2246 master.cpp:1724] Elected as the leading master! I0303 03:03:32.761762 2246 master.cpp:1469] Recovering from registrar I0303 03:03:32.761868 2234 recover.cpp:462] Recover process terminated I0303 03:03:32.762296 2236 registrar.cpp:307] Recovering registrar I0303 03:03:32.763061 2237 log.cpp:659] Attempting to start the writer I0303 03:03:32.764253 2237 replica.cpp:493] Replica received implicit prom= ise request from (15014)@172.17.0.1:35854 with proposal 1 I0303 03:03:32.764611 2237 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 323244ns I0303 03:03:32.764634 2237 replica.cpp:342] Persisted promised to 1 I0303 03:03:32.765344 2248 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0303 03:03:32.766480 2237 replica.cpp:388] Replica received explicit prom= ise request from (15015)@172.17.0.1:35854 for position 0 with proposal 2 I0303 03:03:32.766839 2237 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 320397ns I0303 03:03:32.766861 2237 replica.cpp:712] Persisted action at 0 I0303 03:03:32.767678 2244 replica.cpp:537] Replica received write request= for position 0 from (15016)@172.17.0.1:35854 I0303 03:03:32.767740 2244 leveldb.cpp:436] Reading position from leveldb = took 31224ns I0303 03:03:32.768076 2244 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 295863ns I0303 03:03:32.768101 2244 replica.cpp:712] Persisted action at 0 I0303 03:03:32.768728 2242 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0303 03:03:32.769137 2242 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 380211ns I0303 03:03:32.769165 2242 replica.cpp:712] Persisted action at 0 I0303 03:03:32.769191 2242 replica.cpp:697] Replica learned NOP action at = position 0 I0303 03:03:32.769762 2240 log.cpp:675] Writer started with ending positio= n 0 I0303 03:03:32.770789 2242 leveldb.cpp:436] Reading position from leveldb = took 28309ns I0303 03:03:32.771780 2243 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 9.434112ms I0303 03:03:32.771900 2243 registrar.cpp:439] Applied 1 operations in 3659= 3ns; attempting to update the 'registry' I0303 03:03:32.772554 2234 log.cpp:683] Attempting to append 170 bytes to = the log I0303 03:03:32.772666 2236 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0303 03:03:32.773380 2244 replica.cpp:537] Replica received write request= for position 1 from (15017)@172.17.0.1:35854 I0303 03:03:32.773821 2244 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 408780ns I0303 03:03:32.773846 2244 replica.cpp:712] Persisted action at 1 I0303 03:03:32.774442 2242 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0303 03:03:32.774768 2242 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 293795ns I0303 03:03:32.774794 2242 replica.cpp:712] Persisted action at 1 I0303 03:03:32.774821 2242 replica.cpp:697] Replica learned APPEND action = at position 1 I0303 03:03:32.775717 2246 registrar.cpp:484] Successfully updated the 're= gistry' in 3.761152ms I0303 03:03:32.775847 2246 registrar.cpp:370] Successfully recovered regis= trar I0303 03:03:32.775993 2238 log.cpp:702] Attempting to truncate the log to = 1 I0303 03:03:32.776165 2240 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0303 03:03:32.776478 2249 master.cpp:1521] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0303 03:03:32.776509 2245 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0303 03:03:32.777271 2236 replica.cpp:537] Replica received write request= for position 2 from (15018)@172.17.0.1:35854 I0303 03:03:32.777715 2236 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 400615ns I0303 03:03:32.777746 2236 replica.cpp:712] Persisted action at 2 I0303 03:03:32.778638 2239 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0303 03:03:32.779047 2239 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 367858ns I0303 03:03:32.779134 2239 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 47858ns I0303 03:03:32.779170 2239 replica.cpp:712] Persisted action at 2 I0303 03:03:32.779201 2239 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0303 03:03:32.787488 2215 scheduler.cpp:172] Version: 0.28.0 I0303 03:03:32.788121 2234 scheduler.cpp:432] New master detected at maste= r@172.17.0.1:35854 I0303 03:03:32.789480 2236 scheduler.cpp:332] Connected with the master at= http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.790549 2234 scheduler.cpp:230] Sending SUBSCRIBE call to ht= tp://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.791513 2238 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 03:03:32.792045 2235 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.1:54804 I0303 03:03:32.792357 2235 master.cpp:1973] Received subscription request = for HTTP framework 'default' I0303 03:03:32.792418 2235 master.cpp:1750] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0303 03:03:32.792688 2235 master.cpp:2064] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0303 03:03:32.793153 2237 hierarchical.cpp:265] Added framework 39096cfe-= 22f7-4521-8f7f-5190fdde430e-0000 I0303 03:03:32.793231 2237 hierarchical.cpp:1453] No resources available t= o allocate! I0303 03:03:32.793267 2237 hierarchical.cpp:1548] No inverse offers to sen= d out! I0303 03:03:32.793289 2237 hierarchical.cpp:1130] Performed allocation for= 0 slaves in 111005ns I0303 03:03:32.793474 2237 master.hpp:1657] Sending heartbeat to 39096cfe-= 22f7-4521-8f7f-5190fdde430e-0000 I0303 03:03:32.794247 2240 scheduler.cpp:602] Enqueuing event SUBSCRIBED r= eceived from http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.794647 2240 scheduler.cpp:602] Enqueuing event HEARTBEAT re= ceived from http://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.795333 2240 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0303 03:03:32.795536 2244 scheduler.cpp:230] Sending REQUEST call to http= ://172.17.0.1:35854/master/api/v1/scheduler I0303 03:03:32.797329 2236 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 03:03:32.797711 2237 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.1:54805 I0303 03:03:32.797921 2237 master.cpp:2670] Processing REQUEST call for fr= amework 39096cfe-22f7-4521-8f7f-5190fdde430e-0000 (default) I0303 03:03:32.798087 2249 hierarchical.cpp:589] Received resource request= from framework 39096cfe-22f7-4521-8f7f-5190fdde430e-0000 I0303 03:03:32.798573 2243 master.cpp:1026] Master terminating I0303 03:03:32.798878 2238 hierarchical.cpp:326] Removed framework 39096cf= e-22f7-4521-8f7f-5190fdde430e-0000 E0303 03:03:32.799399 2235 scheduler.cpp:575] End-Of-File received from ma= ster. The master closed the event stream I0303 03:03:32.800894 2244 scheduler.cpp:414] Re-detecting master I0303 03:03:32.801713 2244 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 03:03:32.801759 2244 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 03:03:32.801892 2244 scheduler.cpp:432] New master detected at maste= r@172.17.0.1:35854 I0303 03:03:32.803318 2246 scheduler.cpp:332] Connected with the master at= http://172.17.0.1:35854/master/api/v1/scheduler [ OK ] ContentType/SchedulerTest.Request/1 (61 ms) [----------] 26 tests from ContentType/SchedulerTest (4913 ms total) [----------] Global test environment tear-down E0303 03:03:32.924541 2215 environment.cpp:752] Failed to remove '/tmp/Log= ZooKeeperTest_WriteRead_SoUzbG': No such file or directory E0303 03:03:32.924610 2215 environment.cpp:752] Failed to remove '/tmp/Log= ZooKeeperTest_LostZooKeeper_vuXn1c': No such file or directory [=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D] 997 tests from 128 test cases ran. (352288= ms total) [ PASSED ] 996 tests. [ FAILED ] 1 test, listed below: [ FAILED ] AppcImageFetcherTest.SimpleFetch 1 FAILED TEST YOU HAVE 6 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-1456972126-29774 Untagged: mesos-1456972126-29774:latest Deleted: 8e5a62489900442500843e78ceeaabad37edccb6b18a8960cae9f0caee193b6f Deleted: df931b345b11ef92191bc98131954be25ee9f9603bab518a6e7c26e3cd125561 Deleted: 97b2d2f8ac457f79e23b3bc6478442195561c6e25edb9db5c1639def6f168dc6 Deleted: b3bc4f0a0b7bac94103bda1561c008164e7bc0767c7b91f1af1cab316cfe6a94 Deleted: 54a8afa3877c1d8321a350e26cd46e6df6c8b45cb8a8ab440c8886d38e5dc227 Deleted: 5334689b6267b92f6c86686ccb1e8b0950c4768fc33981281b18d6107377212e Deleted: 90262df29e893d637da9edc15caa77d65faca4a3c76cb8c876904f9a9f175ed8 Deleted: bc56a3b2e21990c803a37fb3723cc5513919868adb7e26b801a47c82c2d8a7a7 Deleted: 959bfd67948c8ef3efe3a89d01fb16de1ba595f14c08f9a696440458cfc0060e Deleted: 9ae3c00af7760f39befde6ece63b891ac334c9532a14abf07dc239b20544759c Deleted: 532f5d6b26d1f0130c92a64566104b74167e7a0cf9e19b9f2b5c7b32d056f283 Deleted: 4393c58ec7c57aefe82fa30a6d313f3abe16ce7a9bcd8dfe4745b5ed9b937090 Deleted: 28bf344c231d0125598017408c5bcb5f80a9ee705040a5908138a85985ea3133 Deleted: b5d2bde50a109037528794117fd6bafb0a5c6f1edbc2d6a2b565a0c45dfcc7d0 Deleted: 38d3cf5c4942bbac3aa2f9ceca60b47e2c0a51b98c64fcd170578463101dbb16 Deleted: 9f6a58eea9a82735cc77cd6c9563666c4f4249b55b60883bf85e8b884b5197a9 Build step 'Execute shell' marked build as failure