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/22 06:06:46 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) #4137
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)/4137/display/redirect>
------------------------------------------
[...truncated 25.46 MB...]
I0822 06:06:41.781096 767 slave.cpp:2185] Launching task '0' for framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.781608 767 paths.cpp:578] Trying to chown '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default/runs/ee4efc88-e107-408d-9046-f1a719d1c4ed' to user 'mesos'
I0822 06:06:41.781730 765 hierarchical.cpp:1161] Recovered cpus(allocated: *):1.9; mem(allocated: *):992; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):0.1; mem(allocated: *):32) on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 from framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.781796 765 hierarchical.cpp:1207] Framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 filtered agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 for 5secs
I0822 06:06:41.781862 767 slave.cpp:7181] Launching executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 with resources [] in work directory '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default/runs/ee4efc88-e107-408d-9046-f1a719d1c4ed'
I0822 06:06:41.782564 767 slave.cpp:2414] Queued task '0' for executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.782649 767 slave.cpp:940] Successfully attached file '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default/runs/ee4efc88-e107-408d-9046-f1a719d1c4ed'
I0822 06:06:41.782688 767 slave.cpp:940] Successfully attached file '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default/runs/ee4efc88-e107-408d-9046-f1a719d1c4ed'
I0822 06:06:41.782886 767 slave.cpp:2872] Launching container ee4efc88-e107-408d-9046-f1a719d1c4ed for executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.785250 764 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.8:37541
I0822 06:06:41.785444 764 exec.cpp:162] Version: 1.5.0
I0822 06:06:41.785729 760 exec.cpp:212] Executor started at: executor(189)@172.17.0.8:37541 with pid 756
I0822 06:06:41.785913 760 slave.cpp:3897] Got registration for executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 from executor(189)@172.17.0.8:37541
I0822 06:06:41.786304 774 exec.cpp:237] Executor registered on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0
I0822 06:06:41.786358 774 exec.cpp:249] Executor::registered took 38807ns
I0822 06:06:41.786833 760 slave.cpp:2619] Sending queued task '0' to executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 at executor(189)@172.17.0.8:37541
I0822 06:06:41.787106 770 exec.cpp:331] Executor asked to run task '0'
I0822 06:06:41.787143 770 exec.cpp:340] Executor::launchTask took 29113ns
I0822 06:06:41.789258 776 process.cpp:3933] Handling HTTP event for process 'slave(671)' with path: '/slave(671)/api/v1'
I0822 06:06:41.790674 773 http.cpp:1166] HTTP POST for /slave(671)/api/v1 from 172.17.0.8:40524
I0822 06:06:41.791025 773 http.cpp:532] Processing call LAUNCH_NESTED_CONTAINER
I0822 06:06:41.800249 766 process.cpp:3933] Handling HTTP event for process 'slave(671)' with path: '/slave(671)/api/v1'
I0822 06:06:41.800676 766 process.cpp:3933] Handling HTTP event for process 'slave(671)' with path: '/slave(671)/api/v1'
I0822 06:06:41.802070 758 http.cpp:1166] HTTP POST for /slave(671)/api/v1 from 172.17.0.8:40528
I0822 06:06:41.802320 758 http.cpp:1166] HTTP POST for /slave(671)/api/v1 from 172.17.0.8:40526
I0822 06:06:41.802644 758 http.cpp:532] Processing call KILL_NESTED_CONTAINER
I0822 06:06:41.802866 758 http.cpp:532] Processing call WAIT_NESTED_CONTAINER
I0822 06:06:41.808748 756 sched.cpp:2021] Asked to stop the driver
I0822 06:06:41.808854 767 sched.cpp:1203] Stopping framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.809180 766 master.cpp:8348] Processing TEARDOWN call for framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 (default) at scheduler-98cfba92-8095-4309-b779-71a20fd24f67@172.17.0.8:37541
I0822 06:06:41.809208 766 master.cpp:8360] Removing framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 (default) at scheduler-98cfba92-8095-4309-b779-71a20fd24f67@172.17.0.8:37541
I0822 06:06:41.809218 766 master.cpp:3264] Deactivating framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 (default) at scheduler-98cfba92-8095-4309-b779-71a20fd24f67@172.17.0.8:37541
I0822 06:06:41.809370 774 hierarchical.cpp:412] Deactivated framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.809448 766 master.cpp:8933] Updating the state of task 0 of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0822 06:06:41.809525 764 slave.cpp:3175] Asked to shut down framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 by master@172.17.0.8:37541
I0822 06:06:41.809559 764 slave.cpp:3200] Shutting down framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.809615 764 slave.cpp:5667] Shutting down executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 at executor(189)@172.17.0.8:37541
I0822 06:06:41.809739 758 exec.cpp:435] Executor asked to shutdown
I0822 06:06:41.809859 758 exec.cpp:450] Executor::shutdown took 31458ns
I0822 06:06:41.809975 766 master.cpp:9027] Removing task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.810189 762 slave.cpp:4945] Got exited event for executor(189)@172.17.0.8:37541
I0822 06:06:41.810247 760 hierarchical.cpp:1161] Recovered cpus(allocated: *):0.1; mem(allocated: *):32 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 from framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.810348 766 master.cpp:9056] Removing executor 'default' with resources [] of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.811065 757 hierarchical.cpp:355] Removed framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.811538 762 slave.cpp:5345] Executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 exited with status 0
I0822 06:06:41.811650 762 slave.cpp:5445] Cleaning up executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 at executor(189)@172.17.0.8:37541
W0822 06:06:41.811791 776 master.cpp:6963] Ignoring unknown exited executor 'default' of framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000 on agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.811882 779 gc.cpp:59] Scheduling '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default/runs/ee4efc88-e107-408d-9046-f1a719d1c4ed' for gc 6.99999141013926days in the future
I0822 06:06:41.812036 762 slave.cpp:5541] Cleaning up framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.812090 779 gc.cpp:59] Scheduling '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000/executors/default' for gc 6.99999141013926days in the future
I0822 06:06:41.812170 780 status_update_manager.cpp:285] Closing status update streams for framework dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000
I0822 06:06:41.812230 763 gc.cpp:59] Scheduling '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_0_NY3q0Q/slaves/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0/frameworks/dada5abe-2c3f-463b-bb93-9a90a6d17c6d-0000' for gc 6.99999141013926days in the future
I0822 06:06:41.812425 756 slave.cpp:859] Agent terminating
I0822 06:06:41.812587 765 master.cpp:1318] Agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066) disconnected
I0822 06:06:41.812609 765 master.cpp:3301] Disconnecting agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.812670 765 master.cpp:3320] Deactivating agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 at slave(671)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.812768 759 hierarchical.cpp:690] Agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0 deactivated
I0822 06:06:41.815418 759 master.cpp:1160] Master terminating
I0822 06:06:41.815940 757 hierarchical.cpp:626] Removed agent dada5abe-2c3f-463b-bb93-9a90a6d17c6d-S0
[ OK ] ContentType/AgentAPITest.NestedContainerLaunch/0 (77 ms)
[ RUN ] ContentType/AgentAPITest.NestedContainerLaunch/1
I0822 06:06:41.822451 756 cluster.cpp:162] Creating default 'local' authorizer
I0822 06:06:41.825167 762 master.cpp:442] Master ca890c50-37f9-4691-a450-ed352be16b25 (841368a0b066) started on 172.17.0.8:37541
I0822 06:06:41.825215 762 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/oEYpNR/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/oEYpNR/master" --zk_session_timeout="10secs"
I0822 06:06:41.825521 762 master.cpp:494] Master only allowing authenticated frameworks to register
I0822 06:06:41.825532 762 master.cpp:508] Master only allowing authenticated agents to register
I0822 06:06:41.825538 762 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0822 06:06:41.825546 762 credentials.hpp:37] Loading credentials for authentication from '/tmp/oEYpNR/credentials'
I0822 06:06:41.825844 762 master.cpp:566] Using default 'crammd5' authenticator
I0822 06:06:41.826046 762 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0822 06:06:41.826228 762 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0822 06:06:41.826359 762 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0822 06:06:41.826486 762 master.cpp:646] Authorization enabled
I0822 06:06:41.826632 774 hierarchical.cpp:171] Initialized hierarchical allocator process
I0822 06:06:41.826668 765 whitelist_watcher.cpp:77] No whitelist given
I0822 06:06:41.829246 777 master.cpp:2163] Elected as the leading master!
I0822 06:06:41.829267 777 master.cpp:1702] Recovering from registrar
I0822 06:06:41.829423 769 registrar.cpp:347] Recovering registrar
I0822 06:06:41.830013 769 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
I0822 06:06:41.830129 769 registrar.cpp:495] Applied 1 operations in 46396ns; attempting to update the registry
I0822 06:06:41.830667 769 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 06:06:41.830776 769 registrar.cpp:424] Successfully recovered registrar
I0822 06:06:41.831149 779 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0822 06:06:41.831130 766 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0822 06:06:41.835933 756 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.8:37541
I0822 06:06:41.836185 756 cluster.cpp:448] Creating default 'local' authorizer
I0822 06:06:41.837990 777 slave.cpp:252] Mesos agent started on (672)@172.17.0.8:37541
I0822 06:06:41.838035 777 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/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/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/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/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/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/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/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/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS" --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/ContentType_AgentAPITest_NestedContainerLaunch_1_HWeL7m"
I0822 06:06:41.838480 777 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/credential'
I0822 06:06:41.838527 756 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.8:37541
I0822 06:06:41.838680 777 slave.cpp:285] Agent using credential for: test-principal
I0822 06:06:41.838702 777 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_MYz7rS/http_credentials'
I0822 06:06:41.838980 777 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:06:41.839170 777 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:06:41.839434 777 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:06:41.839473 756 sched.cpp:232] Version: 1.5.0
I0822 06:06:41.839587 777 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:06:41.839833 777 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:06:41.839980 777 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:06:41.840149 770 sched.cpp:336] New master detected at master@172.17.0.8:37541
I0822 06:06:41.840294 770 sched.cpp:407] Authenticating with master master@172.17.0.8:37541
I0822 06:06:41.840313 768 hierarchical.cpp:1943] No allocations performed
I0822 06:06:41.840353 770 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0822 06:06:41.840423 768 hierarchical.cpp:1486] Performed allocation for 0 agents in 163132ns
I0822 06:06:41.840652 760 authenticatee.cpp:121] Creating new client SASL connection
I0822 06:06:41.840973 758 master.cpp:7837] Authenticating scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541
I0822 06:06:41.841078 757 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1276)@172.17.0.8:37541
I0822 06:06:41.841325 780 authenticator.cpp:98] Creating new server SASL connection
I0822 06:06:41.841539 763 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0822 06:06:41.841562 763 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0822 06:06:41.841516 777 slave.cpp:581] 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"}]
I0822 06:06:41.841692 777 slave.cpp:589] Agent attributes: [ ]
I0822 06:06:41.841696 773 authenticator.cpp:204] Received SASL authentication start
I0822 06:06:41.841713 777 slave.cpp:598] Agent hostname: 841368a0b066
I0822 06:06:41.841768 773 authenticator.cpp:326] Authentication requires more steps
I0822 06:06:41.841889 764 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:06:41.841895 761 authenticatee.cpp:259] Received SASL authentication step
I0822 06:06:41.842000 779 authenticator.cpp:232] Received SASL authentication step
I0822 06:06:41.842075 779 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '841368a0b066' server FQDN: '841368a0b066' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0822 06:06:41.842093 779 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0822 06:06:41.842139 779 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0822 06:06:41.842165 779 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '841368a0b066' server FQDN: '841368a0b066' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0822 06:06:41.842178 779 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0822 06:06:41.842188 779 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0822 06:06:41.842209 779 authenticator.cpp:318] Authentication success
I0822 06:06:41.842309 772 authenticatee.cpp:299] Authentication success
I0822 06:06:41.842507 774 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541
I0822 06:06:41.842567 762 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1276)@172.17.0.8:37541
I0822 06:06:41.842620 767 sched.cpp:513] Successfully authenticated with master master@172.17.0.8:37541
I0822 06:06:41.842713 767 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.8:37541
I0822 06:06:41.842897 767 sched.cpp:869] Will retry registration in 983.111939ms if necessary
I0822 06:06:41.843072 775 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541
I0822 06:06:41.843101 775 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0822 06:06:41.843554 770 state.cpp:64] Recovering state from '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_HWeL7m/meta'
I0822 06:06:41.843741 760 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0822 06:06:41.843883 780 status_update_manager.cpp:203] Recovering status update manager
I0822 06:06:41.844235 772 slave.cpp:6226] Finished recovery
I0822 06:06:41.844279 766 sched.cpp:759] Framework registered with ca890c50-37f9-4691-a450-ed352be16b25-0000
I0822 06:06:41.844326 766 sched.cpp:773] Scheduler::registered took 25907ns
I0822 06:06:41.844460 773 hierarchical.cpp:303] Added framework ca890c50-37f9-4691-a450-ed352be16b25-0000
I0822 06:06:41.844580 773 hierarchical.cpp:1943] No allocations performed
I0822 06:06:41.844612 773 hierarchical.cpp:2033] No inverse offers to send out!
I0822 06:06:41.844646 773 hierarchical.cpp:1486] Performed allocation for 0 agents in 97759ns
I0822 06:06:41.844784 772 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:06:41.844980 765 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:06:41.845029 772 slave.cpp:987] New master detected at master@172.17.0.8:37541
I0822 06:06:41.845131 772 slave.cpp:1022] Detecting new master
I0822 06:06:41.845252 772 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:06:41.845325 772 slave.cpp:1049] Authenticating with master master@172.17.0.8:37541
I0822 06:06:41.845374 772 slave.cpp:1060] Using default CRAM-MD5 authenticatee
I0822 06:06:41.845558 775 authenticatee.cpp:121] Creating new client SASL connection
I0822 06:06:41.845784 768 master.cpp:7837] Authenticating slave(672)@172.17.0.8:37541
I0822 06:06:41.845924 771 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1277)@172.17.0.8:37541
I0822 06:06:41.846174 778 authenticator.cpp:98] Creating new server SASL connection
I0822 06:06:41.846359 777 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0822 06:06:41.846380 777 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0822 06:06:41.846493 759 authenticator.cpp:204] Received SASL authentication start
I0822 06:06:41.846555 759 authenticator.cpp:326] Authentication requires more steps
I0822 06:06:41.846684 770 authenticatee.cpp:259] Received SASL authentication step
I0822 06:06:41.846833 758 authenticator.cpp:232] Received SASL authentication step
I0822 06:06:41.846866 758 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '841368a0b066' server FQDN: '841368a0b066' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0822 06:06:41.846879 758 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0822 06:06:41.846911 758 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0822 06:06:41.846940 758 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '841368a0b066' server FQDN: '841368a0b066' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0822 06:06:41.846951 758 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0822 06:06:41.846957 758 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0822 06:06:41.846972 758 authenticator.cpp:318] Authentication success
I0822 06:06:41.847053 757 authenticatee.cpp:299] Authentication success
I0822 06:06:41.847116 776 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(672)@172.17.0.8:37541
I0822 06:06:41.847147 780 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1277)@172.17.0.8:37541
I0822 06:06:41.847312 761 slave.cpp:1144] Successfully authenticated with master master@172.17.0.8:37541
I0822 06:06:41.847560 761 slave.cpp:1588] Will retry registration in 13.140445ms if necessary
*** Aborted at 1503382001 (unix time) try "date -d @1503382001" if you are using GNU date ***
I0822 06:06:41.847707 766 master.cpp:5712] Received register agent message from slave(672)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.847745 766 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0822 06:06:41.848150 773 master.cpp:5772] Authorized registration of agent at slave(672)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.848254 773 master.cpp:5865] Registering agent at slave(672)@172.17.0.8:37541 (841368a0b066) with id ca890c50-37f9-4691-a450-ed352be16b25-S0
I0822 06:06:41.848623 769 registrar.cpp:495] Applied 1 operations in 71021ns; attempting to update the registry
I0822 06:06:41.849249 769 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 06:06:41.849431 771 master.cpp:5912] Admitted agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.849951 777 slave.cpp:4903] Received ping from slave-observer(617)@172.17.0.8:37541
I0822 06:06:41.850085 777 slave.cpp:1190] Registered with master master@172.17.0.8:37541; given agent ID ca890c50-37f9-4691-a450-ed352be16b25-S0
I0822 06:06:41.850172 758 status_update_manager.cpp:184] Resuming sending status updates
I0822 06:06:41.849989 771 master.cpp:5943] Registered agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066) 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"}]
I0822 06:06:41.850365 777 slave.cpp:1210] Checkpointing SlaveInfo to '/tmp/ContentType_AgentAPITest_NestedContainerLaunch_1_HWeL7m/meta/slaves/ca890c50-37f9-4691-a450-ed352be16b25-S0/slave.info'
PC: @ 0x2add1e1c9a70 process::EventQueue::Consumer::empty()
*** SIGSEGV (@0x8) received by PID 756 (TID 0x2add2a330700) from PID 8; stack trace: ***
I0822 06:06:41.850510 759 hierarchical.cpp:593] Added agent ca890c50-37f9-4691-a450-ed352be16b25-S0 (841368a0b066) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0822 06:06:41.850651 777 slave.cpp:1248] Forwarding total oversubscribed resources {}
I0822 06:06:41.850796 776 master.cpp:6688] Received update of agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066) with total oversubscribed resources {}
@ 0x2add226de330 (unknown)
I0822 06:06:41.852236 759 hierarchical.cpp:2033] No inverse offers to send out!
I0822 06:06:41.852285 759 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.60618ms
I0822 06:06:41.852522 759 hierarchical.cpp:660] Agent ca890c50-37f9-4691-a450-ed352be16b25-S0 (841368a0b066) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0822 06:06:41.852706 763 master.cpp:7667] Sending 1 offers to framework ca890c50-37f9-4691-a450-ed352be16b25-0000 (default) at scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541
@ 0x2add1e1c9a70 process::EventQueue::Consumer::empty()
I0822 06:06:41.853767 760 sched.cpp:933] Scheduler::resourceOffers took 703520ns
I0822 06:06:41.854768 764 master.cpp:9164] Removing offer ca890c50-37f9-4691-a450-ed352be16b25-O0
I0822 06:06:41.854903 764 master.cpp:4153] Processing ACCEPT call for offers: [ ca890c50-37f9-4691-a450-ed352be16b25-O0 ] on agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066) for framework ca890c50-37f9-4691-a450-ed352be16b25-0000 (default) at scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541
I0822 06:06:41.855005 764 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 0
@ 0x2add1e1ada10 process::ProcessManager::resume()
@ 0x2add1e1bc861 process::ProcessManager::init_threads()::$_9::operator()()
W0822 06:06:41.856498 764 validation.cpp:1300] Executor 'default' for task '0' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0822 06:06:41.856528 764 validation.cpp:1312] Executor 'default' for task '0' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
@ 0x2add1e1bc7a5 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
I0822 06:06:41.856827 764 master.cpp:9724] Adding task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] on agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066)
@ 0x2add1e1bc775 std::_Bind_simple<>::operator()()
I0822 06:06:41.857125 764 master.cpp:4816] Launching task 0 of framework ca890c50-37f9-4691-a450-ed352be16b25-0000 (default) at scheduler-474b8a85-9179-4f0a-b883-cc5b8e24d2f0@172.17.0.8:37541 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] on agent ca890c50-37f9-4691-a450-ed352be16b25-S0 at slave(672)@172.17.0.8:37541 (841368a0b066)
I0822 06:06:41.857587 773 slave.cpp:1717] Got assigned task '0' for framework ca890c50-37f9-4691-a450-ed352be16b25-0000
@ 0x2add1e1bc74c std::thread::_Impl<>::_M_run()
@ 0x2add2299da60 (unknown)
I0822 06:06:41.858361 773 slave.cpp:1998] Authorizing task '0' for framework ca890c50-37f9-4691-a450-ed352be16b25-0000
I0822 06:06:41.858427 773 slave.cpp:6725] Authorizing framework principal 'test-principal' to launch task 0
@ 0x2add226d6184 start_thread
@ 0x2add23209ffd (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1503379927-14135
Untagged: mesos-1503379927-14135:latest
Deleted: sha256:b309416b919918556bfdcb0d0df44d66ddc69101dbd94369bcdcfa7469a13ad2
Deleted: sha256:c545739fc2529f92887d0e950bed78c78bdd6c63cb30467a02bc72e0ea3d45b5
Deleted: sha256:9d30b3ff21443729a3f9f4c88f0b4aa6d3ac40946ac84f27347fd92db9f7eff1
Deleted: sha256:0c2d4ceb5d73cf71875d1ada91beaee8ee3a0670419fead0999735a78d7b49ab
Deleted: sha256:e1667aca7799df021ba41e0fb4fc89c68738d1c9fb1ae64c694a6ea279ea65f2
Deleted: sha256:83c7f2ccc48e6a59786e932e54899ef337efee323c0d2f3a2b94a08aa8f91486
Deleted: sha256:f24f5d27267bc46c0f6376559649609eb8bf87d83445c84765e1d5f3a9a5ee05
Deleted: sha256:c33a616acc11ee662fcea0414bb4aca2de964d885e8a72f6b32e782d1577c5ba
Deleted: sha256:387240412a1b24f40ed3c467584156069b416cf405a685b384c456de5685f1d1
Deleted: sha256:199c0900939e7b7a4fffeb433b0820f5258b3c75a399fae773113e13c768ad6b
Deleted: sha256:6b756bc06ddb77b5bd23d1bfa0208f50a8491f42c8fb0f8f9eb69bae3cb052de
Deleted: sha256:daf05e181fda6cd04c4c49a427130c82549adb7e83d9acc863dff85d20c6f484
Deleted: sha256:d7500b761810a14d2a178bf3f9786180513f8ac9cc0b96f204b022bf2012afa2
Deleted: sha256:0c03540a781dc47f3e84fa0a2a76d938ea2ce56799b2f0f6b906cbcf8ac72142
Deleted: sha256:9585759ed9ad31a90102b7fb05de9a83fc64b99f16f3b299fc1dd885316fc918
Deleted: sha256:ffeb13785d7c53ada6e856456893937b92ff6501322b4be9fca69cdaa8b141ec
Deleted: sha256:10db35f55cadb2577a4c540229c42556478b1c332d05352e2c2aa0d7746722a4
Deleted: sha256:d66c9ec4eea2ef200396ba02308363715ba77d4dd6734b4872b1de7e39f1537e
Deleted: sha256:e292c4c2d83c21920dc4d47ddc87f3285573776a6b06e10efa16e34ceebe982b
Deleted: sha256:78fa01a3a36931b73e170924e24687419c3dca124ed92428f64741f2470a0025
Deleted: sha256:35233bdf0ff421c7860dbd6adcc7b95b3ea04b98fa30603a5fd131aae83be503
Deleted: sha256:fca860716a89298377f145c9be84ccf8b667c30b1d6187916feee0dbffef584e
Deleted: sha256:562ce89fa703e49fa0ea7542b6931b62f29a42edcbb5ab46a5d0770ca0944ea5
Deleted: sha256:a1816ee5ae2a1150107f3310eac8108f9df2e25afab45b3ff81b667d46ca46f2
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,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4138
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)/4138/display/redirect?page=changes>