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,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3739
Date Sat, 27 May 2017 15:04:06 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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3739/display/redirect>

------------------------------------------
[...truncated 13.44 MB...]
I0527 15:03:56.947402  1093 master.cpp:5194] Processing ACKNOWLEDGE call a158b8e6-b594-41ca-b8ff-121e49ad2c97
for task 1 of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000 (default) at scheduler-38c368f9-8f26-4f83-aa8c-cd8f89bb1359@172.17.0.3:47110
on agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
I0527 15:03:56.947597  1099 status_update_manager.cpp:395] Received status update acknowledgement
(UUID: a158b8e6-b594-41ca-b8ff-121e49ad2c97) for task 1 of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.947643  1096 exec.cpp:416] Executor received framework message
I0527 15:03:56.947690  1096 exec.cpp:425] Executor::frameworkMessage took 26901ns
I0527 15:03:56.947731  1091 slave.cpp:3529] Status update manager successfully handled status
update acknowledgement (UUID: a158b8e6-b594-41ca-b8ff-121e49ad2c97) for task 1 of framework
b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.947970  1098 slave.cpp:4787] Sending message for framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
to scheduler-38c368f9-8f26-4f83-aa8c-cd8f89bb1359@172.17.0.3:47110
I0527 15:03:56.948097  1097 sched.cpp:1177] Scheduler::frameworkMessage took 23480ns
I0527 15:03:56.948310  1090 sched.cpp:2021] Asked to stop the driver
I0527 15:03:56.948369  1104 sched.cpp:1203] Stopping framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.948508  1103 master.cpp:8000] Processing TEARDOWN call for framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
(default) at scheduler-38c368f9-8f26-4f83-aa8c-cd8f89bb1359@172.17.0.3:47110
I0527 15:03:56.948552  1103 master.cpp:8012] Removing framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
(default) at scheduler-38c368f9-8f26-4f83-aa8c-cd8f89bb1359@172.17.0.3:47110
I0527 15:03:56.948590  1103 master.cpp:3160] Deactivating framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
(default) at scheduler-38c368f9-8f26-4f83-aa8c-cd8f89bb1359@172.17.0.3:47110
I0527 15:03:56.948668  1103 master.cpp:8580] Updating the state of task 1 of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
(latest state: TASK_KILLED, status update state: TASK_KILLED)
I0527 15:03:56.948825  1092 slave.cpp:3082] Asked to shut down framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
by master@172.17.0.3:47110
I0527 15:03:56.948858  1103 master.cpp:8674] Removing task 1 with resources cpus(*)(allocated:
*):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]
of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000 on agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.948906  1092 slave.cpp:3107] Shutting down framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.948920  1092 slave.cpp:5546] Shutting down executor 'default' of framework
b57aadbd-b38b-458f-94a5-66a137115a2d-0000 at executor(123)@172.17.0.3:47110
I0527 15:03:56.948835  1102 hierarchical.cpp:374] Deactivated framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.948974  1103 master.cpp:8703] Removing executor 'default' with resources {}
of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000 on agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.949005  1099 exec.cpp:435] Executor asked to shutdown
I0527 15:03:56.949080  1099 exec.cpp:450] Executor::shutdown took 51303ns
I0527 15:03:56.949187  1102 hierarchical.cpp:1114] 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 b57aadbd-b38b-458f-94a5-66a137115a2d-S0
from framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.949385  1102 hierarchical.cpp:325] Removed framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.949384  1099 slave.cpp:4851] Got exited event for executor(123)@172.17.0.3:47110
I0527 15:03:56.949553  1101 slave.cpp:5232] Executor 'default' of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
exited with status 0
I0527 15:03:56.949699  1101 slave.cpp:5332] Cleaning up executor 'default' of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
at executor(123)@172.17.0.3:47110
W0527 15:03:56.949741  1104 master.cpp:6604] Ignoring unknown exited executor 'default' of
framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000 on agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.949967  1101 slave.cpp:5420] Cleaning up framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.950027  1104 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_uUjSFQ/slaves/b57aadbd-b38b-458f-94a5-66a137115a2d-S0/frameworks/b57aadbd-b38b-458f-94a5-66a137115a2d-0000/executors/default/runs/c5819a59-1f69-4b7a-a5ec-424306db3c8a'
for gc 6.9999890063437days in the future
I0527 15:03:56.950127  1101 slave.cpp:801] Agent terminating
I0527 15:03:56.950206  1095 master.cpp:1313] Agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b) disconnected
I0527 15:03:56.950232  1095 master.cpp:3197] Disconnecting agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.950254  1104 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_uUjSFQ/slaves/b57aadbd-b38b-458f-94a5-66a137115a2d-S0/frameworks/b57aadbd-b38b-458f-94a5-66a137115a2d-0000/executors/default'
for gc 6.99998900512593days in the future
I0527 15:03:56.950217  1092 status_update_manager.cpp:285] Closing status update streams for
framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.950331  1104 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_uUjSFQ/slaves/b57aadbd-b38b-458f-94a5-66a137115a2d-S0/frameworks/b57aadbd-b38b-458f-94a5-66a137115a2d-0000'
for gc 6.99998900338074days in the future
I0527 15:03:56.950345  1092 status_update_manager.cpp:531] Cleaning up status update stream
for task 1 of framework b57aadbd-b38b-458f-94a5-66a137115a2d-0000
I0527 15:03:56.950273  1095 master.cpp:3216] Deactivating agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
at slave(312)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.950433  1096 hierarchical.cpp:653] Agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
deactivated
I0527 15:03:56.951493  1090 master.cpp:1155] Master terminating
I0527 15:03:56.951668  1092 hierarchical.cpp:558] Removed agent b57aadbd-b38b-458f-94a5-66a137115a2d-S0
[       OK ] MasterTest.FrameworkMessage (39 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0527 15:03:56.955727  1090 cluster.cpp:162] Creating default 'local' authorizer
I0527 15:03:56.956972  1106 master.cpp:436] Master 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1 (01545834673b)
started on 172.17.0.3:47110
I0527 15:03:56.957064  1106 master.cpp:438] 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/TStvbm/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/TStvbm/master" --zk_session_timeout="10secs"
I0527 15:03:56.957247  1106 master.cpp:488] Master only allowing authenticated frameworks
to register
I0527 15:03:56.957267  1106 master.cpp:502] Master only allowing authenticated agents to register
I0527 15:03:56.957278  1106 master.cpp:515] Master only allowing authenticated HTTP frameworks
to register
I0527 15:03:56.957295  1106 credentials.hpp:37] Loading credentials for authentication from
'/tmp/TStvbm/credentials'
I0527 15:03:56.957468  1106 master.cpp:560] Using default 'crammd5' authenticator
I0527 15:03:56.957545  1106 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readonly'
I0527 15:03:56.957628  1106 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-readwrite'
I0527 15:03:56.957690  1106 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-master-scheduler'
I0527 15:03:56.957775  1106 master.cpp:640] Authorization enabled
I0527 15:03:56.958082  1098 whitelist_watcher.cpp:77] No whitelist given
I0527 15:03:56.958096  1101 hierarchical.cpp:158] Initialized hierarchical allocator process
I0527 15:03:56.959002  1104 master.cpp:2161] Elected as the leading master!
I0527 15:03:56.959018  1104 master.cpp:1700] Recovering from registrar
I0527 15:03:56.959107  1101 registrar.cpp:345] Recovering registrar
I0527 15:03:56.959520  1092 registrar.cpp:389] Successfully fetched the registry (0B) in 351232ns
I0527 15:03:56.959563  1092 registrar.cpp:493] Applied 1 operations in 6269ns; attempting
to update the registry
I0527 15:03:56.959841  1095 registrar.cpp:550] Successfully updated the registry in 250880ns
I0527 15:03:56.959954  1095 registrar.cpp:422] Successfully recovered registrar
I0527 15:03:56.960275  1095 hierarchical.cpp:185] Skipping recovery of hierarchical allocator:
nothing to recover
I0527 15:03:56.960278  1097 master.cpp:1799] Recovered 0 agents from the registry (129B);
allowing 10mins for agents to re-register
I0527 15:03:56.962496  1090 cluster.cpp:448] Creating default 'local' authorizer
I0527 15:03:56.963089  1105 slave.cpp:232] Mesos agent started on (313)@172.17.0.3:47110
I0527 15:03:56.963114  1105 slave.cpp:233] 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_R3ZG4B/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_reregistration_timeout="2secs"
--executor_secret_key="/tmp/MasterTest_MultipleExecutors_R3ZG4B/executor_secret_key" --executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_R3ZG4B/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_R3ZG4B/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_R3ZG4B" --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_txM57Y"
I0527 15:03:56.963387  1105 credentials.hpp:86] Loading credential for authentication from
'/tmp/MasterTest_MultipleExecutors_R3ZG4B/credential'
I0527 15:03:56.963490  1105 slave.cpp:265] Agent using credential for: test-principal
I0527 15:03:56.963510  1105 credentials.hpp:37] Loading credentials for authentication from
'/tmp/MasterTest_MultipleExecutors_R3ZG4B/http_credentials'
I0527 15:03:56.963665  1090 sched.cpp:232] Version: 1.4.0
I0527 15:03:56.963728  1105 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-executor'
I0527 15:03:56.963771  1105 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-executor'
I0527 15:03:56.963871  1105 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readonly'
I0527 15:03:56.963881  1100 sched.cpp:336] New master detected at master@172.17.0.3:47110
I0527 15:03:56.963918  1100 sched.cpp:407] Authenticating with master master@172.17.0.3:47110
I0527 15:03:56.963919  1105 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readonly'
I0527 15:03:56.964016  1100 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0527 15:03:56.964102  1105 http.cpp:975] Creating default 'basic' HTTP authenticator for
realm 'mesos-agent-readwrite'
I0527 15:03:56.964148  1105 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm
'mesos-agent-readwrite'
I0527 15:03:56.964157  1097 authenticatee.cpp:121] Creating new client SASL connection
I0527 15:03:56.964427  1095 master.cpp:7487] Authenticating scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110
I0527 15:03:56.964495  1104 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(663)@172.17.0.3:47110
I0527 15:03:56.964649  1095 authenticator.cpp:98] Creating new server SASL connection
I0527 15:03:56.964798  1091 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0527 15:03:56.964825  1091 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0527 15:03:56.964844  1105 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I0527 15:03:56.964880  1091 authenticator.cpp:204] Received SASL authentication start
I0527 15:03:56.964884  1105 slave.cpp:544] Agent attributes: [  ]
I0527 15:03:56.964908  1105 slave.cpp:549] Agent hostname: 01545834673b
I0527 15:03:56.964931  1091 authenticator.cpp:326] Authentication requires more steps
I0527 15:03:56.964984  1095 status_update_manager.cpp:177] Pausing sending status updates
I0527 15:03:56.965009  1091 authenticatee.cpp:259] Received SASL authentication step
I0527 15:03:56.965078  1091 authenticator.cpp:232] Received SASL authentication step
I0527 15:03:56.965108  1091 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '01545834673b' server FQDN: '01545834673b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0527 15:03:56.965127  1091 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0527 15:03:56.965145  1091 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0527 15:03:56.965165  1091 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '01545834673b' server FQDN: '01545834673b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0527 15:03:56.965179  1091 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0527 15:03:56.965190  1091 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0527 15:03:56.965212  1091 authenticator.cpp:318] Authentication success
I0527 15:03:56.965286  1106 authenticatee.cpp:299] Authentication success
I0527 15:03:56.965333  1103 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(663)@172.17.0.3:47110
I0527 15:03:56.965348  1091 master.cpp:7517] Successfully authenticated principal 'test-principal'
at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110
I0527 15:03:56.965507  1095 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:47110
I0527 15:03:56.965533  1095 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:47110
I0527 15:03:56.965541  1092 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_txM57Y/meta'
I0527 15:03:56.965634  1091 master.cpp:2813] Received SUBSCRIBE call for framework 'default'
at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110
I0527 15:03:56.965574  1095 sched.cpp:869] Will retry registration in 1.455662253secs if necessary
I0527 15:03:56.965672  1091 master.cpp:2197] Authorizing framework principal 'test-principal'
to receive offers for roles '{ * }'
I0527 15:03:56.965744  1102 status_update_manager.cpp:203] Recovering status update manager
I0527 15:03:56.965932  1096 master.cpp:2890] Subscribing framework default with checkpointing
disabled and capabilities [  ]
I0527 15:03:56.966080  1105 slave.cpp:6083] Finished recovery
I0527 15:03:56.966204  1097 hierarchical.cpp:273] Added framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.966215  1101 sched.cpp:759] Framework registered with 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.966269  1101 sched.cpp:773] Scheduler::registered took 22991ns
I0527 15:03:56.966301  1097 hierarchical.cpp:1854] No allocations performed
I0527 15:03:56.966325  1097 hierarchical.cpp:1944] No inverse offers to send out!
I0527 15:03:56.966344  1097 hierarchical.cpp:1438] Performed allocation for 0 agents in 50902ns
I0527 15:03:56.966514  1105 slave.cpp:6265] Querying resource estimator for oversubscribable
resources
I0527 15:03:56.966652  1105 slave.cpp:929] New master detected at master@172.17.0.3:47110
I0527 15:03:56.966660  1101 status_update_manager.cpp:177] Pausing sending status updates
I0527 15:03:56.966697  1105 slave.cpp:964] Detecting new master
I0527 15:03:56.966760  1105 slave.cpp:6279] Received oversubscribable resources {} from the
resource estimator
I0527 15:03:56.973953  1097 slave.cpp:991] Authenticating with master master@172.17.0.3:47110
I0527 15:03:56.973991  1097 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0527 15:03:56.974189  1091 authenticatee.cpp:121] Creating new client SASL connection
I0527 15:03:56.974373  1095 master.cpp:7487] Authenticating slave(313)@172.17.0.3:47110
I0527 15:03:56.974449  1095 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(664)@172.17.0.3:47110
I0527 15:03:56.974537  1103 authenticator.cpp:98] Creating new server SASL connection
I0527 15:03:56.974699  1105 authenticatee.cpp:213] Received SASL authentication mechanisms:
CRAM-MD5
I0527 15:03:56.974735  1105 authenticatee.cpp:239] Attempting to authenticate with mechanism
'CRAM-MD5'
I0527 15:03:56.974802  1105 authenticator.cpp:204] Received SASL authentication start
I0527 15:03:56.974861  1105 authenticator.cpp:326] Authentication requires more steps
I0527 15:03:56.975033  1103 authenticatee.cpp:259] Received SASL authentication step
I0527 15:03:56.975111  1103 authenticator.cpp:232] Received SASL authentication step
I0527 15:03:56.975185  1103 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '01545834673b' server FQDN: '01545834673b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0527 15:03:56.975208  1103 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0527 15:03:56.975230  1103 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0527 15:03:56.975258  1103 auxprop.cpp:109] Request to lookup properties for user: 'test-principal'
realm: '01545834673b' server FQDN: '01545834673b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0527 15:03:56.975275  1103 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0527 15:03:56.975296  1103 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0527 15:03:56.975320  1103 authenticator.cpp:318] Authentication success
I0527 15:03:56.975399  1097 authenticatee.cpp:299] Authentication success
I0527 15:03:56.975426  1105 master.cpp:7517] Successfully authenticated principal 'test-principal'
at slave(313)@172.17.0.3:47110
I0527 15:03:56.975447  1103 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(664)@172.17.0.3:47110
I0527 15:03:56.975653  1097 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:47110
I0527 15:03:56.975740  1097 slave.cpp:1506] Will retry registration in 6.155979ms if necessary
I0527 15:03:56.975836  1093 master.cpp:5429] Received register agent message from slave(313)@172.17.0.3:47110
(01545834673b)
I0527 15:03:56.975884  1093 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0527 15:03:56.976058  1104 master.cpp:5489] Authorized registration of agent at slave(313)@172.17.0.3:47110
(01545834673b)
I0527 15:03:56.976124  1104 master.cpp:5568] Registering agent at slave(313)@172.17.0.3:47110
(01545834673b) with id 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
I0527 15:03:56.976287  1099 registrar.cpp:493] Applied 1 operations in 22686ns; attempting
to update the registry
I0527 15:03:56.976452  1092 registrar.cpp:550] Successfully updated the registry in 137984ns
I0527 15:03:56.976533  1099 master.cpp:5615] Admitted agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
at slave(313)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.976707  1099 master.cpp:5646] Registered agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
at slave(313)@172.17.0.3:47110 (01545834673b) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 15:03:56.976836  1099 hierarchical.cpp:525] Added agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
(01545834673b) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated:
{})
I0527 15:03:56.977087  1099 hierarchical.cpp:1944] No inverse offers to send out!
I0527 15:03:56.977104  1099 hierarchical.cpp:1438] Performed allocation for 1 agents in 217338ns
I0527 15:03:56.977140  1099 slave.cpp:1132] Registered with master master@172.17.0.3:47110;
given agent ID 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
I0527 15:03:56.977354  1106 master.cpp:7317] Sending 1 offers to framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
(default) at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110
I0527 15:03:56.977427  1105 status_update_manager.cpp:184] Resuming sending status updates
I0527 15:03:56.977581  1106 sched.cpp:933] Scheduler::resourceOffers took 54492ns
I0527 15:03:56.977648  1099 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_txM57Y/meta/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/slave.info'
I0527 15:03:56.978006  1099 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0527 15:03:56.978094  1099 slave.cpp:4809] Received ping from slave-observer(305)@172.17.0.3:47110
I0527 15:03:56.978121  1101 master.cpp:6336] Received update of agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
at slave(313)@172.17.0.3:47110 (01545834673b) with total oversubscribed resources {}
I0527 15:03:56.978404  1101 master.cpp:3875] Processing ACCEPT call for offers: [ 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-O0
] on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0 at slave(313)@172.17.0.3:47110 (01545834673b)
for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000 (default) at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110
I0527 15:03:56.978446  1101 master.cpp:3426] Authorizing framework principal 'test-principal'
to launch task 1
I0527 15:03:56.978543  1101 master.cpp:3426] Authorizing framework principal 'test-principal'
to launch task 2
W0527 15:03:56.979107  1099 validation.cpp:1284] 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.
W0527 15:03:56.979131  1099 validation.cpp:1296] 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.
I0527 15:03:56.979228  1099 master.cpp:9338] Adding task 1 with resources cpus(*)(allocated:
*):1; mem(*)(allocated: *):512 on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0 at slave(313)@172.17.0.3:47110
(01545834673b)
I0527 15:03:56.979285  1099 master.cpp:4531] Launching task 1 of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
(default) at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110 with resources
cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
at slave(313)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.979466  1095 slave.cpp:1616] Got assigned task '1' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
W0527 15:03:56.979617  1099 validation.cpp:1284] 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.
W0527 15:03:56.979641  1099 validation.cpp:1296] 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.
I0527 15:03:56.979743  1099 master.cpp:9338] Adding task 2 with resources cpus(*)(allocated:
*):1; mem(*)(allocated: *):512 on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0 at slave(313)@172.17.0.3:47110
(01545834673b)
I0527 15:03:56.979801  1095 slave.cpp:1897] Authorizing task '1' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.979816  1099 master.cpp:4531] Launching task 2 of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
(default) at scheduler-50e59d8c-12a4-4e05-ad66-2cc08d676631@172.17.0.3:47110 with resources
cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
at slave(313)@172.17.0.3:47110 (01545834673b)
I0527 15:03:56.979830  1095 slave.cpp:6702] Authorizing framework principal 'test-principal'
to launch task 1
I0527 15:03:56.980106  1095 slave.cpp:1616] Got assigned task '2' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.980420  1095 slave.cpp:2084] Launching task '1' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.980407  1101 hierarchical.cpp:850] Updated allocation of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
on agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-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]
I0527 15:03:56.980545  1101 hierarchical.cpp:1114] 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 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0
from framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.980576  1101 hierarchical.cpp:1151] Framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
filtered agent 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0 for 5secs
I0527 15:03:56.980903  1095 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-1/runs/35115b86-fb13-4546-8fb0-7e378575bd21'
to user 'mesos'
I0527 15:03:56.981061  1095 slave.cpp:7042] Launching executor 'executor-1' of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-1/runs/35115b86-fb13-4546-8fb0-7e378575bd21'
I0527 15:03:56.981299  1095 slave.cpp:2313] Queued task '1' for executor 'executor-1' of framework
6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.981338  1095 slave.cpp:1897] Authorizing task '2' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.981355  1095 slave.cpp:6702] Authorizing framework principal 'test-principal'
to launch task 2
I0527 15:03:56.981456  1095 slave.cpp:882] Successfully attached file '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-1/runs/35115b86-fb13-4546-8fb0-7e378575bd21'
I0527 15:03:56.981560  1095 slave.cpp:2779] Launching container 35115b86-fb13-4546-8fb0-7e378575bd21
for executor 'executor-1' of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.981729  1095 slave.cpp:2084] Launching task '2' for framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.982146  1095 paths.cpp:573] Trying to chown '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-2/runs/6fdd2f6f-9ef7-4f0d-ad10-3e62952c5457'
to user 'mesos'
I0527 15:03:56.982306  1095 slave.cpp:7042] Launching executor 'executor-2' of framework 6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-2/runs/6fdd2f6f-9ef7-4f0d-ad10-3e62952c5457'
I0527 15:03:56.982527  1095 slave.cpp:2313] Queued task '2' for executor 'executor-2' of framework
6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000
I0527 15:03:56.982568  1095 slave.cpp:882] Successfully attached file '/tmp/MasterTest_MultipleExecutors_txM57Y/slaves/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-S0/frameworks/6042d8bb-6ac1-4c2e-a66b-10d4b71d9dc1-0000/executors/executor-2/runs/6fdd2f6f-9ef7-4f0d-ad10-3e62952c5457'
*** Aborted at 1495897436 (unix time) try "date -d @1495897436" if you are using GNU date
***
I0527 15:03:56.982847  1104 exec.cpp:162] Version: 1.4.0
I0527 15:03:56.982956  1096 exec.cpp:212] Executor started at: executor(124)@172.17.0.3:47110
with pid 1090
PC: @     0x7fd3695e60cd __GI_getenv
*** SIGSEGV (@0xf0) received by PID 1090 (TID 0x7fd361ecb700) from PID 240; stack trace: ***
    @     0x7fd36a19f370 (unknown)
    @     0x7fd3695e60cd __GI_getenv
    @     0x7fd36e52d8d4 mesos::internal::slave::executorEnvironment()
    @     0x7fd36e54ea39 mesos::internal::slave::Slave::launchExecutor()
    @     0x7fd36d71f0c1 process::ProcessManager::resume()
    @     0x7fd36d728177 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x7fd369f3c230 (unknown)
    @     0x7fd36a197dc5 start_thread
    @     0x7fd3696a576d __clone
