You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/05/15 22:03:44 UTC

Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2120

See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2120/changes>

Changes:

[vinod] Revert "Allowed Gauge to take synchronous functions."

[vinod] Added test for killing unknown task with Slaves in transitional state.

[niklas] Updated CHANGELOG for 0.18.2-rc1.

[benjamin.hindman] Introduced '--' to flags parsing.

[benjamin.hindman] Added override of Flags::load that updates 'argc' and 'argv'.

[bmahler] Added task gauges to slave metrics.

[niklas] Added support for passing flags in override command.

[vinod] mesos-style.py accepts files to lint as args.

[niklas] Temporarily disabled RunTaskWithCommandInfoWithUser due to MESOS-1359.

[niklas] Fixed concurrent wait within the ExternalContainerizer.

[bmahler] Ported some of the master stats to the new metrics library.

[yan] Added message counters for all message types in Master.

[bmahler] Updated Slave.MetricsInStatsEndpoint test to match latest metrics.

[yujie.jay] Fixed a compiler warning from stout flags.

[bmahler] Added task gauges to Master.

[bmahler] Changed 'registry' flag default to 'replicated_log'.

[yan] Fixed comment typos in a previous commit for message counters.

[bmahler] Added resource Gauges to Master.

[vinod] Fixed credentials::read() to properly stat the credentials file.

[yujie.jay] Added API for managing links.

[yujie.jay] Allowed to get/set MTU for a link.

[yujie.jay] Added runtime check to the Linux routing library.

[yujie.jay] Added internal filter and queueing APIs.

[yujie.jay] Added API for managing ICMP packet filters.

[yujie.jay] Added API for managing ARP packet filters.

[yujie.jay] Added API for managing IP packet filters.

[yujie.jay] Added API for getting the default gateway.

[yujie.jay] Allowed waiting for a link to be removed.

