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 2017/02/01 22:43:58 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3207
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3207/changes>
Changes:
[xujyan] Perform batching of allocations to reduce allocator queue backlogging.
[xujyan] Dispatch filter expiration twice.
[xujyan] Fix tests with rapidly triggered allocations.
[xujyan] Fixed MasterAllocatorTest/1.RebalancedForUpdatedWeights.
[xujyan] Fixed OversubscriptionTest.RescindRevocableOfferWithIncreasedRevocable.
[xujyan] Added a simple AllocatorBacklog benchmark.
[bmahler] Simplified AppC provisioner cache keys hashing.
[bmahler] Simplified AppC provisioner cache keys comparison.
------------------------------------------
[...truncated 179402 lines...]
I0201 22:43:49.092365 12562 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1281)@172.17.0.2:32992
I0201 22:43:49.092715 12574 authenticator.cpp:98] Creating new server SASL connection
I0201 22:43:49.092952 12571 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0201 22:43:49.092993 12571 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0201 22:43:49.093168 12569 authenticator.cpp:204] Received SASL authentication start
I0201 22:43:49.093233 12569 authenticator.cpp:326] Authentication requires more steps
I0201 22:43:49.093340 12569 authenticatee.cpp:259] Received SASL authentication step
I0201 22:43:49.093483 12573 authenticator.cpp:232] Received SASL authentication step
I0201 22:43:49.093524 12573 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '034d7505ed51' server FQDN: '034d7505ed51' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0201 22:43:49.093551 12573 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0201 22:43:49.093602 12573 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0201 22:43:49.093644 12573 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '034d7505ed51' server FQDN: '034d7505ed51' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0201 22:43:49.093670 12573 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0201 22:43:49.093690 12573 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0201 22:43:49.093719 12573 authenticator.cpp:318] Authentication success
I0201 22:43:49.093823 12569 authenticatee.cpp:299] Authentication success
I0201 22:43:49.093933 12563 master.cpp:7048] Successfully authenticated principal 'test-principal' at slave(683)@172.17.0.2:32992
I0201 22:43:49.094019 12568 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1281)@172.17.0.2:32992
I0201 22:43:49.094398 12565 slave.cpp:1086] Successfully authenticated with master master@172.17.0.2:32992
I0201 22:43:49.094602 12565 slave.cpp:1508] Will retry registration in 15.067504ms if necessary
I0201 22:43:49.094774 12561 master.cpp:5303] Registering agent at slave(683)@172.17.0.2:32992 (034d7505ed51) with id 262b524a-b132-44d4-9010-1a94c5b91b7f-S0
I0201 22:43:49.095124 12563 registrar.cpp:461] Applied 1 operations in 78588ns; attempting to update the registry
I0201 22:43:49.095927 12568 scheduler.cpp:361] Connected with the master at https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.097529 12559 scheduler.cpp:243] Sending SUBSCRIBE call to https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.099217 12563 registrar.cpp:506] Successfully updated the registry in 3.996928ms
I0201 22:43:49.099305 12559 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0201 22:43:49.100268 12560 slave.cpp:4286] Received ping from slave-observer(618)@172.17.0.2:32992
I0201 22:43:49.100451 12560 slave.cpp:1132] Registered with master master@172.17.0.2:32992; given agent ID 262b524a-b132-44d4-9010-1a94c5b91b7f-S0
I0201 22:43:49.100481 12560 fetcher.cpp:90] Clearing fetcher cache
I0201 22:43:49.100399 12559 master.cpp:5377] Registered agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 22:43:49.100662 12574 status_update_manager.cpp:184] Resuming sending status updates
I0201 22:43:49.100926 12560 slave.cpp:1160] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/meta/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/slave.info'
I0201 22:43:49.100913 12569 hierarchical.cpp:479] Added agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 (034d7505ed51) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0201 22:43:49.101177 12569 hierarchical.cpp:1697] No allocations performed
I0201 22:43:49.101238 12569 hierarchical.cpp:1322] Performed allocation for 1 agents in 195800ns
I0201 22:43:49.101383 12560 slave.cpp:1198] Forwarding total oversubscribed resources {}
I0201 22:43:49.101560 12560 master.cpp:5876] Received update of agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51) with total oversubscribed resources {}
I0201 22:43:49.101904 12566 hierarchical.cpp:550] Agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 (034d7505ed51) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {})
I0201 22:43:49.102154 12566 hierarchical.cpp:1697] No allocations performed
I0201 22:43:49.102223 12566 hierarchical.cpp:1322] Performed allocation for 1 agents in 198872ns
I0201 22:43:49.139392 12565 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:51060
I0201 22:43:49.139834 12565 master.cpp:2422] Received subscription request for HTTP framework 'default'
I0201 22:43:49.139873 12565 master.cpp:2159] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0201 22:43:49.140364 12567 master.cpp:2536] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0201 22:43:49.141227 12564 hierarchical.cpp:272] Added framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.141459 12574 master.hpp:2114] Sending heartbeat to 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.142634 12564 hierarchical.cpp:1786] No inverse offers to send out!
I0201 22:43:49.142701 12564 hierarchical.cpp:1322] Performed allocation for 1 agents in 1.356016ms
I0201 22:43:49.143149 12568 master.cpp:6847] Sending 1 offers to framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default)
I0201 22:43:49.178978 12571 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.180851 12564 scheduler.cpp:676] Enqueuing event HEARTBEAT received from https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.181646 12567 scheduler.cpp:676] Enqueuing event OFFERS received from https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.184355 12559 scheduler.cpp:243] Sending ACCEPT call to https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.187150 12568 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0201 22:43:49.227215 12569 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:51061
I0201 22:43:49.229550 12569 master.cpp:3730] Processing ACCEPT call for offers: [ 262b524a-b132-44d4-9010-1a94c5b91b7f-O0 ] on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51) for framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default)
I0201 22:43:49.229673 12569 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 116b0d23-e8e1-4b10-99d7-e8f4b570248a
W0201 22:43:49.232380 12569 validation.cpp:1018] Executor 'default' for task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0201 22:43:49.232422 12569 validation.cpp:1030] Executor 'default' for task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0201 22:43:49.233005 12569 master.cpp:8902] Adding task 116b0d23-e8e1-4b10-99d7-e8f4b570248a with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.233356 12569 master.cpp:4380] Launching task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.233955 12574 slave.cpp:1576] Got assigned task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' for framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.234799 12574 slave.cpp:1736] Launching task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' for framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.237821 12574 paths.cpp:547] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000/executors/default/runs/d58f6015-9b8b-4f61-8c91-513df8d68017' to user 'mesos'
I0201 22:43:49.238142 12574 slave.cpp:6331] Launching executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 with resources {} in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000/executors/default/runs/d58f6015-9b8b-4f61-8c91-513df8d68017'
I0201 22:43:49.238963 12574 slave.cpp:2058] Queued task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' for executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.239050 12574 slave.cpp:882] Successfully attached file '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000/executors/default/runs/d58f6015-9b8b-4f61-8c91-513df8d68017'
I0201 22:43:49.241269 12562 executor.cpp:192] Version: 1.2.0
I0201 22:43:49.263236 12570 executor.cpp:401] Connected with the agent
I0201 22:43:49.263917 12570 executor.cpp:302] Sending SUBSCRIBE call to https://172.17.0.2:32992/slave(683)/api/v1/executor
I0201 22:43:49.264839 12564 process.cpp:3697] Handling HTTP event for process 'slave(683)' with path: '/slave(683)/api/v1/executor'
I0201 22:43:49.302916 12567 http.cpp:303] HTTP POST for /slave(683)/api/v1/executor from 172.17.0.2:51062
I0201 22:43:49.303200 12567 slave.cpp:3109] Received Subscribe request for HTTP executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.304653 12567 slave.cpp:2271] Sending queued task '116b0d23-e8e1-4b10-99d7-e8f4b570248a' to executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (via HTTP)
I0201 22:43:49.343324 12574 executor.cpp:716] Enqueuing event SUBSCRIBED received from https://172.17.0.2:32992/slave(683)/api/v1/executor
I0201 22:43:49.344468 12560 executor.cpp:716] Enqueuing event LAUNCH received from https://172.17.0.2:32992/slave(683)/api/v1/executor
I0201 22:43:49.347597 12567 executor.cpp:302] Sending UPDATE call to https://172.17.0.2:32992/slave(683)/api/v1/executor
I0201 22:43:49.348709 12568 process.cpp:3697] Handling HTTP event for process 'slave(683)' with path: '/slave(683)/api/v1/executor'
I0201 22:43:49.386833 12567 http.cpp:303] HTTP POST for /slave(683)/api/v1/executor from 172.17.0.2:51063
I0201 22:43:49.387055 12567 slave.cpp:3756] Handling status update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.387912 12566 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.387976 12566 status_update_manager.cpp:500] Creating StatusUpdate stream for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.388706 12566 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 to the agent
I0201 22:43:49.389048 12572 slave.cpp:4196] Forwarding the update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 to master@172.17.0.2:32992
I0201 22:43:49.389336 12572 slave.cpp:4090] Status update manager successfully handled status update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.389487 12573 master.cpp:6021] Status update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 from agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.389559 12573 master.cpp:6089] Forwarding status update TASK_RUNNING (UUID: 42debe2a-7805-4ee9-8006-2612ccceb52d) for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.390413 12573 master.cpp:8157] Updating the state of task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0201 22:43:49.390480 12574 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from https://172.17.0.2:32992/slave(683)/api/v1/executor
I0201 22:43:49.392060 12559 scheduler.cpp:676] Enqueuing event UPDATE received from https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.393628 12564 scheduler.cpp:243] Sending TEARDOWN call to https://172.17.0.2:32992/master/api/v1/scheduler
I0201 22:43:49.394868 12565 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0201 22:43:49.435194 12573 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:51061
I0201 22:43:49.435411 12573 master.cpp:7572] Removing framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default)
I0201 22:43:49.435446 12573 master.cpp:3080] Deactivating framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default)
I0201 22:43:49.435627 12561 hierarchical.cpp:387] Deactivated framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.435678 12573 master.cpp:8157] Updating the state of task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0201 22:43:49.435730 12561 slave.cpp:2598] Asked to shut down framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 by master@172.17.0.2:32992
I0201 22:43:49.435775 12561 slave.cpp:2623] Shutting down framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.435837 12561 slave.cpp:5005] Shutting down executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (via HTTP)
I0201 22:43:49.436683 12573 master.cpp:8251] Removing task 116b0d23-e8e1-4b10-99d7-e8f4b570248a with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.437165 12573 master.cpp:8280] Removing executor 'default' with resources {} of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.437399 12561 hierarchical.cpp:1013] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 from framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.438125 12560 hierarchical.cpp:338] Removed framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.438403 12562 executor.cpp:716] Enqueuing event SHUTDOWN received from https://172.17.0.2:32992/slave(683)/api/v1/executor
E0201 22:43:49.438776 12565 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0201 22:43:49.439267 12565 scheduler.cpp:444] Re-detecting master
I0201 22:43:49.439960 12565 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0201 22:43:49.440115 12565 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0201 22:43:49.440274 12565 scheduler.cpp:470] New master detected at master@172.17.0.2:32992
I0201 22:43:49.440318 12565 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0201 22:43:49.444108 12564 slave.cpp:4691] Executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 exited with status 0
I0201 22:43:49.444360 12564 slave.cpp:4791] Cleaning up executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (via HTTP)
W0201 22:43:49.444480 12567 master.cpp:6145] Ignoring unknown exited executor 'default' of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 on agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.444648 12561 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000/executors/default/runs/d58f6015-9b8b-4f61-8c91-513df8d68017' for gc 6.99999485511704days in the future
I0201 22:43:49.444852 12564 slave.cpp:4879] Cleaning up framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.444972 12561 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000/executors/default' for gc 6.99999485238519days in the future
I0201 22:43:49.445010 12559 status_update_manager.cpp:285] Closing status update streams for framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.445067 12559 status_update_manager.cpp:531] Cleaning up status update stream for task 116b0d23-e8e1-4b10-99d7-e8f4b570248a of framework 262b524a-b132-44d4-9010-1a94c5b91b7f-0000
I0201 22:43:49.445109 12561 gc.cpp:55] Scheduling '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_BSxdqJ/slaves/262b524a-b132-44d4-9010-1a94c5b91b7f-S0/frameworks/262b524a-b132-44d4-9010-1a94c5b91b7f-0000' for gc 6.9999948490637days in the future
I0201 22:43:49.445159 12564 slave.cpp:801] Agent terminating
I0201 22:43:49.445482 12566 master.cpp:1263] Agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51) disconnected
I0201 22:43:49.445515 12566 master.cpp:3117] Disconnecting agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.445607 12566 master.cpp:3136] Deactivating agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 at slave(683)@172.17.0.2:32992 (034d7505ed51)
I0201 22:43:49.445777 12567 hierarchical.cpp:579] Agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0 deactivated
I0201 22:43:49.449374 12568 master.cpp:1102] Master terminating
I0201 22:43:49.450224 12565 hierarchical.cpp:512] Removed agent 262b524a-b132-44d4-9010-1a94c5b91b7f-S0
W0201 22:43:49.451067 30566 master.hpp:2528] Failed to close HTTP pipe for 262b524a-b132-44d4-9010-1a94c5b91b7f-0000 (default)
[ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 (609 ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3
W0201 22:43:49.461673 12575 process.cpp:3022] Attempted to spawn a process (__http_connection__(1051)@172.17.0.2:32992) after finalizing libprocess!
*** Aborted at 1485989029 (unix time) try "date -d @1485989029" if you are using GNU date ***
I0201 22:43:49.464251 30566 process.cpp:1246] libprocess is initialized on 172.17.0.2:58906 with 16 worker threads
I0201 22:43:49.465975 30566 cluster.cpp:160] Creating default 'local' authorizer
I0201 22:43:49.468217 12578 master.cpp:383] Master 2c059445-b379-4a7a-b298-14aecf84f4be (034d7505ed51) started on 172.17.0.2:58906
I0201 22:43:49.468252 12578 master.cpp:385] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/RflxHH/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.2.0/_inst/share/mesos/webui" --work_dir="/tmp/RflxHH/master" --zk_session_timeout="10secs"
I0201 22:43:49.468724 12578 master.cpp:435] Master only allowing authenticated frameworks to register
I0201 22:43:49.468744 12578 master.cpp:449] Master only allowing authenticated agents to register
I0201 22:43:49.468755 12578 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0201 22:43:49.468768 12578 credentials.hpp:37] Loading credentials for authentication from '/tmp/RflxHH/credentials'
I0201 22:43:49.469072 12578 master.cpp:507] Using default 'crammd5' authenticator
I0201 22:43:49.469197 12578 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0201 22:43:49.469331 12578 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0201 22:43:49.469456 12578 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0201 22:43:49.469571 12578 master.cpp:587] Authorization enabled
I0201 22:43:49.469754 12589 hierarchical.cpp:152] Initialized hierarchical allocator process
I0201 22:43:49.469769 12590 whitelist_watcher.cpp:77] No whitelist given
I0201 22:43:49.471830 12581 master.cpp:2123] Elected as the leading master!
I0201 22:43:49.471855 12581 master.cpp:1645] Recovering from registrar
I0201 22:43:49.471953 12577 registrar.cpp:329] Recovering registrar
I0201 22:43:49.474025 12587 registrar.cpp:362] Successfully fetched the registry (0B) in 2.011904ms
I0201 22:43:49.474123 12587 registrar.cpp:461] Applied 1 operations in 26043ns; attempting to update the registry
PC: @ 0x2ba09c129158 process::PID<>::PID()
*** SIGSEGV (@0x0) received by PID 30566 (TID 0x2ba0a98a6700) from PID 0; stack trace: ***
I0201 22:43:49.476388 12590 registrar.cpp:506] Successfully updated the registry in 2.20416ms
I0201 22:43:49.476596 12590 registrar.cpp:392] Successfully recovered registrar
@ 0x2ba0f47d9197 (unknown)
I0201 22:43:49.477175 12577 master.cpp:1761] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0201 22:43:49.477236 12582 hierarchical.cpp:179] Skipping recovery of hierarchical allocator: nothing to recover
@ 0x2ba0f47dd479 (unknown)
@ 0x2ba09e9a6330 (unknown)
I0201 22:43:49.482543 30566 cluster.cpp:446] Creating default 'local' authorizer
I0201 22:43:49.483945 12583 slave.cpp:209] Mesos agent started on (684)@172.17.0.2:58906
I0201 22:43:49.483986 12583 slave.cpp:210] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --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/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_BQMq4H"
I0201 22:43:49.484439 12583 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI/credential'
I0201 22:43:49.484452 30566 scheduler.cpp:184] Version: 1.2.0
I0201 22:43:49.484621 12583 slave.cpp:352] Agent using credential for: test-principal
I0201 22:43:49.484648 12583 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_VaxlrI/http_credentials'
I0201 22:43:49.484935 12583 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 22:43:49.484992 12582 scheduler.cpp:470] New master detected at master@172.17.0.2:58906
I0201 22:43:49.485100 12583 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 22:43:49.486743 12583 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 22:43:49.486848 12583 slave.cpp:547] Agent attributes: [ ]
I0201 22:43:49.486865 12583 slave.cpp:552] Agent hostname: 034d7505ed51
I0201 22:43:49.487087 12580 status_update_manager.cpp:177] Pausing sending status updates
I0201 22:43:49.487381 12582 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0201 22:43:49.488703 12587 state.cpp:60] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_BQMq4H/meta'
I0201 22:43:49.488983 12578 status_update_manager.cpp:203] Recovering status update manager
I0201 22:43:49.489356 12585 slave.cpp:5422] Finished recovery
I0201 22:43:49.489796 12585 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 22:43:49.490048 12584 status_update_manager.cpp:177] Pausing sending status updates
I0201 22:43:49.490051 12585 slave.cpp:929] New master detected at master@172.17.0.2:58906
I0201 22:43:49.490111 12585 slave.cpp:964] Detecting new master
I0201 22:43:49.490231 12585 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
@ 0x2ba09c129158 process::PID<>::PID()
@ 0x2ba09c10662c process::Process<>::self()
@ 0x2ba09c0ec12c process::ProcessManager::spawn()
@ 0x2ba09c0f2906 process::spawn()
@ 0x2ba09c02e5ec process::spawn<>()
@ 0x2ba09c02e53b process::http::Connection::Data::Data()
@ 0x2ba09c02e4d6 _ZN9__gnu_cxx13new_allocatorIN7process4http10Connection4DataEE9constructIS4_JRKNS1_7network8internal6SocketINS7_7AddressEEEEEEvPT_DpOT0_
@ 0x2ba09c02e47d _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE12_S_constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS4_PSF_DpOSG_
@ 0x2ba09c02e0d0 _ZNSt16allocator_traitsISaIN7process4http10Connection4DataEEE9constructIS3_JRKNS0_7network8internal6SocketINS7_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS4_PT_DpOSE_
@ 0x2ba09c02dffa _ZNSt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS3_ELN9__gnu_cxx12_Lock_policyE2EEC2IJRKNS0_7network8internal6SocketINS9_7AddressEEEEEES4_DpOT_
@ 0x2ba09c02deab _ZN9__gnu_cxx13new_allocatorISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS5_ELNS_12_Lock_policyE2EEE9constructIS8_JKS6_RKNS2_7network8internal6SocketINSC_7AddressEEEEEEvPT_DpOT0_
@ 0x2ba09c02de12 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE12_S_constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEENSt9enable_ifIXsr18__construct_helperIT_DpT0_EE5valueEvE4typeERS9_PSL_DpOSM_
@ 0x2ba09c02dd05 _ZNSt16allocator_traitsISaISt23_Sp_counted_ptr_inplaceIN7process4http10Connection4DataESaIS4_ELN9__gnu_cxx12_Lock_policyE2EEEE9constructIS8_JKS5_RKNS1_7network8internal6SocketINSD_7AddressEEEEEEDTcl12_S_constructfp_fp0_spclsr3stdE7forwardIT0_Efp1_EEERS9_PT_DpOSK_
@ 0x2ba09c02db78 _ZNSt14__shared_countILN9__gnu_cxx12_Lock_policyE2EEC2IN7process4http10Connection4DataESaIS7_EJRKNS4_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagPT_RKT0_DpOT1_
@ 0x2ba09c02da8f _ZNSt12__shared_ptrIN7process4http10Connection4DataELN9__gnu_cxx12_Lock_policyE2EEC2ISaIS3_EJRKNS0_7network8internal6SocketINS9_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x2ba09c02da1d _ZNSt10shared_ptrIN7process4http10Connection4DataEEC2ISaIS3_EJRKNS0_7network8internal6SocketINS7_7AddressEEEEEESt19_Sp_make_shared_tagRKT_DpOT0_
@ 0x2ba09c02d95f _ZSt15allocate_sharedIN7process4http10Connection4DataESaIS3_EJRKNS0_7network8internal6SocketINS5_7AddressEEEEESt10shared_ptrIT_ERKT0_DpOT1_
@ 0x2ba09c007e2d _ZSt11make_sharedIN7process4http10Connection4DataEJRKNS0_7network8internal6SocketINS4_7AddressEEEEESt10shared_ptrIT_EDpOT0_
@ 0x2ba09bfc8a4d process::http::Connection::Connection()
@ 0x2ba09bffd47f process::http::connect()::$_1::operator()()
@ 0x2ba09bffd1ff std::_Function_handler<>::_M_invoke()
@ 0x2ba09b38c1bd std::function<>::operator()()
@ 0x2ba09b38c160 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEE6__callIS5_JRK7NothingEJEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x2ba09b38c115 _ZNSt5_BindIFSt8functionIFN7process6FutureINS1_4http10ConnectionEEEvEEvEEclIJRK7NothingES5_EET0_DpOT_
@ 0x2ba09b38bdb4 std::_Function_handler<>::_M_invoke()
@ 0x2ba09b38de2a std::function<>::operator()()
@ 0x2ba09b38c9f1 process::internal::thenf<>()
@ 0x2ba09b38d6c3 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEE6__callIvJSL_EJLm0ELm1ELm2EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x2ba09b38d606 _ZNSt5_BindIFPFvRKSt8functionIFN7process6FutureINS1_4http10ConnectionEEERK7NothingEERKSt10shared_ptrINS1_7PromiseIS4_EEERKNS2_IS6_EEESA_SG_St12_PlaceholderILi1EEEEclIJSL_EvEET0_DpOT_
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1485986616-27503
Untagged: mesos-1485986616-27503:latest
Deleted: sha256:fa5cf31826fe225f78cab2c76de7faa5408b22318c24863a08fabda1df82954f
Deleted: sha256:a6f7aec6d3dabf880258d552be5ee6a4c0ae30dd5520cd8536285bdaa114eb67
Deleted: sha256:781ffb981b7f583f2ffd2a70ab18761db7f8cd63f6b2b496784617981e9a3787
Deleted: sha256:af4380c1d7b2b23122134e2d5cda500bce87d24dd31da0fd111acd3e0fe159b9
Deleted: sha256:45aecb46a951df53a83eb98953b7bdf0c5886875b3608f3bc75455f781506f8e
Deleted: sha256:486c78b4a4291faea590ebab1d24308aa2b1f3df3a9de667d2ea8e649366fe15
Deleted: sha256:8953a7eb0f46ea2c025e2493076bffc7c2bc61e0683dd2c5dc3e9517aac54637
Deleted: sha256:76a359ec41b7d44599bddd173e0af1b2ef99cc83cf88bc85ae34bae4ffb01a9b
Deleted: sha256:cc864391983f508663c4240ba7ed9a9c23c1d3fb31a9364927550f50d6801d43
Deleted: sha256:f4383827af214365ac7b11f31a75298e74b085cf5885ec02c910134f38a12aa9
Deleted: sha256:42f974efbbc66e29b03dbf9a365149ae62e5b3f43c1125b2e41602a47799c02c
Deleted: sha256:e14014d6f4687fff2190f7389e60d05d3b0a5f29e8219da1bd31e1ca4158782f
Deleted: sha256:92db50bc6ffe0f0462557e1e11376a5235fcfeb56ef1ec64ed7c14265123028f
Deleted: sha256:839acdc72fda462b0808cdd8ca843cb0142f0a90b894557dc3f3cb7c80235aaf
Deleted: sha256:84430ebee0f14088fcc02fe7e571e05b6e7d4d4c77845610d28d6daae9883ee8
Deleted: sha256:b49412189d6d4b5066690158f75afede1a1c47b1fb92cccc7f11056e3cd130c9
Deleted: sha256:594909a26480679fdd41fa1afa3d30bbbb9de20c8e89c162fce525b62ab8acee
Deleted: sha256:cd4e3976ff64bdf13b447e1cc9e5cad408b20b89cb08d509f9e18de49c7e0e6f
Deleted: sha256:b339f68f299258cd24439ff4cfe12a2829f30916c641300a0f643fc1c1ef1515
Deleted: sha256:838c0923c4e2048bcc12fc31d26384137c7e4f3f214c962611a8080ab79e2e71
Deleted: sha256:841aa4b974adcedc4571dce0ce74d1b4fad32df2380f705b20cda7ea27303b55
Deleted: sha256:5cf86777a5357be537eba079316abcadcc32c2367c736e822ea574d43d8f9d69
Deleted: sha256:62239d23ee59b0f0e67407f0dd9f70d815389814d1a38ce5d6a4e9f4e78d410f
Deleted: sha256:f909b339a957b036a8f1fe96df8c2d1e30891dbdbcc699fc13e04ee7aebc12a7
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » autotools,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3208
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3208/changes>