mesos-builds mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Reviewbot #18910
Date Fri, 18 Aug 2017 11:25:13 GMT
See <https://builds.apache.org/job/Mesos-Reviewbot/18910/display/redirect>

------------------------------------------
[...truncated 6.80 MB...]
I0818 11:25:06.821988  5268 master.cpp:442] Master fd4a2a33-1eae-47c5-a865-3f540ff0793b (f6f56aab5b6d)
started on 172.17.0.3:36793
I0818 11:25:06.822028  5268 master.cpp:444] 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/ZSFwVi/credentials" --filter_gpu_resources="true"
--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" --port="5050"
--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.5.0/_inst/share/mesos/webui" --work_dir="/tmp/ZSFwVi/master"
--zk_session_timeout="10secs"
I0818 11:25:06.822544  5268 master.cpp:494] Master only allowing authenticated frameworks
to register
I0818 11:25:06.822564  5268 master.cpp:508] Master only allowing authenticated agents to register
I0818 11:25:06.822587  5268 master.cpp:521] Master only allowing authenticated HTTP frameworks
to register
I0818 11:25:06.822602  5268 credentials.hpp:37] Loading credentials for authentication from
'/tmp/ZSFwVi/credentials'
I0818 11:25:06.823021  5268 master.cpp:566] Using default 'crammd5' authenticator
I0818 11:25:06.823254  5268 http.cpp:1026] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0818 11:25:06.823439  5268 http.cpp:1026] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0818 11:25:06.823563  5268 http.cpp:1026] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0818 11:25:06.823683  5268 master.cpp:646] Authorization enabled
I0818 11:25:06.823892  5264 hierarchical.cpp:171] Initialized hierarchical allocator process
I0818 11:25:06.824153  5266 whitelist_watcher.cpp:77] No whitelist given
I0818 11:25:06.827783  5269 master.cpp:2163] Elected as the leading master!
I0818 11:25:06.827817  5269 master.cpp:1702] Recovering from registrar
I0818 11:25:06.828137  5264 registrar.cpp:347] Recovering registrar
I0818 11:25:06.828915  5264 registrar.cpp:391] Successfully fetched the registry (0B) in 725248ns
I0818 11:25:06.829061  5264 registrar.cpp:495] Applied 1 operations in 34798ns; attempting
to update the registry
I0818 11:25:06.829823  5264 registrar.cpp:552] Successfully updated the registry in 689152ns
I0818 11:25:06.829965  5264 registrar.cpp:424] Successfully recovered registrar
I0818 11:25:06.830456  5267 master.cpp:1801] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0818 11:25:06.830572  5265 hierarchical.cpp:209] Skipping recovery of hierarchical allocator:
nothing to recover
I0818 11:25:06.838724  5243 process.cpp:3228] Attempting to spawn already spawned process
files@172.17.0.3:36793
I0818 11:25:06.839365  5243 cluster.cpp:448] Creating default 'local' authorizer
I0818 11:25:06.842604  5263 slave.cpp:250] Mesos agent started on (63)@172.17.0.3:36793
I0818 11:25:06.842648  5263 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/FaultToleranceTest_SchedulerExit_73OdYs/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/FaultToleranceTest_SchedulerExit_73OdYs/credential"
--default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/FaultToleranceTest_SchedulerExit_73OdYs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume"
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs"
--executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/FaultToleranceTest_SchedulerExit_73OdYs/fetch"
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/FaultToleranceTest_SchedulerExit_73OdYs/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
--launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_build/src" --logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs"
--perf_duration="10secs" --perf_interval="1mins" --port="5051" --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/FaultToleranceTest_SchedulerExit_73OdYs" --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/FaultToleranceTest_SchedulerExit_0ZtRWn"
I0818 11:25:06.843570  5263 credentials.hpp:86] Loading credential for authentication from
'/tmp/FaultToleranceTest_SchedulerExit_73OdYs/credential'
I0818 11:25:06.843610  5243 process.cpp:3228] Attempting to spawn already spawned process
version@172.17.0.3:36793
I0818 11:25:06.843816  5263 slave.cpp:283] Agent using credential for: test-principal
I0818 11:25:06.843879  5263 credentials.hpp:37] Loading credentials for authentication from
'/tmp/FaultToleranceTest_SchedulerExit_73OdYs/http_credentials'
I0818 11:25:06.844691  5263 http.cpp:1026] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0818 11:25:06.845213  5263 http.cpp:1026] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0818 11:25:06.845851  5243 sched.cpp:232] Version: 1.5.0
I0818 11:25:06.846609  5266 sched.cpp:336] New master detected at master@172.17.0.3:36793
I0818 11:25:06.846786  5266 sched.cpp:407] Authenticating with master master@172.17.0.3:36793
I0818 11:25:06.846807  5266 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0818 11:25:06.847337  5268 authenticatee.cpp:121] Creating new client SASL connection
I0818 11:25:06.847879  5267 master.cpp:7837] Authenticating scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.848011  5264 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(139)@172.17.0.3:36793
I0818 11:25:06.847765  5263 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0818 11:25:06.848207  5263 slave.cpp:573] Agent attributes: [  ]
I0818 11:25:06.848232  5263 slave.cpp:582] Agent hostname: f6f56aab5b6d
I0818 11:25:06.848374  5266 authenticator.cpp:98] Creating new server SASL connection
I0818 11:25:06.848732  5265 status_update_manager.cpp:177] Pausing sending status updates
I0818 11:25:06.848743  5266 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0818 11:25:06.848794  5266 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0818 11:25:06.848901  5266 authenticator.cpp:204] Received SASL authentication start
I0818 11:25:06.848958  5266 authenticator.cpp:326] Authentication requires more steps
I0818 11:25:06.849072  5268 authenticatee.cpp:259] Received SASL authentication step
I0818 11:25:06.849200  5268 authenticator.cpp:232] Received SASL authentication step
I0818 11:25:06.849236  5268 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: 'f6f56aab5b6d' server FQDN: 'f6f56aab5b6d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0818 11:25:06.849259  5268 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0818 11:25:06.849310  5268 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0818 11:25:06.849345  5268 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: 'f6f56aab5b6d' server FQDN: 'f6f56aab5b6d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0818 11:25:06.849366  5268 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0818 11:25:06.849383  5268 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0818 11:25:06.849411  5268 authenticator.cpp:318] Authentication success
I0818 11:25:06.849500  5269 authenticatee.cpp:299] Authentication success
I0818 11:25:06.849885  5269 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:36793
I0818 11:25:06.849918  5269 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:36793
I0818 11:25:06.849942  5264 master.cpp:7867] Successfully authenticated principal 'test-principal'
at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.850080  5269 sched.cpp:869] Will retry registration in 1.25449916secs if necessary
I0818 11:25:06.850384  5269 master.cpp:2894] Received SUBSCRIBE call for framework 'default'
at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.850482  5269 master.cpp:2228] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0818 11:25:06.850774  5265 state.cpp:64] Recovering state from '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/meta'
I0818 11:25:06.851228  5265 master.cpp:2974] Subscribing framework default with checkpointing
disabled and capabilities [ RESERVATION_REFINEMENT ]
I0818 11:25:06.851327  5269 status_update_manager.cpp:203] Recovering status update manager
I0818 11:25:06.851405  5262 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(139)@172.17.0.3:36793
I0818 11:25:06.851758  5269 slave.cpp:6210] Finished recovery
I0818 11:25:06.852412  5265 sched.cpp:759] Framework registered with fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.852512  5265 sched.cpp:773] Scheduler::registered took 55129ns
I0818 11:25:06.852516  5267 hierarchical.cpp:303] Added framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
*** Aborted at 1503055506 (unix time) try "date -d @1503055506" if you are using GNU date
***
I0818 11:25:06.852737  5267 hierarchical.cpp:1943] No allocations performed
I0818 11:25:06.852779  5267 hierarchical.cpp:2033] No inverse offers to send out!
I0818 11:25:06.852823  5267 hierarchical.cpp:1486] Performed allocation for 0 agents in 129637ns
I0818 11:25:06.853315  5269 slave.cpp:6392] Querying resource estimator for oversubscribable
resources
I0818 11:25:06.853772  5264 slave.cpp:971] New master detected at master@172.17.0.3:36793
I0818 11:25:06.853812  5265 status_update_manager.cpp:177] Pausing sending status updates
I0818 11:25:06.854005  5264 slave.cpp:1006] Detecting new master
I0818 11:25:06.854221  5264 slave.cpp:6406] Received oversubscribable resources {} from the
resource estimator
I0818 11:25:06.859480  5266 slave.cpp:1033] Authenticating with master master@172.17.0.3:36793
I0818 11:25:06.859598  5266 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0818 11:25:06.860013  5266 authenticatee.cpp:121] Creating new client SASL connection
I0818 11:25:06.860445  5262 master.cpp:7837] Authenticating slave(63)@172.17.0.3:36793
I0818 11:25:06.860846  5262 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(140)@172.17.0.3:36793
I0818 11:25:06.861603  5265 authenticator.cpp:98] Creating new server SASL connection
I0818 11:25:06.861966  5267 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0818 11:25:06.862005  5267 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0818 11:25:06.862121  5264 authenticator.cpp:204] Received SASL authentication start
I0818 11:25:06.862184  5264 authenticator.cpp:326] Authentication requires more steps
I0818 11:25:06.862284  5264 authenticatee.cpp:259] Received SASL authentication step
I0818 11:25:06.862385  5264 authenticator.cpp:232] Received SASL authentication step
I0818 11:25:06.862418  5264 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: 'f6f56aab5b6d' server FQDN: 'f6f56aab5b6d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0818 11:25:06.862439  5264 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0818 11:25:06.862489  5264 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0818 11:25:06.862521  5264 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: 'f6f56aab5b6d' server FQDN: 'f6f56aab5b6d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0818 11:25:06.862540  5264 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0818 11:25:06.862556  5264 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0818 11:25:06.862583  5264 authenticator.cpp:318] Authentication success
I0818 11:25:06.862754  5262 authenticatee.cpp:299] Authentication success
I0818 11:25:06.862844  5265 master.cpp:7867] Successfully authenticated principal 'test-principal'
at slave(63)@172.17.0.3:36793
I0818 11:25:06.862893  5264 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(140)@172.17.0.3:36793
I0818 11:25:06.863158  5267 slave.cpp:1128] Successfully authenticated with master master@172.17.0.3:36793
I0818 11:25:06.863442  5267 slave.cpp:1572] Will retry registration in 12.925908ms if necessary
I0818 11:25:06.863972  5267 master.cpp:5712] Received register agent message from slave(63)@172.17.0.3:36793
(f6f56aab5b6d)
I0818 11:25:06.864137  5267 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0818 11:25:06.864898  5264 master.cpp:5772] Authorized registration of agent at slave(63)@172.17.0.3:36793
(f6f56aab5b6d)
I0818 11:25:06.865044  5264 master.cpp:5865] Registering agent at slave(63)@172.17.0.3:36793
(f6f56aab5b6d) with id fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
I0818 11:25:06.865591  5266 registrar.cpp:495] Applied 1 operations in 76402ns; attempting
to update the registry
I0818 11:25:06.866884  5264 registrar.cpp:552] Successfully updated the registry in 1.197312ms
I0818 11:25:06.867211  5266 master.cpp:5912] Admitted agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.868093  5266 master.cpp:5943] Registered agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0818 11:25:06.868674  5266 slave.cpp:1174] Registered with master master@172.17.0.3:36793;
given agent ID fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
I0818 11:25:06.868988  5263 status_update_manager.cpp:184] Resuming sending status updates
I0818 11:25:06.869091  5262 hierarchical.cpp:593] Added agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
(f6f56aab5b6d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0818 11:25:06.869122  5266 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/meta/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/slave.info'
I0818 11:25:06.869591  5266 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0818 11:25:06.869765  5266 slave.cpp:4887] Received ping from slave-observer(54)@172.17.0.3:36793
I0818 11:25:06.870247  5265 master.cpp:6688] Received update of agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d) with total oversubscribed resources {}
PC: @     0x2ae58851422e process::EventQueue::Consumer::empty()
*** SIGSEGV (@0x8) received by PID 5243 (TID 0x2ae593d26700) from PID 8; stack trace: ***
    @     0x2ae58abb6330 (unknown)
