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 AE96317F25 for ; Thu, 3 Mar 2016 07:19:15 +0000 (UTC) Received: (qmail 83297 invoked by uid 500); 3 Mar 2016 07:19:15 -0000 Delivered-To: apmail-mesos-builds-archive@mesos.apache.org Received: (qmail 83270 invoked by uid 500); 3 Mar 2016 07:19:15 -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 83254 invoked by uid 99); 3 Mar 2016 07:19:15 -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 07:19:15 +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 C914D9C003F; Thu, 3 Mar 2016 07:19:09 +0000 (UTC) Date: Thu, 3 Mar 2016 07:19:09 +0000 (UTC) From: Apache Jenkins Server To: builds@mesos.apache.org, joris.van.remoortere@gmail.com, bmahler@twitter.com, yujie.jay@gmail.com, vinodkone@gmail.com Message-ID: <1836491863.2095.1456989549673.JavaMail.jenkins@crius> In-Reply-To: <19991360.2076.1456985133173.JavaMail.jenkins@crius> References: <19991360.2076.1456985133173.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_Mesos_?= =?UTF-8?Q?=C2=BB_clang,--verbose,GLOG=5Fv=3D1_MESO?= =?UTF-8?Q?S=5FVERBOSE=3D1,ubuntu:14.04,(docke?= =?UTF-8?Q?r||Hadoop)&&(!ubuntu-us1)_#1765?= 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=clang,CONFIGURATION=--verbose,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 virtual function shadowing in appc provision t= est. ------------------------------------------ [...truncated 167663 lines...] I0303 07:12:01.961760 31605 recover.cpp:473] Replica is in EMPTY status I0303 07:12:01.963261 31611 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14980)@172.17.0.3:49100 I0303 07:12:01.963600 31611 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0303 07:12:01.964062 31602 recover.cpp:564] Updating replica status to STA= RTING I0303 07:12:01.964859 31610 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 727715ns I0303 07:12:01.964890 31610 replica.cpp:320] Persisted replica status to ST= ARTING I0303 07:12:01.965070 31604 recover.cpp:473] Replica is in STARTING status I0303 07:12:01.966284 31598 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14981)@172.17.0.3:49100 I0303 07:12:01.966584 31598 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0303 07:12:01.967067 31613 recover.cpp:564] Updating replica status to VOT= ING I0303 07:12:01.967608 31598 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 460681ns I0303 07:12:01.967638 31598 replica.cpp:320] Persisted replica status to VO= TING I0303 07:12:01.967725 31598 recover.cpp:578] Successfully joined the Paxos = group I0303 07:12:01.967875 31598 recover.cpp:462] Recover process terminated I0303 07:12:01.969692 31604 master.cpp:375] Master f13c2708-318c-49bd-87ad-= e82aba5a4f03 (b54769608c4c) started on 172.17.0.3:49100 I0303 07:12:01.969730 31604 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/Vc= xkFL/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/VcxkFL/master" --zk_session_timeout=3D"10secs" I0303 07:12:01.970074 31604 master.cpp:424] Master allowing unauthenticated= frameworks to register I0303 07:12:01.970087 31604 master.cpp:427] Master only allowing authentica= ted slaves to register I0303 07:12:01.970095 31604 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/VcxkFL/credentials' I0303 07:12:01.970540 31604 master.cpp:467] Using default 'crammd5' authent= icator I0303 07:12:01.970777 31604 master.cpp:536] Using default 'basic' HTTP auth= enticator I0303 07:12:01.971051 31604 master.cpp:570] Authorization enabled I0303 07:12:01.971796 31611 whitelist_watcher.cpp:77] No whitelist given I0303 07:12:01.971815 31603 hierarchical.cpp:144] Initialized hierarchical = allocator process I0303 07:12:01.973871 31604 master.cpp:1711] The newly elected leader is ma= ster@172.17.0.3:49100 with id f13c2708-318c-49bd-87ad-e82aba5a4f03 I0303 07:12:01.973933 31604 master.cpp:1724] Elected as the leading master! I0303 07:12:01.973948 31604 master.cpp:1469] Recovering from registrar I0303 07:12:01.974114 31602 registrar.cpp:307] Recovering registrar I0303 07:12:01.974966 31604 log.cpp:659] Attempting to start the writer I0303 07:12:01.976346 31604 replica.cpp:493] Replica received implicit prom= ise request from (14983)@172.17.0.3:49100 with proposal 1 I0303 07:12:01.977596 31604 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 1.227266ms I0303 07:12:01.977635 31604 replica.cpp:342] Persisted promised to 1 I0303 07:12:01.978366 31608 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0303 07:12:01.979651 31610 replica.cpp:388] Replica received explicit prom= ise request from (14984)@172.17.0.3:49100 for position 0 with proposal 2 I0303 07:12:01.980118 31610 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 418332ns I0303 07:12:01.980146 31610 replica.cpp:712] Persisted action at 0 I0303 07:12:01.981358 31610 replica.cpp:537] Replica received write request= for position 0 from (14985)@172.17.0.3:49100 I0303 07:12:01.981417 31610 leveldb.cpp:436] Reading position from leveldb = took 37855ns I0303 07:12:01.981796 31610 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 348734ns I0303 07:12:01.981824 31610 replica.cpp:712] Persisted action at 0 I0303 07:12:01.982476 31613 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0303 07:12:01.983119 31613 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 624550ns I0303 07:12:01.983145 31613 replica.cpp:712] Persisted action at 0 I0303 07:12:01.983163 31613 replica.cpp:697] Replica learned NOP action at = position 0 I0303 07:12:01.983963 31613 log.cpp:675] Writer started with ending positio= n 0 I0303 07:12:01.985175 31613 leveldb.cpp:436] Reading position from leveldb = took 47207ns I0303 07:12:01.986284 31613 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 12.130816ms I0303 07:12:01.986405 31613 registrar.cpp:439] Applied 1 operations in 4096= 7ns; attempting to update the 'registry' I0303 07:12:01.987503 31613 log.cpp:683] Attempting to append 170 bytes to = the log I0303 07:12:01.987676 31613 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0303 07:12:01.988571 31613 replica.cpp:537] Replica received write request= for position 1 from (14986)@172.17.0.3:49100 I0303 07:12:01.989187 31613 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 590498ns I0303 07:12:01.989214 31613 replica.cpp:712] Persisted action at 1 I0303 07:12:01.990092 31612 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0303 07:12:01.990577 31612 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 468080ns I0303 07:12:01.990603 31612 replica.cpp:712] Persisted action at 1 I0303 07:12:01.990622 31612 replica.cpp:697] Replica learned APPEND action = at position 1 I0303 07:12:01.991864 31600 registrar.cpp:484] Successfully updated the 're= gistry' in 5.396224ms I0303 07:12:01.992009 31600 registrar.cpp:370] Successfully recovered regis= trar I0303 07:12:01.992492 31600 master.cpp:1521] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0303 07:12:01.992720 31600 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0303 07:12:01.993321 31605 log.cpp:702] Attempting to truncate the log to = 1 I0303 07:12:01.993460 31606 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0303 07:12:01.994227 31602 replica.cpp:537] Replica received write request= for position 2 from (14987)@172.17.0.3:49100 I0303 07:12:01.994704 31602 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 451359ns I0303 07:12:01.994731 31602 replica.cpp:712] Persisted action at 2 I0303 07:12:01.995355 31602 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0303 07:12:01.995676 31602 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 311903ns I0303 07:12:01.995741 31602 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 43466ns I0303 07:12:01.995765 31602 replica.cpp:712] Persisted action at 2 I0303 07:12:01.995784 31602 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0303 07:12:02.004485 31580 scheduler.cpp:172] Version: 0.28.0 I0303 07:12:02.006155 31602 scheduler.cpp:432] New master detected at maste= r@172.17.0.3:49100 I0303 07:12:02.009759 31606 scheduler.cpp:332] Connected with the master at= http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.011818 31600 scheduler.cpp:230] Sending SUBSCRIBE call to ht= tp://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.013953 31600 process.cpp:3136] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 07:12:02.014546 31600 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.3:53374 I0303 07:12:02.014835 31600 master.cpp:1973] Received subscription request = for HTTP framework 'default' I0303 07:12:02.014863 31600 master.cpp:1750] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0303 07:12:02.015588 31600 master.cpp:2064] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0303 07:12:02.016253 31600 hierarchical.cpp:265] Added framework f13c2708-= 318c-49bd-87ad-e82aba5a4f03-0000 I0303 07:12:02.016340 31600 hierarchical.cpp:1453] No resources available t= o allocate! I0303 07:12:02.016381 31600 hierarchical.cpp:1548] No inverse offers to sen= d out! I0303 07:12:02.016407 31600 hierarchical.cpp:1130] Performed allocation for= 0 slaves in 135778ns I0303 07:12:02.016723 31602 master.hpp:1657] Sending heartbeat to f13c2708-= 318c-49bd-87ad-e82aba5a4f03-0000 I0303 07:12:02.018298 31600 scheduler.cpp:602] Enqueuing event SUBSCRIBED r= eceived from http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.019595 31600 scheduler.cpp:602] Enqueuing event HEARTBEAT re= ceived from http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.020145 31600 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0303 07:12:02.020843 31600 scheduler.cpp:230] Sending REQUEST call to http= ://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.022590 31600 process.cpp:3136] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 07:12:02.023120 31610 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.3:53375 I0303 07:12:02.023272 31610 master.cpp:2670] Processing REQUEST call for fr= amework f13c2708-318c-49bd-87ad-e82aba5a4f03-0000 (default) I0303 07:12:02.023515 31610 hierarchical.cpp:589] Received resource request= from framework f13c2708-318c-49bd-87ad-e82aba5a4f03-0000 I0303 07:12:02.024878 31580 master.cpp:1026] Master terminating I0303 07:12:02.025205 31610 hierarchical.cpp:326] Removed framework f13c270= 8-318c-49bd-87ad-e82aba5a4f03-0000 E0303 07:12:02.029017 31612 scheduler.cpp:575] End-Of-File received from ma= ster. The master closed the event stream I0303 07:12:02.033063 31612 scheduler.cpp:414] Re-detecting master [ OK ] ContentType/SchedulerTest.Request/0 (83 ms) [ RUN ] ContentType/SchedulerTest.Request/1 I0303 07:12:02.042008 31580 leveldb.cpp:174] Opened db in 4.173344ms I0303 07:12:02.044713 31580 leveldb.cpp:181] Compacted db in 2.667048ms I0303 07:12:02.044795 31580 leveldb.cpp:196] Created db iterator in 34203ns I0303 07:12:02.044816 31580 leveldb.cpp:202] Seeked to beginning of db in 9= 248ns I0303 07:12:02.044826 31580 leveldb.cpp:271] Iterated through 0 keys in the= db in 6414ns I0303 07:12:02.044872 31580 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0303 07:12:02.045883 31611 recover.cpp:447] Starting replica recovery I0303 07:12:02.046108 31603 recover.cpp:473] Replica is in EMPTY status I0303 07:12:02.047554 31611 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14995)@172.17.0.3:49100 I0303 07:12:02.047994 31611 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0303 07:12:02.048637 31611 recover.cpp:564] Updating replica status to STA= RTING I0303 07:12:02.049631 31611 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 686251ns I0303 07:12:02.049743 31611 replica.cpp:320] Persisted replica status to ST= ARTING I0303 07:12:02.049995 31611 recover.cpp:473] Replica is in STARTING status I0303 07:12:02.051615 31611 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14996)@172.17.0.3:49100 I0303 07:12:02.052067 31611 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0303 07:12:02.052582 31610 recover.cpp:564] Updating replica status to VOT= ING I0303 07:12:02.056774 31612 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 935346ns I0303 07:12:02.056921 31612 replica.cpp:320] Persisted replica status to VO= TING I0303 07:12:02.057142 31612 recover.cpp:578] Successfully joined the Paxos = group I0303 07:12:02.057448 31612 recover.cpp:462] Recover process terminated I0303 07:12:02.059635 31604 master.cpp:375] Master a168ce69-fd8d-4023-bb49-= 482a205f88d6 (b54769608c4c) started on 172.17.0.3:49100 I0303 07:12:02.059777 31604 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/NY= RJvv/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/NYRJvv/master" --zk_session_timeout=3D"10secs" I0303 07:12:02.060359 31604 master.cpp:424] Master allowing unauthenticated= frameworks to register I0303 07:12:02.060430 31604 master.cpp:427] Master only allowing authentica= ted slaves to register I0303 07:12:02.060523 31604 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/NYRJvv/credentials' I0303 07:12:02.061015 31604 master.cpp:467] Using default 'crammd5' authent= icator I0303 07:12:02.061336 31604 master.cpp:536] Using default 'basic' HTTP auth= enticator I0303 07:12:02.061642 31604 master.cpp:570] Authorization enabled I0303 07:12:02.062721 31600 whitelist_watcher.cpp:77] No whitelist given I0303 07:12:02.062765 31609 hierarchical.cpp:144] Initialized hierarchical = allocator process I0303 07:12:02.066097 31604 master.cpp:1711] The newly elected leader is ma= ster@172.17.0.3:49100 with id a168ce69-fd8d-4023-bb49-482a205f88d6 I0303 07:12:02.066251 31604 master.cpp:1724] Elected as the leading master! I0303 07:12:02.066370 31604 master.cpp:1469] Recovering from registrar I0303 07:12:02.066747 31610 registrar.cpp:307] Recovering registrar I0303 07:12:02.067528 31604 log.cpp:659] Attempting to start the writer I0303 07:12:02.069846 31610 replica.cpp:493] Replica received implicit prom= ise request from (14998)@172.17.0.3:49100 with proposal 1 I0303 07:12:02.070725 31610 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 837575ns I0303 07:12:02.070761 31610 replica.cpp:342] Persisted promised to 1 I0303 07:12:02.071954 31610 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0303 07:12:02.074530 31609 replica.cpp:388] Replica received explicit prom= ise request from (14999)@172.17.0.3:49100 for position 0 with proposal 2 I0303 07:12:02.075729 31609 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 1.150196ms I0303 07:12:02.075776 31609 replica.cpp:712] Persisted action at 0 I0303 07:12:02.077852 31610 replica.cpp:537] Replica received write request= for position 0 from (15000)@172.17.0.3:49100 I0303 07:12:02.077952 31610 leveldb.cpp:436] Reading position from leveldb = took 58540ns I0303 07:12:02.078721 31610 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 726125ns I0303 07:12:02.078749 31610 replica.cpp:712] Persisted action at 0 I0303 07:12:02.079895 31610 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0303 07:12:02.080767 31610 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 851578ns I0303 07:12:02.080802 31610 replica.cpp:712] Persisted action at 0 I0303 07:12:02.080827 31610 replica.cpp:697] Replica learned NOP action at = position 0 I0303 07:12:02.081746 31611 log.cpp:675] Writer started with ending positio= n 0 I0303 07:12:02.084210 31613 leveldb.cpp:436] Reading position from leveldb = took 101970ns I0303 07:12:02.085764 31609 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 18.960896ms I0303 07:12:02.085916 31609 registrar.cpp:439] Applied 1 operations in 4946= 2ns; attempting to update the 'registry' I0303 07:12:02.086751 31602 log.cpp:683] Attempting to append 170 bytes to = the log I0303 07:12:02.086894 31611 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0303 07:12:02.088160 31608 replica.cpp:537] Replica received write request= for position 1 from (15001)@172.17.0.3:49100 I0303 07:12:02.089735 31608 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 1.475172ms I0303 07:12:02.089786 31608 replica.cpp:712] Persisted action at 1 I0303 07:12:02.091023 31599 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0303 07:12:02.091719 31599 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 619278ns I0303 07:12:02.091750 31599 replica.cpp:712] Persisted action at 1 I0303 07:12:02.091773 31599 replica.cpp:697] Replica learned APPEND action = at position 1 I0303 07:12:02.093461 31599 registrar.cpp:484] Successfully updated the 're= gistry' in 7.480064ms I0303 07:12:02.093605 31599 registrar.cpp:370] Successfully recovered regis= trar I0303 07:12:02.093940 31599 log.cpp:702] Attempting to truncate the log to = 1 I0303 07:12:02.094379 31599 master.cpp:1521] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0303 07:12:02.094483 31599 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0303 07:12:02.094842 31601 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0303 07:12:02.095837 31609 replica.cpp:537] Replica received write request= for position 2 from (15002)@172.17.0.3:49100 I0303 07:12:02.096729 31609 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 861771ns I0303 07:12:02.096763 31609 replica.cpp:712] Persisted action at 2 I0303 07:12:02.097903 31609 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0303 07:12:02.098721 31609 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 795638ns I0303 07:12:02.098785 31609 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 47977ns I0303 07:12:02.098811 31609 replica.cpp:712] Persisted action at 2 I0303 07:12:02.098835 31609 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0303 07:12:02.107470 31580 scheduler.cpp:172] Version: 0.28.0 I0303 07:12:02.109145 31609 scheduler.cpp:432] New master detected at maste= r@172.17.0.3:49100 I0303 07:12:02.112910 31609 scheduler.cpp:332] Connected with the master at= http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.115805 31609 scheduler.cpp:230] Sending SUBSCRIBE call to ht= tp://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.117800 31605 process.cpp:3136] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 07:12:02.118376 31605 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.3:53376 I0303 07:12:02.118934 31605 master.cpp:1973] Received subscription request = for HTTP framework 'default' I0303 07:12:02.118964 31605 master.cpp:1750] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0303 07:12:02.119736 31612 master.cpp:2064] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0303 07:12:02.120436 31612 hierarchical.cpp:265] Added framework a168ce69-= fd8d-4023-bb49-482a205f88d6-0000 I0303 07:12:02.120523 31612 hierarchical.cpp:1453] No resources available t= o allocate! I0303 07:12:02.120560 31612 hierarchical.cpp:1548] No inverse offers to sen= d out! I0303 07:12:02.120585 31612 hierarchical.cpp:1130] Performed allocation for= 0 slaves in 130445ns I0303 07:12:02.120905 31605 master.hpp:1657] Sending heartbeat to a168ce69-= fd8d-4023-bb49-482a205f88d6-0000 I0303 07:12:02.123518 31607 scheduler.cpp:602] Enqueuing event SUBSCRIBED r= eceived from http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.124377 31607 scheduler.cpp:602] Enqueuing event HEARTBEAT re= ceived from http://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.124979 31607 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0303 07:12:02.126788 31607 scheduler.cpp:230] Sending REQUEST call to http= ://172.17.0.3:49100/master/api/v1/scheduler I0303 07:12:02.128803 31606 process.cpp:3136] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0303 07:12:02.129297 31606 http.cpp:311] HTTP POST for /master/api/v1/sche= duler from 172.17.0.3:53377 I0303 07:12:02.129585 31606 master.cpp:2670] Processing REQUEST call for fr= amework a168ce69-fd8d-4023-bb49-482a205f88d6-0000 (default) I0303 07:12:02.129793 31608 hierarchical.cpp:589] Received resource request= from framework a168ce69-fd8d-4023-bb49-482a205f88d6-0000 I0303 07:12:02.130911 31580 master.cpp:1026] Master terminating I0303 07:12:02.131206 31598 hierarchical.cpp:326] Removed framework a168ce6= 9-fd8d-4023-bb49-482a205f88d6-0000 E0303 07:12:02.132797 31601 scheduler.cpp:575] End-Of-File received from ma= ster. The master closed the event stream I0303 07:12:02.133627 31601 scheduler.cpp:414] Re-detecting master I0303 07:12:02.133908 31601 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 07:12:02.133947 31601 scheduler.cpp:365] Ignoring disconnection attem= pt from stale connection I0303 07:12:02.134032 31601 scheduler.cpp:432] New master detected at maste= r@172.17.0.3:49100 I0303 07:12:02.138447 31602 scheduler.cpp:332] Connected with the master at= http://172.17.0.3:49100/master/api/v1/scheduler [ OK ] ContentType/SchedulerTest.Request/1 (109 ms) [----------] 26 tests from ContentType/SchedulerTest (7305 ms total) [----------] Global test environment tear-down E0303 07:12:02.425236 31580 environment.cpp:752] Failed to remove '/tmp/Log= ZooKeeperTest_WriteRead_YzvYlh': No such file or directory E0303 07:12:02.425315 31580 environment.cpp:752] Failed to remove '/tmp/Log= ZooKeeperTest_LostZooKeeper_0ahJKW': No such file or directory [=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D] 997 tests from 128 test cases ran. (387089= 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-1456986861-12793 Untagged: mesos-1456986861-12793:latest Deleted: 577ab00c1aaf56beef9902c7b591f6e6b8f9fa237788c979fdb74e5774019c76 Deleted: 246d0c78b810f6a18b5979e24aac609446ed069dc2f41eed68810b1947bd1023 Deleted: d0f28a320de20cb58949be42caf5940d2e6509be716f8a9f29c8bf1f0c473987 Deleted: eb64635768ec63421dd429be375e648b9f2dd032e4d2fda9db010548105cc6bc Deleted: be007f3198e5f8e2d85b797a88a744ca8b3d0d21eef5c5deafacc5490a73d250 Deleted: a3d1279650c23fa03502ff0ae6b4099b5b59ab0acbfbf97266ed4c3c986f1f63 Deleted: 4f252c119459b205e4114bd05e79536a360791faf1c3062009b94f6d5fb59e76 Deleted: 099074dacc56f0f0024a4f0c4420f683c90516ceb543a21142d0ef08cbe9b899 Deleted: e73f7539ae80b04a2432e4f47ca4d3435e2f607d47051dacd07f8dfb14a71ef8 Deleted: 9534488f23480185243eb3fb99f5992b0551d8e4294325382f326c0b3d40e5e4 Deleted: 00380449ad35b7d34de8b142160fffc30c1fed2a6f159ee4e635b98ba06e1377 Deleted: b42e49b32b618aeb6631c7884d6886b30798b8b633192849ea3b64d17d6fa1e2 Deleted: dcfe6312dfe0f2881f70f358e2b9889b3719fd970e8cd6309c1a2043c87c3ab9 Deleted: bf14acc7709c8bc6ebfcc14581a1056542799a380dbea5e76140c82cfa019f4a Deleted: 4eef56477ee8e7339c065d0c7d62c62572ac9c7aec24ac99788c6e397a46b664 Deleted: 3d5c2ea89b89a96a0de0ec3be99030cc99fba53bcb45bb4dbd4f3f87a6cdcba9 Build step 'Execute shell' marked build as failure