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/08/09 17:20:32 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4082
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=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4082/display/redirect?page=changes>
Changes:
[toenshoff] Added configure flag to disable fatal errors.
[toenshoff] Modified handling of parallel test configure flag for documentation.
[toenshoff] Added documentation of parallel test execution config flag.
------------------------------------------
[...truncated 14.96 MB...]
I0809 17:20:26.988526 755 slave.cpp:5648] Shutting down executor 'default' of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 at executor(129)@172.17.0.4:45668
I0809 17:20:26.988606 753 exec.cpp:435] Executor asked to shutdown
I0809 17:20:26.988648 753 exec.cpp:450] Executor::shutdown took 32867ns
I0809 17:20:26.988800 765 slave.cpp:4925] Got exited event for executor(129)@172.17.0.4:45668
I0809 17:20:26.989357 755 slave.cpp:5326] Executor 'default' of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 exited with status 0
I0809 17:20:26.989434 755 slave.cpp:5426] Cleaning up executor 'default' of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 at executor(129)@172.17.0.4:45668
I0809 17:20:26.989177 769 master.cpp:9027] Removing task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 on agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:26.989555 756 hierarchical.cpp:1152] 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 84582dcf-0aa0-4272-8a46-235342d38868-S0 from framework 84582dcf-0aa0-4272-8a46-235342d38868-0000
I0809 17:20:26.989639 754 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_KHlECK/slaves/84582dcf-0aa0-4272-8a46-235342d38868-S0/frameworks/84582dcf-0aa0-4272-8a46-235342d38868-0000/executors/default/runs/292e2112-5fdd-4319-8464-8cee7619ee54' for gc 6.99998854653926days in the future
I0809 17:20:26.989720 769 master.cpp:9056] Removing executor 'default' with resources [] of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 on agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:26.989840 755 slave.cpp:5522] Cleaning up framework 84582dcf-0aa0-4272-8a46-235342d38868-0000
I0809 17:20:26.989850 770 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_KHlECK/slaves/84582dcf-0aa0-4272-8a46-235342d38868-S0/frameworks/84582dcf-0aa0-4272-8a46-235342d38868-0000/executors/default' for gc 6.99998854436444days in the future
I0809 17:20:26.989915 772 status_update_manager.cpp:285] Closing status update streams for framework 84582dcf-0aa0-4272-8a46-235342d38868-0000
I0809 17:20:26.989951 772 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000
I0809 17:20:26.990010 765 gc.cpp:59] Scheduling '/tmp/MasterTest_FrameworkMessage_KHlECK/slaves/84582dcf-0aa0-4272-8a46-235342d38868-S0/frameworks/84582dcf-0aa0-4272-8a46-235342d38868-0000' for gc 6.99998854231407days in the future
I0809 17:20:26.990037 755 slave.cpp:843] Agent terminating
W0809 17:20:26.990340 769 master.cpp:6963] Ignoring unknown exited executor 'default' of framework 84582dcf-0aa0-4272-8a46-235342d38868-0000 on agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:26.990424 769 master.cpp:1318] Agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c) disconnected
I0809 17:20:26.990445 765 hierarchical.cpp:355] Removed framework 84582dcf-0aa0-4272-8a46-235342d38868-0000
I0809 17:20:26.990444 769 master.cpp:3301] Disconnecting agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:26.990499 769 master.cpp:3320] Deactivating agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 at slave(331)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:26.990558 757 hierarchical.cpp:690] Agent 84582dcf-0aa0-4272-8a46-235342d38868-S0 deactivated
I0809 17:20:26.992463 765 master.cpp:1160] Master terminating
I0809 17:20:26.992904 757 hierarchical.cpp:626] Removed agent 84582dcf-0aa0-4272-8a46-235342d38868-S0
[ OK ] MasterTest.FrameworkMessage (61 ms)
[ RUN ] MasterTest.MultipleExecutors
I0809 17:20:26.998370 748 cluster.cpp:162] Creating default 'local' authorizer
I0809 17:20:27.000556 757 master.cpp:442] Master a8754da9-7769-4ea0-9e1e-b2960dd2062f (6b10dee1d13c) started on 172.17.0.4:45668
I0809 17:20:27.000591 757 master.cpp:444] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/gzJUkz/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/gzJUkz/master" --zk_session_timeout="10secs"
I0809 17:20:27.000928 757 master.cpp:494] Master only allowing authenticated frameworks to register
I0809 17:20:27.000943 757 master.cpp:508] Master only allowing authenticated agents to register
I0809 17:20:27.000950 757 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0809 17:20:27.000960 757 credentials.hpp:37] Loading credentials for authentication from '/tmp/gzJUkz/credentials'
I0809 17:20:27.001188 757 master.cpp:566] Using default 'crammd5' authenticator
I0809 17:20:27.001314 757 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0809 17:20:27.001444 757 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0809 17:20:27.001543 757 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0809 17:20:27.001633 757 master.cpp:646] Authorization enabled
I0809 17:20:27.001757 763 hierarchical.cpp:171] Initialized hierarchical allocator process
I0809 17:20:27.001803 760 whitelist_watcher.cpp:77] No whitelist given
I0809 17:20:27.004051 770 master.cpp:2163] Elected as the leading master!
I0809 17:20:27.004068 770 master.cpp:1702] Recovering from registrar
I0809 17:20:27.004169 767 registrar.cpp:347] Recovering registrar
I0809 17:20:27.004663 767 registrar.cpp:391] Successfully fetched the registry (0B) in 466944ns
I0809 17:20:27.004768 767 registrar.cpp:495] Applied 1 operations in 38564ns; attempting to update the registry
I0809 17:20:27.005251 767 registrar.cpp:552] Successfully updated the registry in 434176ns
I0809 17:20:27.005357 767 registrar.cpp:424] Successfully recovered registrar
I0809 17:20:27.005630 762 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0809 17:20:27.005666 749 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0809 17:20:27.010004 748 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.4:45668
I0809 17:20:27.010305 748 cluster.cpp:448] Creating default 'local' authorizer
I0809 17:20:27.011910 771 slave.cpp:250] Mesos agent started on (332)@172.17.0.4:45668
I0809 17:20:27.011935 771 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MasterTest_MultipleExecutors_rvnXSt/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_rvnXSt/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/MasterTest_MultipleExecutors_rvnXSt/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_rvnXSt/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_rvnXSt/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_rvnXSt/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_rvnXSt" --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_kHgVB1"
I0809 17:20:27.012228 771 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_rvnXSt/credential'
I0809 17:20:27.012349 771 slave.cpp:283] Agent using credential for: test-principal
I0809 17:20:27.012367 771 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_rvnXSt/http_credentials'
I0809 17:20:27.012368 748 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.4:45668
I0809 17:20:27.012584 771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0809 17:20:27.012694 771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0809 17:20:27.012873 771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0809 17:20:27.012954 771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0809 17:20:27.013097 771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0809 17:20:27.013171 771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0809 17:20:27.013223 748 sched.cpp:232] Version: 1.4.0
I0809 17:20:27.013720 759 sched.cpp:336] New master detected at master@172.17.0.4:45668
I0809 17:20:27.013795 759 sched.cpp:407] Authenticating with master master@172.17.0.4:45668
I0809 17:20:27.013809 759 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0809 17:20:27.014010 756 authenticatee.cpp:121] Creating new client SASL connection
I0809 17:20:27.014241 751 master.cpp:7837] Authenticating scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668
I0809 17:20:27.014353 766 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(697)@172.17.0.4:45668
I0809 17:20:27.014391 771 slave.cpp:565] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0809 17:20:27.014551 771 slave.cpp:573] Agent attributes: [ ]
I0809 17:20:27.014562 771 slave.cpp:582] Agent hostname: 6b10dee1d13c
I0809 17:20:27.014566 750 authenticator.cpp:98] Creating new server SASL connection
I0809 17:20:27.014679 767 status_update_manager.cpp:177] Pausing sending status updates
I0809 17:20:27.014752 768 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0809 17:20:27.014776 768 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0809 17:20:27.014875 769 authenticator.cpp:204] Received SASL authentication start
I0809 17:20:27.014922 769 authenticator.cpp:326] Authentication requires more steps
I0809 17:20:27.015003 762 authenticatee.cpp:259] Received SASL authentication step
I0809 17:20:27.015116 764 authenticator.cpp:232] Received SASL authentication step
I0809 17:20:27.015141 764 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6b10dee1d13c' server FQDN: '6b10dee1d13c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0809 17:20:27.015174 764 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0809 17:20:27.015247 764 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0809 17:20:27.015274 764 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6b10dee1d13c' server FQDN: '6b10dee1d13c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0809 17:20:27.015290 764 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0809 17:20:27.015301 764 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0809 17:20:27.015322 764 authenticator.cpp:318] Authentication success
I0809 17:20:27.015404 758 authenticatee.cpp:299] Authentication success
I0809 17:20:27.015481 770 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668
I0809 17:20:27.015508 765 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(697)@172.17.0.4:45668
I0809 17:20:27.015748 758 sched.cpp:513] Successfully authenticated with master master@172.17.0.4:45668
I0809 17:20:27.015768 758 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.4:45668
I0809 17:20:27.015892 758 sched.cpp:869] Will retry registration in 921.363081ms if necessary
I0809 17:20:27.016011 754 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668
I0809 17:20:27.016029 754 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0809 17:20:27.016193 752 state.cpp:64] Recovering state from '/tmp/MasterTest_MultipleExecutors_kHgVB1/meta'
I0809 17:20:27.016412 767 status_update_manager.cpp:203] Recovering status update manager
I0809 17:20:27.016448 768 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0809 17:20:27.016682 760 slave.cpp:6207] Finished recovery
I0809 17:20:27.016940 763 sched.cpp:759] Framework registered with a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.016981 763 sched.cpp:773] Scheduler::registered took 27606ns
I0809 17:20:27.017067 764 hierarchical.cpp:303] Added framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.017194 760 slave.cpp:6389] Querying resource estimator for oversubscribable resources
I0809 17:20:27.017217 764 hierarchical.cpp:1925] No allocations performed
I0809 17:20:27.017256 764 hierarchical.cpp:2015] No inverse offers to send out!
I0809 17:20:27.017313 764 hierarchical.cpp:1468] Performed allocation for 0 agents in 144319ns
I0809 17:20:27.017370 758 status_update_manager.cpp:177] Pausing sending status updates
I0809 17:20:27.017383 760 slave.cpp:971] New master detected at master@172.17.0.4:45668
I0809 17:20:27.017472 760 slave.cpp:1006] Detecting new master
I0809 17:20:27.017565 760 slave.cpp:6403] Received oversubscribable resources {} from the resource estimator
I0809 17:20:27.019632 749 slave.cpp:1033] Authenticating with master master@172.17.0.4:45668
I0809 17:20:27.019683 749 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0809 17:20:27.019840 759 authenticatee.cpp:121] Creating new client SASL connection
I0809 17:20:27.020035 754 master.cpp:7837] Authenticating slave(332)@172.17.0.4:45668
I0809 17:20:27.020107 756 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(698)@172.17.0.4:45668
I0809 17:20:27.020287 771 authenticator.cpp:98] Creating new server SASL connection
I0809 17:20:27.020431 752 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0809 17:20:27.020449 752 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0809 17:20:27.020517 766 authenticator.cpp:204] Received SASL authentication start
I0809 17:20:27.020552 766 authenticator.cpp:326] Authentication requires more steps
I0809 17:20:27.020629 755 authenticatee.cpp:259] Received SASL authentication step
I0809 17:20:27.020722 751 authenticator.cpp:232] Received SASL authentication step
I0809 17:20:27.020743 751 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6b10dee1d13c' server FQDN: '6b10dee1d13c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0809 17:20:27.020752 751 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0809 17:20:27.020776 751 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0809 17:20:27.020795 751 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6b10dee1d13c' server FQDN: '6b10dee1d13c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0809 17:20:27.020812 751 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0809 17:20:27.020823 751 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0809 17:20:27.020841 751 authenticator.cpp:318] Authentication success
I0809 17:20:27.020913 750 authenticatee.cpp:299] Authentication success
I0809 17:20:27.020968 767 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(332)@172.17.0.4:45668
I0809 17:20:27.020987 769 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(698)@172.17.0.4:45668
I0809 17:20:27.021136 762 slave.cpp:1128] Successfully authenticated with master master@172.17.0.4:45668
I0809 17:20:27.021338 762 slave.cpp:1572] Will retry registration in 15.983013ms if necessary
I0809 17:20:27.021461 770 master.cpp:5712] Received register agent message from slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.021493 770 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0809 17:20:27.021777 765 master.cpp:5772] Authorized registration of agent at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.021870 765 master.cpp:5865] Registering agent at slave(332)@172.17.0.4:45668 (6b10dee1d13c) with id a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0
I0809 17:20:27.022193 764 registrar.cpp:495] Applied 1 operations in 60522ns; attempting to update the registry
I0809 17:20:27.022830 764 registrar.cpp:552] Successfully updated the registry in 564992ns
I0809 17:20:27.023025 754 master.cpp:5912] Admitted agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.023447 752 slave.cpp:4883] Received ping from slave-observer(325)@172.17.0.4:45668
I0809 17:20:27.023577 752 slave.cpp:1174] Registered with master master@172.17.0.4:45668; given agent ID a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0
I0809 17:20:27.023659 751 status_update_manager.cpp:184] Resuming sending status updates
I0809 17:20:27.023486 754 master.cpp:5943] Registered agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0809 17:20:27.023723 766 hierarchical.cpp:593] Added agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 (6b10dee1d13c) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0809 17:20:27.023921 752 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_kHgVB1/meta/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/slave.info'
I0809 17:20:27.024241 752 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0809 17:20:27.024394 750 master.cpp:6688] Received update of agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c) with total oversubscribed resources {}
I0809 17:20:27.024585 766 hierarchical.cpp:2015] No inverse offers to send out!
I0809 17:20:27.024621 766 hierarchical.cpp:1468] Performed allocation for 1 agents in 788720ns
I0809 17:20:27.024749 766 hierarchical.cpp:660] Agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 (6b10dee1d13c) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0809 17:20:27.025055 768 master.cpp:7667] Sending 1 offers to framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 (default) at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668
I0809 17:20:27.025476 767 sched.cpp:933] Scheduler::resourceOffers took 92519ns
I0809 17:20:27.027529 758 master.cpp:9164] Removing offer a8754da9-7769-4ea0-9e1e-b2960dd2062f-O0
I0809 17:20:27.027681 758 master.cpp:4153] Processing ACCEPT call for offers: [ a8754da9-7769-4ea0-9e1e-b2960dd2062f-O0 ] on agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c) for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 (default) at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668
I0809 17:20:27.027784 758 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 1
I0809 17:20:27.027987 758 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 2
W0809 17:20:27.029937 771 validation.cpp:1294] 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.
W0809 17:20:27.029964 771 validation.cpp:1306] 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.
I0809 17:20:27.030344 771 master.cpp:9724] Adding task 1 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 a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.030668 771 master.cpp:4816] Launching task 1 of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 (default) at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668 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 a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.031069 754 slave.cpp:1697] Got assigned task '1' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.031669 754 slave.cpp:1978] Authorizing task '1' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
W0809 17:20:27.031673 771 validation.cpp:1294] 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.
W0809 17:20:27.031708 771 validation.cpp:1306] 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.
I0809 17:20:27.031724 754 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task 1
I0809 17:20:27.032212 771 master.cpp:9724] Adding task 2 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 a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.032461 752 slave.cpp:2165] Launching task '1' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.032506 771 master.cpp:4816] Launching task 2 of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 (default) at scheduler-3933c13b-58ec-4be1-adf4-a452a3fa613d@172.17.0.4:45668 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 a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 at slave(332)@172.17.0.4:45668 (6b10dee1d13c)
I0809 17:20:27.033149 752 paths.cpp:578] Trying to chown '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-1/runs/e708a1ba-feb7-49bc-ae1b-d7f3760c36a6' to user 'mesos'
I0809 17:20:27.033406 752 slave.cpp:7162] Launching executor 'executor-1' of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-1/runs/e708a1ba-feb7-49bc-ae1b-d7f3760c36a6'
I0809 17:20:27.034148 752 slave.cpp:2394] Queued task '1' for executor 'executor-1' of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.034386 752 slave.cpp:1697] Got assigned task '2' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.034608 771 hierarchical.cpp:887] Updated allocation of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 on agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-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]
I0809 17:20:27.034783 752 slave.cpp:924] Successfully attached file '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-1/runs/e708a1ba-feb7-49bc-ae1b-d7f3760c36a6'
I0809 17:20:27.034821 752 slave.cpp:924] Successfully attached file '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-1/runs/e708a1ba-feb7-49bc-ae1b-d7f3760c36a6'
I0809 17:20:27.035037 752 slave.cpp:2852] Launching container e708a1ba-feb7-49bc-ae1b-d7f3760c36a6 for executor 'executor-1' of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.035264 771 hierarchical.cpp:1152] 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 a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 from framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.035320 771 hierarchical.cpp:1189] Framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 filtered agent a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0 for 5secs
I0809 17:20:27.035326 752 slave.cpp:1978] Authorizing task '2' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.035415 752 slave.cpp:6706] Authorizing framework principal 'test-principal' to launch task 2
I0809 17:20:27.035997 749 slave.cpp:2165] Launching task '2' for framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
I0809 17:20:27.036494 749 paths.cpp:578] Trying to chown '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-2/runs/899e66f5-bc86-498a-925d-c5bfb401e169' to user 'mesos'
I0809 17:20:27.036689 749 slave.cpp:7162] Launching executor 'executor-2' of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000 with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_kHgVB1/slaves/a8754da9-7769-4ea0-9e1e-b2960dd2062f-S0/frameworks/a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000/executors/executor-2/runs/899e66f5-bc86-498a-925d-c5bfb401e169'
I0809 17:20:27.037369 749 slave.cpp:2394] Queued task '2' for executor 'executor-2' of framework a8754da9-7769-4ea0-9e1e-b2960dd2062f-0000
*** Aborted at 1502299227 (unix time) try "date -d @1502299227" if you are using GNU date ***
I0809 17:20:27.037904 770 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.4:45668
PC: @ 0x2b938328382d (unknown)
I0809 17:20:27.038067 770 exec.cpp:162] Version: 1.4.0
*** SIGSEGV (@0xb0) received by PID 748 (TID 0x2b938a46c700) from PID 176; stack trace: ***
I0809 17:20:27.038449 764 exec.cpp:212] Executor started at: executor(130)@172.17.0.4:45668 with pid 748
@ 0x2b938281a330 (unknown)
@ 0x2b938328382d (unknown)
@ 0x1cb317b os::getenv()
@ 0x2b937b232429 mesos::internal::slave::executorEnvironment()
@ 0x2b937b22eaf7 mesos::internal::slave::Slave::launchExecutor()
@ 0x2b937b2febf8 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERK6OptionINS_6FutureINS1_6SecretEEEERKNS1_11FrameworkIDERKNS1_10ExecutorIDERKS5_INS1_8TaskInfoEESB_SE_SH_SL_EEvRKNS_3PIDIT_EEMSN_FvT0_T1_T2_T3_EOT4_OT5_OT6_OT7_ENKUlRS9_RSC_RSF_RSJ_PNS_11ProcessBaseEE_clES15_S16_S17_S18_S1A_
@ 0x2b937b2fea7f _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERK6OptionINS0_6FutureINS2_6SecretEEEERKNS2_11FrameworkIDERKNS2_10ExecutorIDERKS6_INS2_8TaskInfoEESC_SF_SI_SM_EEvRKNS0_3PIDIT_EEMSO_FvT0_T1_T2_T3_EOT4_OT5_OT6_OT7_EUlRSA_RSD_RSG_RSK_PNS0_11ProcessBaseEE_SA_SD_SG_SK_St12_PlaceholderILi1EEEE6__callIvJOS1B_EJLm0ELm1ELm2ELm3ELm4EEEESO_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
@ 0x2b937b2fe97d _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERK6OptionINS0_6FutureINS2_6SecretEEEERKNS2_11FrameworkIDERKNS2_10ExecutorIDERKS6_INS2_8TaskInfoEESC_SF_SI_SM_EEvRKNS0_3PIDIT_EEMSO_FvT0_T1_T2_T3_EOT4_OT5_OT6_OT7_EUlRSA_RSD_RSG_RSK_PNS0_11ProcessBaseEE_SA_SD_SG_SK_St12_PlaceholderILi1EEEEclIJS1B_EvEESS_DpOT_
@ 0x2b937b2fe452 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchIN5mesos8internal5slave5SlaveERK6OptionINS0_6FutureINS6_6SecretEEEERKNS6_11FrameworkIDERKNS6_10ExecutorIDERKSA_INS6_8TaskInfoEESG_SJ_SM_SQ_EEvRKNS0_3PIDIT_EEMSS_FvT0_T1_T2_T3_EOT4_OT5_OT6_OT7_EUlRSE_RSH_RSK_RSO_S2_E_SE_SH_SK_SO_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
@ 0x2b937e314da8 std::function<>::operator()()
@ 0x2b937e2f8f74 process::ProcessBase::visit()
@ 0x2b937e39df8e process::DispatchEvent::visit()
@ 0x1bcc3f1 process::ProcessBase::serve()
@ 0x2b937e2f6d1f process::ProcessManager::resume()
@ 0x2b937e305891 process::ProcessManager::init_threads()::$_9::operator()()
@ 0x2b937e3057d5 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
@ 0x2b937e3057a5 std::_Bind_simple<>::operator()()
@ 0x2b937e30577c std::thread::_Impl<>::_M_run()
@ 0x2b9382ad9a60 (unknown)
@ 0x2b9382812184 start_thread
@ 0x2b9383345ffd (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1502297107-21368
Untagged: mesos-1502297107-21368:latest
Deleted: sha256:6e12f038b753626be8d880c2c065d0daf7367a36d21672481fbe3f53e09d5cf4
Deleted: sha256:335da1f90a955537e0b22de5d42217429ecb843e46b573a865f2547c9cc3dee3
Deleted: sha256:68ea84a197ae8d214c8524c6cd950004ee10fd491992053888613064917d1507
Deleted: sha256:eb04fb22c5739c57c6473fc1f4b07c12455f839d384147b0a27fee27e1c9e72d
Deleted: sha256:43629c97aabe521f64e72c3ca8daf38769aee8b3dfa467a0da96307ae8442199
Deleted: sha256:08e9f8e4485ea0edc4256a116eb2cd6e3a67af3b06760a5a5dc1ee2b67aada10
Deleted: sha256:b5a851caff56f3ae5725dddfbac5e1a21afc6fe7237c99b0a329a77333e07f92
Deleted: sha256:5f8b79e116aaf8733a9931bd42cf5cb1cd4b99575bfd86da6a00ed4728d22fa4
Deleted: sha256:9475d69f22e6325b4d175066b7a10c470b035ae142e5521d5cb92fb259fcabac
Deleted: sha256:ad702b17bd468902759a128a942d323edad4f8a654c34f54bb7084692d4df712
Deleted: sha256:6b5fa93fb3916526d9c7f07a75252ea7e53e98a3f003afa0ea98bf7332cd7274
Deleted: sha256:3746399bde075c41f1f827353c696bd824abb78b8bacac90a974cca413b064bc
Deleted: sha256:0920d3575438d93c393ca09235b4f9c5e15115d74af29d3e3641857985b99f10
Deleted: sha256:157042aa04ce4fd022b84fb9d784a9555505405f11e938406cc6831db9773981
Deleted: sha256:284bb06b4e30ca75e1223786efc3c16764c92b7256c5dcb0ac4423cdfa51b7e9
Deleted: sha256:d742bf828f1734848bb9de3efdd1655ec8798b3a045494ebc92638afffa727d4
Deleted: sha256:4aee95a67f09664802d5a901465b63517f6611a7ac4eb9febbf95bcc0dbc49c0
Deleted: sha256:f9abda85896eadcf53fcfd66a69cc9b1763890a4e3727ad077b3641435703ebb
Deleted: sha256:1d1dc8699e42559261369cc9b524de442dd31aa8bbcc951b017a2521dd49741c
Deleted: sha256:cae6729ff62b03f44ab808304d5b9cd10d3378e7cbcddc6bb331bf6f180ea62a
Deleted: sha256:24b18448edd55b71843a5830310acca6e51584d82cc315e841f4cf1a0832659e
Deleted: sha256:664307b6e7a7bf636d6a97ed6f08baf67e99de97d464e9f288efaa4804281d62
Deleted: sha256:a9b86c6a7124173479db71ba1abe2aca4c066039fb157d9106f12e7136977e75
Deleted: sha256:cb914621ee5952349dec27ab29bf1412f26d66348ad4bdc23efd093bee3b54a8
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user toenshoff@me.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4083
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=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4083/display/redirect?page=changes>