You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2015/06/04 02:14:25 UTC
Build failed in Jenkins: Mesos » gcc,docker||Hadoop,centos:7 #305
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,LABEL=docker%7C%7CHadoop,OS=centos%3A7/305/changes>
Changes:
[benjamin.mahler] Fixed a deadlock in libprocess Metrics initialization.
[benjamin.mahler] Print executor status consistently in the example frameworks.
------------------------------------------
[...truncated 33986 lines...]
I0604 00:13:57.864814 26145 replica.cpp:323] Persisted replica status to STARTING
I0604 00:13:57.864591 26137 master.cpp:365] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="true" --authenticate_slaves="true" --authenticators="crammd5" --credentials="/tmp/FetcherCacheTest_FallbackFromEviction_RyKlsv/credentials" --framework_sorter="drf" --help="false" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.23.0/_inst/share/mesos/webui" --work_dir="/tmp/FetcherCacheTest_FallbackFromEviction_RyKlsv/master" --zk_session_timeout="10secs"
I0604 00:13:57.864989 26137 master.cpp:410] Master only allowing authenticated frameworks to register
I0604 00:13:57.865012 26137 master.cpp:415] Master only allowing authenticated slaves to register
I0604 00:13:57.865031 26137 credentials.hpp:37] Loading credentials for authentication from '/tmp/FetcherCacheTest_FallbackFromEviction_RyKlsv/credentials'
I0604 00:13:57.865069 26141 recover.cpp:475] Replica is in STARTING status
I0604 00:13:57.865378 26137 master.cpp:454] Using default 'crammd5' authenticator
I0604 00:13:57.865555 26137 master.cpp:491] Authorization enabled
I0604 00:13:57.865864 26145 hierarchical.hpp:305] Initialized hierarchical allocator process
I0604 00:13:57.865870 26151 whitelist_watcher.cpp:79] No whitelist given
I0604 00:13:57.866044 26144 replica.cpp:641] Replica in STARTING status received a broadcasted recover request
I0604 00:13:57.866546 26142 recover.cpp:195] Received a recover response from a replica in STARTING status
I0604 00:13:57.867136 26145 recover.cpp:566] Updating replica status to VOTING
I0604 00:13:57.867415 26137 master.cpp:1474] The newly elected leader is master@172.17.0.168:45522 with id 20150604-001357-2818576812-45522-26118
I0604 00:13:57.867465 26137 master.cpp:1487] Elected as the leading master!
I0604 00:13:57.867497 26137 master.cpp:1257] Recovering from registrar
I0604 00:13:57.867668 26145 registrar.cpp:313] Recovering registrar
I0604 00:13:57.867794 26139 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 437321ns
I0604 00:13:57.867826 26139 replica.cpp:323] Persisted replica status to VOTING
I0604 00:13:57.867988 26141 recover.cpp:580] Successfully joined the Paxos group
I0604 00:13:57.868237 26141 recover.cpp:464] Recover process terminated
I0604 00:13:57.868661 26143 log.cpp:661] Attempting to start the writer
I0604 00:13:57.869912 26144 replica.cpp:477] Replica received implicit promise request with proposal 1
I0604 00:13:57.870357 26144 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 408206ns
I0604 00:13:57.870385 26144 replica.cpp:345] Persisted promised to 1
I0604 00:13:57.871109 26141 coordinator.cpp:230] Coordinator attemping to fill missing position
I0604 00:13:57.872333 26143 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2
I0604 00:13:57.872992 26143 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 615117ns
I0604 00:13:57.873023 26143 replica.cpp:679] Persisted action at 0
I0604 00:13:57.874259 26138 replica.cpp:511] Replica received write request for position 0
I0604 00:13:57.874325 26138 leveldb.cpp:438] Reading position from leveldb took 32104ns
I0604 00:13:57.874922 26138 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 552151ns
I0604 00:13:57.874951 26138 replica.cpp:679] Persisted action at 0
I0604 00:13:57.875696 26143 replica.cpp:658] Replica received learned notice for position 0
I0604 00:13:57.876068 26143 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 331029ns
I0604 00:13:57.876101 26143 replica.cpp:679] Persisted action at 0
I0604 00:13:57.876137 26143 replica.cpp:664] Replica learned NOP action at position 0
I0604 00:13:57.876891 26147 log.cpp:677] Writer started with ending position 0
I0604 00:13:57.878204 26150 leveldb.cpp:438] Reading position from leveldb took 33292ns
I0604 00:13:57.881292 26151 registrar.cpp:346] Successfully fetched the registry (0B) in 13.552128ms
I0604 00:13:57.881438 26151 registrar.cpp:445] Applied 1 operations in 27867ns; attempting to update the 'registry'
I0604 00:13:57.884443 26149 log.cpp:685] Attempting to append 131 bytes to the log
I0604 00:13:57.884598 26146 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0604 00:13:57.885589 26147 replica.cpp:511] Replica received write request for position 1
I0604 00:13:57.886070 26147 leveldb.cpp:343] Persisting action (150 bytes) to leveldb took 422463ns
I0604 00:13:57.886102 26147 replica.cpp:679] Persisted action at 1
I0604 00:13:57.886904 26140 replica.cpp:658] Replica received learned notice for position 1
I0604 00:13:57.887302 26140 leveldb.cpp:343] Persisting action (152 bytes) to leveldb took 365740ns
I0604 00:13:57.887333 26140 replica.cpp:679] Persisted action at 1
I0604 00:13:57.887356 26140 replica.cpp:664] Replica learned APPEND action at position 1
I0604 00:13:57.888231 26150 registrar.cpp:490] Successfully updated the 'registry' in 6.726912ms
I0604 00:13:57.888411 26150 registrar.cpp:376] Successfully recovered registrar
I0604 00:13:57.888489 26138 log.cpp:704] Attempting to truncate the log to 1
I0604 00:13:57.888701 26146 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0604 00:13:57.888763 26137 master.cpp:1284] Recovered 0 slaves from the Registry (95B) ; allowing 10mins for slaves to re-register
I0604 00:13:57.889688 26140 replica.cpp:511] Replica received write request for position 2
I0604 00:13:57.890101 26140 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 370408ns
I0604 00:13:57.890133 26140 replica.cpp:679] Persisted action at 2
I0604 00:13:57.890775 26149 replica.cpp:658] Replica received learned notice for position 2
I0604 00:13:57.891203 26149 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 394285ns
I0604 00:13:57.891266 26149 leveldb.cpp:401] Deleting ~1 keys from leveldb took 31804ns
I0604 00:13:57.891291 26149 replica.cpp:679] Persisted action at 2
I0604 00:13:57.891314 26149 replica.cpp:664] Replica learned TRUNCATE action at position 2
I0604 00:13:57.903628 26118 containerizer.cpp:111] Using isolation: posix/cpu,posix/mem
I0604 00:13:57.909584 26146 slave.cpp:185] Slave started on 44)@172.17.0.168:45522
I0604 00:13:57.909606 26146 slave.cpp:186] Flags at startup: --authenticatee="crammd5" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_remove_delay="6hrs" --docker_sandbox_directory="/mnt/mesos/sandbox" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8/fetch" --fetcher_cache_size="40B" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-0.23.0/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resource_monitoring_interval="1secs" --resources="cpus(*):1000; mem(*):1000" --revocable_cpu_low_priority="true" --strict="true" --switch_user="true" --version="false" --work_dir="/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8"
I0604 00:13:57.909987 26146 credentials.hpp:85] Loading credential for authentication from '/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8/credential'
I0604 00:13:57.910210 26146 slave.cpp:316] Slave using credential for: test-principal
I0604 00:13:57.910539 26146 slave.cpp:341] Slave resources: cpus(*):1000; mem(*):1000; disk(*):3.70122e+06; ports(*):[31000-32000]
I0604 00:13:57.910632 26146 slave.cpp:371] Slave hostname: 32000eec7ab0
I0604 00:13:57.910646 26146 slave.cpp:376] Slave checkpoint: true
I0604 00:13:57.911808 26145 state.cpp:35] Recovering state from '/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8/meta'
I0604 00:13:57.912238 26144 status_update_manager.cpp:197] Recovering status update manager
I0604 00:13:57.912575 26149 containerizer.cpp:312] Recovering containerizer
I0604 00:13:57.913761 26148 slave.cpp:3939] Finished recovery
I0604 00:13:57.914543 26148 slave.cpp:4096] Received a new estimation of the oversubscribable resources
I0604 00:13:57.914880 26148 slave.cpp:667] New master detected at master@172.17.0.168:45522
I0604 00:13:57.914950 26140 status_update_manager.cpp:171] Pausing sending status updates
I0604 00:13:57.915014 26148 slave.cpp:730] Authenticating with master master@172.17.0.168:45522
I0604 00:13:57.915048 26148 slave.cpp:735] Using default CRAM-MD5 authenticatee
I0604 00:13:57.915230 26148 slave.cpp:703] Detecting new master
I0604 00:13:57.915302 26149 authenticatee.hpp:139] Creating new client SASL connection
I0604 00:13:57.915616 26138 master.cpp:4165] Authenticating slave(44)@172.17.0.168:45522
I0604 00:13:57.915849 26139 authenticator.cpp:406] Starting authentication session for crammd5_authenticatee(134)@172.17.0.168:45522
I0604 00:13:57.916156 26146 authenticator.cpp:92] Creating new server SASL connection
I0604 00:13:57.916458 26152 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5
I0604 00:13:57.916497 26152 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5'
I0604 00:13:57.916615 26145 authenticator.cpp:197] Received SASL authentication start
I0604 00:13:57.916692 26145 authenticator.cpp:319] Authentication requires more steps
I0604 00:13:57.916787 26145 authenticatee.hpp:276] Received SASL authentication step
I0604 00:13:57.916972 26151 authenticator.cpp:225] Received SASL authentication step
I0604 00:13:57.917013 26151 auxprop.cpp:101] Request to lookup properties for user: 'test-principal' realm: '32000eec7ab0' server FQDN: '32000eec7ab0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0604 00:13:57.917029 26151 auxprop.cpp:173] Looking up auxiliary property '*userPassword'
I0604 00:13:57.917079 26151 auxprop.cpp:173] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0604 00:13:57.917116 26151 auxprop.cpp:101] Request to lookup properties for user: 'test-principal' realm: '32000eec7ab0' server FQDN: '32000eec7ab0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0604 00:13:57.917130 26151 auxprop.cpp:123] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0604 00:13:57.917140 26151 auxprop.cpp:123] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0604 00:13:57.917157 26151 authenticator.cpp:311] Authentication success
I0604 00:13:57.917304 26140 authenticatee.hpp:316] Authentication success
I0604 00:13:57.917320 26146 master.cpp:4195] Successfully authenticated principal 'test-principal' at slave(44)@172.17.0.168:45522
I0604 00:13:57.917398 26150 authenticator.cpp:424] Authentication session cleanup for crammd5_authenticatee(134)@172.17.0.168:45522
I0604 00:13:57.917682 26147 slave.cpp:801] Successfully authenticated with master master@172.17.0.168:45522
I0604 00:13:57.917883 26147 slave.cpp:1135] Will retry registration in 17.287847ms if necessary
I0604 00:13:57.918084 26146 master.cpp:3147] Registering slave at slave(44)@172.17.0.168:45522 (32000eec7ab0) with id 20150604-001357-2818576812-45522-26118-S0
I0604 00:13:57.918516 26139 registrar.cpp:445] Applied 1 operations in 53782ns; attempting to update the 'registry'
I0604 00:13:57.920763 26141 log.cpp:685] Attempting to append 305 bytes to the log
I0604 00:13:57.920933 26151 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
I0604 00:13:57.921979 26138 replica.cpp:511] Replica received write request for position 3
I0604 00:13:57.922266 26138 leveldb.cpp:343] Persisting action (324 bytes) to leveldb took 240632ns
I0604 00:13:57.922302 26138 replica.cpp:679] Persisted action at 3
I0604 00:13:57.923074 26141 replica.cpp:658] Replica received learned notice for position 3
I0604 00:13:57.923568 26141 leveldb.cpp:343] Persisting action (326 bytes) to leveldb took 455953ns
I0604 00:13:57.923598 26141 replica.cpp:679] Persisted action at 3
I0604 00:13:57.923621 26141 replica.cpp:664] Replica learned APPEND action at position 3
I0604 00:13:57.924696 26137 registrar.cpp:490] Successfully updated the 'registry' in 6.09792ms
I0604 00:13:57.924942 26146 log.cpp:704] Attempting to truncate the log to 3
I0604 00:13:57.925145 26149 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
I0604 00:13:57.925590 26150 slave.cpp:2884] Received ping from slave-observer(43)@172.17.0.168:45522
I0604 00:13:57.925739 26140 master.cpp:3204] Registered slave 20150604-001357-2818576812-45522-26118-S0 at slave(44)@172.17.0.168:45522 (32000eec7ab0) with cpus(*):1000; mem(*):1000; disk(*):3.70122e+06; ports(*):[31000-32000]
I0604 00:13:57.925999 26150 slave.cpp:835] Registered with master master@172.17.0.168:45522; given slave ID 20150604-001357-2818576812-45522-26118-S0
I0604 00:13:57.925976 26148 hierarchical.hpp:473] Added slave 20150604-001357-2818576812-45522-26118-S0 (32000eec7ab0) with cpus(*):1000; mem(*):1000; disk(*):3.70122e+06; ports(*):[31000-32000] (and cpus(*):1000; mem(*):1000; disk(*):3.70122e+06; ports(*):[31000-32000] available)
I0604 00:13:57.926039 26150 fetcher.cpp:77] Clearing fetcher cache
I0604 00:13:57.926206 26146 status_update_manager.cpp:178] Resuming sending status updates
I0604 00:13:57.926209 26148 hierarchical.hpp:910] No resources available to allocate!
I0604 00:13:57.926259 26148 hierarchical.hpp:829] Performed allocation for slave 20150604-001357-2818576812-45522-26118-S0 in 203882ns
I0604 00:13:57.926352 26143 replica.cpp:511] Replica received write request for position 4
I0604 00:13:57.926506 26150 slave.cpp:858] Checkpointing SlaveInfo to '/tmp/FetcherCacheTest_FallbackFromEviction_d9Fby8/meta/slaves/20150604-001357-2818576812-45522-26118-S0/slave.info'
I0604 00:13:57.926985 26143 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 587871ns
I0604 00:13:57.927021 26143 replica.cpp:679] Persisted action at 4
I0604 00:13:57.927698 26144 replica.cpp:658] Replica received learned notice for position 4
I0604 00:13:57.928112 26144 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 378509ns
I0604 00:13:57.928180 26144 leveldb.cpp:401] Deleting ~2 keys from leveldb took 39177ns
I0604 00:13:57.928208 26144 replica.cpp:679] Persisted action at 4
I0604 00:13:57.928230 26144 replica.cpp:664] Replica learned TRUNCATE action at position 4
I0604 00:13:57.929491 26118 sched.cpp:157] Version: 0.23.0
I0604 00:13:57.929972 26138 sched.cpp:254] New master detected at master@172.17.0.168:45522
I0604 00:13:57.930057 26138 sched.cpp:310] Authenticating with master master@172.17.0.168:45522
I0604 00:13:57.930081 26138 sched.cpp:317] Using default CRAM-MD5 authenticatee
I0604 00:13:57.930224 26143 authenticatee.hpp:139] Creating new client SASL connection
I0604 00:13:57.930459 26140 master.cpp:4165] Authenticating scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522
I0604 00:13:57.930557 26138 authenticator.cpp:406] Starting authentication session for crammd5_authenticatee(135)@172.17.0.168:45522
I0604 00:13:57.930794 26144 authenticator.cpp:92] Creating new server SASL connection
I0604 00:13:57.931022 26152 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5
I0604 00:13:57.931059 26152 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5'
I0604 00:13:57.931169 26151 authenticator.cpp:197] Received SASL authentication start
I0604 00:13:57.931228 26151 authenticator.cpp:319] Authentication requires more steps
I0604 00:13:57.931321 26151 authenticatee.hpp:276] Received SASL authentication step
I0604 00:13:57.931453 26152 authenticator.cpp:225] Received SASL authentication step
I0604 00:13:57.931490 26152 auxprop.cpp:101] Request to lookup properties for user: 'test-principal' realm: '32000eec7ab0' server FQDN: '32000eec7ab0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0604 00:13:57.931505 26152 auxprop.cpp:173] Looking up auxiliary property '*userPassword'
I0604 00:13:57.931548 26152 auxprop.cpp:173] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0604 00:13:57.931581 26152 auxprop.cpp:101] Request to lookup properties for user: 'test-principal' realm: '32000eec7ab0' server FQDN: '32000eec7ab0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0604 00:13:57.931596 26152 auxprop.cpp:123] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0604 00:13:57.931609 26152 auxprop.cpp:123] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0604 00:13:57.931627 26152 authenticator.cpp:311] Authentication success
I0604 00:13:57.931721 26148 authenticatee.hpp:316] Authentication success
I0604 00:13:57.931825 26149 authenticator.cpp:424] Authentication session cleanup for crammd5_authenticatee(135)@172.17.0.168:45522
I0604 00:13:57.932000 26143 master.cpp:4195] Successfully authenticated principal 'test-principal' at scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522
I0604 00:13:57.932186 26146 sched.cpp:398] Successfully authenticated with master master@172.17.0.168:45522
I0604 00:13:57.932214 26146 sched.cpp:521] Sending registration request to master@172.17.0.168:45522
I0604 00:13:57.932276 26146 sched.cpp:554] Will retry registration in 1.411403788secs if necessary
I0604 00:13:57.932358 26140 master.cpp:1714] Received registration request for framework 'default' at scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522
W0604 00:13:57.932426 26140 master.cpp:1537] Framework at scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522 (authenticated as 'test-principal') does not specify principal in its FrameworkInfo
I0604 00:13:57.932484 26140 master.cpp:1553] Authorizing framework principal '' to receive offers for role '*'
I0604 00:13:57.932862 26152 master.cpp:1781] Registering framework 20150604-001357-2818576812-45522-26118-0000 (default) at scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522
I0604 00:13:57.933190 26143 hierarchical.hpp:350] Added framework 20150604-001357-2818576812-45522-26118-0000
I0604 00:13:57.933316 26145 sched.cpp:448] Framework registered with 20150604-001357-2818576812-45522-26118-0000
I0604 00:13:57.933369 26145 sched.cpp:462] Scheduler::registered took 21789ns
I0604 00:13:57.933713 26143 hierarchical.hpp:811] Performed allocation for 1 slaves in 492347ns
I0604 00:13:57.934100 26152 master.cpp:4084] Sending 1 offers to framework 20150604-001357-2818576812-45522-26118-0000 (default) at scheduler-4d2edbf1-c17a-4279-bd7e-c90bd4d328ff@172.17.0.168:45522
GMOCK WARNING:
Uninteresting mock function call - returning directly.
Function call: resourceOffers(0x37b0e90, @0x7fc66e83aa40 { 128-byte object <90-91 2A-7D C6-7F 00-00 00-00 00-00 00-00 00-00 20-8D 00-38 C6-7F 00-00 80-25 00-38 C6-7F 00-00 00-26 00-38 C6-7F 00-00 90-8E 00-38 C6-7F 00-00 70-17 00-38 C6-7F 00-00 04-00 00-00 04-00 00-00 04-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00 0F-00 00-00> })
Stack trace:
I0604 00:13:57.934567 26143 sched.cpp:611] Scheduler::resourceOffers took 148320ns
I0604 00:13:58.867086 26139 hierarchical.hpp:910] No resources available to allocate!
I0604 00:13:58.867141 26139 hierarchical.hpp:811] Performed allocation for 1 slaves in 480940ns
I0604 00:13:58.916224 26148 slave.cpp:4131] Not forwarding total oversubscribed resources because the previous estimate hasn't changed
I0604 00:13:59.868926 26142 hierarchical.hpp:910] No resources available to allocate!
I0604 00:13:59.868993 26142 hierarchical.hpp:811] Performed allocation for 1 slaves in 498435ns
I0604 00:14:00.870266 26147 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:00.870324 26147 hierarchical.hpp:811] Performed allocation for 1 slaves in 425056ns
I0604 00:14:01.871268 26137 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:01.871312 26137 hierarchical.hpp:811] Performed allocation for 1 slaves in 349784ns
I0604 00:14:02.872365 26148 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:02.872418 26148 hierarchical.hpp:811] Performed allocation for 1 slaves in 335942ns
I0604 00:14:03.873458 26142 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:03.873513 26142 hierarchical.hpp:811] Performed allocation for 1 slaves in 435844ns
I0604 00:14:04.875128 26148 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:04.875183 26148 hierarchical.hpp:811] Performed allocation for 1 slaves in 546875ns
I0604 00:14:05.876497 26147 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:05.876561 26147 hierarchical.hpp:811] Performed allocation for 1 slaves in 428850ns
I0604 00:14:06.877643 26148 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:06.877686 26148 hierarchical.hpp:811] Performed allocation for 1 slaves in 340752ns
I0604 00:14:07.878295 26149 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:07.878345 26149 hierarchical.hpp:811] Performed allocation for 1 slaves in 332043ns
I0604 00:14:08.879600 26144 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:08.879645 26144 hierarchical.hpp:811] Performed allocation for 1 slaves in 376973ns
I0604 00:14:09.880565 26150 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:09.880620 26150 hierarchical.hpp:811] Performed allocation for 1 slaves in 412875ns
I0604 00:14:10.881678 26145 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:10.881744 26145 hierarchical.hpp:811] Performed allocation for 1 slaves in 419521ns
I0604 00:14:11.882657 26144 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:11.882707 26144 hierarchical.hpp:811] Performed allocation for 1 slaves in 398933ns
I0604 00:14:12.883868 26148 hierarchical.hpp:910] No resources available to allocate!
I0604 00:14:12.883921 26148 hierarchical.hpp:811] Performed allocation for 1 slaves in 456650ns
I0604 00:14:12.926882 26137 slave.cpp:2884] Received ping from slave-observer(43)@172.17.0.168:45522
F0604 00:14:12.947424 26118 fetcher_cache_tests.cpp:354] CHECK_READY(offers): is PENDING Failed to wait for resource offers
*** Check failure stack trace: ***
@ 0x7fc67c612b9a google::LogMessage::Fail()
@ 0x7fc67c612af9 google::LogMessage::SendToLog()
@ 0x7fc67c61250a google::LogMessage::Flush()
@ 0x7fc67c61523e google::LogMessageFatal::~LogMessageFatal()
@ 0x96f3b8 _CheckFatal::~_CheckFatal()
@ 0xb4541a mesos::internal::tests::FetcherCacheTest::launchTask()
@ 0xb5390f mesos::internal::tests::FetcherCacheTest_FallbackFromEviction_Test::TestBody()
@ 0x1158121 testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x115331e testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x113b747 testing::Test::Run()
@ 0x113be6a testing::TestInfo::Run()
@ 0x113c3f2 testing::TestCase::Run()
@ 0x114116e testing::internal::UnitTestImpl::RunAllTests()
@ 0x1158f93 testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x115400f testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x114001e testing::UnitTest::Run()
@ 0xcb2aa0 main
@ 0x7fc677a67af5 __libc_start_main
@ 0x867419 (unknown)
make[4]: *** [check-local] Aborted
make[4]: Leaving directory `/mesos/mesos-0.23.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.23.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.23.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.23.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1433375776-21238
Untagged: mesos-1433375776-21238:latest
Deleted: 81d0208b2def6048b64cf805250f33f95ecf79376c9a0df3e63529f9adda7c77
Deleted: a2cfbca8ba286c873f77053a3df6e5d86bd9faffacb9f0118fd71ca903604b7e
Deleted: a89de86c19fdc898d28ba711de28e24a5c41361ee86da42af844f698311df526
Deleted: 59052ae9aa627b5ae7d74b724bec10a913c3be97f8c6a277280a3405ebd06201
Deleted: 3dfb9c5bd9735b953e09835c85b8d797fe18474923f24ef49b77ef978c1bc59b
Deleted: d9dea7600e21017b9bd98c187c549cdd2e8c01df746992650b182305a46f90f1
Deleted: c04441b34b7b26410d21b03760241313cfe836d414f566cd3a9c23bab61a394a
Deleted: 578b2d8c661b5fb7d5cb209b81127aa26410d045c33ce83b2d1e2849a488323f
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,docker||Hadoop,centos:7 #306
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,LABEL=docker%7C%7CHadoop,OS=centos%3A7/306/changes>