I0818 11:25:06.871367  5262 hierarchical.cpp:2033] No inverse offers to send out!
I0818 11:25:06.871467  5262 hierarchical.cpp:1486] Performed allocation for 1 agents in 2.037836ms
I0818 11:25:06.871732  5262 hierarchical.cpp:660] Agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
(f6f56aab5b6d) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0818 11:25:06.872558  5262 master.cpp:7667] Sending 1 offers to framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.873314  5267 sched.cpp:933] Scheduler::resourceOffers took 140485ns
I0818 11:25:06.876363  5263 master.cpp:9164] Removing offer fd4a2a33-1eae-47c5-a865-3f540ff0793b-O0
I0818 11:25:06.876590  5263 master.cpp:4153] Processing ACCEPT call for offers: [ fd4a2a33-1eae-47c5-a865-3f540ff0793b-O0
] on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0 at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
for framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 (default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.876725  5263 master.cpp:3530] Authorizing framework principal 'test-principal'
to launch task 1
W0818 11:25:06.879894  5264 validation.cpp:1294] Executor 'default' for task '1' uses less
CPUs (None) than the minimum required (0.01). Please update your executor, as this will be
mandatory in future releases.
W0818 11:25:06.879962  5264 validation.cpp:1306] Executor 'default' for task '1' uses less
memory (None) than the minimum required (32MB). Please update your executor, as this will
be mandatory in future releases.
I0818 11:25:06.880894  5264 master.cpp:9724] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0 at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.882046  5264 master.cpp:4816] Launching task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0 at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.883321  5265 slave.cpp:1701] Got assigned task '1' for framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.884300  5265 slave.cpp:1982] Authorizing task '1' for framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.884390  5265 slave.cpp:6709] Authorizing framework principal 'test-principal'
to launch task 1
I0818 11:25:06.885881  5264 slave.cpp:2169] Launching task '1' for framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.886498  5263 hierarchical.cpp:887] Updated allocation of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0 from cpus(allocated: *):2; mem(allocated:
*):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] to cpus(allocated: *):2;
mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]
I0818 11:25:06.886862  5264 paths.cpp:578] Trying to chown '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default/runs/49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4'
to user 'mesos'
I0818 11:25:06.887284  5264 slave.cpp:7165] Launching executor 'default' of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
with resources [] in work directory '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default/runs/49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4'
I0818 11:25:06.888120  5264 slave.cpp:2856] Launching container 49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4
for executor 'default' of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
    @     0x2ae58851422e process::EventQueue::Consumer::empty()
