mesos-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Niklas Nielsen <nik...@mesosphere.io>
Subject Re: Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui #2746
Date Wed, 18 Feb 2015 02:12:52 GMT
https://issues.apache.org/jira/browse/MESOS-2366

On 17 February 2015 at 17:56, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:

> See <
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2746/changes
> >
>
> Changes:
>
> [benjamin.mahler] Updated EventLoop::delay to take a lambda::function.
>
> ------------------------------------------
> [...truncated 72164 lines...]
> I0218 01:55:15.052839 13946 master.cpp:785] Master terminating
> I0218 01:55:15.053035 13943 registrar.cpp:444] Applied 1 operations in
> 72064ns; attempting to update the 'registry'
> I0218 01:55:15.053145 13935 slave.cpp:2751] master@67.195.81.187:57268
> exited
> W0218 01:55:15.053166 13935 slave.cpp:2754] Master disconnected! Waiting
> for a new master to be elected
> I0218 01:55:15.054481 13918 process.cpp:2117] Dropped / Lost event for
> PID: master@67.195.81.187:57268
> I0218 01:55:15.054572 13918 process.cpp:2117] Dropped / Lost event for
> PID: master@67.195.81.187:57268
> I0218 01:55:15.056511 13940 log.cpp:683] Attempting to append 316 bytes to
> the log
> I0218 01:55:15.056644 13935 coordinator.cpp:339] Coordinator attempting to
> write 2 action at position 3
> I0218 01:55:15.057008 13945 process.cpp:2117] Dropped / Lost event for
> PID: log-coordinator(287)@67.195.81.187:57268
> I0218 01:55:15.060351 13941 process.cpp:2117] Dropped / Lost event for
> PID: master@67.195.81.187:57268
> I0218 01:55:15.229552 13941 slave.cpp:1089] Will retry registration in
> 32.644031ms if necessary
> I0218 01:55:15.099928 13948 process.cpp:2117] Dropped / Lost event for
> PID: scheduler-3b7a53ae-0e3b-42d1-8461-93911caf9079@67.195.81.187:57268
> I0218 01:55:15.230154 13945 process.cpp:2117] Dropped / Lost event for
> PID: registrar(256)@67.195.81.187:57268
> I0218 01:55:15.238539 13943 slave.cpp:505] Slave terminating
> I0218 01:55:15.241852 13918 process.cpp:2117] Dropped / Lost event for
> PID: slave(221)@67.195.81.187:57268
> I0218 01:55:15.242988 13918 process.cpp:2117] Dropped / Lost event for
> PID: scheduler-9b2103c5-38b0-4c4b-8614-1aeb1fcc95ed@67.195.81.187:57268
> [       OK ] ExceptionTest.DisallowSchedulerActionsOnAbort (361 ms)
> [ RUN      ] ExceptionTest.DisallowSchedulerCallbacksOnAbort
> Using temporary directory
> '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_VuflGx'
> I0218 01:55:15.248679 13918 leveldb.cpp:175] Opened db in 2.668145ms
> I0218 01:55:15.249372 13918 leveldb.cpp:182] Compacted db in 663293ns
> I0218 01:55:15.249419 13918 leveldb.cpp:197] Created db iterator in 21632ns
> I0218 01:55:15.249439 13918 leveldb.cpp:203] Seeked to beginning of db in
> 2067ns
> I0218 01:55:15.249449 13918 leveldb.cpp:272] Iterated through 0 keys in
> the db in 289ns
> I0218 01:55:15.249492 13918 replica.cpp:743] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0218 01:55:15.249970 13947 recover.cpp:448] Starting replica recovery
> I0218 01:55:15.250306 13947 recover.cpp:474] Replica is in 4 status
> I0218 01:55:15.251730 13937 replica.cpp:640] Replica in 4 status received
> a broadcasted recover request
> I0218 01:55:15.252112 13942 recover.cpp:194] Received a recover response
> from a replica in 4 status
> I0218 01:55:15.252532 13945 master.cpp:347] Master
> 20150218-015515-3142697795-57268-13918 (pomona.apache.org) started on
> 67.195.81.187:57268
> I0218 01:55:15.252576 13945 master.cpp:393] Master only allowing
> authenticated frameworks to register
> I0218 01:55:15.252593 13945 master.cpp:398] Master only allowing
> authenticated slaves to register
> I0218 01:55:15.252617 13945 credentials.hpp:36] Loading credentials for
> authentication from
> '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_VuflGx/credentials'
> I0218 01:55:15.252769 13941 recover.cpp:565] Updating replica status to 3
> I0218 01:55:15.252887 13945 master.cpp:440] Authorization enabled
> I0218 01:55:15.253491 13936 whitelist_watcher.cpp:78] No whitelist given
> I0218 01:55:15.253628 13947 hierarchical.hpp:286] Initialized hierarchical
> allocator process
> I0218 01:55:15.253706 13937 leveldb.cpp:305] Persisting metadata (8 bytes)
> to leveldb took 565291ns
> I0218 01:55:15.253726 13937 replica.cpp:322] Persisted replica status to 3
> I0218 01:55:15.253965 13939 recover.cpp:474] Replica is in 3 status
> I0218 01:55:15.254829 13940 master.cpp:1354] The newly elected leader is
> master@67.195.81.187:57268 with id 20150218-015515-3142697795-57268-13918
> I0218 01:55:15.254858 13940 master.cpp:1367] Elected as the leading master!
> I0218 01:55:15.254871 13940 master.cpp:1185] Recovering from registrar
> I0218 01:55:15.254978 13946 registrar.cpp:312] Recovering registrar
> I0218 01:55:15.255887 13932 replica.cpp:640] Replica in 3 status received
> a broadcasted recover request
> I0218 01:55:15.256160 13935 recover.cpp:194] Received a recover response
> from a replica in 3 status
> I0218 01:55:15.256742 13937 recover.cpp:565] Updating replica status to 1
> I0218 01:55:15.257387 13934 leveldb.cpp:305] Persisting metadata (8 bytes)
> to leveldb took 437201ns
> I0218 01:55:15.257407 13934 replica.cpp:322] Persisted replica status to 1
> I0218 01:55:15.257489 13934 recover.cpp:579] Successfully joined the Paxos
> group
> I0218 01:55:15.257643 13934 recover.cpp:463] Recover process terminated
> I0218 01:55:15.258038 13947 log.cpp:659] Attempting to start the writer
> I0218 01:55:15.259137 13935 replica.cpp:476] Replica received implicit
> promise request with proposal 1
> I0218 01:55:15.259568 13935 leveldb.cpp:305] Persisting metadata (8 bytes)
> to leveldb took 396694ns
> I0218 01:55:15.259591 13935 replica.cpp:344] Persisted promised to 1
> I0218 01:55:15.262418 13948 process.cpp:2117] Dropped / Lost event for
> PID: slave(221)@67.195.81.187:57268
> I0218 01:55:15.262723 13939 coordinator.cpp:229] Coordinator attemping to
> fill missing position
> I0218 01:55:15.267627 13932 replica.cpp:377] Replica received explicit
> promise request for position 0 with proposal 2
> I0218 01:55:15.267979 13932 leveldb.cpp:342] Persisting action (8 bytes)
> to leveldb took 322740ns
> I0218 01:55:15.267999 13932 replica.cpp:678] Persisted action at 0
> I0218 01:55:15.269002 13933 replica.cpp:510] Replica received write
> request for position 0
> I0218 01:55:15.269050 13933 leveldb.cpp:437] Reading position from leveldb
> took 25471ns
> I0218 01:55:15.269343 13933 leveldb.cpp:342] Persisting action (14 bytes)
> to leveldb took 265493ns
> I0218 01:55:15.269363 13933 replica.cpp:678] Persisted action at 0
> I0218 01:55:15.270083 13935 replica.cpp:657] Replica received learned
> notice for position 0
> I0218 01:55:15.270478 13935 leveldb.cpp:342] Persisting action (16 bytes)
> to leveldb took 371190ns
> I0218 01:55:15.270498 13935 replica.cpp:678] Persisted action at 0
> I0218 01:55:15.270517 13935 replica.cpp:663] Replica learned 1 action at
> position 0
> I0218 01:55:15.270912 13936 log.cpp:675] Writer started with ending
> position 0
> I0218 01:55:15.271814 13942 leveldb.cpp:437] Reading position from leveldb
> took 28195ns
> I0218 01:55:15.274863 13933 registrar.cpp:345] Successfully fetched the
> registry (0B) in 19.652096ms
> I0218 01:55:15.274950 13933 registrar.cpp:444] Applied 1 operations in
> 20986ns; attempting to update the 'registry'
> I0218 01:55:15.277163 13946 log.cpp:683] Attempting to append 139 bytes to
> the log
> I0218 01:55:15.277295 13936 coordinator.cpp:339] Coordinator attempting to
> write 2 action at position 1
> I0218 01:55:15.277963 13936 replica.cpp:510] Replica received write
> request for position 1
> I0218 01:55:15.278688 13936 leveldb.cpp:342] Persisting action (158 bytes)
> to leveldb took 700481ns
> I0218 01:55:15.278712 13936 replica.cpp:678] Persisted action at 1
> I0218 01:55:15.279357 13935 replica.cpp:657] Replica received learned
> notice for position 1
> I0218 01:55:15.279918 13935 leveldb.cpp:342] Persisting action (160 bytes)
> to leveldb took 539008ns
> I0218 01:55:15.279940 13935 replica.cpp:678] Persisted action at 1
> I0218 01:55:15.279959 13935 replica.cpp:663] Replica learned 2 action at
> position 1
> I0218 01:55:15.280833 13944 log.cpp:702] Attempting to truncate the log to
> 1
> I0218 01:55:15.280931 13941 coordinator.cpp:339] Coordinator attempting to
> write 3 action at position 2
> I0218 01:55:15.281132 13933 registrar.cpp:489] Successfully updated the
> 'registry' in 5.803008ms
> I0218 01:55:15.281225 13933 registrar.cpp:375] Successfully recovered
> registrar
> I0218 01:55:15.281772 13935 master.cpp:1212] Recovered 0 slaves from the
> Registry (101B) ; allowing 10mins for slaves to re-register
> I0218 01:55:15.282418 13936 replica.cpp:510] Replica received write
> request for position 2
> I0218 01:55:15.282774 13936 leveldb.cpp:342] Persisting action (16 bytes)
> to leveldb took 331042ns
> I0218 01:55:15.282794 13936 replica.cpp:678] Persisted action at 2
> I0218 01:55:15.283903 13941 replica.cpp:657] Replica received learned
> notice for position 2
> I0218 01:55:15.284450 13941 leveldb.cpp:342] Persisting action (18 bytes)
> to leveldb took 516030ns
> I0218 01:55:15.284518 13941 leveldb.cpp:400] Deleting ~1 keys from leveldb
> took 41767ns
> I0218 01:55:15.284533 13941 replica.cpp:678] Persisted action at 2
> I0218 01:55:15.284548 13941 replica.cpp:663] Replica learned 3 action at
> position 2
> I0218 01:55:15.294095 13918 containerizer.cpp:104] Using isolation:
> posix/cpu,posix/mem
> I0218 01:55:15.300398 13933 slave.cpp:173] Slave started on 222)@
> 67.195.81.187:57268
> I0218 01:55:15.300432 13933 credentials.hpp:84] Loading credential for
> authentication from
> '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_HYR85I/credential'
> I0218 01:55:15.305230 13918 sched.cpp:151] Version: 0.22.0
> I0218 01:55:15.401885 13933 slave.cpp:280] Slave using credential for:
> test-principal
> I0218 01:55:15.402096 13933 slave.cpp:298] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0218 01:55:15.402178 13933 slave.cpp:327] Slave hostname:
> pomona.apache.org
> I0218 01:55:15.402190 13933 slave.cpp:328] Slave checkpoint: false
> W0218 01:55:15.402196 13933 slave.cpp:330] Disabling checkpointing is
> deprecated and the --checkpoint flag will be removed in a future release.
> Please avoid using this flag
> I0218 01:55:15.402732 13938 sched.cpp:248] New master detected at
> master@67.195.81.187:57268
> I0218 01:55:15.402848 13938 sched.cpp:304] Authenticating with master
> master@67.195.81.187:57268
> I0218 01:55:15.402870 13938 sched.cpp:311] Using default CRAM-MD5
> authenticatee
> I0218 01:55:15.403012 13947 state.cpp:34] Recovering state from
> '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_HYR85I/meta'
> I0218 01:55:15.403075 13943 authenticatee.hpp:138] Creating new client
> SASL connection
> I0218 01:55:15.403332 13936 status_update_manager.cpp:196] Recovering
> status update manager
> I0218 01:55:15.403370 13937 master.cpp:3811] Authenticating
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.403400 13937 master.cpp:3822] Using default CRAM-MD5
> authenticator
> I0218 01:55:15.403607 13938 containerizer.cpp:301] Recovering containerizer
> I0218 01:55:15.403657 13947 authenticator.hpp:169] Creating new server
> SASL connection
> I0218 01:55:15.403861 13947 authenticatee.hpp:229] Received SASL
> authentication mechanisms: CRAM-MD5
> I0218 01:55:15.403889 13947 authenticatee.hpp:255] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0218 01:55:15.404000 13936 authenticator.hpp:275] Received SASL
> authentication start
> I0218 01:55:15.404057 13936 authenticator.hpp:397] Authentication requires
> more steps
> I0218 01:55:15.404177 13936 authenticatee.hpp:275] Received SASL
> authentication step
> I0218 01:55:15.404350 13934 authenticator.hpp:303] Received SASL
> authentication step
> I0218 01:55:15.404391 13934 auxprop.cpp:98] Request to lookup properties
> for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: '
> pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0218 01:55:15.404412 13934 auxprop.cpp:170] Looking up auxiliary property
> '*userPassword'
> I0218 01:55:15.404458 13934 auxprop.cpp:170] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0218 01:55:15.404486 13934 auxprop.cpp:98] Request to lookup properties
> for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: '
> pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0218 01:55:15.404505 13934 auxprop.cpp:120] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0218 01:55:15.404521 13934 auxprop.cpp:120] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0218 01:55:15.404548 13934 authenticator.hpp:389] Authentication success
> I0218 01:55:15.404657 13932 authenticatee.hpp:315] Authentication success
> I0218 01:55:15.404680 13937 slave.cpp:3611] Finished recovery
> I0218 01:55:15.404716 13943 master.cpp:3869] Successfully authenticated
> principal 'test-principal' at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.405220 13933 sched.cpp:392] Successfully authenticated with
> master master@67.195.81.187:57268
> I0218 01:55:15.405248 13933 sched.cpp:515] Sending registration request to
> master@67.195.81.187:57268
> I0218 01:55:15.405390 13933 sched.cpp:548] Will retry registration in
> 1.684708433secs if necessary
> I0218 01:55:15.405504 13943 master.cpp:1572] Received registration request
> for framework 'default' at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.405586 13933 slave.cpp:623] New master detected at
> master@67.195.81.187:57268
> I0218 01:55:15.405597 13943 master.cpp:1433] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0218 01:55:15.405594 13946 status_update_manager.cpp:170] Pausing sending
> status updates
> I0218 01:55:15.405670 13933 slave.cpp:686] Authenticating with master
> master@67.195.81.187:57268
> I0218 01:55:15.405690 13933 slave.cpp:691] Using default CRAM-MD5
> authenticatee
> I0218 01:55:15.405838 13933 slave.cpp:659] Detecting new master
> I0218 01:55:15.405859 13939 authenticatee.hpp:138] Creating new client
> SASL connection
> I0218 01:55:15.406088 13944 master.cpp:1636] Registering framework
> 20150218-015515-3142697795-57268-13918-0000 (default) at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.406452 13941 hierarchical.hpp:320] Added framework
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.406489 13941 hierarchical.hpp:831] No resources available
> to allocate!
> I0218 01:55:15.406507 13941 hierarchical.hpp:738] Performed allocation for
> 0 slaves in 28112ns
> I0218 01:55:15.406538 13942 sched.cpp:442] Framework registered with
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.406582 13942 sched.cpp:456] Scheduler::registered took
> 19531ns
> I0218 01:55:15.406606 13944 master.cpp:3811] Authenticating slave(222)@
> 67.195.81.187:57268
> I0218 01:55:15.406628 13944 master.cpp:3822] Using default CRAM-MD5
> authenticator
> I0218 01:55:15.406833 13943 authenticator.hpp:169] Creating new server
> SASL connection
> I0218 01:55:15.407002 13943 authenticatee.hpp:229] Received SASL
> authentication mechanisms: CRAM-MD5
> I0218 01:55:15.407033 13943 authenticatee.hpp:255] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0218 01:55:15.407112 13948 process.cpp:2117] Dropped / Lost event for
> PID: hierarchical-allocator(244)@67.195.81.187:57268
> I0218 01:55:15.407146 13946 authenticator.hpp:275] Received SASL
> authentication start
> I0218 01:55:15.407197 13946 authenticator.hpp:397] Authentication requires
> more steps
> I0218 01:55:15.407312 13937 authenticatee.hpp:275] Received SASL
> authentication step
> I0218 01:55:15.407471 13945 authenticator.hpp:303] Received SASL
> authentication step
> I0218 01:55:15.407500 13945 auxprop.cpp:98] Request to lookup properties
> for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: '
> pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0218 01:55:15.407510 13945 auxprop.cpp:170] Looking up auxiliary property
> '*userPassword'
> I0218 01:55:15.407539 13945 auxprop.cpp:170] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0218 01:55:15.407562 13945 auxprop.cpp:98] Request to lookup properties
> for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: '
> pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0218 01:55:15.407572 13945 auxprop.cpp:120] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0218 01:55:15.407580 13945 auxprop.cpp:120] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0218 01:55:15.407595 13945 authenticator.hpp:389] Authentication success
> I0218 01:55:15.407697 13946 authenticatee.hpp:315] Authentication success
> I0218 01:55:15.407702 13937 master.cpp:3869] Successfully authenticated
> principal 'test-principal' at slave(222)@67.195.81.187:57268
> I0218 01:55:15.408095 13943 slave.cpp:757] Successfully authenticated with
> master master@67.195.81.187:57268
> I0218 01:55:15.408252 13943 slave.cpp:1089] Will retry registration in
> 5.107666ms if necessary
> I0218 01:55:15.408439 13938 master.cpp:2936] Registering slave at
> slave(222)@67.195.81.187:57268 (pomona.apache.org) with id
> 20150218-015515-3142697795-57268-13918-S0
> I0218 01:55:15.408859 13946 registrar.cpp:444] Applied 1 operations in
> 63151ns; attempting to update the 'registry'
> I0218 01:55:15.411748 13937 log.cpp:683] Attempting to append 316 bytes to
> the log
> I0218 01:55:15.411895 13942 coordinator.cpp:339] Coordinator attempting to
> write 2 action at position 3
> I0218 01:55:15.414677 13944 slave.cpp:1089] Will retry registration in
> 3.876088ms if necessary
> I0218 01:55:15.414839 13936 master.cpp:2924] Ignoring register slave
> message from slave(222)@67.195.81.187:57268 (pomona.apache.org) as
> admission is already in progress
> I0218 01:55:15.429661 13948 process.cpp:2117] Dropped / Lost event for
> PID: hierarchical-allocator(245)@67.195.81.187:57268
> I0218 01:55:15.559209 13948 process.cpp:2117] Dropped / Lost event for
> PID: hierarchical-allocator(246)@67.195.81.187:57268
> I0218 01:55:15.560606 13937 replica.cpp:510] Replica received write
> request for position 3
> I0218 01:55:15.560876 13937 leveldb.cpp:342] Persisting action (335 bytes)
> to leveldb took 224285ns
> I0218 01:55:15.560899 13937 replica.cpp:678] Persisted action at 3
> I0218 01:55:15.562650 13936 replica.cpp:657] Replica received learned
> notice for position 3
> I0218 01:55:15.563143 13936 leveldb.cpp:342] Persisting action (337 bytes)
> to leveldb took 458021ns
> I0218 01:55:15.563145 13937 slave.cpp:1089] Will retry registration in
> 27.373943ms if necessary
> I0218 01:55:15.563185 13936 replica.cpp:678] Persisted action at 3
> I0218 01:55:15.563222 13936 replica.cpp:663] Replica learned 2 action at
> position 3
> I0218 01:55:15.563364 13932 master.cpp:2924] Ignoring register slave
> message from slave(222)@67.195.81.187:57268 (pomona.apache.org) as
> admission is already in progress
> I0218 01:55:15.564877 13935 log.cpp:702] Attempting to truncate the log to
> 3
> I0218 01:55:15.564936 13939 registrar.cpp:489] Successfully updated the
> 'registry' in 155.678976ms
> I0218 01:55:15.565021 13943 coordinator.cpp:339] Coordinator attempting to
> write 3 action at position 4
> I0218 01:55:15.565786 13935 replica.cpp:510] Replica received write
> request for position 4
> I0218 01:55:15.565812 13939 slave.cpp:2666] Received ping from
> slave-observer(199)@67.195.81.187:57268
> I0218 01:55:15.565982 13940 master.cpp:2993] Registered slave
> 20150218-015515-3142697795-57268-13918-S0 at slave(222)@
> 67.195.81.187:57268 (pomona.apache.org) with cpus(*):2; mem(*):1024;
> disk(*):1024; ports(*):[31000-32000]
> I0218 01:55:15.566082 13939 slave.cpp:791] Registered with master
> master@67.195.81.187:57268; given slave ID
> 20150218-015515-3142697795-57268-13918-S0
> I0218 01:55:15.566118 13947 hierarchical.hpp:452] Added slave
> 20150218-015515-3142697795-57268-13918-S0 (pomona.apache.org) with
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
> I0218 01:55:15.566160 13935 leveldb.cpp:342] Persisting action (16 bytes)
> to leveldb took 338964ns
> I0218 01:55:15.566195 13935 replica.cpp:678] Persisted action at 4
> I0218 01:55:15.566195 13937 status_update_manager.cpp:177] Resuming
> sending status updates
> I0218 01:55:15.566603 13947 hierarchical.hpp:756] Performed allocation for
> slave 20150218-015515-3142697795-57268-13918-S0 in 421519ns
> I0218 01:55:15.566828 13943 replica.cpp:657] Replica received learned
> notice for position 4
> I0218 01:55:15.566946 13937 master.cpp:3753] Sending 1 offers to framework
> 20150218-015515-3142697795-57268-13918-0000 (default) at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.567214 13943 leveldb.cpp:342] Persisting action (18 bytes)
> to leveldb took 361791ns
> I0218 01:55:15.567261 13943 leveldb.cpp:400] Deleting ~2 keys from leveldb
> took 29859ns
> I0218 01:55:15.567275 13943 replica.cpp:678] Persisted action at 4
> I0218 01:55:15.567302 13943 replica.cpp:663] Replica learned 3 action at
> position 4
> I0218 01:55:15.567345 13934 sched.cpp:605] Scheduler::resourceOffers took
> 106099ns
> I0218 01:55:15.567883 13918 sched.cpp:1504] Asked to abort the driver
> I0218 01:55:15.568099 13935 sched.cpp:833] Aborting framework
> '20150218-015515-3142697795-57268-13918-0000'
> I0218 01:55:15.568346 13936 master.cpp:1957] Deactivating framework
> 20150218-015515-3142697795-57268-13918-0000 (default) at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.568480 13935 sched.cpp:611] Ignoring rescind offer message
> because the driver is not running!
> I0218 01:55:15.568527 13937 hierarchical.hpp:399] Deactivated framework
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.568737 13937 hierarchical.hpp:645] Recovered cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable:
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave
> 20150218-015515-3142697795-57268-13918-S0 from framework
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.568860 13934 sched.cpp:611] Ignoring rescind offer message
> because the driver is not running!
> I0218 01:55:15.568974 13918 sched.cpp:1470] Asked to stop the driver
> I0218 01:55:15.569103 13937 sched.cpp:808] Stopping framework
> '20150218-015515-3142697795-57268-13918-0000'
> I0218 01:55:15.569435 13942 master.cpp:1896] Asked to unregister framework
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.569473 13942 master.cpp:4181] Removing framework
> 20150218-015515-3142697795-57268-13918-0000 (default) at
> scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> I0218 01:55:15.569919 13932 slave.cpp:1594] Asked to shut down framework
> 20150218-015515-3142697795-57268-13918-0000 by master@67.195.81.187:57268
> W0218 01:55:15.569950 13932 slave.cpp:1609] Cannot shut down unknown
> framework 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.571519 13942 master.cpp:785] Master terminating
> I0218 01:55:15.571637 13946 hierarchical.hpp:353] Removed framework
> 20150218-015515-3142697795-57268-13918-0000
> I0218 01:55:15.572909 13942 slave.cpp:2751] master@67.195.81.187:57268
> exited
> W0218 01:55:15.572942 13942 slave.cpp:2754] Master disconnected! Waiting
> for a new master to be elected
> I0218 01:55:15.574981 13918 process.cpp:2117] Dropped / Lost event for
> PID: master@67.195.81.187:57268
> I0218 01:55:15.575103 13918 process.cpp:2117] Dropped / Lost event for
> PID: master@67.195.81.187:57268
> I0218 01:55:15.580725 13933 slave.cpp:505] Slave terminating
> I0218 01:55:15.583437 13918 process.cpp:2117] Dropped / Lost event for
> PID: slave(222)@67.195.81.187:57268
> I0218 01:55:15.584887 13918 process.cpp:2117] Dropped / Lost event for
> PID: scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268
> [       OK ] ExceptionTest.DisallowSchedulerCallbacksOnAbort (342 ms)
> [----------] 3 tests from ExceptionTest (1134 ms total)
>
> [----------] Global test environment tear-down
> I0218 01:55:15.590626 13948 process.cpp:2117] Dropped / Lost event for
> PID: slave(222)@67.195.81.187:57268
> [==========] 487 tests from 77 test cases ran. (249081 ms total)
> [  PASSED  ] 486 tests.
> [  FAILED  ] 1 test, listed below:
> [  FAILED  ] MasterSlaveReconciliationTest.ReconcileLostTask
>
>  1 FAILED TEST
>   YOU HAVE 7 DISABLED TESTS
>
> make[3]: *** [check-local] Error 1
> make[3]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src
> '>
> make[2]: *** [check-am] Error 2
> make[2]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src
> '>
> make[1]: *** [check] Error 2
> make[1]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src
> '>
> make: *** [check-recursive] Error 1
> Test finished
> Exit status: 2
> Build step 'Execute shell' marked build as failure
> Recording test results
>

Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message