See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4054/display/redirect?page=changes>
Changes: [adam] Updated configuration.md for --executor_reregistration_retry_interval. ------------------------------------------ [...truncated 3.36 MB...] I0802 10:03:24.452010 1910 master.cpp:383] Master 37abc2dc-5fba-4578-9f26-ca883233e11b (547982cad16e) started on 172.17.0.7:33985 I0802 10:03:24.452055 1910 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/JDd0ZM/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.2.2/_inst/share/mesos/webui" --work_dir="/tmp/JDd0ZM/master" --zk_session_timeout="10secs" I0802 10:03:24.452482 1910 master.cpp:435] Master only allowing authenticated frameworks to register I0802 10:03:24.452495 1910 master.cpp:449] Master only allowing authenticated agents to register I0802 10:03:24.452503 1910 master.cpp:462] Master only allowing authenticated HTTP frameworks to register I0802 10:03:24.452512 1910 credentials.hpp:37] Loading credentials for authentication from '/tmp/JDd0ZM/credentials' I0802 10:03:24.452826 1910 master.cpp:507] Using default 'crammd5' authenticator I0802 10:03:24.452960 1910 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0802 10:03:24.453089 1910 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0802 10:03:24.453178 1910 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0802 10:03:24.453290 1910 master.cpp:587] Authorization enabled I0802 10:03:24.453465 1901 hierarchical.cpp:161] Initialized hierarchical allocator process I0802 10:03:24.453469 1913 whitelist_watcher.cpp:77] No whitelist given I0802 10:03:24.456328 1907 master.cpp:2124] Elected as the leading master! I0802 10:03:24.456362 1907 master.cpp:1646] Recovering from registrar I0802 10:03:24.456511 1899 registrar.cpp:329] Recovering registrar I0802 10:03:24.457412 1899 registrar.cpp:362] Successfully fetched the registry (0B) in 839936ns I0802 10:03:24.457545 1899 registrar.cpp:461] Applied 1 operations in 28479ns; attempting to update the registry I0802 10:03:24.458787 1899 registrar.cpp:506] Successfully updated the registry in 1.159936ms I0802 10:03:24.458956 1899 registrar.cpp:392] Successfully recovered registrar I0802 10:03:24.459429 1907 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0802 10:03:24.459451 1906 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover I0802 10:03:24.465514 1878 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W0802 10:03:24.466369 1878 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0802 10:03:24.466492 1878 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0802 10:03:24.466536 1878 provisioner.cpp:249] Using default backend 'copy' I0802 10:03:24.470297 1916 slave.cpp:217] Mesos agent started on 172.17.0.7:33985 I0802 10:03:24.470324 1916 slave.cpp:218] 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/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/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="true" --http_credentials="/tmp/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.2/_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/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD" --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/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI" I0802 10:03:24.471071 1916 credentials.hpp:86] Loading credential for authentication from '/tmp/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/credential' I0802 10:03:24.471271 1916 slave.cpp:360] Agent using credential for: test-principal I0802 10:03:24.471300 1916 credentials.hpp:37] Loading credentials for authentication from '/tmp/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/http_credentials' I0802 10:03:24.471578 1916 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0802 10:03:24.471771 1916 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0802 10:03:24.471779 1878 sched.cpp:232] Version: 1.2.2 I0802 10:03:24.472478 1912 sched.cpp:336] New master detected at [email protected]:33985 I0802 10:03:24.472591 1912 sched.cpp:407] Authenticating with master [email protected]:33985 I0802 10:03:24.472615 1912 sched.cpp:414] Using default CRAM-MD5 authenticatee I0802 10:03:24.472908 1902 authenticatee.cpp:121] Creating new client SASL connection I0802 10:03:24.473235 1920 master.cpp:7199] Authenticating [email protected]:33985 I0802 10:03:24.473353 1906 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(34)@172.17.0.7:33985 I0802 10:03:24.473315 1916 slave.cpp:547] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0802 10:03:24.473393 1916 slave.cpp:555] Agent attributes: [ ] I0802 10:03:24.473407 1916 slave.cpp:560] Agent hostname: 547982cad16e I0802 10:03:24.473664 1912 status_update_manager.cpp:177] Pausing sending status updates I0802 10:03:24.473704 1910 authenticator.cpp:98] Creating new server SASL connection I0802 10:03:24.473930 1902 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0802 10:03:24.473968 1902 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0802 10:03:24.474089 1910 authenticator.cpp:204] Received SASL authentication start I0802 10:03:24.474156 1910 authenticator.cpp:326] Authentication requires more steps I0802 10:03:24.474318 1910 authenticatee.cpp:259] Received SASL authentication step I0802 10:03:24.474545 1914 authenticator.cpp:232] Received SASL authentication step I0802 10:03:24.474578 1914 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '547982cad16e' server FQDN: '547982cad16e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0802 10:03:24.474598 1914 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0802 10:03:24.474638 1914 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0802 10:03:24.474664 1914 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '547982cad16e' server FQDN: '547982cad16e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0802 10:03:24.474676 1914 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0802 10:03:24.474684 1914 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0802 10:03:24.474701 1914 authenticator.cpp:318] Authentication success I0802 10:03:24.474807 1920 authenticatee.cpp:299] Authentication success I0802 10:03:24.474894 1917 master.cpp:7229] Successfully authenticated principal 'test-principal' at [email protected]:33985 I0802 10:03:24.474946 1906 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(34)@172.17.0.7:33985 I0802 10:03:24.475296 1918 sched.cpp:513] Successfully authenticated with master [email protected]:33985 I0802 10:03:24.475317 1918 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:33985 I0802 10:03:24.475414 1918 sched.cpp:869] Will retry registration in 263.121702ms if necessary I0802 10:03:24.475620 1917 master.cpp:2737] Received SUBSCRIBE call for framework 'default' at [email protected]:33985 I0802 10:03:24.475697 1917 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*' I0802 10:03:24.475847 1911 state.cpp:62] Recovering state from '/tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/meta' I0802 10:03:24.476104 1917 status_update_manager.cpp:203] Recovering status update manager I0802 10:03:24.476184 1902 master.cpp:2813] Subscribing framework default with checkpointing disabled and capabilities [ ] I0802 10:03:24.476358 1906 containerizer.cpp:600] Recovering containerizer I0802 10:03:24.476713 1918 sched.cpp:759] Framework registered with 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.476771 1918 sched.cpp:773] Scheduler::registered took 28279ns I0802 10:03:24.476869 1915 hierarchical.cpp:286] Added framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.476995 1915 hierarchical.cpp:1810] No allocations performed I0802 10:03:24.477033 1915 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:24.477085 1915 hierarchical.cpp:1394] Performed allocation for 0 agents in 131576ns I0802 10:03:24.478457 1919 provisioner.cpp:410] Provisioner recovery complete I0802 10:03:24.478961 1918 slave.cpp:5662] Finished recovery I0802 10:03:24.479457 1918 slave.cpp:5836] Querying resource estimator for oversubscribable resources I0802 10:03:24.479809 1915 status_update_manager.cpp:177] Pausing sending status updates I0802 10:03:24.479815 1898 slave.cpp:937] New master detected at [email protected]:33985 I0802 10:03:24.479928 1898 slave.cpp:972] Detecting new master I0802 10:03:24.481148 1905 slave.cpp:999] Authenticating with master [email protected]:33985 I0802 10:03:24.481231 1905 slave.cpp:1010] Using default CRAM-MD5 authenticatee I0802 10:03:24.481448 1898 authenticatee.cpp:121] Creating new client SASL connection I0802 10:03:24.481699 1899 master.cpp:7199] Authenticating (13)@172.17.0.7:33985 I0802 10:03:24.481904 1905 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(35)@172.17.0.7:33985 I0802 10:03:24.482137 1901 authenticator.cpp:98] Creating new server SASL connection I0802 10:03:24.482374 1917 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0802 10:03:24.482401 1917 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0802 10:03:24.482590 1904 authenticator.cpp:204] Received SASL authentication start I0802 10:03:24.482640 1904 authenticator.cpp:326] Authentication requires more steps I0802 10:03:24.482754 1909 authenticatee.cpp:259] Received SASL authentication step I0802 10:03:24.482965 1899 authenticator.cpp:232] Received SASL authentication step I0802 10:03:24.482991 1899 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '547982cad16e' server FQDN: '547982cad16e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0802 10:03:24.483003 1899 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0802 10:03:24.483036 1899 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0802 10:03:24.483054 1899 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '547982cad16e' server FQDN: '547982cad16e' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0802 10:03:24.483064 1899 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0802 10:03:24.483073 1899 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0802 10:03:24.483088 1899 authenticator.cpp:318] Authentication success I0802 10:03:24.483168 1902 authenticatee.cpp:299] Authentication success I0802 10:03:24.483232 1900 master.cpp:7229] Successfully authenticated principal 'test-principal' at (13)@172.17.0.7:33985 I0802 10:03:24.483394 1920 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(35)@172.17.0.7:33985 I0802 10:03:24.483588 1913 slave.cpp:1094] Successfully authenticated with master [email protected]:33985 I0802 10:03:24.483777 1913 slave.cpp:1521] Will retry registration in 15.34141ms if necessary I0802 10:03:24.484025 1903 master.cpp:5396] Registering agent at (13)@172.17.0.7:33985 (547982cad16e) with id 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 I0802 10:03:24.484498 1900 registrar.cpp:461] Applied 1 operations in 69234ns; attempting to update the registry I0802 10:03:24.486460 1900 registrar.cpp:506] Successfully updated the registry in 1.889024ms I0802 10:03:24.487197 1917 slave.cpp:4395] Received ping from slave-observer(9)@172.17.0.7:33985 I0802 10:03:24.487277 1912 master.cpp:5470] Registered agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 at (13)@172.17.0.7:33985 (547982cad16e) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0802 10:03:24.487385 1917 slave.cpp:1140] Registered with master [email protected]:33985; given agent ID 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 I0802 10:03:24.487416 1917 fetcher.cpp:94] Clearing fetcher cache I0802 10:03:24.487629 1904 status_update_manager.cpp:184] Resuming sending status updates I0802 10:03:24.487689 1918 hierarchical.cpp:516] Added agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 (547982cad16e) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0802 10:03:24.487974 1917 slave.cpp:1168] Checkpointing SlaveInfo to '/tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/meta/slaves/37abc2dc-5fba-4578-9f26-ca883233e11b-S0/slave.info' I0802 10:03:24.488968 1918 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:24.489034 1918 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.178697ms I0802 10:03:24.489495 1901 master.cpp:7028] Sending 1 offers to framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:24.490010 1913 sched.cpp:933] Scheduler::resourceOffers took 105419ns I0802 10:03:24.491750 1898 master.cpp:3776] Processing ACCEPT call for offers: [ 37abc2dc-5fba-4578-9f26-ca883233e11b-O0 ] on agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 at (13)@172.17.0.7:33985 (547982cad16e) for framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:24.491848 1898 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 413cbb47-3436-428a-926a-d7bc9c0160f0 I0802 10:03:24.493806 1898 master.cpp:9089] Adding task 413cbb47-3436-428a-926a-d7bc9c0160f0 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 at (13)@172.17.0.7:33985 (547982cad16e) I0802 10:03:24.494108 1898 master.cpp:4426] Launching task 413cbb47-3436-428a-926a-d7bc9c0160f0 of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 at (13)@172.17.0.7:33985 (547982cad16e) I0802 10:03:24.494959 1906 slave.cpp:1631] Got assigned task '413cbb47-3436-428a-926a-d7bc9c0160f0' for framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.495887 1906 slave.cpp:1791] Launching task '413cbb47-3436-428a-926a-d7bc9c0160f0' for framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.496809 1906 paths.cpp:547] Trying to chown '/tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/slaves/37abc2dc-5fba-4578-9f26-ca883233e11b-S0/frameworks/37abc2dc-5fba-4578-9f26-ca883233e11b-0000/executors/413cbb47-3436-428a-926a-d7bc9c0160f0/runs/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568' to user 'mesos' I0802 10:03:24.497146 1906 slave.cpp:6584] Launching executor '413cbb47-3436-428a-926a-d7bc9c0160f0' of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32 in work directory '/tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/slaves/37abc2dc-5fba-4578-9f26-ca883233e11b-S0/frameworks/37abc2dc-5fba-4578-9f26-ca883233e11b-0000/executors/413cbb47-3436-428a-926a-d7bc9c0160f0/runs/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568' I0802 10:03:24.497880 1916 hierarchical.cpp:807] Updated allocation of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 on agent 37abc2dc-5fba-4578-9f26-ca883233e11b-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] I0802 10:03:24.497964 1920 containerizer.cpp:993] Starting container ab1f2ca1-611b-4a76-9cb7-70e2f4c91568 for executor '413cbb47-3436-428a-926a-d7bc9c0160f0' of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.498073 1906 slave.cpp:2124] Queued task '413cbb47-3436-428a-926a-d7bc9c0160f0' for executor '413cbb47-3436-428a-926a-d7bc9c0160f0' of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:24.498134 1906 slave.cpp:890] Successfully attached file '/tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/slaves/37abc2dc-5fba-4578-9f26-ca883233e11b-S0/frameworks/37abc2dc-5fba-4578-9f26-ca883233e11b-0000/executors/413cbb47-3436-428a-926a-d7bc9c0160f0/runs/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568' I0802 10:03:24.507819 1903 containerizer.cpp:1524] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/mesos-1.2.2\/_build\/src"],"shell":false,"value":"\/mesos\/mesos-1.2.2\/_build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","value":"172.17.0.7:33985"},{"name":"MESOS_CHECKPOINT","value":"0"},{"name":"MESOS_DIRECTORY","value":"\/tmp\/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI\/slaves\/37abc2dc-5fba-4578-9f26-ca883233e11b-S0\/frameworks\/37abc2dc-5fba-4578-9f26-ca883233e11b-0000\/executors\/413cbb47-3436-428a-926a-d7bc9c0160f0\/runs\/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568"},{"name":"MESOS_EXECUTOR_ID","value":"413cbb47-3436-428a-926a-d7bc9c0160f0"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","value":"37abc2dc-5fba-4578-9f26-ca883233e11b-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","value":"1"},{"name":"MESOS_SLAVE_ID","value":"37abc2dc-5fba-4578-9f26-ca883233e11b-S0"},{"name":"MESOS_SLAVE_PID","value":"(13)@172.17.0.7:33985"},{"name":"MESOS_SANDBOX","value":"\/tmp\/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI\/slaves\/37abc2dc-5fba-4578-9f26-ca883233e11b-S0\/frameworks\/37abc2dc-5fba-4578-9f26-ca883233e11b-0000\/executors\/413cbb47-3436-428a-926a-d7bc9c0160f0\/runs\/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568"}]},"user":"mesos","working_directory":"\/tmp\/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI\/slaves\/37abc2dc-5fba-4578-9f26-ca883233e11b-S0\/frameworks\/37abc2dc-5fba-4578-9f26-ca883233e11b-0000\/executors\/413cbb47-3436-428a-926a-d7bc9c0160f0\/runs\/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568"}" --pipe_read="7" --pipe_write="8" --runtime_directory="/tmp/HTTPCommandExecutorTest_TerminateWithACK_PCsxRD/containers/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568" --unshare_namespace_mnt="false"' I0802 10:03:24.510676 1903 launcher.cpp:135] Forked child with pid '1933' for container 'ab1f2ca1-611b-4a76-9cb7-70e2f4c91568' I0802 10:03:24.515141 1919 fetcher.cpp:353] Starting to fetch URIs for container: ab1f2ca1-611b-4a76-9cb7-70e2f4c91568, directory: /tmp/HTTPCommandExecutorTest_TerminateWithACK_1jUKqI/slaves/37abc2dc-5fba-4578-9f26-ca883233e11b-S0/frameworks/37abc2dc-5fba-4578-9f26-ca883233e11b-0000/executors/413cbb47-3436-428a-926a-d7bc9c0160f0/runs/ab1f2ca1-611b-4a76-9cb7-70e2f4c91568 I0802 10:03:25.454440 1906 hierarchical.cpp:1810] No allocations performed I0802 10:03:25.454535 1906 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:25.454622 1906 hierarchical.cpp:1394] Performed allocation for 1 agents in 401073ns I0802 10:03:26.455528 1905 hierarchical.cpp:1810] No allocations performed I0802 10:03:26.455626 1905 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:26.455713 1905 hierarchical.cpp:1394] Performed allocation for 1 agents in 391580ns I0802 10:03:27.457173 1911 hierarchical.cpp:1810] No allocations performed I0802 10:03:27.457253 1911 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:27.457322 1911 hierarchical.cpp:1394] Performed allocation for 1 agents in 310435ns I0802 10:03:28.458726 1899 hierarchical.cpp:1810] No allocations performed I0802 10:03:28.458824 1899 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:28.458906 1899 hierarchical.cpp:1394] Performed allocation for 1 agents in 403681ns I0802 10:03:29.460559 1917 hierarchical.cpp:1810] No allocations performed I0802 10:03:29.460669 1917 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:29.460808 1917 hierarchical.cpp:1394] Performed allocation for 1 agents in 475089ns I0802 10:03:30.461967 1901 hierarchical.cpp:1810] No allocations performed I0802 10:03:30.462074 1901 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:30.462172 1901 hierarchical.cpp:1394] Performed allocation for 1 agents in 446623ns I0802 10:03:31.463331 1901 hierarchical.cpp:1810] No allocations performed I0802 10:03:31.463439 1901 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:31.463529 1901 hierarchical.cpp:1394] Performed allocation for 1 agents in 409790ns I0802 10:03:32.464357 1912 hierarchical.cpp:1810] No allocations performed I0802 10:03:32.464467 1912 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:32.464565 1912 hierarchical.cpp:1394] Performed allocation for 1 agents in 441328ns I0802 10:03:33.465493 1920 hierarchical.cpp:1810] No allocations performed I0802 10:03:33.465605 1920 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:33.465693 1920 hierarchical.cpp:1394] Performed allocation for 1 agents in 532605ns I0802 10:03:34.466985 1902 hierarchical.cpp:1810] No allocations performed I0802 10:03:34.467090 1902 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:34.467171 1902 hierarchical.cpp:1394] Performed allocation for 1 agents in 417335ns I0802 10:03:35.467883 1897 hierarchical.cpp:1810] No allocations performed I0802 10:03:35.467973 1897 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:35.468045 1897 hierarchical.cpp:1394] Performed allocation for 1 agents in 353731ns I0802 10:03:36.469594 1904 hierarchical.cpp:1810] No allocations performed I0802 10:03:36.469700 1904 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:36.469795 1904 hierarchical.cpp:1394] Performed allocation for 1 agents in 468394ns I0802 10:03:37.471112 1907 hierarchical.cpp:1810] No allocations performed I0802 10:03:37.471199 1907 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:37.471273 1907 hierarchical.cpp:1394] Performed allocation for 1 agents in 360936ns I0802 10:03:38.472770 1899 hierarchical.cpp:1810] No allocations performed I0802 10:03:38.472862 1899 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:38.472947 1899 hierarchical.cpp:1394] Performed allocation for 1 agents in 375277ns I0802 10:03:39.473693 1917 hierarchical.cpp:1810] No allocations performed I0802 10:03:39.473785 1917 hierarchical.cpp:1900] No inverse offers to send out! I0802 10:03:39.473870 1917 hierarchical.cpp:1394] Performed allocation for 1 agents in 376766ns I0802 10:03:39.487848 1901 slave.cpp:4395] Received ping from slave-observer(9)@172.17.0.7:33985 ../../src/tests/command_executor_tests.cpp:402: Failure Failed to wait 15secs for statusRunning I0802 10:03:39.492808 1914 master.cpp:1381] Framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 disconnected I0802 10:03:39.492874 1914 master.cpp:3081] Deactivating framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:39.493015 1914 master.cpp:3058] Disconnecting framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:39.493072 1914 master.cpp:1396] Giving framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 0ns to failover I../../src/tests/command_executor_tests.cpp:391: Failure Actual function call count doesn't match EXPECT_CALL(sched, statusUpdate(_, _))... Expected: to be called twice 0802 10:03:39.493140 1919 hierarchical.cpp:415] Deactivated framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 Actual: never called - unsatisfied and active I0802 10:03:39.493396 1918 master.cpp:6868] Framework failover timeout, removing framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:39.493458 1918 master.cpp:7753] Removing framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (default) at [email protected]:33985 I0802 10:03:39.493655 1899 slave.cpp:2664] Asked to shut down framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 by [email protected]:33985 I0802 10:03:39.493701 1899 slave.cpp:2689] Shutting down framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 I0802 10:03:39.493728 1918 master.cpp:8338] Updating the state of task 413cbb47-3436-428a-926a-d7bc9c0160f0 of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0802 10:03:39.493755 1899 slave.cpp:5131] Shutting down executor '413cbb47-3436-428a-926a-d7bc9c0160f0' of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 W0802 10:03:39.493793 1899 slave.hpp:915] Unable to send event to executor '413cbb47-3436-428a-926a-d7bc9c0160f0' of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000: unknown connection type ../../src/tests/command_executor_tests.cpp:396: Failure Actual function call count doesn't match EXPECT_CALL(slave, executorTerminated(_, _, _))... Expected: to be called once Actual: never called - unsatisfied and active I0802 10:03:39.494709 1918 master.cpp:8432] Removing task 413cbb47-3436-428a-926a-d7bc9c0160f0 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 on agent 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 at (13)@172.17.0.7:33985 (547982cad16e) I0802 10:03:39.495337 1908 hierarchical.cpp:1064] 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 37abc2dc-5fba-4578-9f26-ca883233e11b-S0 from framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 *** Aborted at 1501668219 (unix time) try "date -d @1501668219" if you are using GNU date *** I0802 10:03:39.495623 1908 hierarchical.cpp:362] Removed framework 37abc2dc-5fba-4578-9f26-ca883233e11b-0000 PC: @ 0x0 (unknown) *** SIGSEGV (@0x0) received by PID 1878 (TID 0x7f84780e5700) from PID 0; stack trace: *** @ 0x7f848034f370 (unknown) make[4]: *** [check-local] Segmentation fault (core dumped) make[4]: Leaving directory `/mesos/mesos-1.2.2/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.2.2/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.2.2/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.2.2/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1501666202-14730 Untagged: mesos-1501666202-14730:latest Deleted: sha256:37f518534afa85578b8f435b7d708dd3b04b7c219e9890918cf34e99a71a46da Deleted: sha256:ff3b207dc8c7a002d8c5a29d2baca147a3684592a3e093ce9369a04d2e4e95eb Deleted: sha256:fc0d4dfd95b1c1f96c1a8d8d473d8f55c7ade023008761239379d3a4256002b1 Deleted: sha256:a21c644aaf50c5e6a04a1b484aedf53d567375394961ef8351238b4dcd8dcaec Deleted: sha256:f4fbe201213cb8b9ea685d0570d8b5ef4601ae4d7429f43b5cdc41eb1e3f9bec Deleted: sha256:c792f13e8a3b5818488aa1d0a75b7869f67fad2a86cf74610e7929c243b5e499 Deleted: sha256:ac88e2ea65e1858f1ecb3c9bb515bfe110418e0d5edf52b4b68403ccf362f420 Deleted: sha256:50db9c2ba22dd713cab028cc4b449a6bb5b4e2c884a0f08d4c039752ed89342d Deleted: sha256:f34e166293ac332ef2e504dd2381f1ac7f4e95f54fef9c8b98c8292d61289035 Deleted: sha256:d3996eef3538e0862e6cffaa1990b24cf1862ebc7cdf496caa2f6e1758d41096 Deleted: sha256:718a1fca60f59962fb4f4e86a73e10cb1e8c8a199b96dabcb70dd9de51f48284 Deleted: sha256:b7844a6218dc87ef3109a102237a34b01bc1ca2cb4f0fc92abb124a7713eb86c Deleted: sha256:0feab2d9e25ef8911bf41af1adf78e7037ca0e6ab51c219d944e283a9b020dc4 Deleted: sha256:8652e18f4b22ee421e6ebdba4a89e5ab4d868f8cc0d7b89fc8523c80c2727000 Deleted: sha256:aa5b96646bb51a6ba7e0c291e48981e7f860cd5ecfdda6b305d12d55fb2d2fdd Deleted: sha256:ea4104b92748ea8a439bcfcd6f785987a0bed9a3687f1fa052828e18748258ec Deleted: sha256:417576e4528abf58ef7058a590e58da97e4a3959b1283f3da8f74d691804de4a Deleted: sha256:110d121560528bdcef65f85bd82929f1852c8544d5b03ebb2aa0c1a3a32b30e8 Deleted: sha256:a7555824802585303238da36f7b636cf44237ce6fd864a132530cf730a57ff46 Deleted: sha256:2ee580bd179d518bb50acbc4629368d3a8df268727ebeae4225e5df56f59908a Deleted: sha256:c282d45e6831058adfee926784c63d6b70eb9f910f3ac3506e649421835ce331 Deleted: sha256:640bad9d5bcfe1247010500ff80114dbc4c8e2e456d0a52fa438ea2014d0bf0e Deleted: sha256:34a4e19043564c351cc339e6a108b4f63e3419a34092f102a51c5b37119ac790 Deleted: sha256:f63a202608f5aa24292447150dc457c2b2086aa323b44b03dfc6dda5ec8e6800 Deleted: sha256:98e4eee8f5161059a992b419af23432f1761ea74f3f31de41fb16b858645ee71 Build step 'Execute shell' marked build as failure Not sending mail to unregistered user [email protected] Not sending mail to unregistered user [email protected]