I0818 11:25:06.888613  5264 slave.cpp:2398] Queued task '1' for executor 'default' of framework
fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.888749  5264 slave.cpp:924] Successfully attached file '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default/runs/49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4'
I0818 11:25:06.888804  5264 slave.cpp:924] Successfully attached file '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default/runs/49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4'
I0818 11:25:06.892066  5269 process.cpp:3228] Attempting to spawn already spawned process
version@172.17.0.3:36793
I0818 11:25:06.892313  5269 exec.cpp:162] Version: 1.5.0
I0818 11:25:06.892668  5263 exec.cpp:212] Executor started at: executor(9)@172.17.0.3:36793
with pid 5243
I0818 11:25:06.893113  5263 slave.cpp:3881] Got registration for executor 'default' of framework
fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 from executor(9)@172.17.0.3:36793
I0818 11:25:06.893771  5266 exec.cpp:237] Executor registered on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
I0818 11:25:06.893888  5266 exec.cpp:249] Executor::registered took 67570ns
I0818 11:25:06.894392  5263 slave.cpp:2603] Sending queued task '1' to executor 'default'
of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 at executor(9)@172.17.0.3:36793
I0818 11:25:06.894984  5267 exec.cpp:331] Executor asked to run task '1'
I0818 11:25:06.895113  5267 exec.cpp:340] Executor::launchTask took 87009ns
I0818 11:25:06.895277  5267 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID:
f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.895809  5265 slave.cpp:4345] Handling status update TASK_RUNNING (UUID: f9959a57-617c-40db-8d18-713c901b70b4)
for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 from executor(9)@172.17.0.3:36793
I0818 11:25:06.896714  5264 status_update_manager.cpp:323] Received status update TASK_RUNNING
(UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.896793  5264 status_update_manager.cpp:500] Creating StatusUpdate stream for
task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
    @     0x2ae588500edc process::ProcessManager::resume()
