See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4548/display/redirect>
------------------------------------------
[...truncated 14.83 MB...]
3: I1206 13:54:03.613024 15975 slave.cpp:889] Agent terminating
3: I1206 13:54:03.613090 15975 slave.cpp:3315] Asked to shut down framework
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000 by @0.0.0.0:0
3: W1206 13:54:03.613126 15975 slave.cpp:3336] Ignoring shutdown framework
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000 because it is terminating
3: I1206 13:54:03.613611 15976 master.cpp:10132] Removing task 1 with resources
cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024;
ports(allocated: *):[31000-32000] of framework
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000 on agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 at slave(361)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.613927 15976 master.cpp:10161] Removing executor 'default'
with resources [] of framework ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000 on
agent ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 at slave(361)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.614089 15980 hierarchical.cpp:1202] 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 ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 from framework
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000
3: I1206 13:54:03.614259 15978 exec.cpp:435] Executor asked to shutdown
3: I1206 13:54:03.614292 15978 exec.cpp:450] Executor::shutdown took 21829ns
3: I1206 13:54:03.614578 15976 master.cpp:1317] Agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 at slave(361)@172.17.0.4:38384
(b0940c1f4a66) disconnected
3: I1206 13:54:03.614611 15976 master.cpp:3376] Disconnecting agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 at slave(361)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.614624 15988 hierarchical.cpp:349] Removed framework
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-0000
3: I1206 13:54:03.614679 15976 master.cpp:3395] Deactivating agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 at slave(361)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.614811 15991 hierarchical.cpp:767] Agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0 deactivated
3: I1206 13:54:03.620527 15975 master.cpp:1159] Master terminating
3: I1206 13:54:03.621254 15985 hierarchical.cpp:610] Removed agent
ca69fe62-46a2-4ebe-b5d3-2365a2ac7c15-S0
3: [ OK ] MasterTest.FrameworkMessage (71 ms)
3: [ RUN ] MasterTest.MultipleExecutors
3: I1206 13:54:03.628062 15975 cluster.cpp:172] Creating default 'local'
authorizer
3: I1206 13:54:03.631513 15976 master.cpp:454] Master
c17bc1fe-c409-4e7c-8fc7-a46d24c68635 (b0940c1f4a66) started on 172.17.0.4:38384
3: I1206 13:54:03.631559 15976 master.cpp:456] 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/fZOplB/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="/usr/local/share/mesos/webui" --work_dir="/tmp/fZOplB/master"
--zk_session_timeout="10secs"
3: I1206 13:54:03.631976 15976 master.cpp:505] Master only allowing
authenticated frameworks to register
3: I1206 13:54:03.631990 15976 master.cpp:511] Master only allowing
authenticated agents to register
3: I1206 13:54:03.632000 15976 master.cpp:517] Master only allowing
authenticated HTTP frameworks to register
3: I1206 13:54:03.632011 15976 credentials.hpp:37] Loading credentials for
authentication from '/tmp/fZOplB/credentials'
3: I1206 13:54:03.632376 15976 master.cpp:561] Using default 'crammd5'
authenticator
3: I1206 13:54:03.632555 15976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1206 13:54:03.632748 15976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1206 13:54:03.632936 15976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1206 13:54:03.633100 15976 master.cpp:640] Authorization enabled
3: I1206 13:54:03.633291 15988 whitelist_watcher.cpp:77] No whitelist given
3: I1206 13:54:03.633379 15977 hierarchical.cpp:175] Initialized hierarchical
allocator process
3: I1206 13:54:03.636416 15980 master.cpp:2221] Elected as the leading master!
3: I1206 13:54:03.636438 15980 master.cpp:1701] Recovering from registrar
3: I1206 13:54:03.636595 15979 registrar.cpp:347] Recovering registrar
3: I1206 13:54:03.637361 15979 registrar.cpp:391] Successfully fetched the
registry (0B) in 728064ns
3: I1206 13:54:03.637496 15979 registrar.cpp:495] Applied 1 operations in
50509ns; attempting to update the registry
3: I1206 13:54:03.638105 15979 registrar.cpp:552] Successfully updated the
registry in 541952ns
3: I1206 13:54:03.638279 15979 registrar.cpp:424] Successfully recovered
registrar
3: I1206 13:54:03.638816 15977 master.cpp:1814] Recovered 0 agents from the
registry (135B); allowing 10mins for agents to re-register
3: I1206 13:54:03.638911 15978 hierarchical.cpp:213] Skipping recovery of
hierarchical allocator: nothing to recover
3: W1206 13:54:03.644464 15975 process.cpp:2756] Attempted to spawn already
running process [email protected]:38384
3: I1206 13:54:03.644862 15975 cluster.cpp:460] Creating default 'local'
authorizer
3: I1206 13:54:03.648558 15984 slave.cpp:258] Mesos agent started on
(362)@172.17.0.4:38384
3: I1206 13:54:03.648600 15984 slave.cpp:259] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://"
--appc_store_dir="/tmp/MasterTest_MultipleExecutors_DCxNQp/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/MasterTest_MultipleExecutors_DCxNQp/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/MasterTest_MultipleExecutors_DCxNQp/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/MasterTest_MultipleExecutors_DCxNQp/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_DCxNQp/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" --reconfiguration_policy="equal" --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_DCxNQp"
--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_i7T5A0"
--zk_session_timeout="10secs"
3: I1206 13:54:03.649147 15984 credentials.hpp:86] Loading credential for
authentication from '/tmp/MasterTest_MultipleExecutors_DCxNQp/credential'
3: W1206 13:54:03.649158 15975 process.cpp:2756] Attempted to spawn already
running process [email protected]:38384
3: I1206 13:54:03.649324 15984 slave.cpp:291] Agent using credential for:
test-principal
3: I1206 13:54:03.649346 15984 credentials.hpp:37] Loading credentials for
authentication from '/tmp/MasterTest_MultipleExecutors_DCxNQp/http_credentials'
3: I1206 13:54:03.649603 15984 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1206 13:54:03.649780 15984 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
3: I1206 13:54:03.650517 15975 sched.cpp:232] Version: 1.5.0
3: I1206 13:54:03.651087 15982 sched.cpp:336] New master detected at
[email protected]:38384
3: I1206 13:54:03.651170 15982 sched.cpp:396] Authenticating with master
[email protected]:38384
3: I1206 13:54:03.651185 15982 sched.cpp:403] Using default CRAM-MD5
authenticatee
3: I1206 13:54:03.651254 15984 slave.cpp:590] 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"}]
3: I1206 13:54:03.651448 15984 slave.cpp:598] Agent attributes: [ ]
3: I1206 13:54:03.651460 15984 slave.cpp:607] Agent hostname: b0940c1f4a66
3: I1206 13:54:03.651497 15976 authenticatee.cpp:121] Creating new client SASL
connection
3: I1206 13:54:03.651571 15980 task_status_update_manager.cpp:181] Pausing
sending task status updates
3: I1206 13:54:03.651795 15978 master.cpp:8800] Authenticating
[email protected]:38384
3: I1206 13:54:03.651943 15986 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(719)@172.17.0.4:38384
3: I1206 13:54:03.652230 15983 authenticator.cpp:98] Creating new server SASL
connection
3: I1206 13:54:03.652441 15981 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1206 13:54:03.652474 15981 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1206 13:54:03.652612 15989 authenticator.cpp:204] Received SASL
authentication start
3: I1206 13:54:03.652689 15989 authenticator.cpp:326] Authentication requires
more steps
3: I1206 13:54:03.652822 15990 authenticatee.cpp:259] Received SASL
authentication step
3: I1206 13:54:03.652930 15985 authenticator.cpp:232] Received SASL
authentication step
3: I1206 13:54:03.652961 15985 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: 'b0940c1f4a66' server FQDN: 'b0940c1f4a66'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1206 13:54:03.652971 15985 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1206 13:54:03.652972 15979 state.cpp:66] Recovering state from
'/tmp/MasterTest_MultipleExecutors_i7T5A0/meta'
3: I1206 13:54:03.652998 15985 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1206 13:54:03.653015 15985 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: 'b0940c1f4a66' server FQDN: 'b0940c1f4a66'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1206 13:54:03.653028 15985 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1206 13:54:03.653031 15985 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1206 13:54:03.653045 15985 authenticator.cpp:318] Authentication success
3: I1206 13:54:03.653112 15977 authenticatee.cpp:299] Authentication success
3: I1206 13:54:03.653224 15976 master.cpp:8830] Successfully authenticated
principal 'test-principal' at
[email protected]:38384
3: I1206 13:54:03.653321 15978 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(719)@172.17.0.4:38384
3: I1206 13:54:03.653396 15986 task_status_update_manager.cpp:207] Recovering
task status update manager
3: I1206 13:54:03.653441 15977 sched.cpp:502] Successfully authenticated with
master [email protected]:38384
3: I1206 13:54:03.653589 15977 sched.cpp:824] Sending SUBSCRIBE call to
[email protected]:38384
3: I1206 13:54:03.653729 15977 sched.cpp:857] Will retry registration in
1.238396064secs if necessary
3: I1206 13:54:03.653959 15990 master.cpp:2969] Received SUBSCRIBE call for
framework 'default' at
[email protected]:38384
3: I1206 13:54:03.653983 15990 master.cpp:2286] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
3: I1206 13:54:03.654064 15984 slave.cpp:6570] Finished recovery
3: I1206 13:54:03.654515 15980 master.cpp:3049] Subscribing framework default
with checkpointing disabled and capabilities [ MULTI_ROLE,
RESERVATION_REFINEMENT ]
3: I1206 13:54:03.654688 15980 master.cpp:9021] Adding framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 (default) at
[email protected]:38384 with roles { }
suppressed
3: I1206 13:54:03.655037 15981 slave.cpp:1013] New master detected at
[email protected]:38384
3: I1206 13:54:03.655071 15980 task_status_update_manager.cpp:181] Pausing
sending task status updates
3: I1206 13:54:03.655119 15981 slave.cpp:1068] Detecting new master
3: I1206 13:54:03.655133 15989 sched.cpp:751] Framework registered with
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.655174 15989 sched.cpp:765] Scheduler::registered took 30333ns
3: I1206 13:54:03.655189 15976 hierarchical.cpp:297] Added framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.655364 15976 hierarchical.cpp:1527] Performed allocation for
0 agents in 71351ns
3: I1206 13:54:03.663552 15986 slave.cpp:1095] Authenticating with master
[email protected]:38384
3: I1206 13:54:03.663627 15986 slave.cpp:1104] Using default CRAM-MD5
authenticatee
3: I1206 13:54:03.663914 15988 authenticatee.cpp:121] Creating new client SASL
connection
3: I1206 13:54:03.664193 15977 master.cpp:8800] Authenticating
slave(362)@172.17.0.4:38384
3: I1206 13:54:03.664340 15987 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(720)@172.17.0.4:38384
3: I1206 13:54:03.664628 15990 authenticator.cpp:98] Creating new server SASL
connection
3: I1206 13:54:03.664861 15985 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1206 13:54:03.664880 15985 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1206 13:54:03.664974 15984 authenticator.cpp:204] Received SASL
authentication start
3: I1206 13:54:03.665030 15984 authenticator.cpp:326] Authentication requires
more steps
3: I1206 13:54:03.665141 15979 authenticatee.cpp:259] Received SASL
authentication step
3: I1206 13:54:03.665277 15991 authenticator.cpp:232] Received SASL
authentication step
3: I1206 13:54:03.665316 15991 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: 'b0940c1f4a66' server FQDN: 'b0940c1f4a66'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1206 13:54:03.665333 15991 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1206 13:54:03.665362 15991 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1206 13:54:03.665385 15991 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: 'b0940c1f4a66' server FQDN: 'b0940c1f4a66'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1206 13:54:03.665395 15991 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1206 13:54:03.665400 15991 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1206 13:54:03.665411 15991 authenticator.cpp:318] Authentication success
3: I1206 13:54:03.665486 15983 authenticatee.cpp:299] Authentication success
3: I1206 13:54:03.665571 15980 master.cpp:8830] Successfully authenticated
principal 'test-principal' at slave(362)@172.17.0.4:38384
3: I1206 13:54:03.665592 15978 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(720)@172.17.0.4:38384
3: I1206 13:54:03.665812 15983 slave.cpp:1187] Successfully authenticated with
master [email protected]:38384
3: I1206 13:54:03.666108 15983 slave.cpp:1730] Will retry registration in
19.889929ms if necessary
3: I1206 13:54:03.666450 15986 master.cpp:6042] Received register agent message
from slave(362)@172.17.0.4:38384 (b0940c1f4a66)
3: I1206 13:54:03.666570 15986 master.cpp:3878] Authorizing agent with
principal 'test-principal'
3: I1206 13:54:03.667033 15977 master.cpp:6118] Authorized registration of
agent at slave(362)@172.17.0.4:38384 (b0940c1f4a66)
3: I1206 13:54:03.667129 15977 master.cpp:6211] Registering agent at
slave(362)@172.17.0.4:38384 (b0940c1f4a66) with id
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0
3: I1206 13:54:03.667608 15987 registrar.cpp:495] Applied 1 operations in
111210ns; attempting to update the registry
3: I1206 13:54:03.668314 15987 registrar.cpp:552] Successfully updated the
registry in 646144ns
3: I1206 13:54:03.668614 15991 master.cpp:6260] Admitted agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.669188 15991 master.cpp:6296] Registered agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1206 13:54:03.669330 15989 slave.cpp:1233] Registered with master
[email protected]:38384; given agent ID c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0
3: I1206 13:54:03.669452 15981 task_status_update_manager.cpp:188] Resuming
sending task status updates
3: I1206 13:54:03.669668 15980 hierarchical.cpp:577] Added agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 (b0940c1f4a66) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
3: I1206 13:54:03.669692 15989 slave.cpp:1253] Checkpointing SlaveInfo to
'/tmp/MasterTest_MultipleExecutors_i7T5A0/meta/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/slave.info'
3: I1206 13:54:03.670260 15989 slave.cpp:1332] Forwarding total oversubscribed
resources {}
3: I1206 13:54:03.670459 15978 master.cpp:7243] Received update of agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66) with total oversubscribed resources {}
3: I1206 13:54:03.670625 15978 master.cpp:7286] Ignoring update on agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66) as it reports no changes
3: I1206 13:54:03.671144 15980 hierarchical.cpp:1527] Performed allocation for
1 agents in 1.259988ms
3: I1206 13:54:03.671579 15986 master.cpp:8630] Sending 1 offers to framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 (default) at
[email protected]:38384
3: I1206 13:54:03.672034 15988 sched.cpp:921] Scheduler::resourceOffers took
106823ns
3: I1206 13:54:03.674376 15991 master.cpp:10550] Removing offer
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-O0
3: I1206 13:54:03.674572 15991 master.cpp:4236] Processing ACCEPT call for
offers: [ c17bc1fe-c409-4e7c-8fc7-a46d24c68635-O0 ] on agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66) for framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
(default) at [email protected]:38384
3: I1206 13:54:03.674700 15991 master.cpp:3605] Authorizing framework principal
'test-principal' to launch task 1
3: I1206 13:54:03.674890 15991 master.cpp:3605] Authorizing framework principal
'test-principal' to launch task 2
3: W1206 13:54:03.676635 15983 validation.cpp:1391] 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.
3: W1206 13:54:03.676668 15983 validation.cpp:1403] 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.
3: I1206 13:54:03.677067 15983 master.cpp:11302] Adding task 1 with resources
cpus(allocated: *):1; mem(allocated: *):512 on agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.677232 15983 master.cpp:4984] Launching task 1 of framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 (default) at
[email protected]:38384 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at
slave(362)@172.17.0.4:38384 (b0940c1f4a66)
3: I1206 13:54:03.677791 15978 slave.cpp:1851] Got assigned task '1' for
framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: W1206 13:54:03.678342 15983 validation.cpp:1391] 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.
3: W1206 13:54:03.678366 15983 validation.cpp:1403] 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.
3: I1206 13:54:03.678444 15978 slave.cpp:2119] Authorizing task '1' for
framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.678496 15978 slave.cpp:7468] Authorizing framework principal
'test-principal' to launch task 1
3: I1206 13:54:03.678660 15983 master.cpp:11302] Adding task 2 with resources
cpus(allocated: *):1; mem(allocated: *):512 on agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at slave(362)@172.17.0.4:38384
(b0940c1f4a66)
3: I1206 13:54:03.678818 15983 master.cpp:4984] Launching task 2 of framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 (default) at
[email protected]:38384 with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
on agent c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 at
slave(362)@172.17.0.4:38384 (b0940c1f4a66)
3: I1206 13:54:03.679229 15977 slave.cpp:1851] Got assigned task '2' for
framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.679744 15977 slave.cpp:2287] Launching task '1' for framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.679879 15990 hierarchical.cpp:1202] 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 c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 from
framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.679956 15990 hierarchical.cpp:1248] Framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 filtered agent
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0 for 5secs
3: I1206 13:54:03.680409 15977 paths.cpp:702] Trying to chown
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
to user 'mesos'
3: I1206 13:54:03.680671 15977 slave.cpp:7942] Launching executor 'executor-1'
of framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 with resources [] in
work directory
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
3: I1206 13:54:03.681115 15977 slave.cpp:2978] Launching container
893f1cbe-7f76-4e76-963e-29a66f939862 for executor 'executor-1' of framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.681355 15977 slave.cpp:2515] Queued task '1' for executor
'executor-1' of framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.681484 15977 slave.cpp:2119] Authorizing task '2' for
framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.681555 15977 slave.cpp:7468] Authorizing framework principal
'test-principal' to launch task 2
3: I1206 13:54:03.681864 15977 slave.cpp:964] Successfully attached
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
to virtual path
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/latest'
3: I1206 13:54:03.681901 15977 slave.cpp:964] Successfully attached
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
to virtual path
'/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/latest'
3: I1206 13:54:03.681942 15977 slave.cpp:964] Successfully attached
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
to virtual path
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-1/runs/893f1cbe-7f76-4e76-963e-29a66f939862'
3: I1206 13:54:03.682229 15991 slave.cpp:2287] Launching task '2' for framework
c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000
3: I1206 13:54:03.682749 15991 paths.cpp:702] Trying to chown
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-2/runs/8b3a8646-a576-4fad-83a7-2021c8de5cac'
to user 'mesos'
3: I1206 13:54:03.682986 15991 slave.cpp:7942] Launching executor 'executor-2'
of framework c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000 with resources [] in
work directory
'/tmp/MasterTest_MultipleExecutors_i7T5A0/slaves/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-S0/frameworks/c17bc1fe-c409-4e7c-8fc7-a46d24c68635-0000/executors/executor-2/runs/8b3a8646-a576-4fad-83a7-2021c8de5cac'
3: *** Aborted at 1512568443 (unix time) try "date -d @1512568443" if you are
using GNU date ***
3: W1206 13:54:03.683915 15979 process.cpp:2756] Attempted to spawn already
running process [email protected]:38384
3: PC: @ 0x2aca2059a82d (unknown)
3: I1206 13:54:03.684116 15979 exec.cpp:162] Version: 1.5.0
3: *** SIGSEGV (@0xd0) received by PID 15975 (TID 0x2aca29831700) from PID 208;
stack trace: ***
3: I1206 13:54:03.684427 15978 exec.cpp:212] Executor started at:
executor(134)@172.17.0.4:38384 with pid 15975
3: @ 0x2aca1c6c5330 (unknown)
3: @ 0x2aca2059a82d (unknown)
3: @ 0xe386c8 os::getenv()
3: @ 0x2aca1794720b mesos::internal::slave::executorEnvironment()
3: @ 0x2aca17942879 mesos::internal::slave::Slave::launchExecutor()
3: @ 0x2aca1793df07 mesos::internal::slave::Slave::__run()
3: @ 0x2aca17a61dc3
_ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEESB_SE_SH_SM_SQ_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_ENKUlOS9_OSC_OSF_OSK_OSO_PNS_11ProcessBaseEE_clES1D_S1E_S1F_S1G_S1H_S1J_
3: @ 0x2aca17a61413
_ZN5cpp176invokeIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS1_6FutureISt4listIbSaIbEEEERKNS3_13FrameworkInfoERKNS3_12ExecutorInfoERK6OptionINS3_8TaskInfoEERKSK_INS3_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS1_3PIDIT_EEMSU_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSB_OSE_OSH_OSM_OSQ_PNS1_11ProcessBaseEE_JSB_SE_SH_SM_SQ_S1L_EEEDTclclsr3stdE7forwardISU_Efp_Espclsr3stdE7forwardIT0_Efp0_EEEOSU_DpOS1N_
3: @ 0x2aca17a61345
_ZN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS2_6FutureISt4listIbSaIbEEEERKNS4_13FrameworkInfoERKNS4_12ExecutorInfoERK6OptionINS4_8TaskInfoEERKSL_INS4_13TaskGroupInfoEESE_SH_SK_SP_ST_EEvRKNS2_3PIDIT_EEMSV_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSC_OSF_OSI_OSN_OSR_PNS2_11ProcessBaseEE_JSC_SF_SI_SN_SR_St12_PlaceholderILi1EEEE13invoke_expandIS1N_St5tupleIJSC_SF_SI_SN_SR_S1P_EES1S_IJOS1M_EEJLm0ELm1ELm2ELm3ELm4ELm5EEEEDTclsr5cpp17E6invokeclsr3stdE7forwardISV_Efp_Espcl6expandclsr3stdE3getIXT2_EEclsr3stdE7forwardISZ_Efp0_EEclsr3stdE7forwardIS10_Efp2_EEEEOSV_OSZ_N5cpp1416integer_sequenceImJXspT2_EEEEOS10_
3: @ 0x2aca17a611cb
_ZNO6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS2_6FutureISt4listIbSaIbEEEERKNS4_13FrameworkInfoERKNS4_12ExecutorInfoERK6OptionINS4_8TaskInfoEERKSL_INS4_13TaskGroupInfoEESE_SH_SK_SP_ST_EEvRKNS2_3PIDIT_EEMSV_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSC_OSF_OSI_OSN_OSR_PNS2_11ProcessBaseEE_JSC_SF_SI_SN_SR_St12_PlaceholderILi1EEEEclIJS1M_EEEDTcl13invoke_expandclL_ZSt4moveIRS1N_EONSt16remove_referenceISV_E4typeEOSV_EdtdefpT1fEclL_ZS1S_IRSt5tupleIJSC_SF_SI_SN_SR_S1P_EEES1X_S1Y_EdtdefpT10bound_argsEcvN5cpp1416integer_sequenceImJLm0ELm1ELm2ELm3ELm4ELm5EEEE_Eclsr3stdE16forward_as_tuplespclsr3stdE7forwardIT_Efp_EEEEDpOS25_
3: @ 0x2aca17a61152
_ZN5cpp176invokeIN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS4_6FutureISt4listIbSaIbEEEERKNS6_13FrameworkInfoERKNS6_12ExecutorInfoERK6OptionINS6_8TaskInfoEERKSN_INS6_13TaskGroupInfoEESG_SJ_SM_SR_SV_EEvRKNS4_3PIDIT_EEMSX_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSE_OSH_OSK_OSP_OST_PNS4_11ProcessBaseEE_JSE_SH_SK_SP_ST_St12_PlaceholderILi1EEEEEJS1O_EEEDTclclsr3stdE7forwardISX_Efp_Espclsr3stdE7forwardIT0_Efp0_EEEOSX_DpOS1T_
3: @ 0x2aca17a61116
_ZN6lambda8internal6InvokeIvEclINS0_7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS5_6FutureISt4listIbSaIbEEEERKNS7_13FrameworkInfoERKNS7_12ExecutorInfoERK6OptionINS7_8TaskInfoEERKSO_INS7_13TaskGroupInfoEESH_SK_SN_SS_SW_EEvRKNS5_3PIDIT_EEMSY_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSF_OSI_OSL_OSQ_OSU_PNS5_11ProcessBaseEE_JSF_SI_SL_SQ_SU_St12_PlaceholderILi1EEEEEJS1P_EEEvOSY_DpOT0_
3: @ 0x2aca17a610ba
_ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEE10CallableFnINS_8internal7PartialIZNS1_8dispatchIN5mesos8internal5slave5SlaveERKNS1_6FutureISt4listIbSaIbEEEERKNSA_13FrameworkInfoERKNSA_12ExecutorInfoERK6OptionINSA_8TaskInfoEERKSR_INSA_13TaskGroupInfoEESK_SN_SQ_SV_SZ_EEvRKNS1_3PIDIT_EEMS11_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlOSI_OSL_OSO_OST_OSX_S3_E_JSI_SL_SO_ST_SX_St12_PlaceholderILi1EEEEEEclEOS3_
3: @ 0x2aca1b945e5d
_ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEEclES3_
3: @ 0x2aca1b9275cc process::ProcessBase::consume()
3: @ 0x2aca1b9e9649
_ZNO7process13DispatchEvent7consumeEPNS_13EventConsumerE
3: @ 0xd04154 process::ProcessBase::serve()
3: @ 0x2aca1b924483 process::ProcessManager::resume()
3: @ 0x2aca1b937101
process::ProcessManager::init_threads()::$_9::operator()()
3: @ 0x2aca1b937045
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3: @ 0x2aca1b937015 std::_Bind_simple<>::operator()()
3: @ 0x2aca1b936fec std::thread::_Impl<>::_M_run()
3: @ 0x2aca1fdf0a60 (unknown)
3: @ 0x2aca1c6bd184 start_thread
3: @ 0x2aca2065cffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: SegFault188.04 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 204.19 sec
The following tests FAILED:
3 - MesosTests (SEGFAULT)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
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-1512566694-9572
Untagged: mesos-1512566694-9572:latest
Deleted: sha256:1b23b9b51e865d9ebb59ed50b54a62ad219ab5defdcd769653282cc30b6d622e
Deleted: sha256:54773df4e81b7750157c4256289133f8af7babf588ed3f21d5d72e16ac4d5a1d
Deleted: sha256:7071f114b38a31602cfaddd880778dba10541473f2e02e12da93ac60a38421f4
Deleted: sha256:cdd7d73a9e2320bceba569488013eeecd48bd1e08566d3c7b3991008975ea8eb
Deleted: sha256:6573415cbd2fcefc49bff7d708c51022cc242510fcaa4805ada93dff24c1194f
Deleted: sha256:51404157e249de9cd304315eed261fcb573118f6f68d4caa5b32ebf6dc380a96
Deleted: sha256:3b8d55ca39abd91d96d2a05c94fd979c63993a340f9040042395235c7afc799b
Deleted: sha256:9df0c5e505afc9b1bbf8f3955d4981af14fb27edef5df81d50248b57a787b38a
Deleted: sha256:885f4658cf4fa56444abde39adff5fed0066b16e6c979cce1e373576203292d9
Deleted: sha256:acf32ed053a9f90395add344dedf785e1f4061a2bb44589c0d57765637eae934
Deleted: sha256:5f57e4caa7d38aa5691f076328c15f985713c1a27859db9c123229d5be83f082
Deleted: sha256:eeda5016619c09d3ca77f5acf0661c63a7dbb2806f52ebd8e0d129aa67fe1040
Deleted: sha256:919905f9cdbe07faf63c1feeb42c5aa8181365f62fb8bfcbb6a6e11ccb737046
Deleted: sha256:106a409084a40a8485b20f04f0e013861b1dda4434949b6c2aec4db32d883d03
Deleted: sha256:bb3e9780b99ff577fe854a390e1304c6d8e4aada5aed73f81c6481ec15cc618a
Deleted: sha256:00f09c1e76413b3d96dfcafa811dc772c66a9f3d64dc5e5e6cc7b54ed39c1ab8
Deleted: sha256:f32b4e867201706bff4662ad70a82eb5efcf489047faaa6d70f08f00f6b75bb8
Deleted: sha256:319c25c340f63cd540f0a49e4eec746537a0ad7a4965f307a6978a237ced8b64
Deleted: sha256:55ff968de5e37994637ee33c8c8294a000ff165113e1559a10e16869b3b81582
Deleted: sha256:a1a56e803064f04ef6f2df41513a9a62b7b4cc1de717f1be5145acce0d8403e0
Deleted: sha256:afcb3b970d2daedd70d71209d68da37224ec3c836f35bd63046ab2cb568c0666
Deleted: sha256:78bcdc93d44f634a970364d1293f706e87b8e9a8f6805d9e54329d32d1e9dc29
Deleted: sha256:b270104c89e53a54fb6727169c7d679f71c01c136bf8bb4f3bfb66bc1cb4eb0b
Deleted: sha256:7e13f2ef4a090cc712d72554061f40612b3a58362bcce872c4ebce28acd7ae0f
Deleted: sha256:6900393c241a67aee99d164de143a81546980112eb4bff340db8ea2062638b75
Deleted: sha256:156d15906020ec0cc21439c0b0a9d3253cb636f8340eec7542f6b1e3aba8ee20
Deleted: sha256:705aadd8a273285b8f1bc3753b7d5d070ad59d33f628d3b215de79a22dc28d3d
Deleted: sha256:13712f46653f0c0535776c9b3f131d85f2141a51f44e745c85049573b24d6644
Deleted: sha256:3d0c7bc0f7ead751ca086a15f3ca4afe43ba2e95b321489bc3b861ab9b5d1355
Deleted: sha256:7dee4d34620f8343fc455e8f3f8a0f9fa02e74fe853f4eac76c07d88b3afdb39
Deleted: sha256:d6ed29ffda6b37d78b98cf4d2ca809df6366d6578c6704c233fa8c7b24a3caa4
Build step 'Execute shell' marked build as failure