You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/02/01 20:16:11 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3206
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3206/changes>
Changes:
[alexr] Fixed minor formatting issue in "scheduler.proto".
[alexr] Updated reconciliation comment in "scheduler.proto".
[vinodkone] Removed inactive Athens, Greece MUG from communities.
------------------------------------------
[...truncated 85565 lines...]
I0201 20:16:05.740766 25330 slave.cpp:3756] Handling status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 from executor(120)@172.17.0.3:33639
I0201 20:16:05.741016 25332 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.741040 25332 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.741195 25332 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 to the agent
I0201 20:16:05.741309 25335 slave.cpp:4196] Forwarding the update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 to master@172.17.0.3:33639
I0201 20:16:05.741428 25335 slave.cpp:4090] Status update manager successfully handled status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.741437 25330 master.cpp:6021] Status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 from agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.741458 25335 slave.cpp:4106] Sending acknowledgement for status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 to executor(120)@172.17.0.3:33639
I0201 20:16:05.741466 25330 master.cpp:6089] Forwarding status update TASK_RUNNING (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.741540 25324 exec.cpp:369] Executor received status update acknowledgement 88d44739-9f4a-48cb-ad69-4d3971168cff for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.741574 25330 master.cpp:8157] Updating the state of task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0201 20:16:05.741765 25335 sched.cpp:1041] Scheduler::statusUpdate took 115303ns
I0201 20:16:05.741881 25328 master.cpp:5017] Processing ACKNOWLEDGE call 88d44739-9f4a-48cb-ad69-4d3971168cff for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (default) at scheduler-c598b27f-4063-4fd6-bc76-c081a91e74c4@172.17.0.3:33639 on agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0
I0201 20:16:05.742183 25330 exec.cpp:391] Executor received framework message
I0201 20:16:05.742197 25327 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.742223 25330 exec.cpp:400] Executor::frameworkMessage took 31898ns
I0201 20:16:05.742319 25330 slave.cpp:3045] Status update manager successfully handled status update acknowledgement (UUID: 88d44739-9f4a-48cb-ad69-4d3971168cff) for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.742516 25332 slave.cpp:4264] Sending message for framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 to scheduler-c598b27f-4063-4fd6-bc76-c081a91e74c4@172.17.0.3:33639
I0201 20:16:05.742588 25332 sched.cpp:1177] Scheduler::frameworkMessage took 26641ns
I0201 20:16:05.742787 25321 sched.cpp:2021] Asked to stop the driver
I0201 20:16:05.742843 25336 sched.cpp:1203] Stopping framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.742939 25332 master.cpp:7560] Processing TEARDOWN call for framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (default) at scheduler-c598b27f-4063-4fd6-bc76-c081a91e74c4@172.17.0.3:33639
I0201 20:16:05.743108 25332 master.cpp:7572] Removing framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (default) at scheduler-c598b27f-4063-4fd6-bc76-c081a91e74c4@172.17.0.3:33639
I0201 20:16:05.743130 25332 master.cpp:3080] Deactivating framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (default) at scheduler-c598b27f-4063-4fd6-bc76-c081a91e74c4@172.17.0.3:33639
I0201 20:16:05.743221 25332 master.cpp:8157] Updating the state of task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0201 20:16:05.743239 25328 slave.cpp:2598] Asked to shut down framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 by master@172.17.0.3:33639
I0201 20:16:05.743229 25329 hierarchical.cpp:386] Deactivated framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.743302 25328 slave.cpp:2623] Shutting down framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.743352 25328 slave.cpp:5005] Shutting down executor 'default' of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 at executor(120)@172.17.0.3:33639
I0201 20:16:05.743455 25328 exec.cpp:410] Executor asked to shutdown
I0201 20:16:05.743479 25332 master.cpp:8251] Removing task 1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 on agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.743538 25328 exec.cpp:425] Executor::shutdown took 76200ns
I0201 20:16:05.743597 25332 master.cpp:8280] Removing executor 'default' with resources {} of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 on agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.743592 25329 hierarchical.cpp:1011] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 from framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.743645 25326 slave.cpp:4328] Got exited event for executor(120)@172.17.0.3:33639
I0201 20:16:05.743928 25329 hierarchical.cpp:337] Removed framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.744065 25337 slave.cpp:4691] Executor 'default' of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 exited with status 0
I0201 20:16:05.744096 25337 slave.cpp:4791] Cleaning up executor 'default' of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 at executor(120)@172.17.0.3:33639
W0201 20:16:05.744143 25328 master.cpp:6145] Ignoring unknown exited executor 'default' of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000 on agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.744235 25328 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BvIIt1/slaves/1782e7b1-d2c7-4228-b959-d358aa03c898-S0/frameworks/1782e7b1-d2c7-4228-b959-d358aa03c898-0000/executors/default/runs/47279c32-8f4f-46a5-9d7b-f83a756dad6a' for gc 6.99999138656296days in the future
I0201 20:16:05.744308 25337 slave.cpp:4879] Cleaning up framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.744313 25328 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BvIIt1/slaves/1782e7b1-d2c7-4228-b959-d358aa03c898-S0/frameworks/1782e7b1-d2c7-4228-b959-d358aa03c898-0000/executors/default' for gc 6.99999138561481days in the future
I0201 20:16:05.744400 25333 status_update_manager.cpp:285] Closing status update streams for framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.744416 25333 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 1782e7b1-d2c7-4228-b959-d358aa03c898-0000
I0201 20:16:05.744454 25337 slave.cpp:801] Agent terminating
I0201 20:16:05.744503 25333 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_BvIIt1/slaves/1782e7b1-d2c7-4228-b959-d358aa03c898-S0/frameworks/1782e7b1-d2c7-4228-b959-d358aa03c898-0000' for gc 6.99999138400593days in the future
I0201 20:16:05.744549 25333 master.cpp:1263] Agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d) disconnected
I0201 20:16:05.744560 25333 master.cpp:3117] Disconnecting agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.744582 25333 master.cpp:3136] Deactivating agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 at slave(286)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.744717 25333 hierarchical.cpp:577] Agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0 deactivated
I0201 20:16:05.745723 25321 master.cpp:1102] Master terminating
I0201 20:16:05.746034 25333 hierarchical.cpp:510] Removed agent 1782e7b1-d2c7-4228-b959-d358aa03c898-S0
[ OK ] MasterTest.FrameworkMessage (27 ms)
[ RUN ] MasterTest.MultipleExecutors
I0201 20:16:05.749316 25321 cluster.cpp:160] Creating default 'local' authorizer
I0201 20:16:05.750126 25326 master.cpp:383] Master f2fa33bc-8e2b-4a1d-a272-e1366127ec56 (491517a1478d) started on 172.17.0.3:33639
I0201 20:16:05.750151 25326 master.cpp:385] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/TpEWlV/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/TpEWlV/master" --zk_session_timeout="10secs"
I0201 20:16:05.750368 25326 master.cpp:435] Master only allowing authenticated frameworks to register
I0201 20:16:05.750380 25326 master.cpp:449] Master only allowing authenticated agents to register
I0201 20:16:05.750387 25326 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0201 20:16:05.750394 25326 credentials.hpp:37] Loading credentials for authentication from '/tmp/TpEWlV/credentials'
I0201 20:16:05.750545 25326 master.cpp:507] Using default 'crammd5' authenticator
I0201 20:16:05.750592 25326 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0201 20:16:05.750656 25326 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0201 20:16:05.750713 25326 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0201 20:16:05.750766 25326 master.cpp:587] Authorization enabled
I0201 20:16:05.750854 25336 hierarchical.cpp:151] Initialized hierarchical allocator process
I0201 20:16:05.750895 25336 whitelist_watcher.cpp:77] No whitelist given
I0201 20:16:05.751473 25326 master.cpp:2123] Elected as the leading master!
I0201 20:16:05.751487 25326 master.cpp:1645] Recovering from registrar
I0201 20:16:05.751646 25331 registrar.cpp:329] Recovering registrar
I0201 20:16:05.751848 25331 registrar.cpp:362] Successfully fetched the registry (0B) in 185088ns
I0201 20:16:05.751878 25331 registrar.cpp:461] Applied 1 operations in 6415ns; attempting to update the registry
I0201 20:16:05.752182 25328 registrar.cpp:506] Successfully updated the registry in 288us
I0201 20:16:05.752230 25328 registrar.cpp:392] Successfully recovered registrar
I0201 20:16:05.752357 25328 master.cpp:1761] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0201 20:16:05.752403 25328 hierarchical.cpp:178] Skipping recovery of hierarchical allocator: nothing to recover
I0201 20:16:05.754227 25321 cluster.cpp:446] Creating default 'local' authorizer
I0201 20:16:05.754706 25328 slave.cpp:209] Mesos agent started on (287)@172.17.0.3:33639
I0201 20:16:05.754775 25328 slave.cpp:210] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MultipleExecutors_zwEaon/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_zwEaon/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_zwEaon/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" --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_zwEaon" --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_Qbe3m9"
I0201 20:16:05.755120 25328 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_zwEaon/credential'
I0201 20:16:05.755210 25328 slave.cpp:352] Agent using credential for: test-principal
I0201 20:16:05.755223 25328 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_zwEaon/http_credentials'
I0201 20:16:05.755313 25321 sched.cpp:232] Version: 1.2.0
I0201 20:16:05.755354 25328 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 20:16:05.755401 25328 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 20:16:05.755602 25325 sched.cpp:336] New master detected at master@172.17.0.3:33639
I0201 20:16:05.755630 25325 sched.cpp:407] Authenticating with master master@172.17.0.3:33639
I0201 20:16:05.755638 25325 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0201 20:16:05.755740 25325 authenticatee.cpp:121] Creating new client SASL connection
I0201 20:16:05.755893 25325 master.cpp:7018] Authenticating scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639
I0201 20:16:05.755936 25328 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 20:16:05.755985 25337 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(634)@172.17.0.3:33639
I0201 20:16:05.755992 25328 slave.cpp:547] Agent attributes: [ ]
I0201 20:16:05.756018 25328 slave.cpp:552] Agent hostname: 491517a1478d
I0201 20:16:05.756074 25337 authenticator.cpp:98] Creating new server SASL connection
I0201 20:16:05.756227 25334 status_update_manager.cpp:177] Pausing sending status updates
I0201 20:16:05.756243 25333 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0201 20:16:05.756395 25333 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0201 20:16:05.756559 25327 state.cpp:60] Recovering state from '/tmp/MasterTest_MultipleExecutors_Qbe3m9/meta'
I0201 20:16:05.756568 25333 authenticator.cpp:204] Received SASL authentication start
I0201 20:16:05.756644 25333 authenticator.cpp:326] Authentication requires more steps
I0201 20:16:05.756705 25326 authenticatee.cpp:259] Received SASL authentication step
I0201 20:16:05.756773 25327 status_update_manager.cpp:203] Recovering status update manager
I0201 20:16:05.756824 25330 authenticator.cpp:232] Received SASL authentication step
I0201 20:16:05.756876 25327 slave.cpp:5422] Finished recovery
I0201 20:16:05.756881 25330 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '491517a1478d' server FQDN: '491517a1478d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0201 20:16:05.756894 25330 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0201 20:16:05.756911 25330 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0201 20:16:05.756922 25330 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '491517a1478d' server FQDN: '491517a1478d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0201 20:16:05.756927 25330 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0201 20:16:05.756935 25330 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0201 20:16:05.756968 25330 authenticator.cpp:318] Authentication success
I0201 20:16:05.757022 25330 authenticatee.cpp:299] Authentication success
I0201 20:16:05.757056 25330 master.cpp:7048] Successfully authenticated principal 'test-principal' at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639
I0201 20:16:05.757083 25330 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(634)@172.17.0.3:33639
I0201 20:16:05.757158 25330 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:33639
I0201 20:16:05.757169 25330 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:33639
I0201 20:16:05.757210 25330 sched.cpp:869] Will retry registration in 286.280277ms if necessary
I0201 20:16:05.757225 25327 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 20:16:05.757346 25330 status_update_manager.cpp:177] Pausing sending status updates
I0201 20:16:05.757383 25332 slave.cpp:929] New master detected at master@172.17.0.3:33639
I0201 20:16:05.757423 25332 slave.cpp:964] Detecting new master
I0201 20:16:05.757467 25332 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 20:16:05.757566 25327 master.cpp:2736] Received SUBSCRIBE call for framework 'default' at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639
I0201 20:16:05.757585 25327 master.cpp:2159] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0201 20:16:05.757704 25327 master.cpp:2812] Subscribing framework default with checkpointing disabled and capabilities [ ]
I0201 20:16:05.757860 25327 hierarchical.cpp:271] Added framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.757884 25327 hierarchical.cpp:1675] No allocations performed
I0201 20:16:05.757894 25327 hierarchical.cpp:1770] No inverse offers to send out!
I0201 20:16:05.757907 25327 hierarchical.cpp:1279] Performed allocation for 0 agents in 35674ns
I0201 20:16:05.758002 25327 sched.cpp:759] Framework registered with f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.758029 25327 sched.cpp:773] Scheduler::registered took 17553ns
I0201 20:16:05.764703 25327 slave.cpp:991] Authenticating with master master@172.17.0.3:33639
I0201 20:16:05.764734 25327 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0201 20:16:05.764809 25332 authenticatee.cpp:121] Creating new client SASL connection
I0201 20:16:05.764964 25332 master.cpp:7018] Authenticating slave(287)@172.17.0.3:33639
I0201 20:16:05.765027 25336 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(635)@172.17.0.3:33639
I0201 20:16:05.765118 25329 authenticator.cpp:98] Creating new server SASL connection
I0201 20:16:05.765246 25332 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0201 20:16:05.765310 25332 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0201 20:16:05.765362 25332 authenticator.cpp:204] Received SASL authentication start
I0201 20:16:05.765419 25332 authenticator.cpp:326] Authentication requires more steps
I0201 20:16:05.765465 25332 authenticatee.cpp:259] Received SASL authentication step
I0201 20:16:05.765522 25332 authenticator.cpp:232] Received SASL authentication step
I0201 20:16:05.765544 25332 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '491517a1478d' server FQDN: '491517a1478d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0201 20:16:05.765554 25332 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0201 20:16:05.765570 25332 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0201 20:16:05.765586 25332 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '491517a1478d' server FQDN: '491517a1478d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0201 20:16:05.765600 25332 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0201 20:16:05.765611 25332 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0201 20:16:05.765630 25332 authenticator.cpp:318] Authentication success
I0201 20:16:05.765682 25332 authenticatee.cpp:299] Authentication success
I0201 20:16:05.765720 25332 master.cpp:7048] Successfully authenticated principal 'test-principal' at slave(287)@172.17.0.3:33639
I0201 20:16:05.765759 25332 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(635)@172.17.0.3:33639
I0201 20:16:05.765899 25324 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:33639
I0201 20:16:05.765998 25324 slave.cpp:1508] Will retry registration in 5.006039ms if necessary
I0201 20:16:05.766026 25336 master.cpp:5303] Registering agent at slave(287)@172.17.0.3:33639 (491517a1478d) with id f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0
I0201 20:16:05.766183 25334 registrar.cpp:461] Applied 1 operations in 23621ns; attempting to update the registry
I0201 20:16:05.766541 25331 registrar.cpp:506] Successfully updated the registry in 322048ns
I0201 20:16:05.766777 25332 slave.cpp:4286] Received ping from slave-observer(281)@172.17.0.3:33639
I0201 20:16:05.766793 25334 master.cpp:5377] Registered agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 20:16:05.766836 25332 slave.cpp:1132] Registered with master master@172.17.0.3:33639; given agent ID f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0
I0201 20:16:05.766890 25332 fetcher.cpp:90] Clearing fetcher cache
I0201 20:16:05.766929 25337 hierarchical.cpp:478] Added agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 (491517a1478d) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0201 20:16:05.767074 25334 status_update_manager.cpp:184] Resuming sending status updates
I0201 20:16:05.767324 25337 hierarchical.cpp:1770] No inverse offers to send out!
I0201 20:16:05.767352 25332 slave.cpp:1160] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_Qbe3m9/meta/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/slave.info'
I0201 20:16:05.767352 25337 hierarchical.cpp:1302] Performed allocation for agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 in 399864ns
I0201 20:16:05.767513 25328 master.cpp:6847] Sending 1 offers to framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 (default) at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639
I0201 20:16:05.767691 25332 slave.cpp:1198] Forwarding total oversubscribed resources {}
I0201 20:16:05.767803 25328 master.cpp:5876] Received update of agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d) with total oversubscribed resources {}
I0201 20:16:05.767884 25332 hierarchical.cpp:548] Agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 (491517a1478d) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000])
I0201 20:16:05.767923 25323 sched.cpp:933] Scheduler::resourceOffers took 113628ns
I0201 20:16:05.767930 25332 hierarchical.cpp:1675] No allocations performed
I0201 20:16:05.768095 25332 hierarchical.cpp:1770] No inverse offers to send out!
I0201 20:16:05.768127 25332 hierarchical.cpp:1302] Performed allocation for agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 in 222153ns
I0201 20:16:05.768630 25327 master.cpp:3730] Processing ACCEPT call for offers: [ f2fa33bc-8e2b-4a1d-a272-e1366127ec56-O0 ] on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d) for framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 (default) at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639
I0201 20:16:05.768674 25327 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 1
I0201 20:16:05.768754 25327 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 2
W0201 20:16:05.769201 25327 validation.cpp:1018] 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.
W0201 20:16:05.769227 25327 validation.cpp:1030] 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.
I0201 20:16:05.769304 25327 master.cpp:8902] Adding task 1 with resources cpus(*):1; mem(*):512 on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.769353 25327 master.cpp:4380] Launching task 1 of framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 (default) at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639 with resources cpus(*):1; mem(*):512 on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.769513 25328 slave.cpp:1576] Got assigned task '1' for framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
W0201 20:16:05.769616 25327 validation.cpp:1018] 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.
W0201 20:16:05.769639 25327 validation.cpp:1030] 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.
I0201 20:16:05.769711 25327 master.cpp:8902] Adding task 2 with resources cpus(*):1; mem(*):512 on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.769747 25328 slave.cpp:1736] Launching task '1' for framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.769759 25327 master.cpp:4380] Launching task 2 of framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 (default) at scheduler-410efaeb-a65c-4fae-9ede-aa5e41be2626@172.17.0.3:33639 with resources cpus(*):1; mem(*):512 on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 at slave(287)@172.17.0.3:33639 (491517a1478d)
I0201 20:16:05.770026 25326 hierarchical.cpp:1011] Recovered ports(*):[31000-32000]; disk(*):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):1024) on agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 from framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.770057 25326 hierarchical.cpp:1048] Framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 filtered agent f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0 for 5secs
I0201 20:16:05.770252 25328 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_Qbe3m9/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/frameworks/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000/executors/executor-1/runs/fd6b166e-78d2-4947-ac04-ba3fb63bab9c' to user 'mesos'
I0201 20:16:05.770417 25328 slave.cpp:6331] Launching executor 'executor-1' of framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_Qbe3m9/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/frameworks/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000/executors/executor-1/runs/fd6b166e-78d2-4947-ac04-ba3fb63bab9c'
I0201 20:16:05.770604 25328 slave.cpp:2058] Queued task '1' for executor 'executor-1' of framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.770680 25328 slave.cpp:1576] Got assigned task '2' for framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.770884 25328 slave.cpp:882] Successfully attached file '/tmp/MasterTest_MultipleExecutors_Qbe3m9/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/frameworks/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000/executors/executor-1/runs/fd6b166e-78d2-4947-ac04-ba3fb63bab9c'
I0201 20:16:05.770916 25328 slave.cpp:1736] Launching task '2' for framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000
I0201 20:16:05.771306 25328 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_Qbe3m9/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/frameworks/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000/executors/executor-2/runs/457bb45b-2e07-44c8-96e6-84d792c5ca86' to user 'mesos'
I0201 20:16:05.771471 25328 slave.cpp:6331] Launching executor 'executor-2' of framework f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_Qbe3m9/slaves/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-S0/frameworks/f2fa33bc-8e2b-4a1d-a272-e1366127ec56-0000/executors/executor-2/runs/457bb45b-2e07-44c8-96e6-84d792c5ca86'
*** Aborted at 1485980165 (unix time) try "date -d @1485980165" if you are using GNU date ***
I0201 20:16:05.771716 25330 exec.cpp:162] Version: 1.2.0
I0201 20:16:05.771798 25323 exec.cpp:212] Executor started at: executor(121)@172.17.0.3:33639 with pid 25321
PC: @ 0x2ac6f0b8a82d (unknown)
*** SIGSEGV (@0xa0) received by PID 25321 (TID 0x2ac6f8716700) from PID 160; stack trace: ***
@ 0x2ac6f0121330 (unknown)
@ 0x2ac6f0b8a82d (unknown)
@ 0x2ac6ebdb0925 mesos::internal::slave::executorEnvironment()
@ 0x2ac6ebd8f096 mesos::internal::slave::Framework::launchExecutor()
@ 0x2ac6ebd8b931 mesos::internal::slave::Slave::_run()
@ 0x2ac6ed585127 process::ProcessManager::resume()
@ 0x2ac6ed5998cf std::thread::_Impl<>::_M_run()
@ 0x2ac6f03e0a60 (unknown)
@ 0x2ac6f0119184 start_thread
@ 0x2ac6f0c4937d (unknown)
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make: *** [check] Error 2
+ docker rmi mesos-1485977928-25955
Untagged: mesos-1485977928-25955:latest
Deleted: sha256:6f597350cfdd3661cb80cf77fb27ccbacc3bbae1db1ba71c25efc25224e84b42
Deleted: sha256:7bbecd896de9976fea58852f68399c5f7a459c3a7b78fded0a374b1fe8f72254
Deleted: sha256:d062ea2f0fd7de1ece616293758fb757d902021363a3f911c792ca6dbb6193db
Deleted: sha256:5cc350408822111b57995128757181133b103b1ec126afb9535e6d93eff268ec
Deleted: sha256:d42d94814e8191a539aace006b7560f9b958fe69c58dfb61bb9fdf02b229d5ed
Deleted: sha256:4d132e614b646fb32e314217450e4e5048409a672bed6d46fbf59a53e928cef4
Deleted: sha256:62184c6a9c24c717e4d18a52e476358df3c5471d5303ed40f92067aca77acd56
Deleted: sha256:1bf70f018ccd196f06e76a1a5752b828e73aba68f065a24baa150ffe5d0575a8
Deleted: sha256:c18f3f0316fc22950ab36c5048f768ac9d94db88decab168a450f9beba043dc9
Deleted: sha256:0466a8b7464da0d937a4179ac64e5fcdf4c379fa2f73e8c9986fd4c064899d8f
Deleted: sha256:2e06551a249a9b3280cd4255f8690de4ba82210ff31df5d7d0a3fa199f0811f8
Deleted: sha256:1786fe7f8c96cc1b6ec3c11fdab9718d08dbad33cbd6540b5c1b5b4281b09064
Deleted: sha256:14ad93bcbba99cb016b3ea896feb8dbf3d0fc6c60124869d8c4011c03fce6233
Deleted: sha256:16c0df62d6da2cd5dfc0e6439c83cd02fb3a4471a952891b76e5024f7087a310
Deleted: sha256:4e27e413845e93bcd17cdc855cf4f6705f5198e91e8be2154ac9d5c91e2b7ff1
Deleted: sha256:fd5bc864d3745d853256401c6275eebbdb1432db8fadce2700651623875344d9
Deleted: sha256:68555bc78bef12e5f7d4394a87f7796a05ab3e3e8c1172bf40107e2ae09777e0
Deleted: sha256:6e4d7b78d04e695231cd7784ac71aa2094dab41c520f8fb76697b40f1cdd7bad
Deleted: sha256:d1bdf68a1ba7bc149769ee07fd6c22b5ffa28d3dafc82bf4bdbc5b351ff52ecb
Deleted: sha256:ae43f11e3e22cfeec33519825175ca5ae68df98893fadd79f8322689e56ac011
Deleted: sha256:299d93ad679c768721899ad78404aaadbaecfabb9b8b49250fb538f5f29ae7b6
Deleted: sha256:08a8ba1cd8f09e1df693ef6caa4ee140a6b03e81ffaaee7fb0079fa0bca9a0ad
Deleted: sha256:780f4778b52656f06a9d78e93460a3cb80b8d0739799dafe8a03f2ffaa0c24da
Deleted: sha256:ba4e0395b5e0a19369de244fc82988b99401fdf777198c16b670aed54f847ba2
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3207
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3207/changes>