I0818 11:25:06.897379  5264 status_update_manager.cpp:377] Forwarding update TASK_RUNNING
(UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
to the agent
I0818 11:25:06.897770  5266 slave.cpp:4797] Forwarding the update TASK_RUNNING (UUID: f9959a57-617c-40db-8d18-713c901b70b4)
for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 to master@172.17.0.3:36793
I0818 11:25:06.898061  5266 slave.cpp:4691] Status update manager successfully handled status
update TASK_RUNNING (UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.898128  5266 slave.cpp:4707] Sending acknowledgement for status update TASK_RUNNING
(UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
to executor(9)@172.17.0.3:36793
I0818 11:25:06.898324  5266 exec.cpp:388] Executor received status update acknowledgement
f9959a57-617c-40db-8d18-713c901b70b4 for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.898552  5263 master.cpp:6846] Status update TASK_RUNNING (UUID: f9959a57-617c-40db-8d18-713c901b70b4)
for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 from agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.898659  5263 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID:
f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.898900  5263 master.cpp:8933] Updating the state of task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0818 11:25:06.899396  5265 sched.cpp:1041] Scheduler::statusUpdate took 151342ns
I0818 11:25:06.899914  5267 master.cpp:5477] Processing ACKNOWLEDGE call f9959a57-617c-40db-8d18-713c901b70b4
for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 (default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
I0818 11:25:06.899961  5243 sched.cpp:2021] Asked to stop the driver
I0818 11:25:06.900146  5267 sched.cpp:1203] Stopping framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.900486  5264 master.cpp:8348] Processing TEARDOWN call for framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.900533  5264 master.cpp:8360] Removing framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.900562  5264 master.cpp:3264] Deactivating framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(default) at scheduler-e3d560bc-d4a8-4406-869f-dc26ff3ff739@172.17.0.3:36793
I0818 11:25:06.900578  5262 status_update_manager.cpp:395] Received status update acknowledgement
(UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.900710  5266 hierarchical.cpp:412] Deactivated framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.900801  5266 slave.cpp:3159] Asked to shut down framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
by master@172.17.0.3:36793
I0818 11:25:06.900799  5264 master.cpp:8933] Updating the state of task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
(latest state: TASK_KILLED, status update state: TASK_KILLED)
I0818 11:25:06.900851  5266 slave.cpp:3184] Shutting down framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.900913  5266 slave.cpp:5651] Shutting down executor 'default' of framework
fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 at executor(9)@172.17.0.3:36793
I0818 11:25:06.901113  5266 slave.cpp:3609] Status update manager successfully handled status
update acknowledgement (UUID: f9959a57-617c-40db-8d18-713c901b70b4) for task 1 of framework
fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.901165  5265 exec.cpp:435] Executor asked to shutdown
I0818 11:25:06.901283  5265 exec.cpp:450] Executor::shutdown took 77616ns
I0818 11:25:06.901504  5265 slave.cpp:4929] Got exited event for executor(9)@172.17.0.3:36793
    @     0x2ae5884fd4d8 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