make[3]: *** [CMakeFiles/check] Segmentation fault
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-1495894094-834
Untagged: mesos-1495894094-834:latest
Deleted: sha256:8f87436731bce1c457697f1cc4c5d2b1629cea523d5eab0f2fbfee3cdde09efc
Deleted: sha256:b5ce4d98187151895e92414b450e0833e0643eb9f574d2c18c255c349cb26643
Deleted: sha256:e7b4e06f84c1c07e09a2d7ac6063db506bc15e3c0982ebdb6581cd9ec3b46bbf
Deleted: sha256:effeb353281565808e6436476d032c7cecacb9f12b820a27d0d7c546adafd9d3
Deleted: sha256:c1811e3534571884545cce72e4992044cd0e9d86142c60c82e4e44b444e800c5
Deleted: sha256:fe58cb5e437fd17e07d20842a36a349aee1b4146335699f429ae24af7e4edc97
Deleted: sha256:ce07c52eb88c5f6e619b52f34b9e34ca63c27a80b048e3c2540a6b289d7f24c0
Deleted: sha256:be64d1366bdbf461f2cf4304efdcb0f4788c553615c5313759c1ae928d5e5dd0
Deleted: sha256:5fb25f19e34d0d1ae5d86c0d661630641bf75aa2b69b64615cf0f366bdfb695b
Deleted: sha256:95d4d92bcb0f5ed3b420ffd5f178cd3ea4b44e497abf012b00dac3b44e6ff887
Deleted: sha256:c2ef913fa8835b992fd9fbca495845da14ced27c2b6bd38838f32086d720f902
Deleted: sha256:70c1bef81e82dbf485ce350ff015f58adfa63fae92fdc3539b08e5b84c7f7363
Deleted: sha256:e6e2b4e55a51966a3069d2ba12470068d8db32b8712c5b5cbfa43084cae7ea1c
Deleted: sha256:73b558eaf623d888a0dee2cf7055882b4399a2407411dd6189885e42597d0908
Deleted: sha256:90a8df0d498f498826313603ff4b82e83d3d434f38e4be3c52541c7710c48b67
Deleted: sha256:97f9ae6e4254e30e36fc4bde9562f96709629564ab70d8ffc858bd5ccdc380bd
Deleted: sha256:b71e3e45c7bd49809331ac484242388956c1421befdfc8bd7e6bf83b19a53de6
Deleted: sha256:fa1a443b37575324182313e05a809b33700ab1b7ad04eee84dc90d353f02209b
Deleted: sha256:0e251f21c01d24d46918d54e0aeb81ee5c95407a2d2b949b7b42bf5ff9ea1173
Deleted: sha256:461b29f010e6970acd60fbfe719d6f2244b4776af38d6fa5ad93b91881fb2cef
Deleted: sha256:ec1f474fab101d3fb7bfdf89765c4a51bc95bebeb63e7f66433be4148ec1152f
Deleted: sha256:735f9118fe1c2f77f67489c22551a5f67530e39f4f9bd6ea3d1804df1d34fc51
Deleted: sha256:c39a96fb601311e005d4a2dae818f4bbb24f3c373bad4591adae1520d83be519
Deleted: sha256:4226056d0a1a126bdf270aa013be4fa5b4cc2e2f4d6d29021a5603423a89b846
Deleted: sha256:463f908b8de4587e426f30fc30be76891a720afdff49f39824ccbad96e7aae5a
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Mime
View raw message