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-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3518
Date Sun, 16 Apr 2017 19:11:51 GMT
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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)/3518/display/redirect?page=changes>

Changes:

[haosdent] Fixed health check bug when running agents with `docker_mesos_image`.

------------------------------------------
[...truncated 12.81 MB...]
I0416 19:11:48.005424 28497 slave.cpp:4565] Sending acknowledgement for status update TASK_RUNNING
(UUID: caf3aa36-f136-4db0-9d72-f020f116abb5) for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
to executor(120)@172.17.0.3:41771
I0416 19:11:48.005494 28498 exec.cpp:374] Executor received status update acknowledgement
caf3aa36-f136-4db0-9d72-f020f116abb5 for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.005488 28487 master.cpp:6260] Status update TASK_RUNNING (UUID: caf3aa36-f136-4db0-9d72-f020f116abb5)
for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 from agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.005527 28487 master.cpp:6328] Forwarding status update TASK_RUNNING (UUID:
caf3aa36-f136-4db0-9d72-f020f116abb5) for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.005590 28487 master.cpp:8362] Updating the state of task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
(latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0416 19:11:48.005692 28487 sched.cpp:1041] Scheduler::statusUpdate took 26643ns
I0416 19:11:48.005770 28487 master.cpp:5168] Processing ACKNOWLEDGE call caf3aa36-f136-4db0-9d72-f020f116abb5
for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 (default) at scheduler-7f285fd7-8e44-4d0a-ba9b-21d9b8fad916@172.17.0.3:41771
on agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
I0416 19:11:48.005889 28487 status_update_manager.cpp:395] Received status update acknowledgement
(UUID: caf3aa36-f136-4db0-9d72-f020f116abb5) for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.006021 28487 slave.cpp:3504] Status update manager successfully handled status
update acknowledgement (UUID: caf3aa36-f136-4db0-9d72-f020f116abb5) for task 1 of framework
606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.006100 28487 exec.cpp:396] Executor received framework message
I0416 19:11:48.006136 28487 exec.cpp:405] Executor::frameworkMessage took 19946ns
I0416 19:11:48.006417 28487 slave.cpp:4723] Sending message for framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
to scheduler-7f285fd7-8e44-4d0a-ba9b-21d9b8fad916@172.17.0.3:41771
I0416 19:11:48.006628 28494 sched.cpp:1177] Scheduler::frameworkMessage took 29080ns
I0416 19:11:48.006758 28485 sched.cpp:2021] Asked to stop the driver
I0416 19:11:48.006816 28504 sched.cpp:1203] Stopping framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.006939 28497 master.cpp:7782] Processing TEARDOWN call for framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
(default) at scheduler-7f285fd7-8e44-4d0a-ba9b-21d9b8fad916@172.17.0.3:41771
I0416 19:11:48.006960 28497 master.cpp:7794] Removing framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
(default) at scheduler-7f285fd7-8e44-4d0a-ba9b-21d9b8fad916@172.17.0.3:41771
I0416 19:11:48.006974 28497 master.cpp:3165] Deactivating framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
(default) at scheduler-7f285fd7-8e44-4d0a-ba9b-21d9b8fad916@172.17.0.3:41771
I0416 19:11:48.007027 28497 master.cpp:8362] Updating the state of task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
(latest state: TASK_KILLED, status update state: TASK_KILLED)
I0416 19:11:48.007050 28501 hierarchical.cpp:376] Deactivated framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.007123 28492 slave.cpp:3057] Asked to shut down framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
by master@172.17.0.3:41771
I0416 19:11:48.007148 28492 slave.cpp:3082] Shutting down framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.007164 28492 slave.cpp:5475] Shutting down executor 'default' of framework
606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 at executor(120)@172.17.0.3:41771
I0416 19:11:48.007232 28497 master.cpp:8456] Removing task 1 with resources cpus(*)(allocated:
*):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]
of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 on agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.007283 28495 exec.cpp:415] Executor asked to shutdown
I0416 19:11:48.007323 28495 exec.cpp:430] Executor::shutdown took 10509ns
I0416 19:11:48.007338 28497 master.cpp:8485] Removing executor 'default' with resources {}
of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 on agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.007345 28505 hierarchical.cpp:1116] 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 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
from framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.007510 28491 slave.cpp:4787] Got exited event for executor(120)@172.17.0.3:41771
I0416 19:11:48.007827 28501 hierarchical.cpp:323] Removed framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.007975 28497 slave.cpp:5161] Executor 'default' of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
exited with status 0
I0416 19:11:48.008093 28497 slave.cpp:5261] Cleaning up executor 'default' of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
at executor(120)@172.17.0.3:41771
W0416 19:11:48.008143 28502 master.cpp:6384] Ignoring unknown exited executor 'default' of
framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000 on agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.008249 28489 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_PALPAG/slaves/606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0/frameworks/606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000/executors/default/runs/8fd4821a-b738-43f4-9892-037f4423c66c'
for gc 6.99999990527704days in the future
I0416 19:11:48.008266 28497 slave.cpp:5349] Cleaning up framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.008298 28489 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_PALPAG/slaves/606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0/frameworks/606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000/executors/default'
for gc 6.99999990446815days in the future
I0416 19:11:48.008435 28504 status_update_manager.cpp:285] Closing status update streams for
framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.008452 28504 status_update_manager.cpp:531] Cleaning up status update stream
for task 1 of framework 606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000
I0416 19:11:48.008548 28494 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_PALPAG/slaves/606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0/frameworks/606167de-d495-4d46-bbe3-3ff3b2d42e5e-0000'
for gc 6.99999990277926days in the future
I0416 19:11:48.008580 28504 slave.cpp:790] Agent terminating
I0416 19:11:48.008777 28488 master.cpp:1318] Agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7) disconnected
I0416 19:11:48.008800 28488 master.cpp:3202] Disconnecting agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.008843 28488 master.cpp:3221] Deactivating agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
at slave(301)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.008949 28497 hierarchical.cpp:655] Agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
deactivated
I0416 19:11:48.010244 28493 master.cpp:1157] Master terminating
I0416 19:11:48.010452 28494 hierarchical.cpp:560] Removed agent 606167de-d495-4d46-bbe3-3ff3b2d42e5e-S0
[       OK ] MasterTest.FrameworkMessage (34 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0416 19:11:48.013783 28485 cluster.cpp:162] Creating default 'local' authorizer
I0416 19:11:48.014933 28502 master.cpp:438] Master 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e (419465c996d7)
started on 172.17.0.3:41771
I0416 19:11:48.014955 28502 master.cpp:440] 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/KpqGDe/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" --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="/usr/local/share/mesos/webui"
--work_dir="/tmp/KpqGDe/master" --zk_session_timeout="10secs"
I0416 19:11:48.015136 28502 master.cpp:490] Master only allowing authenticated frameworks
to register
I0416 19:11:48.015149 28502 master.cpp:504] Master only allowing authenticated agents to register
I0416 19:11:48.015156 28502 master.cpp:517] Master only allowing authenticated HTTP frameworks
to register
I0416 19:11:48.015166 28502 credentials.hpp:37] Loading credentials for authentication from
'/tmp/KpqGDe/credentials'
I0416 19:11:48.015302 28502 master.cpp:562] Using default 'crammd5' authenticator
I0416 19:11:48.015343 28502 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0416 19:11:48.015383 28502 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0416 19:11:48.015411 28502 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0416 19:11:48.015519 28502 master.cpp:642] Authorization enabled
I0416 19:11:48.015575 28491 hierarchical.cpp:159] Initialized hierarchical allocator process
I0416 19:11:48.015578 28505 whitelist_watcher.cpp:77] No whitelist given
I0416 19:11:48.016264 28506 master.cpp:2166] Elected as the leading master!
I0416 19:11:48.016278 28506 master.cpp:1705] Recovering from registrar
I0416 19:11:48.016373 28501 registrar.cpp:331] Recovering registrar
I0416 19:11:48.016655 28491 registrar.cpp:364] Successfully fetched the registry (0B) in 263936ns
I0416 19:11:48.016690 28491 registrar.cpp:463] Applied 1 operations in 3044ns; attempting
to update the registry
I0416 19:11:48.016943 28500 registrar.cpp:508] Successfully updated the registry in 235776ns
I0416 19:11:48.017014 28500 registrar.cpp:394] Successfully recovered registrar
I0416 19:11:48.017176 28496 hierarchical.cpp:186] Skipping recovery of hierarchical allocator:
nothing to recover
I0416 19:11:48.017269 28500 master.cpp:1804] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0416 19:11:48.018941 28485 cluster.cpp:448] Creating default 'local' authorizer
I0416 19:11:48.019634 28494 slave.cpp:225] Mesos agent started on (302)@172.17.0.3:41771
I0416 19:11:48.019651 28494 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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/MasterTest_MultipleExecutors_J97ML0/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_secret_key="/tmp/MasterTest_MultipleExecutors_J97ML0/executor_secret_key"
--executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_J97ML0/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/MasterTest_MultipleExecutors_J97ML0/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
--launcher="posix" --launcher_dir="/mesos/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/MasterTest_MultipleExecutors_J97ML0" --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/MasterTest_MultipleExecutors_10pJH7"
I0416 19:11:48.019919 28494 credentials.hpp:86] Loading credential for authentication from
'/tmp/MasterTest_MultipleExecutors_J97ML0/credential'
I0416 19:11:48.020063 28494 slave.cpp:258] Agent using credential for: test-principal
I0416 19:11:48.020082 28494 credentials.hpp:37] Loading credentials for authentication from
'/tmp/MasterTest_MultipleExecutors_J97ML0/http_credentials'
I0416 19:11:48.020246 28494 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-executor'
I0416 19:11:48.020295 28494 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-executor'
I0416 19:11:48.020340 28485 sched.cpp:232] Version: 1.3.0
I0416 19:11:48.020342 28494 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0416 19:11:48.020550 28497 sched.cpp:336] New master detected at master@172.17.0.3:41771
I0416 19:11:48.020584 28494 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readonly'
I0416 19:11:48.020593 28497 sched.cpp:407] Authenticating with master master@172.17.0.3:41771
I0416 19:11:48.020606 28497 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0416 19:11:48.020680 28494 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0416 19:11:48.020685 28505 authenticatee.cpp:121] Creating new client SASL connection
I0416 19:11:48.020731 28494 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readwrite'
I0416 19:11:48.020843 28495 master.cpp:7269] Authenticating scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771
I0416 19:11:48.020916 28491 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(651)@172.17.0.3:41771
I0416 19:11:48.021209 28507 authenticator.cpp:98] Creating new server SASL connection
I0416 19:11:48.021317 28507 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0416 19:11:48.021332 28507 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0416 19:11:48.021370 28495 authenticator.cpp:204] Received SASL authentication start
I0416 19:11:48.021425 28495 authenticator.cpp:326] Authentication requires more steps
I0416 19:11:48.021431 28494 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I0416 19:11:48.021466 28494 slave.cpp:533] Agent attributes: [  ]
I0416 19:11:48.021469 28495 authenticatee.cpp:259] Received SASL authentication step
I0416 19:11:48.021471 28494 slave.cpp:538] Agent hostname: 419465c996d7
I0416 19:11:48.021533 28488 status_update_manager.cpp:177] Pausing sending status updates
I0416 19:11:48.021601 28503 authenticator.cpp:232] Received SASL authentication step
I0416 19:11:48.021630 28503 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '419465c996d7' server FQDN: '419465c996d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0416 19:11:48.021642 28503 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0416 19:11:48.021656 28503 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0416 19:11:48.021670 28503 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '419465c996d7' server FQDN: '419465c996d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0416 19:11:48.021783 28507 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_10pJH7/meta'
I0416 19:11:48.021787 28503 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0416 19:11:48.021821 28503 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0416 19:11:48.021841 28503 authenticator.cpp:318] Authentication success
I0416 19:11:48.021931 28508 master.cpp:7299] Successfully authenticated principal 'test-principal'
at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771
I0416 19:11:48.021965 28509 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(651)@172.17.0.3:41771
I0416 19:11:48.021987 28507 authenticatee.cpp:299] Authentication success
I0416 19:11:48.022020 28493 status_update_manager.cpp:203] Recovering status update manager
I0416 19:11:48.022172 28495 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:41771
I0416 19:11:48.022188 28495 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:41771
I0416 19:11:48.022236 28495 sched.cpp:869] Will retry registration in 256.368717ms if necessary
I0416 19:11:48.022269 28498 slave.cpp:5963] Finished recovery
I0416 19:11:48.022310 28491 master.cpp:2818] Received SUBSCRIBE call for framework 'default'
at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771
I0416 19:11:48.022333 28491 master.cpp:2202] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0416 19:11:48.022490 28494 master.cpp:2895] Subscribing framework default with checkpointing
disabled and capabilities [  ]
I0416 19:11:48.022644 28506 hierarchical.cpp:271] Added framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.022694 28506 hierarchical.cpp:1862] No allocations performed
I0416 19:11:48.022708 28500 sched.cpp:759] Framework registered with 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.022713 28506 hierarchical.cpp:1952] No inverse offers to send out!
I0416 19:11:48.022745 28500 sched.cpp:773] Scheduler::registered took 10605ns
I0416 19:11:48.022647 28498 slave.cpp:6145] Querying resource estimator for oversubscribable
resources
I0416 19:11:48.022753 28506 hierarchical.cpp:1446] Performed allocation for 0 agents in 63955ns
I0416 19:11:48.022855 28498 slave.cpp:918] New master detected at master@172.17.0.3:41771
I0416 19:11:48.022864 28503 status_update_manager.cpp:177] Pausing sending status updates
I0416 19:11:48.022883 28498 slave.cpp:953] Detecting new master
I0416 19:11:48.023051 28498 slave.cpp:6159] Received oversubscribable resources {} from the
resource estimator
I0416 19:11:48.031188 28509 slave.cpp:980] Authenticating with master master@172.17.0.3:41771
I0416 19:11:48.031209 28509 slave.cpp:991] Using default CRAM-MD5 authenticatee
I0416 19:11:48.031270 28490 authenticatee.cpp:121] Creating new client SASL connection
I0416 19:11:48.031416 28500 master.cpp:7269] Authenticating slave(302)@172.17.0.3:41771
I0416 19:11:48.031647 28492 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(652)@172.17.0.3:41771
I0416 19:11:48.031728 28486 authenticator.cpp:98] Creating new server SASL connection
I0416 19:11:48.031836 28486 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0416 19:11:48.031849 28486 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0416 19:11:48.031893 28492 authenticator.cpp:204] Received SASL authentication start
I0416 19:11:48.031952 28492 authenticator.cpp:326] Authentication requires more steps
I0416 19:11:48.032025 28500 authenticatee.cpp:259] Received SASL authentication step
I0416 19:11:48.032114 28486 authenticator.cpp:232] Received SASL authentication step
I0416 19:11:48.032137 28486 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '419465c996d7' server FQDN: '419465c996d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0416 19:11:48.032147 28486 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0416 19:11:48.032161 28486 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0416 19:11:48.032177 28486 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '419465c996d7' server FQDN: '419465c996d7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0416 19:11:48.032187 28486 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0416 19:11:48.032196 28486 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0416 19:11:48.032212 28486 authenticator.cpp:318] Authentication success
I0416 19:11:48.032263 28500 authenticatee.cpp:299] Authentication success
I0416 19:11:48.032289 28509 master.cpp:7299] Successfully authenticated principal 'test-principal'
at slave(302)@172.17.0.3:41771
I0416 19:11:48.032299 28486 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(652)@172.17.0.3:41771
I0416 19:11:48.032480 28496 slave.cpp:1075] Successfully authenticated with master master@172.17.0.3:41771
I0416 19:11:48.032552 28496 slave.cpp:1503] Will retry registration in 11.17825ms if necessary
I0416 19:11:48.032600 28488 master.cpp:5454] Registering agent at slave(302)@172.17.0.3:41771
(419465c996d7) with id 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
I0416 19:11:48.032896 28499 registrar.cpp:463] Applied 1 operations in 12474ns; attempting
to update the registry
I0416 19:11:48.033295 28499 registrar.cpp:508] Successfully updated the registry in 370176ns
I0416 19:11:48.033519 28499 master.cpp:5528] Registered agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
at slave(302)@172.17.0.3:41771 (419465c996d7) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0416 19:11:48.033648 28499 hierarchical.cpp:527] Added agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
(419465c996d7) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated:
{})
I0416 19:11:48.033939 28499 hierarchical.cpp:1952] No inverse offers to send out!
I0416 19:11:48.033962 28499 hierarchical.cpp:1446] Performed allocation for 1 agents in 256766ns
I0416 19:11:48.033994 28499 slave.cpp:1121] Registered with master master@172.17.0.3:41771;
given agent ID 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
I0416 19:11:48.034005 28499 fetcher.cpp:94] Clearing fetcher cache
I0416 19:11:48.034289 28499 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_10pJH7/meta/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/slave.info'
I0416 19:11:48.034538 28499 slave.cpp:1187] Forwarding total oversubscribed resources {}
I0416 19:11:48.034585 28499 slave.cpp:4745] Received ping from slave-observer(296)@172.17.0.3:41771
I0416 19:11:48.034754 28499 master.cpp:7098] Sending 1 offers to framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
(default) at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771
I0416 19:11:48.034823 28499 master.cpp:6115] Received update of agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
at slave(302)@172.17.0.3:41771 (419465c996d7) with total oversubscribed resources {}
I0416 19:11:48.034907 28499 status_update_manager.cpp:184] Resuming sending status updates
I0416 19:11:48.035037 28499 sched.cpp:933] Scheduler::resourceOffers took 39628ns
I0416 19:11:48.035617 28506 master.cpp:3856] Processing ACCEPT call for offers: [ 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-O0
] on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0 at slave(302)@172.17.0.3:41771 (419465c996d7)
for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000 (default) at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771
I0416 19:11:48.035652 28506 master.cpp:3432] Authorizing framework principal 'test-principal'
to launch task 1
I0416 19:11:48.035723 28506 master.cpp:3432] Authorizing framework principal 'test-principal'
to launch task 2
W0416 19:11:48.036331 28493 validation.cpp:1113] Executor 'executor-1' 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.
W0416 19:11:48.036355 28493 validation.cpp:1125] Executor 'executor-1' for task '1' uses less
memory (None) than the minimum required (32MB). Please update your executor, as this will
be mandatory in future releases.
I0416 19:11:48.036423 28493 master.cpp:9114] Adding task 1 with resources cpus(*)(allocated:
*):1; mem(*)(allocated: *):512 on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0 at slave(302)@172.17.0.3:41771
(419465c996d7)
I0416 19:11:48.036475 28493 master.cpp:4506] Launching task 1 of framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
(default) at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771 with resources
cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
at slave(302)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.036612 28491 slave.cpp:1613] Got assigned task '1' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
W0416 19:11:48.036731 28493 validation.cpp:1113] Executor 'executor-2' for task '2' uses less
CPUs (None) than the minimum required (0.01). Please update your executor, as this will be
mandatory in future releases.
W0416 19:11:48.036751 28493 validation.cpp:1125] Executor 'executor-2' for task '2' uses less
memory (None) than the minimum required (32MB). Please update your executor, as this will
be mandatory in future releases.
I0416 19:11:48.036801 28491 slave.cpp:1894] Authorizing task '1' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.036819 28491 slave.cpp:6582] Authorizing framework principal 'test-principal'
to launch task 1
I0416 19:11:48.036823 28493 master.cpp:9114] Adding task 2 with resources cpus(*)(allocated:
*):1; mem(*)(allocated: *):512 on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0 at slave(302)@172.17.0.3:41771
(419465c996d7)
I0416 19:11:48.036875 28493 master.cpp:4506] Launching task 2 of framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
(default) at scheduler-c73fd7a3-3733-481b-be38-87c4c0c38206@172.17.0.3:41771 with resources
cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
at slave(302)@172.17.0.3:41771 (419465c996d7)
I0416 19:11:48.037091 28494 slave.cpp:1613] Got assigned task '2' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.037286 28494 slave.cpp:2081] Launching task '1' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.037443 28495 hierarchical.cpp:852] Updated allocation of framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-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]
I0416 19:11:48.037609 28495 hierarchical.cpp:1116] Recovered ports(*)(allocated: *):[31000-32000];
disk(*)(allocated: *):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000],
allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024) on agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0
from framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.037633 28494 paths.cpp:556] Trying to chown '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-1/runs/23323780-53a6-4d81-b228-69a85a241a30'
to user 'mesos'
I0416 19:11:48.037633 28495 hierarchical.cpp:1153] Framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
filtered agent 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0 for 5secs
I0416 19:11:48.037771 28494 slave.cpp:6926] Launching executor 'executor-1' of framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-1/runs/23323780-53a6-4d81-b228-69a85a241a30'
I0416 19:11:48.037971 28494 slave.cpp:2310] Queued task '1' for executor 'executor-1' of framework
2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.038022 28494 slave.cpp:1894] Authorizing task '2' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.038043 28494 slave.cpp:6582] Authorizing framework principal 'test-principal'
to launch task 2
I0416 19:11:48.038164 28494 slave.cpp:871] Successfully attached file '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-1/runs/23323780-53a6-4d81-b228-69a85a241a30'
I0416 19:11:48.038390 28494 slave.cpp:2081] Launching task '2' for framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.038656 28494 paths.cpp:556] Trying to chown '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-2/runs/fc2e39c1-bf2d-4fe6-9e02-d945c4bef953'
to user 'mesos'
I0416 19:11:48.038780 28494 slave.cpp:6926] Launching executor 'executor-2' of framework 2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-2/runs/fc2e39c1-bf2d-4fe6-9e02-d945c4bef953'
I0416 19:11:48.038956 28494 slave.cpp:2310] Queued task '2' for executor 'executor-2' of framework
2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000
I0416 19:11:48.039001 28494 slave.cpp:871] Successfully attached file '/tmp/MasterTest_MultipleExecutors_10pJH7/slaves/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-S0/frameworks/2e8944f9-600d-4f8a-8ebe-85fa8bfafb9e-0000/executors/executor-2/runs/fc2e39c1-bf2d-4fe6-9e02-d945c4bef953'
*** Aborted at 1492369908 (unix time) try "date -d @1492369908" if you are using GNU date
***
I0416 19:11:48.039221 28495 exec.cpp:162] Version: 1.3.0
I0416 19:11:48.039288 28502 exec.cpp:212] Executor started at: executor(121)@172.17.0.3:41771
with pid 28485
PC: @     0x2b8419b2382d (unknown)
*** SIGSEGV (@0x71) received by PID 28485 (TID 0x2b8422cd4700) from PID 113; stack trace:
***
    @     0x2b84190ba330 (unknown)
    @     0x2b8419b2382d (unknown)
    @     0x2b841610d464 mesos::internal::slave::executorEnvironment()
    @     0x2b8416132ff8 mesos::internal::slave::Slave::launchExecutor()
    @     0x2b841748c5d1 process::ProcessManager::resume()
    @     0x2b84174957c7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2b8419379a60 (unknown)
    @     0x2b84190b2184 start_thread
    @     0x2b8419be5bed (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1492367267-7427
Untagged: mesos-1492367267-7427:latest
Deleted: sha256:7e3fbe9e9530b61cb452af85c3c40f3a0bb73de17f263f4341a9b9ccc803de5f
Deleted: sha256:ca79fcdb745fa14b102feb376721e85f94ffc36997f8cf1e57ffd5db023205e5
Deleted: sha256:926ff738e837e8b22617b25d48181a63aeeea7d89a6ae9b567bd196be9f8f04d
Deleted: sha256:2c35cf71dbe0896b81d72adb94881004fdc9c2562c44d3d019710348d1ca9893
Deleted: sha256:d5e636bb7f8ecc6a60692a39ff7f1664f845fc6c5fc3768c175e0dc81ec46d77
Deleted: sha256:5d8bd5916413c47497bd043fa596ba4e71f698e7bbb8c39d287c525746795797
Deleted: sha256:24a3abb346ae4982b43e64c36ba5e90c4830bb55f0f11e8705ffbdb1ee4556b9
Deleted: sha256:cd156abc5b1ed922d44e12a4d1ba2496da9feb6c705e722c33459629fc21d212
Deleted: sha256:804af306c8834915bf713d8919107264f87fc1769fb8bee550c04c7992084bac
Deleted: sha256:00ca00ac3bd8d736238f2fa10673b37b700a0e578d829a41ea31b0b8e55658cb
Deleted: sha256:40450d9f33fe0a74447467472d740ff0ecfa0cfbe3aa39899e4d7b59e7e88534
Deleted: sha256:4b67a02b0597aaf1e3a0ace46ba609e972bbf5506c429587721fe583bf6f53ed
Deleted: sha256:eefd038403a82299792fb4da62496d26cf7b38f32578810f645581daf1ee35fb
Deleted: sha256:5ab35c5feb7c47398e2dd99531efa6269cf86c90cbd51adf61ff318757182df0
Deleted: sha256:dd02ab34bd8656b1719a4d8c8aff36bf2b22c8c93849ad4b0f767f80c1426a90
Deleted: sha256:73eadab2b7b1837d68fa8769140097532417a9a9bd1cf071ee261ba64f1ff18d
Deleted: sha256:cc91439852b6881e2ba8d394a7505f21fc633aa1e1d0a3a3171e45d3230bb01c
Deleted: sha256:f07328620b600ae714b200b804fb7eb41c1c6a9ddf03bdc594b9a23edb72755a
Deleted: sha256:824a42b66e283493e20c109b1055e1960e4a6d85449fca28eaa1b7b36b1152c7
Deleted: sha256:5bd290f72559b93b3528c0c7c2e53810bc2177ebd8b43bb5fca1c8156bb597b3
Deleted: sha256:4c46510211596ea833161e9b3ac46aaf5457ddd0c95584ce839de3bc01c6be4b
Deleted: sha256:cfa27c9fdf6833775833b47ba71f98b6468256b4f4254b3fc8bf28fe3cae8772
Deleted: sha256:3e310ad1f4e74c3546241b5c2874d451199f05d192c3ff5de2b78804f4ee6c87
Deleted: sha256:f3b7b0df63ff2a8a1d124f1adc49f5d994c89a874adc7e866d748bd94e4f7865
Build step 'Execute shell' marked build as failure

Mime
View raw message