I0818 11:25:06.902015  5264 master.cpp:9027] Removing task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.902956  5264 master.cpp:9056] Removing executor 'default' with resources []
of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.902957  5262 hierarchical.cpp:1161] Recovered cpus(allocated: *):2; mem(allocated:
*):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024;
disk:1024; ports:[31000-32000], allocated: {}) on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
from framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.903828  5265 slave.cpp:5329] Executor 'default' of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
exited with status 0
I0818 11:25:06.904001  5265 slave.cpp:5429] Cleaning up executor 'default' of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
at executor(9)@172.17.0.3:36793
I0818 11:25:06.904085  5264 hierarchical.cpp:355] Removed framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.904418  5267 gc.cpp:59] Scheduling '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default/runs/49b3c4c8-ed83-41d9-8ba2-df91efe5c8a4'
for gc 6.99998953484741days in the future
I0818 11:25:06.904484  5265 slave.cpp:5525] Cleaning up framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
W0818 11:25:06.904461  5263 master.cpp:6963] Ignoring unknown exited executor 'default' of
framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000 on agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.904682  5264 status_update_manager.cpp:285] Closing status update streams for
framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.904745  5264 status_update_manager.cpp:531] Cleaning up status update stream
for task 1 of framework fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000
I0818 11:25:06.904654  5267 gc.cpp:59] Scheduling '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000/executors/default'
for gc 6.99998953240593days in the future
I0818 11:25:06.904981  5267 gc.cpp:59] Scheduling '/tmp/FaultToleranceTest_SchedulerExit_0ZtRWn/slaves/fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0/frameworks/fd4a2a33-1eae-47c5-a865-3f540ff0793b-0000'
for gc 6.9999895301837days in the future
I0818 11:25:06.905261  5243 slave.cpp:843] Agent terminating
I0818 11:25:06.905581  5263 master.cpp:1318] Agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d) disconnected
I0818 11:25:06.905619  5263 master.cpp:3301] Disconnecting agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.905689  5263 master.cpp:3320] Deactivating agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
at slave(63)@172.17.0.3:36793 (f6f56aab5b6d)
I0818 11:25:06.905814  5267 hierarchical.cpp:690] Agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
deactivated
    @     0x2ae58850ec46 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