------------------------------------------
[...truncated 21000 lines...]
I0515 19:11:40.528422  1642 leveldb.cpp:198] Created db iterator in 4439ns
I0515 19:11:40.528435  1642 leveldb.cpp:204] Seeked to beginning of db in 896ns
I0515 19:11:40.528441  1642 leveldb.cpp:273] Iterated through 0 keys in the db in 325ns
I0515 19:11:40.528455  1642 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0515 19:11:40.528712  1667 recover.cpp:425] Starting replica recovery
I0515 19:11:40.528849  1667 recover.cpp:451] Replica is in EMPTY status
I0515 19:11:40.529289  1667 replica.cpp:638] Replica in EMPTY status received a broadcasted recover request
I0515 19:11:40.529450  1665 recover.cpp:188] Received a recover response from a replica in EMPTY status
I0515 19:11:40.529639  1661 recover.cpp:542] Updating replica status to STARTING
I0515 19:11:40.529810  1662 master.cpp:269] Master 20140515-191140-160088899-45547-1642 (vesta.apache.org) started on 67.195.138.9:45547
I0515 19:11:40.529831  1662 master.cpp:306] Master only allowing authenticated frameworks to register
I0515 19:11:40.529842  1662 master.cpp:311] Master only allowing authenticated slaves to register
I0515 19:11:40.529849  1662 credentials.hpp:35] Loading credentials for authentication from '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_icVq5E/credentials'
I0515 19:11:40.530112  1664 master.cpp:106] No whitelist given. Advertising offers for all slaves
I0515 19:11:40.530182  1668 hierarchical_allocator_process.hpp:301] Initializing hierarchical allocator process with master : master@67.195.138.9:45547
I0515 19:11:40.530514  1667 master.cpp:923] The newly elected leader is master@67.195.138.9:45547 with id 20140515-191140-160088899-45547-1642
I0515 19:11:40.530525  1667 master.cpp:933] Elected as the leading master!
I0515 19:11:40.530532  1667 master.cpp:754] Recovering from registrar
I0515 19:11:40.530602  1664 registrar.cpp:313] Recovering registrar
I0515 19:11:40.568043  1665 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 38.350201ms
I0515 19:11:40.568068  1665 replica.cpp:320] Persisted replica status to STARTING
I0515 19:11:40.568147  1665 recover.cpp:451] Replica is in STARTING status
I0515 19:11:40.568500  1664 replica.cpp:638] Replica in STARTING status received a broadcasted recover request
I0515 19:11:40.568614  1663 recover.cpp:188] Received a recover response from a replica in STARTING status
I0515 19:11:40.568790  1661 recover.cpp:542] Updating replica status to VOTING
I0515 19:11:40.571449  1663 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 2.576402ms
I0515 19:11:40.571470  1663 replica.cpp:320] Persisted replica status to VOTING
I0515 19:11:40.571555  1666 recover.cpp:556] Successfully joined the Paxos group
I0515 19:11:40.571673  1666 recover.cpp:440] Recover process terminated
I0515 19:11:40.571816  1666 log.cpp:656] Attempting to start the writer
I0515 19:11:40.572340  1668 replica.cpp:474] Replica received implicit promise request with proposal 1
I0515 19:11:40.579468  1668 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 7.111361ms
I0515 19:11:40.579485  1668 replica.cpp:342] Persisted promised to 1
I0515 19:11:40.579781  1667 coordinator.cpp:230] Coordinator attemping to fill missing position
I0515 19:11:40.580343  1665 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0515 19:11:40.599325  1665 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 18.931841ms
I0515 19:11:40.599344  1665 replica.cpp:676] Persisted action at 0
I0515 19:11:40.599776  1662 replica.cpp:508] Replica received write request for position 0
I0515 19:11:40.599802  1662 leveldb.cpp:438] Reading position from leveldb took 12540ns
I0515 19:11:40.607293  1662 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 7.477437ms
I0515 19:11:40.607312  1662 replica.cpp:676] Persisted action at 0
I0515 19:11:40.607472  1662 replica.cpp:655] Replica received learned notice for position 0
I0515 19:11:40.615274  1662 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.72362ms
I0515 19:11:40.615291  1662 replica.cpp:676] Persisted action at 0
I0515 19:11:40.615301  1662 replica.cpp:661] Replica learned NOP action at position 0
I0515 19:11:40.615531  1663 log.cpp:672] Writer started with ending position 0
I0515 19:11:40.615932  1664 leveldb.cpp:438] Reading position from leveldb took 15277ns
I0515 19:11:40.617210  1667 registrar.cpp:346] Successfully fetched the registry (0B)
I0515 19:11:40.617238  1667 registrar.cpp:422] Attempting to update the 'registry'
I0515 19:11:40.618459  1663 log.cpp:680] Attempting to append 133 bytes to the log
I0515 19:11:40.618517  1663 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0515 19:11:40.618831  1666 replica.cpp:508] Replica received write request for position 1
I0515 19:11:40.635179  1666 leveldb.cpp:343] Persisting action (152 bytes) to leveldb took 16.332541ms
I0515 19:11:40.635198  1666 replica.cpp:676] Persisted action at 1
I0515 19:11:40.635409  1666 replica.cpp:655] Replica received learned notice for position 1
I0515 19:11:40.643151  1666 leveldb.cpp:343] Persisting action (154 bytes) to leveldb took 7.673383ms
I0515 19:11:40.643167  1666 replica.cpp:676] Persisted action at 1
I0515 19:11:40.643177  1666 replica.cpp:661] Replica learned APPEND action at position 1
I0515 19:11:40.643466  1662 registrar.cpp:479] Successfully updated 'registry'
I0515 19:11:40.643571  1663 log.cpp:699] Attempting to truncate the log to 1
I0515 19:11:40.643591  1662 registrar.cpp:372] Successfully recovered registrar
I0515 19:11:40.643653  1667 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0515 19:11:40.643707  1661 master.cpp:781] Recovered 0 slaves from the Registry (96B) ; allowing 10mins for slaves to re-register
I0515 19:11:40.643944  1664 replica.cpp:508] Replica received write request for position 2
I0515 19:11:40.644243  1642 mesos_containerizer.cpp:122] Using isolation: posix/cpu,posix/mem
I0515 19:11:40.646425  1662 slave.cpp:143] Slave started on 64)@67.195.138.9:45547
I0515 19:11:40.646440  1662 credentials.hpp:35] Loading credentials for authentication from '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/credential'
I0515 19:11:40.646498  1662 slave.cpp:236] Slave using credential for: test-principal
I0515 19:11:40.646615  1662 slave.cpp:249] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0515 19:11:40.646666  1662 slave.cpp:277] Slave hostname: vesta.apache.org
I0515 19:11:40.646677  1662 slave.cpp:278] Slave checkpoint: true
I0515 19:11:40.647181  1665 state.cpp:33] Recovering state from '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta'
I0515 19:11:40.647325  1665 status_update_manager.cpp:193] Recovering status update manager
I0515 19:11:40.647434  1665 mesos_containerizer.cpp:279] Recovering containerizer
I0515 19:11:40.647702  1665 slave.cpp:2965] Finished recovery
I0515 19:11:40.647940  1665 slave.cpp:530] New master detected at master@67.195.138.9:45547
I0515 19:11:40.648005  1665 slave.cpp:590] Authenticating with master master@67.195.138.9:45547
I0515 19:11:40.648095  1665 slave.cpp:563] Detecting new master
I0515 19:11:40.648175  1665 status_update_manager.cpp:167] New master detected at master@67.195.138.9:45547
I0515 19:11:40.648206  1642 sched.cpp:121] Version: 0.19.0
I0515 19:11:40.648262  1665 authenticatee.hpp:128] Creating new client SASL connection
I0515 19:11:40.648483  1667 master.cpp:2841] Authenticating slave(64)@67.195.138.9:45547
I0515 19:11:40.648555  1663 authenticator.hpp:148] Creating new server SASL connection
I0515 19:11:40.648569  1662 sched.cpp:217] New master detected at master@67.195.138.9:45547
I0515 19:11:40.648586  1662 sched.cpp:268] Authenticating with master master@67.195.138.9:45547
I0515 19:11:40.648627  1667 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0515 19:11:40.648635  1665 authenticatee.hpp:128] Creating new client SASL connection
I0515 19:11:40.648648  1667 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0515 19:11:40.648731  1668 master.cpp:2841] Authenticating scheduler(57)@67.195.138.9:45547
I0515 19:11:40.648763  1665 authenticator.hpp:254] Received SASL authentication start
I0515 19:11:40.648797  1667 authenticator.hpp:148] Creating new server SASL connection
I0515 19:11:40.648800  1665 authenticator.hpp:342] Authentication requires more steps
I0515 19:11:40.648847  1665 authenticatee.hpp:265] Received SASL authentication step
I0515 19:11:40.648866  1667 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0515 19:11:40.648885  1667 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0515 19:11:40.648891  1665 authenticator.hpp:282] Received SASL authentication step
I0515 19:11:40.648908  1665 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0515 19:11:40.648921  1665 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0515 19:11:40.648910  1667 authenticator.hpp:254] Received SASL authentication start
I0515 19:11:40.648937  1665 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0515 19:11:40.648949  1665 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0515 19:11:40.648957  1665 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0515 19:11:40.648962  1665 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0515 19:11:40.648972  1667 authenticator.hpp:342] Authentication requires more steps
I0515 19:11:40.648974  1665 authenticator.hpp:334] Authentication success
I0515 19:11:40.649011  1667 authenticatee.hpp:265] Received SASL authentication step
I0515 19:11:40.649027  1662 authenticatee.hpp:305] Authentication success
I0515 19:11:40.649044  1665 master.cpp:2881] Successfully authenticated slave(64)@67.195.138.9:45547
I0515 19:11:40.649066  1667 authenticator.hpp:282] Received SASL authentication step
I0515 19:11:40.649087  1667 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0515 19:11:40.649096  1667 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0515 19:11:40.649106  1667 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0515 19:11:40.649112  1662 slave.cpp:647] Successfully authenticated with master master@67.195.138.9:45547
I0515 19:11:40.649116  1667 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0515 19:11:40.649134  1667 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0515 19:11:40.649139  1667 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0515 19:11:40.649147  1662 slave.cpp:876] Will retry registration in 9.546662983secs if necessary
I0515 19:11:40.649152  1667 authenticator.hpp:334] Authentication success
I0515 19:11:40.649201  1667 authenticatee.hpp:305] Authentication success
I0515 19:11:40.649340  1667 sched.cpp:342] Successfully authenticated with master master@67.195.138.9:45547
I0515 19:11:40.649348  1665 master.cpp:2157] Registering slave at slave(64)@67.195.138.9:45547 (vesta.apache.org) with id 20140515-191140-160088899-45547-1642-0
I0515 19:11:40.649353  1667 sched.cpp:461] Sending registration request to master@67.195.138.9:45547
I0515 19:11:40.649466  1665 master.cpp:2881] Successfully authenticated scheduler(57)@67.195.138.9:45547
I0515 19:11:40.649493  1663 registrar.cpp:422] Attempting to update the 'registry'
I0515 19:11:40.649544  1665 master.cpp:982] Received registration request from scheduler(57)@67.195.138.9:45547
I0515 19:11:40.649588  1665 master.cpp:1000] Registering framework 20140515-191140-160088899-45547-1642-0000 at scheduler(57)@67.195.138.9:45547
I0515 19:11:40.649660  1662 sched.cpp:392] Framework registered with 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.649719  1662 sched.cpp:406] Scheduler::registered took 10138ns
I0515 19:11:40.649690  1668 hierarchical_allocator_process.hpp:331] Added framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.649761  1668 hierarchical_allocator_process.hpp:725] No resources available to allocate!
I0515 19:11:40.649770  1668 hierarchical_allocator_process.hpp:687] Performed allocation for 0 slaves in 8803ns
I0515 19:11:40.651123  1664 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.163446ms
I0515 19:11:40.651139  1664 replica.cpp:676] Persisted action at 2
I0515 19:11:40.651329  1664 replica.cpp:655] Replica received learned notice for position 2
I0515 19:11:40.659086  1664 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 7.744393ms
I0515 19:11:40.659114  1664 leveldb.cpp:401] Deleting ~1 keys from leveldb took 11927ns
I0515 19:11:40.659124  1664 replica.cpp:676] Persisted action at 2
I0515 19:11:40.659132  1664 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0515 19:11:40.659458  1662 log.cpp:680] Attempting to append 325 bytes to the log
I0515 19:11:40.659518  1666 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
I0515 19:11:40.659904  1663 replica.cpp:508] Replica received write request for position 3
I0515 19:11:40.667059  1663 leveldb.cpp:343] Persisting action (344 bytes) to leveldb took 7.14175ms
I0515 19:11:40.667078  1663 replica.cpp:676] Persisted action at 3
I0515 19:11:40.667300  1664 replica.cpp:655] Replica received learned notice for position 3
I0515 19:11:40.675027  1664 leveldb.cpp:343] Persisting action (346 bytes) to leveldb took 7.711991ms
I0515 19:11:40.675045  1664 replica.cpp:676] Persisted action at 3
I0515 19:11:40.675055  1664 replica.cpp:661] Replica learned APPEND action at position 3
I0515 19:11:40.675444  1667 registrar.cpp:479] Successfully updated 'registry'
I0515 19:11:40.675531  1662 log.cpp:699] Attempting to truncate the log to 3
I0515 19:11:40.675576  1662 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
I0515 19:11:40.675618  1665 master.cpp:2197] Registered slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org)
I0515 19:11:40.675701  1665 master.cpp:3326] Adding slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0515 19:11:40.675823  1664 slave.cpp:680] Registered with master master@67.195.138.9:45547; given slave ID 20140515-191140-160088899-45547-1642-0
I0515 19:11:40.675935  1667 hierarchical_allocator_process.hpp:444] Added slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
I0515 19:11:40.676077  1667 hierarchical_allocator_process.hpp:751] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 to framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.676120  1664 slave.cpp:693] Checkpointing SlaveInfo to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/slave.info'
I0515 19:11:40.676266  1667 hierarchical_allocator_process.hpp:707] Performed allocation for slave 20140515-191140-160088899-45547-1642-0 in 215235ns
I0515 19:11:40.675957  1662 replica.cpp:508] Replica received write request for position 4
I0515 19:11:40.676331  1663 master.hpp:663] Adding offer 20140515-191140-160088899-45547-1642-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org)
I0515 19:11:40.676409  1663 master.cpp:2788] Sending 1 offers to framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.676535  1663 sched.cpp:529] Scheduler::resourceOffers took 25156ns
I0515 19:11:40.677845  1661 master.hpp:673] Removing offer 20140515-191140-160088899-45547-1642-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org)
I0515 19:11:40.677906  1661 master.cpp:1822] Processing reply for offers: [ 20140515-191140-160088899-45547-1642-0 ] on slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org) for framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.678022  1661 master.hpp:635] Adding task 3659da35-6351-4e38-84c5-f76bb3eca499 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org)
I0515 19:11:40.678073  1661 master.cpp:2965] Launching task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org)
I0515 19:11:40.678212  1661 slave.cpp:910] Got assigned task 3659da35-6351-4e38-84c5-f76bb3eca499 for framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.678288  1661 slave.cpp:3237] Checkpointing FrameworkInfo to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/framework.info'
I0515 19:11:40.678392  1661 slave.cpp:3244] Checkpointing framework pid 'scheduler(57)@67.195.138.9:45547' to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/framework.pid'
I0515 19:11:40.678594  1661 slave.cpp:1020] Launching task 3659da35-6351-4e38-84c5-f76bb3eca499 for framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.679785  1661 slave.cpp:3559] Checkpointing ExecutorInfo to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/executors/3659da35-6351-4e38-84c5-f76bb3eca499/executor.info'
I0515 19:11:40.680172  1667 mesos_containerizer.cpp:523] Starting container '09947a0f-892b-4a60-8dc3-63424a50f207' for executor '3659da35-6351-4e38-84c5-f76bb3eca499' of framework '20140515-191140-160088899-45547-1642-0000'
I0515 19:11:40.680187  1661 slave.cpp:3674] Checkpointing TaskInfo to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/executors/3659da35-6351-4e38-84c5-f76bb3eca499/runs/09947a0f-892b-4a60-8dc3-63424a50f207/tasks/3659da35-6351-4e38-84c5-f76bb3eca499/task.info'
I0515 19:11:40.680425  1661 slave.cpp:1130] Queuing task '3659da35-6351-4e38-84c5-f76bb3eca499' for executor 3659da35-6351-4e38-84c5-f76bb3eca499 of framework '20140515-191140-160088899-45547-1642-0000
I0515 19:11:40.680515  1661 slave.cpp:491] Successfully attached file '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/executors/3659da35-6351-4e38-84c5-f76bb3eca499/runs/09947a0f-892b-4a60-8dc3-63424a50f207'
I0515 19:11:40.683475  1667 launcher.cpp:117] Forked child with pid '2154' for container '09947a0f-892b-4a60-8dc3-63424a50f207'
I0515 19:11:40.683593  1667 mesos_containerizer.cpp:746] Checkpointing executor's forked pid 2154 to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/executors/3659da35-6351-4e38-84c5-f76bb3eca499/runs/09947a0f-892b-4a60-8dc3-63424a50f207/pids/forked.pid'
I0515 19:11:40.684821  1665 mesos_containerizer.cpp:623] Fetching URIs for container '09947a0f-892b-4a60-8dc3-63424a50f207' using command '/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src/mesos-fetcher'
I0515 19:11:40.703064  1662 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 26.641507ms
I0515 19:11:40.703152  1662 replica.cpp:676] Persisted action at 4
I0515 19:11:40.704370  1667 replica.cpp:655] Replica received learned notice for position 4
I0515 19:11:40.722848  1667 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 18.367871ms
I0515 19:11:40.722893  1667 leveldb.cpp:401] Deleting ~2 keys from leveldb took 19731ns
I0515 19:11:40.722903  1667 replica.cpp:676] Persisted action at 4
I0515 19:11:40.722913  1667 replica.cpp:661] Replica learned TRUNCATE action at position 4
I0515 19:11:41.235136  1668 slave.cpp:2302] Monitoring executor '3659da35-6351-4e38-84c5-f76bb3eca499' of framework '20140515-191140-160088899-45547-1642-0000' in container '09947a0f-892b-4a60-8dc3-63424a50f207'
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0515 19:11:41.275168  2176 process.cpp:1671] libprocess is initialized on 67.195.138.9:55464 for 8 cpus
I0515 19:11:41.276181  2176 exec.cpp:131] Version: 0.19.0
I0515 19:11:41.277737  2193 exec.cpp:181] Executor started at: executor(1)@67.195.138.9:55464 with pid 2176
I0515 19:11:41.278373  1665 slave.cpp:1610] Got registration for executor '3659da35-6351-4e38-84c5-f76bb3eca499' of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.278439  1665 slave.cpp:1695] Checkpointing executor pid 'executor(1)@67.195.138.9:55464' to '/tmp/SlaveRecoveryTest_0_RecoverCompletedExecutor_8A1wz1/meta/slaves/20140515-191140-160088899-45547-1642-0/frameworks/20140515-191140-160088899-45547-1642-0000/executors/3659da35-6351-4e38-84c5-f76bb3eca499/runs/09947a0f-892b-4a60-8dc3-63424a50f207/pids/libprocess.pid'
I0515 19:11:41.278866  1665 slave.cpp:1729] Flushing queued task 3659da35-6351-4e38-84c5-f76bb3eca499 for executor '3659da35-6351-4e38-84c5-f76bb3eca499' of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.279049  1669 process.cpp:1098] Socket closed while receiving
I0515 19:11:41.279211  2191 exec.cpp:205] Executor registered on slave 20140515-191140-160088899-45547-1642-0
I0515 19:11:41.279233  2198 process.cpp:1037] Socket closed while receiving
I0515 19:11:41.280128  2191 exec.cpp:217] Executor::registered took 106701ns
Registered executor on vesta.apache.org
I0515 19:11:41.280304  2191 exec.cpp:292] Executor asked to run task '3659da35-6351-4e38-84c5-f76bb3eca499'
I0515 19:11:41.280357  2191 exec.cpp:301] Executor::launchTask took 40460ns
Starting task 3659da35-6351-4e38-84c5-f76bb3eca499
Forked command at 2199
sh -c 'exit 0'
I0515 19:11:41.281980  2190 exec.cpp:524] Executor sending status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.282326  1664 slave.cpp:1965] Handling status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 from executor(1)@67.195.138.9:55464
I0515 19:11:41.282485  1666 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.282506  1666 status_update_manager.cpp:499] Creating StatusUpdate stream for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.282747  1666 status_update_manager.hpp:342] Checkpointing UPDATE for status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.444167  1666 status_update_manager.cpp:373] Forwarding status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 to master@67.195.138.9:45547
I0515 19:11:41.444340  1664 master.cpp:2483] Status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 from slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org)
I0515 19:11:41.444373  1668 slave.cpp:2086] Status update manager successfully handled status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.444396  1668 slave.cpp:2092] Sending acknowledgement for status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 to executor(1)@67.195.138.9:55464
I0515 19:11:41.444455  1665 sched.cpp:620] Scheduler::statusUpdate took 17935ns
I0515 19:11:41.444571  1669 process.cpp:1098] Socket closed while receiving
I0515 19:11:41.444602  1668 status_update_manager.cpp:398] Received status update acknowledgement (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.444627  1668 status_update_manager.hpp:342] Checkpointing ACK for status update TASK_RUNNING (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.444689  2192 exec.cpp:338] Executor received status update acknowledgement c6c33075-e5ce-4e53-bd44-cb1164ff54e7 for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.444720  2198 process.cpp:1037] Socket closed while receiving
I0515 19:11:41.520257  1668 slave.cpp:1550] Status update manager successfully handled status update acknowledgement (UUID: c6c33075-e5ce-4e53-bd44-cb1164ff54e7) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:41.530926  1662 hierarchical_allocator_process.hpp:687] Performed allocation for 1 slaves in 43326ns
Command exited with status 0 (pid: 2199)
I0515 19:11:42.282755  2190 exec.cpp:524] Executor sending status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.283025  1665 slave.cpp:1965] Handling status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 from executor(1)@67.195.138.9:55464
I0515 19:11:42.283097  1665 slave.cpp:3607] Terminating task 3659da35-6351-4e38-84c5-f76bb3eca499
I0515 19:11:42.283318  1663 status_update_manager.cpp:320] Received status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.283339  1663 status_update_manager.hpp:342] Checkpointing UPDATE for status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.384146  1663 status_update_manager.cpp:373] Forwarding status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 to master@67.195.138.9:45547
I0515 19:11:42.384321  1668 master.cpp:2483] Status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 from slave 20140515-191140-160088899-45547-1642-0 at slave(64)@67.195.138.9:45547 (vesta.apache.org)
I0515 19:11:42.384366  1666 slave.cpp:2086] Status update manager successfully handled status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.384414  1666 slave.cpp:2092] Sending acknowledgement for status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000 to executor(1)@67.195.138.9:55464
I0515 19:11:42.384397  1668 master.hpp:653] Removing task 3659da35-6351-4e38-84c5-f76bb3eca499 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org)
I0515 19:11:42.384479  1662 sched.cpp:620] Scheduler::statusUpdate took 11773ns
I0515 19:11:42.384629  1664 hierarchical_allocator_process.hpp:636] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave 20140515-191140-160088899-45547-1642-0 from framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.384712  1669 process.cpp:1098] Socket closed while receiving
I0515 19:11:42.384831  1662 status_update_manager.cpp:398] Received status update acknowledgement (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.384877  1662 status_update_manager.hpp:342] Checkpointing ACK for status update TASK_FINISHED (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.384912  2194 exec.cpp:338] Executor received status update acknowledgement 760234eb-547c-49ad-a0c9-57984e5fcb67 for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.385021  2198 process.cpp:1037] Socket closed while receiving
I0515 19:11:42.454076  1662 status_update_manager.cpp:530] Cleaning up status update stream for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.454205  1662 slave.cpp:1550] Status update manager successfully handled status update acknowledgement (UUID: 760234eb-547c-49ad-a0c9-57984e5fcb67) for task 3659da35-6351-4e38-84c5-f76bb3eca499 of framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.454234  1662 slave.cpp:3649] Completing task 3659da35-6351-4e38-84c5-f76bb3eca499
I0515 19:11:42.532122  1667 hierarchical_allocator_process.hpp:751] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 to framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.532286  1667 hierarchical_allocator_process.hpp:687] Performed allocation for 1 slaves in 256525ns
I0515 19:11:42.532357  1663 master.hpp:663] Adding offer 20140515-191140-160088899-45547-1642-1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140515-191140-160088899-45547-1642-0 (vesta.apache.org)
I0515 19:11:42.532412  1663 master.cpp:2788] Sending 1 offers to framework 20140515-191140-160088899-45547-1642-0000
I0515 19:11:42.532569  1661 sched.cpp:529] Scheduler::resourceOffers took 19163ns
I0515 19:11:43.283460  1669 process.cpp:1037] Socket closed while receiving
I0515 19:11:43.532954  1664 hierarchical_allocator_process.hpp:687] Performed allocation for 1 slaves in 30283ns
Build timed out (after 120 minutes). Marking the build as failed.
Build was aborted