I0818 11:25:06.910012  5263 master.cpp:1160] Master terminating
I0818 11:25:06.911617  5262 hierarchical.cpp:626] Removed agent fd4a2a33-1eae-47c5-a865-3f540ff0793b-S0
    @     0x2ae58850eb9d _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2ae58850eb36 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2ae58a437a60 (unknown)
    @     0x2ae58abae184 start_thread
    @     0x2ae58aec1ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1503049485-18605
Untagged: mesos-1503049485-18605:latest
Deleted: sha256:9584196a0b93ba937c8fe305e177553d97cc26d230363dff7046cb6831aac3d7
Deleted: sha256:eed76567bf67721e528ce76919b8e5df63dd9dbc42f781a0b228fa4bc348d13d
Deleted: sha256:9292b26919cec1f73842bff276193367f0030b2420d9105418a9d63d12e50739
Deleted: sha256:f4e6cf3345f02a2f50333a296c991472c10d43a6f75f68a12d7845a4977d4dd6
Deleted: sha256:43617ccda9408a8b93ef495afab3e761a65a804d0f2accb0bd420ac24d41c635
Deleted: sha256:e9373273cf3aa317ec661a4b0bbd8f7027071bf7a2ec5daf372178b549745bc0
Deleted: sha256:e3193df2092b94bf2e1a07e8fc70be75c096cebfb1494039fe1fdabe03beb4cf
Deleted: sha256:959697613436ebb8a22854b9fcc43eb30e07d11b72c809ff044297ca4a2d1444
Deleted: sha256:633abf22c78ee31c7230a04e38ddeab3f477e57644eb58380c4963e242dba6ee
Deleted: sha256:b70db6d04021a06edb8f21348a1087be85ca555985b5054afa36109d6815c2ba
Deleted: sha256:e46aa620097faae437273f9974ebda171d13d0ff79144edcdc6d3a67d05bbcb0
Deleted: sha256:aa96547814dbbe5a98168c420e80739b4ab3dd18649fd7eebf5148285183efb1
Deleted: sha256:c453f8d26aa64835556b8dce28950cbd947b7e5c7133523235b1f8fa66e4e58d
Deleted: sha256:5ce97b99e0599405fb859d697edcf186a24d6a7ec4776043af8ce98a72897729
Deleted: sha256:f84d9eb14381126d29762e42cad61c5305421a96aa9897942c09929452b3f4bc
Deleted: sha256:be29b40a9c04f451cc8a45e9c5d88f3df1a1e3203e132b7409403379a07a4223
Deleted: sha256:bc0c67e870a450fd07bdfdfc90a63dfd328ad67d2d870c1d8630a989bb0396a6
Deleted: sha256:5a01aab7dc536d794e9c966484f4869efdf81a94064c6310aa99e1667d189389
Deleted: sha256:556c3baf6d9fd0bc2f4b737af283012510c87b1a875cf989cbe39af4422e330e
Deleted: sha256:76ae23851e8d63e6827b3354be5d3d86df5c397cde37e3b813457037e2c7d895
Deleted: sha256:47ac868b7439629fde06f05c0407e264654a903bb38ef4c27aba151b8bb88989
Deleted: sha256:45e07084bb228aed80399689a588e721d4c7e14902e0413ff9a4b9b75ca48dc1
Deleted: sha256:29381cbf9e223dbc4c35b338afea5ae04a414a94b43e481e6e3be8f13b958150
Deleted: sha256:bba9fb628c7d5698496f80dfb4d27156531c83c4190422c260587ef250d5d633
Build step 'Execute shell' marked build as failure

Mime
View raw message