Jenkins build is back to normal : Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2123

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2123/changes>


Re: Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2122

Posted by Ian Downes <id...@twitter.com>.
Apologies - just committed a corrected stout/Makefile.

Ian
On May 20, 2014, at 7:58 PM, Vinod Kone <vi...@twitter.com> wrote:

> ian, looks like execenv was not added to the distribution/Makefile?
> 
> 
> @vinodkone
> 
> 
> On Tue, May 20, 2014 at 6:58 PM, Apache Jenkins Server <je...@builds.apache.org> wrote:
> See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2122/changes>
> 
> Changes:
> 
> [vinod] Minor fix to pre-commit hook.
> 
> [vinod] Updated post-reviews to work with 'post-review' (RBTools < 0.6) and
> 
> [idownes] Add os::getgid() and os::getuid() using reentrant version of getpwnam.
> 
> [idownes] Add ExecEnv for use with execle to safely exec.
> 
> [idownes] Update Subprocess to use ExecEnv from stout.
> 
> [idownes] Make execute in MesosContainerizer async signal safe.
> 
> [idownes] Cleaned up some style issues in MesosContainerizer
> 
> ------------------------------------------
> [...truncated 357 lines...]
> checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
> checking if more special flags are required for pthreads... no
> checking whether to check for GCC pthread/shared inconsistencies... yes
> checking whether -pthread is sufficient with -shared... yes
> checking for backtrace in -lunwind... no
> checking whether or not we can build with JNI... yes
> checking for mvn... /home/jenkins/tools/maven/latest/bin/mvn
> checking for a Python interpreter with version >= 2.6... python
> checking for python... /usr/bin/python
> checking for python version... 2.7
> checking for python platform... linux2
> checking for python script directory... ${prefix}/lib/python2.7/site-packages
> checking for python extension module directory... ${exec_prefix}/lib/python2.7/site-packages
> checking for python2.7... (cached) /usr/bin/python
> checking for a version of Python >= '2.1.0'... yes
> checking for a version of Python >= '2.6'... yes
> checking for the distutils Python package... yes
> checking for Python include path... -I/usr/include/python2.7
> checking for Python library path... -L/usr/lib -lpython2.7
> checking for Python site-packages path... /usr/lib/python2.7/dist-packages
> checking python extra libraries... -lpthread -ldl  -lutil
> checking python extra linking flags... -Xlinker -export-dynamic -Wl,-O1 -Wl,-Bsymbolic-functions
> checking consistency of all components of python development environment... yes
> checking whether we can build usable Python eggs... cc1plus: warning: command line option '-Wstrict-prototypes' is valid for Ada/C/ObjC but not for C++ [enabled by default]
> yes
> checking python module: boto... no
> configure: WARNING: can not find python-boto
> -------------------------------------------------------------------
> mesos-ec2 services will not function.
> -------------------------------------------------------------------
> checking for gzread in -lz... yes
> checking for curl_global_init in -lcurl... yes
> checking whether g++ supports C++11 features by default... no
> checking whether g++ supports C++11 features with -std=c++11... no
> checking whether g++ supports C++11 features with -std=c++0x... yes
> checking for sasl_done in -lsasl2... yes
> configure: creating ./config.status
> config.status: creating Makefile
> config.status: creating mesos.pc
> config.status: creating ec2/Makefile
> config.status: creating src/Makefile
> config.status: creating 3rdparty/Makefile
> config.status: creating bin/mesos.sh
> config.status: creating bin/mesos-local.sh
> config.status: creating bin/mesos-master.sh
> config.status: creating bin/mesos-slave.sh
> config.status: creating bin/mesos-tests.sh
> config.status: creating bin/mesos-local-flags.sh
> config.status: creating bin/mesos-master-flags.sh
> config.status: creating bin/mesos-slave-flags.sh
> config.status: creating bin/mesos-tests-flags.sh
> config.status: creating bin/gdb-mesos-local.sh
> config.status: creating bin/gdb-mesos-master.sh
> config.status: creating bin/gdb-mesos-slave.sh
> config.status: creating bin/gdb-mesos-tests.sh
> config.status: creating bin/lldb-mesos-local.sh
> config.status: creating bin/lldb-mesos-master.sh
> config.status: creating bin/lldb-mesos-slave.sh
> config.status: creating bin/lldb-mesos-tests.sh
> config.status: creating bin/valgrind-mesos-local.sh
> config.status: creating bin/valgrind-mesos-slave.sh
> config.status: creating bin/valgrind-mesos-master.sh
> config.status: creating bin/valgrind-mesos-tests.sh
> config.status: creating src/deploy/mesos-daemon.sh
> config.status: creating src/deploy/mesos-start-cluster.sh
> config.status: creating src/deploy/mesos-start-masters.sh
> config.status: creating src/deploy/mesos-start-slaves.sh
> config.status: creating src/deploy/mesos-stop-cluster.sh
> config.status: creating src/deploy/mesos-stop-masters.sh
> config.status: creating src/deploy/mesos-stop-slaves.sh
> config.status: creating include/mesos/mesos.hpp
> config.status: creating src/java/generated/org/apache/mesos/MesosNativeLibrary.java
> config.status: creating mpi/mpiexec-mesos
> config.status: creating src/examples/java/test-exception-framework
> config.status: creating src/examples/java/test-executor
> config.status: creating src/examples/java/test-framework
> config.status: creating src/examples/java/test-multiple-executors-framework
> config.status: creating src/examples/java/test-log
> config.status: creating src/java/mesos.pom
> config.status: creating src/examples/python/test-executor
> config.status: creating src/examples/python/test-framework
> config.status: creating src/examples/python/test-containerizer
> config.status: creating src/python/setup.py
> config.status: executing depfiles commands
> config.status: executing libtool commands
> === configuring in 3rdparty/libprocess (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess)
> configure: running /bin/bash ../../../3rdparty/libprocess/configure --disable-option-checking '--prefix=/usr/local'  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no' '--with-pic' --cache-file=/dev/null --srcdir=../../../3rdparty/libprocess
> checking build system type... x86_64-unknown-linux-gnu
> checking host system type... x86_64-unknown-linux-gnu
> checking target system type... x86_64-unknown-linux-gnu
> checking for a BSD-compatible install... /usr/bin/install -c
> checking whether build environment is sane... yes
> checking for a thread-safe mkdir -p... /bin/mkdir -p
> checking for gawk... no
> checking for mawk... mawk
> checking whether make sets $(MAKE)... yes
> checking for style of include used by make... GNU
> checking for g++... g++
> checking whether the C++ compiler works... yes
> checking for C++ compiler default output file name... a.out
> checking for suffix of executables...
> checking whether we are cross compiling... no
> checking for suffix of object files... o
> checking whether we are using the GNU C++ compiler... yes
> checking whether g++ accepts -g... yes
> checking dependency style of g++... gcc3
> checking for ar... ar
> checking the archiver (ar) interface... ar
> checking how to print strings... printf
> checking for gcc... gcc
> checking whether we are using the GNU C compiler... yes
> checking whether gcc accepts -g... yes
> checking for gcc option to accept ISO C89... none needed
> checking dependency style of gcc... gcc3
> checking for a sed that does not truncate output... /bin/sed
> checking for grep that handles long lines and -e... /bin/grep
> checking for egrep... /bin/grep -E
> checking for fgrep... /bin/grep -F
> checking for ld used by gcc... /usr/bin/ld
> checking if the linker (/usr/bin/ld) is GNU ld... yes
> checking for BSD- or MS-compatible name lister (nm)... /usr/bin/nm -B
> checking the name lister (/usr/bin/nm -B) interface... BSD nm
> checking whether ln -s works... yes
> checking the maximum length of command line arguments... 1572864
> checking whether the shell understands some XSI constructs... yes
> checking whether the shell understands "+="... yes
> checking how to convert x86_64-unknown-linux-gnu file names to x86_64-unknown-linux-gnu format... func_convert_file_noop
> checking how to convert x86_64-unknown-linux-gnu file names to toolchain format... func_convert_file_noop
> checking for /usr/bin/ld option to reload object files... -r
> checking for objdump... objdump
> checking how to recognize dependent libraries... pass_all
> checking for dlltool... no
> checking how to associate runtime and link libraries... printf %s\n
> checking for archiver @FILE support... @
> checking for strip... strip
> checking for ranlib... ranlib
> checking command to parse /usr/bin/nm -B output from gcc object... ok
> checking for sysroot... no
> checking for mt... mt
> checking if mt is a manifest tool... no
> checking how to run the C preprocessor... gcc -E
> checking for ANSI C header files... yes
> checking for sys/types.h... yes
> checking for sys/stat.h... yes
> checking for stdlib.h... yes
> checking for string.h... yes
> checking for memory.h... yes
> checking for strings.h... yes
> checking for inttypes.h... yes
> checking for stdint.h... yes
> checking for unistd.h... yes
> checking for dlfcn.h... yes
> checking for objdir... .libs
> checking if gcc supports -fno-rtti -fno-exceptions... no
> checking for gcc option to produce PIC... -fPIC -DPIC
> checking if gcc PIC flag -fPIC -DPIC works... yes
> checking if gcc static flag -static works... yes
> checking if gcc supports -c -o file.o... yes
> checking if gcc supports -c -o file.o... (cached) yes
> checking whether the gcc linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
> checking dynamic linker characteristics... GNU/Linux ld.so
> checking how to hardcode library paths into programs... immediate
> checking whether stripping libraries is possible... yes
> checking if libtool supports shared libraries... yes
> checking whether to build shared libraries... no
> checking whether to build static libraries... yes
> checking how to run the C++ preprocessor... g++ -E
> checking for ld used by g++... /usr/bin/ld -m elf_x86_64
> checking if the linker (/usr/bin/ld -m elf_x86_64) is GNU ld... yes
> checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
> checking for g++ option to produce PIC... -fPIC -DPIC
> checking if g++ PIC flag -fPIC -DPIC works... yes
> checking if g++ static flag -static works... yes
> checking if g++ supports -c -o file.o... yes
> checking if g++ supports -c -o file.o... (cached) yes
> checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
> checking dynamic linker characteristics... (cached) GNU/Linux ld.so
> checking how to hardcode library paths into programs... immediate
> configure: creating ./config.lt
> config.lt: creating libtool
> checking whether we are using the GNU C++ compiler... (cached) yes
> checking whether g++ accepts -g... (cached) yes
> checking dependency style of g++... (cached) gcc3
> checking whether we are using the GNU C compiler... (cached) yes
> checking whether gcc accepts -g... (cached) yes
> checking for gcc option to accept ISO C89... (cached) none needed
> checking dependency style of gcc... (cached) gcc3
> checking if compiling with clang... no
> configure: GCC version: 4.6
> checking for the pthreads library -lpthreads... no
> checking whether pthreads work without any flags... no
> checking whether pthreads work with -Kthread... no
> checking whether pthreads work with -kthread... no
> checking for the pthreads library -llthread... no
> checking whether pthreads work with -pthread... yes
> checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
> checking if more special flags are required for pthreads... no
> checking whether to check for GCC pthread/shared inconsistencies... yes
> checking whether -pthread is sufficient with -shared... yes
> checking for deflate, gzread, gzwrite, inflate in -lz... yes
> checking whether g++ supports C++11 features by default... no
> checking whether g++ supports C++11 features with -std=c++11... no
> checking whether g++ supports C++11 features with -std=c++0x... yes
> checking for dlopen in -ldl... yes
> found
> configure: creating ./config.status
> config.status: creating Makefile
> config.status: creating 3rdparty/Makefile
> config.status: executing depfiles commands
> config.status: executing libtool commands
> === configuring in 3rdparty/stout (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout)
> configure: running /bin/bash ../../../../../3rdparty/libprocess/3rdparty/stout/configure --disable-option-checking '--prefix=/usr/local'  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no' '--with-pic' --cache-file=/dev/null --srcdir=../../../../../3rdparty/libprocess/3rdparty/stout
> checking for a BSD-compatible install... /usr/bin/install -c
> checking whether build environment is sane... yes
> checking for a thread-safe mkdir -p... /bin/mkdir -p
> checking for gawk... no
> checking for mawk... mawk
> checking whether make sets $(MAKE)... yes
> configure: creating ./config.status
> config.status: creating Makefile
> + GLOG_v=1
> + MESOS_VERBOSE=1
> + make distcheck GTEST_SHUFFLE=1
> if test -d "mesos-0.19.0"; then find "mesos-0.19.0" -type d ! -perm -200 -exec chmod u+w {} ';' && rm -rf "mesos-0.19.0" || { sleep 5 && rm -rf "mesos-0.19.0"; }; else :; fi
> test -d "mesos-0.19.0" || mkdir "mesos-0.19.0"
>  (cd 3rdparty && make  top_distdir=../mesos-0.19.0 distdir=../mesos-0.19.0/3rdparty \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
> make[1]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
>  (cd libprocess && make  top_distdir=../../mesos-0.19.0 distdir=../../mesos-0.19.0/3rdparty/libprocess \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
> make[2]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
> :
> test -d "../../mesos-0.19.0/3rdparty/libprocess" || mkdir "../../mesos-0.19.0/3rdparty/libprocess"
>  (cd 3rdparty && make  top_distdir=../../../mesos-0.19.0 distdir=../../../mesos-0.19.0/3rdparty/libprocess/3rdparty \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
> make[3]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
>  (cd stout && make  top_distdir=../../../../mesos-0.19.0 distdir=../../../../mesos-0.19.0/3rdparty/libprocess/3rdparty/stout \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
> make[4]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
> make[4]: *** No rule to make target `include/stout/execenv.hpp', needed by `distdir'.  Stop.
> make[4]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
> make[3]: *** [distdir] Error 1
> make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
> make[2]: *** [distdir] Error 1
> make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
> make[1]: *** [distdir] Error 1
> make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
> make: *** [distdir] Error 1
> Build step 'Execute shell' marked build as failure
> 


Re: Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2122

Posted by Vinod Kone <vi...@twitter.com>.
ian, looks like execenv was not added to the distribution/Makefile?


@vinodkone


On Tue, May 20, 2014 at 6:58 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:

> See <
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2122/changes
> >
>
> Changes:
>
> [vinod] Minor fix to pre-commit hook.
>
> [vinod] Updated post-reviews to work with 'post-review' (RBTools < 0.6) and
>
> [idownes] Add os::getgid() and os::getuid() using reentrant version of
> getpwnam.
>
> [idownes] Add ExecEnv for use with execle to safely exec.
>
> [idownes] Update Subprocess to use ExecEnv from stout.
>
> [idownes] Make execute in MesosContainerizer async signal safe.
>
> [idownes] Cleaned up some style issues in MesosContainerizer
>
> ------------------------------------------
> [...truncated 357 lines...]
> checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
> checking if more special flags are required for pthreads... no
> checking whether to check for GCC pthread/shared inconsistencies... yes
> checking whether -pthread is sufficient with -shared... yes
> checking for backtrace in -lunwind... no
> checking whether or not we can build with JNI... yes
> checking for mvn... /home/jenkins/tools/maven/latest/bin/mvn
> checking for a Python interpreter with version >= 2.6... python
> checking for python... /usr/bin/python
> checking for python version... 2.7
> checking for python platform... linux2
> checking for python script directory...
> ${prefix}/lib/python2.7/site-packages
> checking for python extension module directory...
> ${exec_prefix}/lib/python2.7/site-packages
> checking for python2.7... (cached) /usr/bin/python
> checking for a version of Python >= '2.1.0'... yes
> checking for a version of Python >= '2.6'... yes
> checking for the distutils Python package... yes
> checking for Python include path... -I/usr/include/python2.7
> checking for Python library path... -L/usr/lib -lpython2.7
> checking for Python site-packages path... /usr/lib/python2.7/dist-packages
> checking python extra libraries... -lpthread -ldl  -lutil
> checking python extra linking flags... -Xlinker -export-dynamic -Wl,-O1
> -Wl,-Bsymbolic-functions
> checking consistency of all components of python development
> environment... yes
> checking whether we can build usable Python eggs... cc1plus: warning:
> command line option '-Wstrict-prototypes' is valid for Ada/C/ObjC but not
> for C++ [enabled by default]
> yes
> checking python module: boto... no
> configure: WARNING: can not find python-boto
> -------------------------------------------------------------------
> mesos-ec2 services will not function.
> -------------------------------------------------------------------
> checking for gzread in -lz... yes
> checking for curl_global_init in -lcurl... yes
> checking whether g++ supports C++11 features by default... no
> checking whether g++ supports C++11 features with -std=c++11... no
> checking whether g++ supports C++11 features with -std=c++0x... yes
> checking for sasl_done in -lsasl2... yes
> configure: creating ./config.status
> config.status: creating Makefile
> config.status: creating mesos.pc
> config.status: creating ec2/Makefile
> config.status: creating src/Makefile
> config.status: creating 3rdparty/Makefile
> config.status: creating bin/mesos.sh
> config.status: creating bin/mesos-local.sh
> config.status: creating bin/mesos-master.sh
> config.status: creating bin/mesos-slave.sh
> config.status: creating bin/mesos-tests.sh
> config.status: creating bin/mesos-local-flags.sh
> config.status: creating bin/mesos-master-flags.sh
> config.status: creating bin/mesos-slave-flags.sh
> config.status: creating bin/mesos-tests-flags.sh
> config.status: creating bin/gdb-mesos-local.sh
> config.status: creating bin/gdb-mesos-master.sh
> config.status: creating bin/gdb-mesos-slave.sh
> config.status: creating bin/gdb-mesos-tests.sh
> config.status: creating bin/lldb-mesos-local.sh
> config.status: creating bin/lldb-mesos-master.sh
> config.status: creating bin/lldb-mesos-slave.sh
> config.status: creating bin/lldb-mesos-tests.sh
> config.status: creating bin/valgrind-mesos-local.sh
> config.status: creating bin/valgrind-mesos-slave.sh
> config.status: creating bin/valgrind-mesos-master.sh
> config.status: creating bin/valgrind-mesos-tests.sh
> config.status: creating src/deploy/mesos-daemon.sh
> config.status: creating src/deploy/mesos-start-cluster.sh
> config.status: creating src/deploy/mesos-start-masters.sh
> config.status: creating src/deploy/mesos-start-slaves.sh
> config.status: creating src/deploy/mesos-stop-cluster.sh
> config.status: creating src/deploy/mesos-stop-masters.sh
> config.status: creating src/deploy/mesos-stop-slaves.sh
> config.status: creating include/mesos/mesos.hpp
> config.status: creating
> src/java/generated/org/apache/mesos/MesosNativeLibrary.java
> config.status: creating mpi/mpiexec-mesos
> config.status: creating src/examples/java/test-exception-framework
> config.status: creating src/examples/java/test-executor
> config.status: creating src/examples/java/test-framework
> config.status: creating src/examples/java/test-multiple-executors-framework
> config.status: creating src/examples/java/test-log
> config.status: creating src/java/mesos.pom
> config.status: creating src/examples/python/test-executor
> config.status: creating src/examples/python/test-framework
> config.status: creating src/examples/python/test-containerizer
> config.status: creating src/python/setup.py
> config.status: executing depfiles commands
> config.status: executing libtool commands
> === configuring in 3rdparty/libprocess
> (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess)
> configure: running /bin/bash ../../../3rdparty/libprocess/configure
> --disable-option-checking '--prefix=/usr/local'
>  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no'
> '--with-pic' --cache-file=/dev/null --srcdir=../../../3rdparty/libprocess
> checking build system type... x86_64-unknown-linux-gnu
> checking host system type... x86_64-unknown-linux-gnu
> checking target system type... x86_64-unknown-linux-gnu
> checking for a BSD-compatible install... /usr/bin/install -c
> checking whether build environment is sane... yes
> checking for a thread-safe mkdir -p... /bin/mkdir -p
> checking for gawk... no
> checking for mawk... mawk
> checking whether make sets $(MAKE)... yes
> checking for style of include used by make... GNU
> checking for g++... g++
> checking whether the C++ compiler works... yes
> checking for C++ compiler default output file name... a.out
> checking for suffix of executables...
> checking whether we are cross compiling... no
> checking for suffix of object files... o
> checking whether we are using the GNU C++ compiler... yes
> checking whether g++ accepts -g... yes
> checking dependency style of g++... gcc3
> checking for ar... ar
> checking the archiver (ar) interface... ar
> checking how to print strings... printf
> checking for gcc... gcc
> checking whether we are using the GNU C compiler... yes
> checking whether gcc accepts -g... yes
> checking for gcc option to accept ISO C89... none needed
> checking dependency style of gcc... gcc3
> checking for a sed that does not truncate output... /bin/sed
> checking for grep that handles long lines and -e... /bin/grep
> checking for egrep... /bin/grep -E
> checking for fgrep... /bin/grep -F
> checking for ld used by gcc... /usr/bin/ld
> checking if the linker (/usr/bin/ld) is GNU ld... yes
> checking for BSD- or MS-compatible name lister (nm)... /usr/bin/nm -B
> checking the name lister (/usr/bin/nm -B) interface... BSD nm
> checking whether ln -s works... yes
> checking the maximum length of command line arguments... 1572864
> checking whether the shell understands some XSI constructs... yes
> checking whether the shell understands "+="... yes
> checking how to convert x86_64-unknown-linux-gnu file names to
> x86_64-unknown-linux-gnu format... func_convert_file_noop
> checking how to convert x86_64-unknown-linux-gnu file names to toolchain
> format... func_convert_file_noop
> checking for /usr/bin/ld option to reload object files... -r
> checking for objdump... objdump
> checking how to recognize dependent libraries... pass_all
> checking for dlltool... no
> checking how to associate runtime and link libraries... printf %s\n
> checking for archiver @FILE support... @
> checking for strip... strip
> checking for ranlib... ranlib
> checking command to parse /usr/bin/nm -B output from gcc object... ok
> checking for sysroot... no
> checking for mt... mt
> checking if mt is a manifest tool... no
> checking how to run the C preprocessor... gcc -E
> checking for ANSI C header files... yes
> checking for sys/types.h... yes
> checking for sys/stat.h... yes
> checking for stdlib.h... yes
> checking for string.h... yes
> checking for memory.h... yes
> checking for strings.h... yes
> checking for inttypes.h... yes
> checking for stdint.h... yes
> checking for unistd.h... yes
> checking for dlfcn.h... yes
> checking for objdir... .libs
> checking if gcc supports -fno-rtti -fno-exceptions... no
> checking for gcc option to produce PIC... -fPIC -DPIC
> checking if gcc PIC flag -fPIC -DPIC works... yes
> checking if gcc static flag -static works... yes
> checking if gcc supports -c -o file.o... yes
> checking if gcc supports -c -o file.o... (cached) yes
> checking whether the gcc linker (/usr/bin/ld -m elf_x86_64) supports
> shared libraries... yes
> checking dynamic linker characteristics... GNU/Linux ld.so
> checking how to hardcode library paths into programs... immediate
> checking whether stripping libraries is possible... yes
> checking if libtool supports shared libraries... yes
> checking whether to build shared libraries... no
> checking whether to build static libraries... yes
> checking how to run the C++ preprocessor... g++ -E
> checking for ld used by g++... /usr/bin/ld -m elf_x86_64
> checking if the linker (/usr/bin/ld -m elf_x86_64) is GNU ld... yes
> checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports
> shared libraries... yes
> checking for g++ option to produce PIC... -fPIC -DPIC
> checking if g++ PIC flag -fPIC -DPIC works... yes
> checking if g++ static flag -static works... yes
> checking if g++ supports -c -o file.o... yes
> checking if g++ supports -c -o file.o... (cached) yes
> checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports
> shared libraries... yes
> checking dynamic linker characteristics... (cached) GNU/Linux ld.so
> checking how to hardcode library paths into programs... immediate
> configure: creating ./config.lt
> config.lt: creating libtool
> checking whether we are using the GNU C++ compiler... (cached) yes
> checking whether g++ accepts -g... (cached) yes
> checking dependency style of g++... (cached) gcc3
> checking whether we are using the GNU C compiler... (cached) yes
> checking whether gcc accepts -g... (cached) yes
> checking for gcc option to accept ISO C89... (cached) none needed
> checking dependency style of gcc... (cached) gcc3
> checking if compiling with clang... no
> configure: GCC version: 4.6
> checking for the pthreads library -lpthreads... no
> checking whether pthreads work without any flags... no
> checking whether pthreads work with -Kthread... no
> checking whether pthreads work with -kthread... no
> checking for the pthreads library -llthread... no
> checking whether pthreads work with -pthread... yes
> checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
> checking if more special flags are required for pthreads... no
> checking whether to check for GCC pthread/shared inconsistencies... yes
> checking whether -pthread is sufficient with -shared... yes
> checking for deflate, gzread, gzwrite, inflate in -lz... yes
> checking whether g++ supports C++11 features by default... no
> checking whether g++ supports C++11 features with -std=c++11... no
> checking whether g++ supports C++11 features with -std=c++0x... yes
> checking for dlopen in -ldl... yes
> found
> configure: creating ./config.status
> config.status: creating Makefile
> config.status: creating 3rdparty/Makefile
> config.status: executing depfiles commands
> config.status: executing libtool commands
> === configuring in 3rdparty/stout
> (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout)
> configure: running /bin/bash
> ../../../../../3rdparty/libprocess/3rdparty/stout/configure
> --disable-option-checking '--prefix=/usr/local'
>  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no'
> '--with-pic' --cache-file=/dev/null
> --srcdir=../../../../../3rdparty/libprocess/3rdparty/stout
> checking for a BSD-compatible install... /usr/bin/install -c
> checking whether build environment is sane... yes
> checking for a thread-safe mkdir -p... /bin/mkdir -p
> checking for gawk... no
> checking for mawk... mawk
> checking whether make sets $(MAKE)... yes
> configure: creating ./config.status
> config.status: creating Makefile
> + GLOG_v=1
> + MESOS_VERBOSE=1
> + make distcheck GTEST_SHUFFLE=1
> if test -d "mesos-0.19.0"; then find "mesos-0.19.0" -type d ! -perm -200
> -exec chmod u+w {} ';' && rm -rf "mesos-0.19.0" || { sleep 5 && rm -rf
> "mesos-0.19.0"; }; else :; fi
> test -d "mesos-0.19.0" || mkdir "mesos-0.19.0"
>  (cd 3rdparty && make  top_distdir=../mesos-0.19.0
> distdir=../mesos-0.19.0/3rdparty \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=:
> distdir)
> make[1]: Entering directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
>  (cd libprocess && make  top_distdir=../../mesos-0.19.0
> distdir=../../mesos-0.19.0/3rdparty/libprocess \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=:
> distdir)
> make[2]: Entering directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
> :
> test -d "../../mesos-0.19.0/3rdparty/libprocess" || mkdir
> "../../mesos-0.19.0/3rdparty/libprocess"
>  (cd 3rdparty && make  top_distdir=../../../mesos-0.19.0
> distdir=../../../mesos-0.19.0/3rdparty/libprocess/3rdparty \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=:
> distdir)
> make[3]: Entering directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
>  (cd stout && make  top_distdir=../../../../mesos-0.19.0
> distdir=../../../../mesos-0.19.0/3rdparty/libprocess/3rdparty/stout \
>      am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=:
> distdir)
> make[4]: Entering directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
> make[4]: *** No rule to make target `include/stout/execenv.hpp', needed by
> `distdir'.  Stop.
> make[4]: Leaving directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
> make[3]: *** [distdir] Error 1
> make[3]: Leaving directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
> make[2]: *** [distdir] Error 1
> make[2]: Leaving directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
> make[1]: *** [distdir] Error 1
> make[1]: Leaving directory
> `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
> make: *** [distdir] Error 1
> Build step 'Execute shell' marked build as failure
>

Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2122

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2122/changes>

Changes:

[vinod] Minor fix to pre-commit hook.

[vinod] Updated post-reviews to work with 'post-review' (RBTools < 0.6) and

[idownes] Add os::getgid() and os::getuid() using reentrant version of getpwnam.

[idownes] Add ExecEnv for use with execle to safely exec.

[idownes] Update Subprocess to use ExecEnv from stout.

[idownes] Make execute in MesosContainerizer async signal safe.

[idownes] Cleaned up some style issues in MesosContainerizer

------------------------------------------
[...truncated 357 lines...]
checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
checking if more special flags are required for pthreads... no
checking whether to check for GCC pthread/shared inconsistencies... yes
checking whether -pthread is sufficient with -shared... yes
checking for backtrace in -lunwind... no
checking whether or not we can build with JNI... yes
checking for mvn... /home/jenkins/tools/maven/latest/bin/mvn
checking for a Python interpreter with version >= 2.6... python
checking for python... /usr/bin/python
checking for python version... 2.7
checking for python platform... linux2
checking for python script directory... ${prefix}/lib/python2.7/site-packages
checking for python extension module directory... ${exec_prefix}/lib/python2.7/site-packages
checking for python2.7... (cached) /usr/bin/python
checking for a version of Python >= '2.1.0'... yes
checking for a version of Python >= '2.6'... yes
checking for the distutils Python package... yes
checking for Python include path... -I/usr/include/python2.7
checking for Python library path... -L/usr/lib -lpython2.7
checking for Python site-packages path... /usr/lib/python2.7/dist-packages
checking python extra libraries... -lpthread -ldl  -lutil
checking python extra linking flags... -Xlinker -export-dynamic -Wl,-O1 -Wl,-Bsymbolic-functions
checking consistency of all components of python development environment... yes
checking whether we can build usable Python eggs... cc1plus: warning: command line option '-Wstrict-prototypes' is valid for Ada/C/ObjC but not for C++ [enabled by default]
yes
checking python module: boto... no
configure: WARNING: can not find python-boto
-------------------------------------------------------------------
mesos-ec2 services will not function.
-------------------------------------------------------------------
checking for gzread in -lz... yes
checking for curl_global_init in -lcurl... yes
checking whether g++ supports C++11 features by default... no
checking whether g++ supports C++11 features with -std=c++11... no
checking whether g++ supports C++11 features with -std=c++0x... yes
checking for sasl_done in -lsasl2... yes
configure: creating ./config.status
config.status: creating Makefile
config.status: creating mesos.pc
config.status: creating ec2/Makefile
config.status: creating src/Makefile
config.status: creating 3rdparty/Makefile
config.status: creating bin/mesos.sh
config.status: creating bin/mesos-local.sh
config.status: creating bin/mesos-master.sh
config.status: creating bin/mesos-slave.sh
config.status: creating bin/mesos-tests.sh
config.status: creating bin/mesos-local-flags.sh
config.status: creating bin/mesos-master-flags.sh
config.status: creating bin/mesos-slave-flags.sh
config.status: creating bin/mesos-tests-flags.sh
config.status: creating bin/gdb-mesos-local.sh
config.status: creating bin/gdb-mesos-master.sh
config.status: creating bin/gdb-mesos-slave.sh
config.status: creating bin/gdb-mesos-tests.sh
config.status: creating bin/lldb-mesos-local.sh
config.status: creating bin/lldb-mesos-master.sh
config.status: creating bin/lldb-mesos-slave.sh
config.status: creating bin/lldb-mesos-tests.sh
config.status: creating bin/valgrind-mesos-local.sh
config.status: creating bin/valgrind-mesos-slave.sh
config.status: creating bin/valgrind-mesos-master.sh
config.status: creating bin/valgrind-mesos-tests.sh
config.status: creating src/deploy/mesos-daemon.sh
config.status: creating src/deploy/mesos-start-cluster.sh
config.status: creating src/deploy/mesos-start-masters.sh
config.status: creating src/deploy/mesos-start-slaves.sh
config.status: creating src/deploy/mesos-stop-cluster.sh
config.status: creating src/deploy/mesos-stop-masters.sh
config.status: creating src/deploy/mesos-stop-slaves.sh
config.status: creating include/mesos/mesos.hpp
config.status: creating src/java/generated/org/apache/mesos/MesosNativeLibrary.java
config.status: creating mpi/mpiexec-mesos
config.status: creating src/examples/java/test-exception-framework
config.status: creating src/examples/java/test-executor
config.status: creating src/examples/java/test-framework
config.status: creating src/examples/java/test-multiple-executors-framework
config.status: creating src/examples/java/test-log
config.status: creating src/java/mesos.pom
config.status: creating src/examples/python/test-executor
config.status: creating src/examples/python/test-framework
config.status: creating src/examples/python/test-containerizer
config.status: creating src/python/setup.py
config.status: executing depfiles commands
config.status: executing libtool commands
=== configuring in 3rdparty/libprocess (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess)
configure: running /bin/bash ../../../3rdparty/libprocess/configure --disable-option-checking '--prefix=/usr/local'  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no' '--with-pic' --cache-file=/dev/null --srcdir=../../../3rdparty/libprocess
checking build system type... x86_64-unknown-linux-gnu
checking host system type... x86_64-unknown-linux-gnu
checking target system type... x86_64-unknown-linux-gnu
checking for a BSD-compatible install... /usr/bin/install -c
checking whether build environment is sane... yes
checking for a thread-safe mkdir -p... /bin/mkdir -p
checking for gawk... no
checking for mawk... mawk
checking whether make sets $(MAKE)... yes
checking for style of include used by make... GNU
checking for g++... g++
checking whether the C++ compiler works... yes
checking for C++ compiler default output file name... a.out
checking for suffix of executables... 
checking whether we are cross compiling... no
checking for suffix of object files... o
checking whether we are using the GNU C++ compiler... yes
checking whether g++ accepts -g... yes
checking dependency style of g++... gcc3
checking for ar... ar
checking the archiver (ar) interface... ar
checking how to print strings... printf
checking for gcc... gcc
checking whether we are using the GNU C compiler... yes
checking whether gcc accepts -g... yes
checking for gcc option to accept ISO C89... none needed
checking dependency style of gcc... gcc3
checking for a sed that does not truncate output... /bin/sed
checking for grep that handles long lines and -e... /bin/grep
checking for egrep... /bin/grep -E
checking for fgrep... /bin/grep -F
checking for ld used by gcc... /usr/bin/ld
checking if the linker (/usr/bin/ld) is GNU ld... yes
checking for BSD- or MS-compatible name lister (nm)... /usr/bin/nm -B
checking the name lister (/usr/bin/nm -B) interface... BSD nm
checking whether ln -s works... yes
checking the maximum length of command line arguments... 1572864
checking whether the shell understands some XSI constructs... yes
checking whether the shell understands "+="... yes
checking how to convert x86_64-unknown-linux-gnu file names to x86_64-unknown-linux-gnu format... func_convert_file_noop
checking how to convert x86_64-unknown-linux-gnu file names to toolchain format... func_convert_file_noop
checking for /usr/bin/ld option to reload object files... -r
checking for objdump... objdump
checking how to recognize dependent libraries... pass_all
checking for dlltool... no
checking how to associate runtime and link libraries... printf %s\n
checking for archiver @FILE support... @
checking for strip... strip
checking for ranlib... ranlib
checking command to parse /usr/bin/nm -B output from gcc object... ok
checking for sysroot... no
checking for mt... mt
checking if mt is a manifest tool... no
checking how to run the C preprocessor... gcc -E
checking for ANSI C header files... yes
checking for sys/types.h... yes
checking for sys/stat.h... yes
checking for stdlib.h... yes
checking for string.h... yes
checking for memory.h... yes
checking for strings.h... yes
checking for inttypes.h... yes
checking for stdint.h... yes
checking for unistd.h... yes
checking for dlfcn.h... yes
checking for objdir... .libs
checking if gcc supports -fno-rtti -fno-exceptions... no
checking for gcc option to produce PIC... -fPIC -DPIC
checking if gcc PIC flag -fPIC -DPIC works... yes
checking if gcc static flag -static works... yes
checking if gcc supports -c -o file.o... yes
checking if gcc supports -c -o file.o... (cached) yes
checking whether the gcc linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
checking dynamic linker characteristics... GNU/Linux ld.so
checking how to hardcode library paths into programs... immediate
checking whether stripping libraries is possible... yes
checking if libtool supports shared libraries... yes
checking whether to build shared libraries... no
checking whether to build static libraries... yes
checking how to run the C++ preprocessor... g++ -E
checking for ld used by g++... /usr/bin/ld -m elf_x86_64
checking if the linker (/usr/bin/ld -m elf_x86_64) is GNU ld... yes
checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
checking for g++ option to produce PIC... -fPIC -DPIC
checking if g++ PIC flag -fPIC -DPIC works... yes
checking if g++ static flag -static works... yes
checking if g++ supports -c -o file.o... yes
checking if g++ supports -c -o file.o... (cached) yes
checking whether the g++ linker (/usr/bin/ld -m elf_x86_64) supports shared libraries... yes
checking dynamic linker characteristics... (cached) GNU/Linux ld.so
checking how to hardcode library paths into programs... immediate
configure: creating ./config.lt
config.lt: creating libtool
checking whether we are using the GNU C++ compiler... (cached) yes
checking whether g++ accepts -g... (cached) yes
checking dependency style of g++... (cached) gcc3
checking whether we are using the GNU C compiler... (cached) yes
checking whether gcc accepts -g... (cached) yes
checking for gcc option to accept ISO C89... (cached) none needed
checking dependency style of gcc... (cached) gcc3
checking if compiling with clang... no
configure: GCC version: 4.6
checking for the pthreads library -lpthreads... no
checking whether pthreads work without any flags... no
checking whether pthreads work with -Kthread... no
checking whether pthreads work with -kthread... no
checking for the pthreads library -llthread... no
checking whether pthreads work with -pthread... yes
checking for joinable pthread attribute... PTHREAD_CREATE_JOINABLE
checking if more special flags are required for pthreads... no
checking whether to check for GCC pthread/shared inconsistencies... yes
checking whether -pthread is sufficient with -shared... yes
checking for deflate, gzread, gzwrite, inflate in -lz... yes
checking whether g++ supports C++11 features by default... no
checking whether g++ supports C++11 features with -std=c++11... no
checking whether g++ supports C++11 features with -std=c++0x... yes
checking for dlopen in -ldl... yes
found
configure: creating ./config.status
config.status: creating Makefile
config.status: creating 3rdparty/Makefile
config.status: executing depfiles commands
config.status: executing libtool commands
=== configuring in 3rdparty/stout (/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout)
configure: running /bin/bash ../../../../../3rdparty/libprocess/3rdparty/stout/configure --disable-option-checking '--prefix=/usr/local'  'JAVA_HOME=/home/jenkins/tools/java/jdk1.6.0_20-64' '--enable-shared=no' '--with-pic' --cache-file=/dev/null --srcdir=../../../../../3rdparty/libprocess/3rdparty/stout
checking for a BSD-compatible install... /usr/bin/install -c
checking whether build environment is sane... yes
checking for a thread-safe mkdir -p... /bin/mkdir -p
checking for gawk... no
checking for mawk... mawk
checking whether make sets $(MAKE)... yes
configure: creating ./config.status
config.status: creating Makefile
+ GLOG_v=1
+ MESOS_VERBOSE=1
+ make distcheck GTEST_SHUFFLE=1
if test -d "mesos-0.19.0"; then find "mesos-0.19.0" -type d ! -perm -200 -exec chmod u+w {} ';' && rm -rf "mesos-0.19.0" || { sleep 5 && rm -rf "mesos-0.19.0"; }; else :; fi
test -d "mesos-0.19.0" || mkdir "mesos-0.19.0"
 (cd 3rdparty && make  top_distdir=../mesos-0.19.0 distdir=../mesos-0.19.0/3rdparty \
     am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
make[1]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
 (cd libprocess && make  top_distdir=../../mesos-0.19.0 distdir=../../mesos-0.19.0/3rdparty/libprocess \
     am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
make[2]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
:
test -d "../../mesos-0.19.0/3rdparty/libprocess" || mkdir "../../mesos-0.19.0/3rdparty/libprocess"
 (cd 3rdparty && make  top_distdir=../../../mesos-0.19.0 distdir=../../../mesos-0.19.0/3rdparty/libprocess/3rdparty \
     am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
make[3]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
 (cd stout && make  top_distdir=../../../../mesos-0.19.0 distdir=../../../../mesos-0.19.0/3rdparty/libprocess/3rdparty/stout \
     am__remove_distdir=: am__skip_length_check=: am__skip_mode_fix=: distdir)
make[4]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
make[4]: *** No rule to make target `include/stout/execenv.hpp', needed by `distdir'.  Stop.
make[4]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty/stout'
make[3]: *** [distdir] Error 1
make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess/3rdparty'
make[2]: *** [distdir] Error 1
make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty/libprocess'
make[1]: *** [distdir] Error 1
make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/3rdparty'
make: *** [distdir] Error 1
Build step 'Execute shell' marked build as failure

Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #2121

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2121/changes>

Changes:

[vinod] Added a pre-commit hook to check style.

[vinod] Enabled whitespace/blank_line rule for cpplint.

[yujie.jay] Added stream operator for filter::ip::PortRange.

[bmahler] MESOS-1376: Fixed an invalid reference in the Registrar.

[vinod] Added backoff to slave's initial (re-)registration attempt.

[vinod] Set work_dir flag for mesos-local.

[vinod] Fixed invalid comment string in slave.cpp

[yujie.jay] Set slave subsystems only in containerizer tests and cleaned up the

[yujie.jay] Included the error message when nl_connect fails.

[vinod] Added elected time to master's web ui.

[yujie.jay] Fixed the broken build on OSX caused by cgroups::enabled().

------------------------------------------
[...truncated 52711 lines...]
I0520 09:49:36.376677 31712 replica.cpp:508] Replica received write request for position 0
I0520 09:49:36.376718 31712 leveldb.cpp:438] Reading position from leveldb took 14716ns
I0520 09:49:36.376760 31717 replica.cpp:508] Replica received write request for position 0
I0520 09:49:36.376796 31717 leveldb.cpp:438] Reading position from leveldb took 12108ns
I0520 09:49:36.395930 31717 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 19.113264ms
I0520 09:49:36.395937 31712 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 19.201135ms
I0520 09:49:36.395990 31712 replica.cpp:676] Persisted action at 0
I0520 09:49:36.395952 31717 replica.cpp:676] Persisted action at 0
I0520 09:49:36.396914 31724 replica.cpp:655] Replica received learned notice for position 0
I0520 09:49:36.397011 31719 replica.cpp:655] Replica received learned notice for position 0
I0520 09:49:36.416091 31719 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 19.064195ms
I0520 09:49:36.416113 31719 replica.cpp:676] Persisted action at 0
I0520 09:49:36.416123 31719 replica.cpp:661] Replica learned NOP action at position 0
I0520 09:49:36.416122 31724 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 19.192361ms
I0520 09:49:36.416141 31724 replica.cpp:676] Persisted action at 0
I0520 09:49:36.416149 31724 replica.cpp:661] Replica learned NOP action at position 0
I0520 09:49:36.416358 31733 log.cpp:672] Writer started with ending position 0
I0520 09:49:36.417569 31721 leveldb.cpp:438] Reading position from leveldb took 10785ns
I0520 09:49:36.420555 31720 registrar.cpp:346] Successfully fetched the registry (0B)
I0520 09:49:36.420584 31720 registrar.cpp:422] Attempting to update the 'registry'
I0520 09:49:36.423617 31726 log.cpp:680] Attempting to append 144 bytes to the log
I0520 09:49:36.423879 31732 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0520 09:49:36.425396 31729 replica.cpp:508] Replica received write request for position 1
I0520 09:49:36.425639 31712 replica.cpp:508] Replica received write request for position 1
I0520 09:49:36.444214 31712 leveldb.cpp:343] Persisting action (163 bytes) to leveldb took 18.548654ms
I0520 09:49:36.444248 31712 replica.cpp:676] Persisted action at 1
I0520 09:49:36.444252 31729 leveldb.cpp:343] Persisting action (163 bytes) to leveldb took 18.828656ms
I0520 09:49:36.444284 31729 replica.cpp:676] Persisted action at 1
I0520 09:49:36.445077 31711 replica.cpp:655] Replica received learned notice for position 1
I0520 09:49:36.445204 31724 replica.cpp:655] Replica received learned notice for position 1
I0520 09:49:36.464303 31724 leveldb.cpp:343] Persisting action (165 bytes) to leveldb took 19.082643ms
I0520 09:49:36.464326 31724 replica.cpp:676] Persisted action at 1
I0520 09:49:36.464335 31724 replica.cpp:661] Replica learned APPEND action at position 1
I0520 09:49:36.464364 31711 leveldb.cpp:343] Persisting action (165 bytes) to leveldb took 19.256453ms
I0520 09:49:36.464396 31711 replica.cpp:676] Persisted action at 1
I0520 09:49:36.464421 31711 replica.cpp:661] Replica learned APPEND action at position 1
I0520 09:49:36.464674 31711 registrar.cpp:479] Successfully updated 'registry'
I0520 09:49:36.464711 31711 registrar.cpp:372] Successfully recovered registrar
I0520 09:49:36.464933 31728 log.cpp:699] Attempting to truncate the log to 1
I0520 09:49:36.464998 31728 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0520 09:49:36.467126 31716 replica.cpp:508] Replica received write request for position 2
I0520 09:49:36.467349 31717 replica.cpp:508] Replica received write request for position 2
I0520 09:49:36.467412 31730 registrar.cpp:422] Attempting to update the 'registry'
I0520 09:49:36.488402 31717 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 21.032721ms
I0520 09:49:36.488425 31717 replica.cpp:676] Persisted action at 2
I0520 09:49:36.488435 31716 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 21.280688ms
I0520 09:49:36.488466 31716 replica.cpp:676] Persisted action at 2
I0520 09:49:36.489109 31722 replica.cpp:655] Replica received learned notice for position 2
I0520 09:49:36.489136 31713 replica.cpp:655] Replica received learned notice for position 2
I0520 09:49:36.508544 31713 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 19.390241ms
I0520 09:49:36.508558 31722 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 19.420085ms
I0520 09:49:36.508602 31713 leveldb.cpp:401] Deleting ~1 keys from leveldb took 26111ns
I0520 09:49:36.508612 31722 leveldb.cpp:401] Deleting ~1 keys from leveldb took 25756ns
I0520 09:49:36.508618 31713 replica.cpp:676] Persisted action at 2
I0520 09:49:36.508630 31722 replica.cpp:676] Persisted action at 2
I0520 09:49:36.508630 31713 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0520 09:49:36.508640 31722 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0520 09:49:36.508869 31731 log.cpp:680] Attempting to append 167 bytes to the log
I0520 09:49:36.509083 31712 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
I0520 09:49:36.510399 31734 replica.cpp:508] Replica received write request for position 3
I0520 09:49:36.510429 31730 replica.cpp:508] Replica received write request for position 3
I0520 09:49:36.528597 31730 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 18.120024ms
I0520 09:49:36.528619 31730 replica.cpp:676] Persisted action at 3
I0520 09:49:36.528609 31734 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 18.182665ms
I0520 09:49:36.528637 31734 replica.cpp:676] Persisted action at 3
I0520 09:49:36.529991 31720 replica.cpp:655] Replica received learned notice for position 3
I0520 09:49:36.530565 31731 replica.cpp:655] Replica received learned notice for position 3
I0520 09:49:36.548777 31731 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 18.189882ms
I0520 09:49:36.548811 31731 replica.cpp:676] Persisted action at 3
I0520 09:49:36.548843 31731 replica.cpp:661] Replica learned APPEND action at position 3
I0520 09:49:36.548800 31720 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 18.784948ms
I0520 09:49:36.548874 31720 replica.cpp:676] Persisted action at 3
I0520 09:49:36.548897 31720 replica.cpp:661] Replica learned APPEND action at position 3
I0520 09:49:36.549095 31712 registrar.cpp:479] Successfully updated 'registry'
I0520 09:49:36.549237 31724 log.cpp:699] Attempting to truncate the log to 3
I0520 09:49:36.549574 31734 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
I0520 09:49:36.550927 31711 registrar.cpp:422] Attempting to update the 'registry'
I0520 09:49:36.551044 31723 replica.cpp:508] Replica received write request for position 4
I0520 09:49:36.551466 31733 replica.cpp:508] Replica received write request for position 4
I0520 09:49:36.568830 31733 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 17.336849ms
I0520 09:49:36.568857 31733 replica.cpp:676] Persisted action at 4
I0520 09:49:36.568860 31723 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 17.763144ms
I0520 09:49:36.568889 31723 replica.cpp:676] Persisted action at 4
I0520 09:49:36.569211 31733 replica.cpp:655] Replica received learned notice for position 4
I0520 09:49:36.569250 31711 replica.cpp:655] Replica received learned notice for position 4
I0520 09:49:36.584951 31711 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 15.678034ms
I0520 09:49:36.584988 31733 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 15.759571ms
I0520 09:49:36.585032 31733 leveldb.cpp:401] Deleting ~2 keys from leveldb took 25434ns
I0520 09:49:36.585037 31711 leveldb.cpp:401] Deleting ~2 keys from leveldb took 54343ns
I0520 09:49:36.585043 31733 replica.cpp:676] Persisted action at 4
I0520 09:49:36.585058 31711 replica.cpp:676] Persisted action at 4
I0520 09:49:36.585063 31733 replica.cpp:661] Replica learned TRUNCATE action at position 4
I0520 09:49:36.585068 31711 replica.cpp:661] Replica learned TRUNCATE action at position 4
I0520 09:49:36.585296 31719 log.cpp:680] Attempting to append 167 bytes to the log
I0520 09:49:36.585501 31715 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 5
I0520 09:49:36.586238 31711 replica.cpp:508] Replica received write request for position 5
I0520 09:49:36.586753 31724 replica.cpp:508] Replica received write request for position 5
I0520 09:49:36.605084 31724 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 18.310833ms
I0520 09:49:36.605108 31724 replica.cpp:676] Persisted action at 5
I0520 09:49:36.605140 31711 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 18.873785ms
I0520 09:49:36.605170 31711 replica.cpp:676] Persisted action at 5
I0520 09:49:36.605291 31724 replica.cpp:655] Replica received learned notice for position 5
I0520 09:49:36.605334 31720 replica.cpp:655] Replica received learned notice for position 5
I0520 09:49:36.621129 31724 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 15.798845ms
I0520 09:49:36.621150 31724 replica.cpp:676] Persisted action at 5
I0520 09:49:36.621160 31724 replica.cpp:661] Replica learned APPEND action at position 5
I0520 09:49:36.621160 31720 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 15.804268ms
I0520 09:49:36.621191 31720 replica.cpp:676] Persisted action at 5
I0520 09:49:36.621202 31720 replica.cpp:661] Replica learned APPEND action at position 5
I0520 09:49:36.621451 31723 registrar.cpp:479] Successfully updated 'registry'
I0520 09:49:36.621996 31718 registrar.cpp:422] Attempting to update the 'registry'
I0520 09:49:36.622581 31723 log.cpp:699] Attempting to truncate the log to 5
I0520 09:49:36.622665 31723 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 6
I0520 09:49:36.623584 31726 replica.cpp:508] Replica received write request for position 6
I0520 09:49:36.624254 31717 replica.cpp:508] Replica received write request for position 6
I0520 09:49:36.637696 31717 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 13.422383ms
I0520 09:49:36.637717 31717 replica.cpp:676] Persisted action at 6
I0520 09:49:36.637722 31726 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 14.113064ms
I0520 09:49:36.637753 31726 replica.cpp:676] Persisted action at 6
I0520 09:49:36.639950 31715 replica.cpp:655] Replica received learned notice for position 6
I0520 09:49:36.639977 31711 replica.cpp:655] Replica received learned notice for position 6
I0520 09:49:36.653803 31715 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 13.828706ms
I0520 09:49:36.653846 31711 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 13.846505ms
I0520 09:49:36.653872 31715 leveldb.cpp:401] Deleting ~2 keys from leveldb took 37737ns
I0520 09:49:36.653887 31715 replica.cpp:676] Persisted action at 6
I0520 09:49:36.653899 31715 replica.cpp:661] Replica learned TRUNCATE action at position 6
I0520 09:49:36.653909 31711 leveldb.cpp:401] Deleting ~2 keys from leveldb took 31638ns
I0520 09:49:36.653931 31711 replica.cpp:676] Persisted action at 6
I0520 09:49:36.653949 31711 replica.cpp:661] Replica learned TRUNCATE action at position 6
I0520 09:49:36.654193 31711 log.cpp:680] Attempting to append 187 bytes to the log
I0520 09:49:36.654438 31732 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 7
I0520 09:49:36.655809 31729 replica.cpp:508] Replica received write request for position 7
I0520 09:49:36.656195 31723 replica.cpp:508] Replica received write request for position 7
I0520 09:49:36.673879 31723 leveldb.cpp:343] Persisting action (206 bytes) to leveldb took 17.655646ms
I0520 09:49:36.673910 31723 replica.cpp:676] Persisted action at 7
I0520 09:49:36.673919 31729 leveldb.cpp:343] Persisting action (206 bytes) to leveldb took 18.080253ms
I0520 09:49:36.673949 31729 replica.cpp:676] Persisted action at 7
I0520 09:49:36.674922 31732 replica.cpp:655] Replica received learned notice for position 7
I0520 09:49:36.674928 31715 replica.cpp:655] Replica received learned notice for position 7
I0520 09:49:36.694056 31715 leveldb.cpp:343] Persisting action (208 bytes) to leveldb took 18.999365ms
I0520 09:49:36.694089 31715 replica.cpp:676] Persisted action at 7
I0520 09:49:36.694102 31715 replica.cpp:661] Replica learned APPEND action at position 7
I0520 09:49:36.694109 31732 leveldb.cpp:343] Persisting action (208 bytes) to leveldb took 19.068525ms
I0520 09:49:36.694140 31732 replica.cpp:676] Persisted action at 7
I0520 09:49:36.694160 31732 replica.cpp:661] Replica learned APPEND action at position 7
I0520 09:49:36.694489 31715 registrar.cpp:479] Successfully updated 'registry'
I0520 09:49:36.694669 31727 log.cpp:699] Attempting to truncate the log to 7
I0520 09:49:36.695291 31724 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 8
I0520 09:49:36.697044 31717 replica.cpp:508] Replica received write request for position 8
I0520 09:49:36.697669 31722 replica.cpp:508] Replica received write request for position 8
I0520 09:49:36.714153 31722 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 16.455804ms
I0520 09:49:36.714174 31717 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 17.110872ms
I0520 09:49:36.714184 31722 replica.cpp:676] Persisted action at 8
I0520 09:49:36.714196 31717 replica.cpp:676] Persisted action at 8
[       OK ] Strict/RegistrarTest.readmit/0 (704 ms)
[ RUN      ] Strict/RegistrarTest.storeTimeout/0
Using temporary directory '/tmp/Strict_RegistrarTest_storeTimeout_0_G9FojA'
I0520 09:49:36.759380 31692 leveldb.cpp:176] Opened db in 43.759548ms
I0520 09:49:36.775789 31692 leveldb.cpp:183] Compacted db in 16.385093ms
I0520 09:49:36.775813 31692 leveldb.cpp:198] Created db iterator in 4540ns
I0520 09:49:36.775822 31692 leveldb.cpp:204] Seeked to beginning of db in 806ns
I0520 09:49:36.775830 31692 leveldb.cpp:273] Iterated through 0 keys in the db in 281ns
I0520 09:49:36.775846 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:36.787806 31720 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 11.679418ms
I0520 09:49:36.787842 31720 replica.cpp:320] Persisted replica status to VOTING
I0520 09:49:36.828687 31692 leveldb.cpp:176] Opened db in 40.250548ms
I0520 09:49:36.840999 31692 leveldb.cpp:183] Compacted db in 12.290628ms
I0520 09:49:36.841023 31692 leveldb.cpp:198] Created db iterator in 3559ns
I0520 09:49:36.841032 31692 leveldb.cpp:204] Seeked to beginning of db in 428ns
I0520 09:49:36.841038 31692 leveldb.cpp:273] Iterated through 0 keys in the db in 194ns
I0520 09:49:36.841052 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:36.856974 31734 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 15.432347ms
I0520 09:49:36.857007 31734 replica.cpp:320] Persisted replica status to VOTING
I0520 09:49:36.893803 31692 leveldb.cpp:176] Opened db in 36.514417ms
I0520 09:49:36.934852 31692 leveldb.cpp:183] Compacted db in 41.021887ms
I0520 09:49:36.934883 31692 leveldb.cpp:198] Created db iterator in 5953ns
I0520 09:49:36.934901 31692 leveldb.cpp:204] Seeked to beginning of db in 9422ns
I0520 09:49:36.934923 31692 leveldb.cpp:273] Iterated through 1 keys in the db in 13455ns
I0520 09:49:36.934936 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:36.983641 31692 leveldb.cpp:176] Opened db in 48.651505ms
I0520 09:49:37.028450 31692 leveldb.cpp:183] Compacted db in 44.779885ms
I0520 09:49:37.028483 31692 leveldb.cpp:198] Created db iterator in 5752ns
I0520 09:49:37.028502 31692 leveldb.cpp:204] Seeked to beginning of db in 9693ns
I0520 09:49:37.028520 31692 leveldb.cpp:273] Iterated through 1 keys in the db in 12610ns
I0520 09:49:37.028532 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:37.029027 31718 recover.cpp:425] Starting replica recovery
I0520 09:49:37.029285 31724 recover.cpp:451] Replica is in VOTING status
I0520 09:49:37.029481 31724 recover.cpp:440] Recover process terminated
I0520 09:49:37.031111 31734 registrar.cpp:313] Recovering registrar
I0520 09:49:37.033354 31734 registrar.cpp:346] Successfully fetched the registry (0B)
I0520 09:49:37.033383 31734 registrar.cpp:422] Attempting to update the 'registry'
E0520 09:49:37.041651 31734 registrar.cpp:500] Registrar aborting: Failed to update 'registry': Failed to perform store within 5secs
[       OK ] Strict/RegistrarTest.storeTimeout/0 (338 ms)
[ RUN      ] Strict/RegistrarTest.fetchTimeout/0
Using temporary directory '/tmp/Strict_RegistrarTest_fetchTimeout_0_ckLK5a'
I0520 09:49:37.089289 31692 leveldb.cpp:176] Opened db in 35.284899ms
I0520 09:49:37.101511 31692 leveldb.cpp:183] Compacted db in 12.184912ms
I0520 09:49:37.101539 31692 leveldb.cpp:198] Created db iterator in 4502ns
I0520 09:49:37.101549 31692 leveldb.cpp:204] Seeked to beginning of db in 975ns
I0520 09:49:37.101557 31692 leveldb.cpp:273] Iterated through 0 keys in the db in 310ns
I0520 09:49:37.101575 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:37.113617 31721 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 11.852144ms
I0520 09:49:37.113641 31721 replica.cpp:320] Persisted replica status to VOTING
I0520 09:49:37.154870 31692 leveldb.cpp:176] Opened db in 40.68217ms
I0520 09:49:37.167217 31692 leveldb.cpp:183] Compacted db in 12.323958ms
I0520 09:49:37.167243 31692 leveldb.cpp:198] Created db iterator in 3782ns
I0520 09:49:37.167254 31692 leveldb.cpp:204] Seeked to beginning of db in 666ns
I0520 09:49:37.167261 31692 leveldb.cpp:273] Iterated through 0 keys in the db in 294ns
I0520 09:49:37.167273 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:37.183265 31732 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 15.748195ms
I0520 09:49:37.183289 31732 replica.cpp:320] Persisted replica status to VOTING
I0520 09:49:37.232065 31692 leveldb.cpp:176] Opened db in 48.132755ms
I0520 09:49:37.280910 31692 leveldb.cpp:183] Compacted db in 48.816578ms
I0520 09:49:37.280948 31692 leveldb.cpp:198] Created db iterator in 7435ns
I0520 09:49:37.280971 31692 leveldb.cpp:204] Seeked to beginning of db in 10871ns
I0520 09:49:37.280994 31692 leveldb.cpp:273] Iterated through 1 keys in the db in 15116ns
I0520 09:49:37.281011 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:37.329519 31692 leveldb.cpp:176] Opened db in 48.441229ms
I0520 09:49:37.370400 31692 leveldb.cpp:183] Compacted db in 40.846041ms
I0520 09:49:37.370484 31692 leveldb.cpp:198] Created db iterator in 41816ns
I0520 09:49:37.370508 31692 leveldb.cpp:204] Seeked to beginning of db in 11215ns
I0520 09:49:37.370532 31692 leveldb.cpp:273] Iterated through 1 keys in the db in 14484ns
I0520 09:49:37.370548 31692 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0520 09:49:37.370754 31717 recover.cpp:425] Starting replica recovery
I0520 09:49:37.371062 31731 recover.cpp:451] Replica is in VOTING status
I0520 09:49:37.371345 31731 recover.cpp:440] Recover process terminated
I0520 09:49:37.373803 31712 registrar.cpp:313] Recovering registrar
[       OK ] Strict/RegistrarTest.fetchTimeout/0 (343 ms)
[----------] 16 tests from Strict/RegistrarTest (9915 ms total)

[----------] Global test environment tear-down
[==========] 344 tests from 55 test cases ran. (422832 ms total)
[  PASSED  ] 343 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 3 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/mesos-0.19.0/_build'
make: *** [distcheck] Error 1
Build step 'Execute shell' marked build as failure