See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4550/display/redirect?page=changes>
Changes: [yujie.jay] Used a wrapper message for storage resource provider info. [songzihao1990] Added excluded image parameter to containerizer pruneImages(). [songzihao1990] Added a flag conversion protobuf message 'ImageGcConfig'. [songzihao1990] Added an optional agent flag '--image_gc_config'. [songzihao1990] Supported basic auto image gc in the agent. [songzihao1990] Deleted a redundant line in test/containerizer.hpp. [songzihao1990] Fixed a typo in gc_test.cpp. [songzihao1990] Fixed comments for linux MACRO. [songzihao1990] Tracked layers in memory for provisioned containers. [mpark] Changed agent reregistration to work with messages directly. [mpark] Reduced copying of agent data during reregistration. [mpark] Fixed incorrect testing of existence of variables. [yujie.jay] Imported and reconcile resources from CSI plugins. [andrew] Added `curl` executable to Windows build. [andrew] Renamed CMake `curl` target to `libcurl`. [andrew] Windows: Enabled HTTP health checks. ------------------------------------------ [...truncated 5.63 MB...] 3: I1207 01:25:45.007954 20097 authenticator.cpp:98] Creating new server SASL connection 3: I1207 01:25:45.008152 20092 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1207 01:25:45.008172 20092 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1207 01:25:45.008263 20092 authenticator.cpp:204] Received SASL authentication start 3: I1207 01:25:45.008304 20092 authenticator.cpp:326] Authentication requires more steps 3: I1207 01:25:45.008404 20083 authenticatee.cpp:259] Received SASL authentication step 3: I1207 01:25:45.008523 20096 authenticator.cpp:232] Received SASL authentication step 3: I1207 01:25:45.008558 20096 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9349dcbfe61' server FQDN: 'f9349dcbfe61' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1207 01:25:45.008574 20096 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1207 01:25:45.008610 20096 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1207 01:25:45.008628 20096 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9349dcbfe61' server FQDN: 'f9349dcbfe61' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1207 01:25:45.008637 20096 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1207 01:25:45.008642 20096 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1207 01:25:45.008657 20096 authenticator.cpp:318] Authentication success 3: I1207 01:25:45.008743 20095 authenticatee.cpp:299] Authentication success 3: I1207 01:25:45.008824 20082 master.cpp:8768] Successfully authenticated principal 'test-principal' at slave(110)@172.17.0.2:42132 3: I1207 01:25:45.008890 20085 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(235)@172.17.0.2:42132 3: I1207 01:25:45.008985 20086 slave.cpp:1202] Successfully authenticated with master [email protected]:42132 3: I1207 01:25:45.009197 20086 slave.cpp:1745] Will retry registration in 17.7458ms if necessary 3: I1207 01:25:45.009377 20098 master.cpp:6033] Received register agent message from slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.009503 20098 master.cpp:3869] Authorizing agent with principal 'test-principal' 3: I1207 01:25:45.009894 20100 master.cpp:6109] Authorized registration of agent at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.009992 20100 master.cpp:6202] Registering agent at slave(110)@172.17.0.2:42132 (f9349dcbfe61) with id 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.010470 20088 registrar.cpp:495] Applied 1 operations in 73229ns; attempting to update the registry 3: I1207 01:25:45.011020 20088 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1207 01:25:45.011234 20091 master.cpp:6251] Admitted agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.011873 20091 master.cpp:6287] Registered agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] 3: I1207 01:25:45.011973 20101 slave.cpp:1248] Registered with master [email protected]:42132; given agent ID 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.012079 20092 task_status_update_manager.cpp:188] Resuming sending task status updates 3: I1207 01:25:45.012210 20097 hierarchical.cpp:577] Added agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 (f9349dcbfe61) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) 3: I1207 01:25:45.012253 20101 slave.cpp:1268] Checkpointing SlaveInfo to '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/meta/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/slave.info' 3: I1207 01:25:45.012629 20101 slave.cpp:1347] Forwarding total oversubscribed resources {} 3: I1207 01:25:45.012809 20095 master.cpp:7181] Received update of agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) with total oversubscribed resources {} 3: I1207 01:25:45.012987 20095 master.cpp:7224] Ignoring update on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) as it reports no changes 3: I1207 01:25:45.013525 20097 hierarchical.cpp:1527] Performed allocation for 1 agents in 1.152192ms 3: I1207 01:25:45.013967 20096 master.cpp:8568] Sending 1 offers to framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.014437 20102 sched.cpp:921] Scheduler::resourceOffers took 73122ns 3: I1207 01:25:45.015933 20089 master.cpp:10488] Removing offer 9badc083-05eb-44f9-91d4-aa28a1c55841-O0 3: I1207 01:25:45.016059 20089 master.cpp:4227] Processing ACCEPT call for offers: [ 9badc083-05eb-44f9-91d4-aa28a1c55841-O0 ] on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.016144 20089 master.cpp:3596] Authorizing framework principal 'test-principal' to launch task fa51689c-4d62-4142-a3b6-071373ac70ca 3: I1207 01:25:45.018007 20085 master.cpp:11240] Adding task fa51689c-4d62-4142-a3b6-071373ac70ca with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.018307 20085 master.cpp:4975] Launching task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 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"}] on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.019179 20098 slave.cpp:1866] Got assigned task 'fa51689c-4d62-4142-a3b6-071373ac70ca' for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.019762 20098 slave.cpp:2134] Authorizing task 'fa51689c-4d62-4142-a3b6-071373ac70ca' for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.019815 20098 slave.cpp:7529] Authorizing framework principal 'test-principal' to launch task fa51689c-4d62-4142-a3b6-071373ac70ca 3: I1207 01:25:45.020571 20087 slave.cpp:2302] Launching task 'fa51689c-4d62-4142-a3b6-071373ac70ca' for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.021142 20087 paths.cpp:702] Trying to chown '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' to user 'mesos' 3: I1207 01:25:45.021375 20087 slave.cpp:8003] Launching executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' 3: I1207 01:25:45.022537 20087 slave.cpp:2530] Queued task 'fa51689c-4d62-4142-a3b6-071373ac70ca' for executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.022625 20087 slave.cpp:979] Successfully attached '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' to virtual path '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/latest' 3: I1207 01:25:45.022666 20087 slave.cpp:979] Successfully attached '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' to virtual path '/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/latest' 3: I1207 01:25:45.022701 20087 slave.cpp:979] Successfully attached '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' to virtual path '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' 3: I1207 01:25:45.023010 20087 slave.cpp:2993] Launching container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 for executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.023270 20088 containerizer.cpp:1201] Starting container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 3: I1207 01:25:45.024055 20088 containerizer.cpp:1373] Checkpointed ContainerConfig at '/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_vHBcOp/containers/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2/config' 3: I1207 01:25:45.024080 20088 containerizer.cpp:2930] Transitioning the state of container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 from PROVISIONING to PREPARING 3: I1207 01:25:45.028250 20096 containerizer.cpp:1842] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:42132"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9\/slaves\/9badc083-05eb-44f9-91d4-aa28a1c55841-S0\/frameworks\/9badc083-05eb-44f9-91d4-aa28a1c55841-0000\/executors\/fa51689c-4d62-4142-a3b6-071373ac70ca\/runs\/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiJjNGVmMThjMi02MjUyLTQ2ZDMtYWU2YS0yYjE3YTVkMTUyYzIiLCJlaWQiOiJmYTUxNjg5Yy00ZDYyLTQxNDItYTNiNi0wNzEzNzNhYzcwY2EiLCJmaWQiOiI5YmFkYzA4My0wNWViLTQ0ZjktOTFkNC1hYTI4YTFjNTU4NDEtMDAwMCJ9.qxTVH4iOpuDvZMeIsaPMeZVV3uGBRQldqUYxctOvXH4"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"fa51689c-4d62-4142-a3b6-071373ac70ca"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"9badc083-05eb-44f9-91d4-aa28a1c55841-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"9badc083-05eb-44f9-91d4-aa28a1c55841-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(110)@172.17.0.2:42132"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9\/slaves\/9badc083-05eb-44f9-91d4-aa28a1c55841-S0\/frameworks\/9badc083-05eb-44f9-91d4-aa28a1c55841-0000\/executors\/fa51689c-4d62-4142-a3b6-071373ac70ca\/runs\/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9\/slaves\/9badc083-05eb-44f9-91d4-aa28a1c55841-S0\/frameworks\/9badc083-05eb-44f9-91d4-aa28a1c55841-0000\/executors\/fa51689c-4d62-4142-a3b6-071373ac70ca\/runs\/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2"}" --pipe_read="8" --pipe_write="9" --runtime_directory="/tmp/PartitionTest_ReregisterSlaveNotPartitionAware_vHBcOp/containers/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2" --unshare_namespace_mnt="false"' 3: I1207 01:25:45.030766 20096 launcher.cpp:140] Forked child with pid '22028' for container 'c4ef18c2-6252-46d3-ae6a-2b17a5d152c2' 3: I1207 01:25:45.032037 20096 containerizer.cpp:2930] Transitioning the state of container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 from PREPARING to ISOLATING 3: I1207 01:25:45.033160 20096 containerizer.cpp:2930] Transitioning the state of container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 from ISOLATING to FETCHING 3: I1207 01:25:45.033331 20084 fetcher.cpp:380] Starting to fetch URIs for container: c4ef18c2-6252-46d3-ae6a-2b17a5d152c2, directory: /tmp/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9/slaves/9badc083-05eb-44f9-91d4-aa28a1c55841-S0/frameworks/9badc083-05eb-44f9-91d4-aa28a1c55841-0000/executors/fa51689c-4d62-4142-a3b6-071373ac70ca/runs/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 3: I1207 01:25:45.034377 20088 containerizer.cpp:2930] Transitioning the state of container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 from FETCHING to RUNNING 3: I1207 01:25:45.295884 22029 exec.cpp:162] Version: 1.5.0 3: I1207 01:25:45.307258 20083 slave.cpp:4182] Got registration for executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 from executor(1)@172.17.0.2:43436 3: I1207 01:25:45.309938 20100 slave.cpp:2732] Sending queued task 'fa51689c-4d62-4142-a3b6-071373ac70ca' to executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 at executor(1)@172.17.0.2:43436 3: I1207 01:25:45.313637 22048 exec.cpp:237] Executor registered on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.317165 22053 executor.cpp:171] Received SUBSCRIBED event 3: I1207 01:25:45.318259 22053 executor.cpp:175] Subscribed executor on f9349dcbfe61 3: I1207 01:25:45.318483 22053 executor.cpp:171] Received LAUNCH event 3: I1207 01:25:45.320222 22053 executor.cpp:637] Starting task fa51689c-4d62-4142-a3b6-071373ac70ca 3: I1207 01:25:45.322824 20081 slave.cpp:4636] Handling status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 from executor(1)@172.17.0.2:43436 3: I1207 01:25:45.324609 20083 task_status_update_manager.cpp:328] Received task status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.324652 20083 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.325129 20083 task_status_update_manager.cpp:383] Forwarding task status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to the agent 3: I1207 01:25:45.325359 20102 slave.cpp:5119] Forwarding the update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to [email protected]:42132 3: I1207 01:25:45.325608 20102 slave.cpp:5012] Task status update manager successfully handled status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.325664 20102 slave.cpp:5028] Sending acknowledgement for status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to executor(1)@172.17.0.2:43436 3: I1207 01:25:45.325829 20085 master.cpp:7689] Status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 from agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.325896 20085 master.cpp:7745] Forwarding status update TASK_STARTING (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.326099 20085 master.cpp:9964] Updating the state of task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING) 3: I1207 01:25:45.326367 20103 sched.cpp:1029] Scheduler::statusUpdate took 66556ns 3: I1207 01:25:45.326700 20099 master.cpp:5790] Processing ACKNOWLEDGE call a44fb24a-c757-49a5-b0d9-b88cadd666ad for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.327080 20082 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.327350 20095 slave.cpp:3920] Task status update manager successfully handled status update acknowledgement (UUID: a44fb24a-c757-49a5-b0d9-b88cadd666ad) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.335280 22053 executor.cpp:477] Running '/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>' 3: I1207 01:25:45.338244 22053 executor.cpp:650] Forked command at 22055 3: I1207 01:25:45.341210 20098 slave.cpp:4636] Handling status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 from executor(1)@172.17.0.2:43436 3: I1207 01:25:45.343034 20092 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.343260 20092 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to the agent 3: I1207 01:25:45.343534 20097 slave.cpp:5119] Forwarding the update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to [email protected]:42132 3: I1207 01:25:45.343819 20097 slave.cpp:5012] Task status update manager successfully handled status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.343880 20097 slave.cpp:5028] Sending acknowledgement for status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 to executor(1)@172.17.0.2:43436 3: I1207 01:25:45.343962 20101 master.cpp:7689] Status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 from agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.344027 20101 master.cpp:7745] Forwarding status update TASK_RUNNING (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.344236 20101 master.cpp:9964] Updating the state of task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) 3: I1207 01:25:45.344445 20083 sched.cpp:1029] Scheduler::statusUpdate took 64770ns 3: I1207 01:25:45.344877 20102 master.cpp:5790] Processing ACKNOWLEDGE call 7478440f-240d-4966-a5ad-75c52745c9cb for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.345341 20085 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.345585 20099 slave.cpp:3920] Task status update manager successfully handled status update acknowledgement (UUID: 7478440f-240d-4966-a5ad-75c52745c9cb) for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.347961 20082 hierarchical.cpp:1527] Performed allocation for 1 agents in 196220ns 3: I1207 01:25:45.348959 20088 hierarchical.cpp:1527] Performed allocation for 1 agents in 130918ns 3: I1207 01:25:45.349715 20102 hierarchical.cpp:1527] Performed allocation for 1 agents in 109917ns 3: I1207 01:25:45.350448 20098 hierarchical.cpp:1527] Performed allocation for 1 agents in 109440ns 3: I1207 01:25:45.350531 20095 slave.cpp:6179] Current disk usage 66.18%. Max allowed age: 1.667269565600625days 3: I1207 01:25:45.351487 20084 master.cpp:8007] Marking agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) unreachable: health check timed out 3: I1207 01:25:45.351505 20100 hierarchical.cpp:1527] Performed allocation for 1 agents in 157100ns 3: I1207 01:25:45.352046 20092 registrar.cpp:495] Applied 1 operations in 111663ns; attempting to update the registry 3: I1207 01:25:45.352701 20092 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1207 01:25:45.352881 20103 master.cpp:8055] Marked agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) unreachable: health check timed out 3: I1207 01:25:45.353101 20103 master.cpp:9964] Updating the state of task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (latest state: TASK_LOST, status update state: TASK_LOST) 3: I1207 01:25:45.353607 20099 hierarchical.cpp:610] Removed agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.353826 20103 master.cpp:10070] Removing task fa51689c-4d62-4142-a3b6-071373ac70ca with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.354075 20103 master.cpp:7740] Sending status update TASK_LOST for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 'health check timed out' 3: I1207 01:25:45.354418 20086 sched.cpp:1029] Scheduler::statusUpdate took 40611ns 3: I1207 01:25:45.354445 20103 master.cpp:2129] Notifying framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 of lost agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 (f9349dcbfe61) 3: I1207 01:25:45.354671 20089 sched.cpp:1091] Lost agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: I1207 01:25:45.354728 20089 sched.cpp:1102] Scheduler::slaveLost took 23962ns 3: I1207 01:25:45.357065 20081 process.cpp:3503] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot' 3: I1207 01:25:45.358148 20082 http.cpp:851] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot' 3: I1207 01:25:45.379400 20088 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/state' 3: I1207 01:25:45.381058 20086 http.cpp:1185] HTTP GET for /master/state from 172.17.0.2:36758 3: I1207 01:25:45.390064 20096 slave.cpp:1021] Lost leading master 3: I1207 01:25:45.390089 20096 slave.cpp:1083] Detecting new master 3: I1207 01:25:45.390121 20082 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1207 01:25:45.390501 20100 slave.cpp:1028] New master detected at [email protected]:42132 3: I1207 01:25:45.390539 20093 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1207 01:25:45.390601 20100 slave.cpp:1083] Detecting new master 3: I1207 01:25:45.390776 20100 slave.cpp:1110] Authenticating with master [email protected]:42132 3: I1207 01:25:45.390842 20100 slave.cpp:1119] Using default CRAM-MD5 authenticatee 3: I1207 01:25:45.391155 20092 authenticatee.cpp:121] Creating new client SASL connection 3: I1207 01:25:45.391481 20102 master.cpp:8738] Authenticating slave(110)@172.17.0.2:42132 3: I1207 01:25:45.391646 20085 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(236)@172.17.0.2:42132 3: I1207 01:25:45.391932 20094 authenticator.cpp:98] Creating new server SASL connection 3: I1207 01:25:45.392163 20083 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1207 01:25:45.392190 20083 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1207 01:25:45.392300 20083 authenticator.cpp:204] Received SASL authentication start 3: I1207 01:25:45.392355 20083 authenticator.cpp:326] Authentication requires more steps 3: I1207 01:25:45.392503 20087 authenticatee.cpp:259] Received SASL authentication step 3: I1207 01:25:45.392635 20086 authenticator.cpp:232] Received SASL authentication step 3: I1207 01:25:45.392660 20086 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9349dcbfe61' server FQDN: 'f9349dcbfe61' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1207 01:25:45.392673 20086 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1207 01:25:45.392714 20086 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1207 01:25:45.392730 20086 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9349dcbfe61' server FQDN: 'f9349dcbfe61' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1207 01:25:45.392740 20086 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1207 01:25:45.392745 20086 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1207 01:25:45.392762 20086 authenticator.cpp:318] Authentication success 3: I1207 01:25:45.392858 20098 authenticatee.cpp:299] Authentication success 3: I1207 01:25:45.392938 20103 master.cpp:8768] Successfully authenticated principal 'test-principal' at slave(110)@172.17.0.2:42132 3: I1207 01:25:45.392995 20104 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(236)@172.17.0.2:42132 3: I1207 01:25:45.393214 20090 slave.cpp:1202] Successfully authenticated with master [email protected]:42132 3: I1207 01:25:45.393735 20090 slave.cpp:1745] Will retry registration in 10.739579ms if necessary 3: I1207 01:25:45.394112 20101 master.cpp:6366] Received re-register agent message from agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.394192 20101 master.cpp:3869] Authorizing agent with principal 'test-principal' 3: I1207 01:25:45.394601 20082 master.cpp:6455] Authorized re-registration of agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.394683 20082 master.cpp:6595] Consulting registry about agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132(f9349dcbfe61) 3: I1207 01:25:45.395190 20096 registrar.cpp:495] Applied 1 operations in 108162ns; attempting to update the registry 3: I1207 01:25:45.395858 20096 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1207 01:25:45.396024 20092 master.cpp:6646] Re-admitted agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.396616 20092 master.cpp:11240] Adding task fa51689c-4d62-4142-a3b6-071373ac70ca with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.397275 20092 master.cpp:6809] Re-registered agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] 3: I1207 01:25:45.397469 20083 slave.cpp:1392] Re-registered with master [email protected]:42132 3: I1207 01:25:45.397565 20087 task_status_update_manager.cpp:188] Resuming sending task status updates 3: I1207 01:25:45.397631 20083 slave.cpp:1460] Forwarding total oversubscribed resources {} 3: I1207 01:25:45.397833 20086 master.cpp:7181] Received update of agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) with total oversubscribed resources {} 3: I1207 01:25:45.397871 20083 slave.cpp:3501] Updating info for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 with pid updated to [email protected]:42132 3: I1207 01:25:45.397974 20097 task_status_update_manager.cpp:188] Resuming sending task status updates 3: I1207 01:25:45.398051 20086 master.cpp:7224] Ignoring update on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) as it reports no changes 3: I1207 01:25:45.398114 20089 hierarchical.cpp:577] Added agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 (f9349dcbfe61) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]) 3: I1207 01:25:45.398433 20089 hierarchical.cpp:1527] Performed allocation for 1 agents in 147680ns 3: I1207 01:25:45.398921 20095 master.cpp:8205] Performing explicit task state reconciliation for 1 tasks of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.399063 20095 master.cpp:8353] Sending explicit reconciliation state TASK_RUNNING for task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.399430 20103 sched.cpp:1029] Scheduler::statusUpdate took 52511ns 3: I1207 01:25:45.401840 20093 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/state' 3: I1207 01:25:45.403275 20094 http.cpp:1185] HTTP GET for /master/state from 172.17.0.2:36760 3: I1207 01:25:45.411813 20096 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/state-summary' 3: I1207 01:25:45.413255 20092 http.cpp:1185] HTTP GET for /master/state-summary from 172.17.0.2:36762 3: I1207 01:25:45.419390 20098 process.cpp:3503] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot' 3: I1207 01:25:45.420495 20087 http.cpp:851] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot' 3: I1207 01:25:45.436764 20080 sched.cpp:2009] Asked to stop the driver 3: I1207 01:25:45.436887 20093 sched.cpp:1191] Stopping framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.437234 20104 master.cpp:9248] Processing TEARDOWN call for framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.437264 20104 master.cpp:9260] Removing framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.437275 20104 master.cpp:3330] Deactivating framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (default) at [email protected]:42132 3: I1207 01:25:45.437415 20096 hierarchical.cpp:410] Deactivated framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.437461 20088 slave.cpp:3330] Asked to shut down framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 by [email protected]:42132 3: I1207 01:25:45.437470 20104 master.cpp:9964] Updating the state of task fa51689c-4d62-4142-a3b6-071373ac70ca of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) 3: I1207 01:25:45.437499 20088 slave.cpp:3355] Shutting down framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.437543 20088 slave.cpp:5995] Shutting down executor 'fa51689c-4d62-4142-a3b6-071373ac70ca' of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 at executor(1)@172.17.0.2:43436 3: I1207 01:25:45.437839 20088 slave.cpp:904] Agent terminating 3: I1207 01:25:45.437897 20088 slave.cpp:3330] Asked to shut down framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 by @0.0.0.0:0 3: W1207 01:25:45.437932 20088 slave.cpp:3351] Ignoring shutdown framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 because it is terminating 3: I1207 01:25:45.438484 20104 master.cpp:10070] Removing task fa51689c-4d62-4142-a3b6-071373ac70ca with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 on agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.438737 20100 containerizer.cpp:2328] Destroying container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 in RUNNING state 3: I1207 01:25:45.438769 20100 containerizer.cpp:2930] Transitioning the state of container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 from RUNNING to DESTROYING 3: I1207 01:25:45.438997 22042 exec.cpp:435] Executor asked to shutdown 3: I1207 01:25:45.439016 20094 hierarchical.cpp:1202] 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 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 from framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.439215 20100 launcher.cpp:156] Asked to destroy container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 3: I1207 01:25:45.439399 20094 hierarchical.cpp:349] Removed framework 9badc083-05eb-44f9-91d4-aa28a1c55841-0000 3: I1207 01:25:45.439435 22046 executor.cpp:171] Received SHUTDOWN event 3: I1207 01:25:45.439467 22046 executor.cpp:747] Shutting down 3: I1207 01:25:45.439523 22046 executor.cpp:854] Sending SIGTERM to process tree at pid 22055 3: I1207 01:25:45.441155 20104 master.cpp:1308] Agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) disconnected 3: I1207 01:25:45.441179 20104 master.cpp:3367] Disconnecting agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.441221 20104 master.cpp:3386] Deactivating agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 at slave(110)@172.17.0.2:42132 (f9349dcbfe61) 3: I1207 01:25:45.441296 20095 hierarchical.cpp:767] Agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 deactivated 3: I1207 01:25:45.442590 22046 executor.cpp:867] Sent SIGTERM to the following process trees: 3: [ 3: --- 22055 mesos-containerizer launch --help=false --launch_info={"command":{"shell":true,"value":"sleep 60"},"environment":{"variables":[{"name":"PATH","type":"VALUE","value":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(110)@172.17.0.2:42132"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"9badc083-05eb-44f9-91d4-aa28a1c55841-S0"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:42132"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9\/slaves\/9badc083-05eb-44f9-91d4-aa28a1c55841-S0\/frameworks\/9badc083-05eb-44f9-91d4-aa28a1c55841-0000\/executors\/fa51689c-4d62-4142-a3b6-071373ac70ca\/runs\/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiJjNGVmMThjMi02MjUyLTQ2ZDMtYWU2YS0yYjE3YTVkMTUyYzIiLCJlaWQiOiJmYTUxNjg5Yy00ZDYyLTQxNDItYTNiNi0wNzEzNzNhYzcwY2EiLCJmaWQiOiI5YmFkYzA4My0wNWViLTQ0ZjktOTFkNC1hYTI4YTFjNTU4NDEtMDAwMCJ9.qxTVH4iOpuDvZMeIsaPMeZVV3uGBRQldqUYxctOvXH4"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"fa51689c-4d62-4142-a3b6-071373ac70ca"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"9badc083-05eb-44f9-91d4-aa28a1c55841-0000"},{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlaveNotPartitionAware_FOENX9\/slaves\/9badc083-05eb-44f9-91d4-aa28a1c55841-S0\/frameworks\/9badc083-05eb-44f9-91d4-aa28a1c55841-0000\/executors\/fa51689c-4d62-4142-a3b6-071373ac70ca\/runs\/c4ef18c2-6252-46d3-ae6a-2b17a5d152c2"}]}} --unshare_namespace_mnt=false 3: ] 3: I1207 01:25:45.442603 22046 executor.cpp:871] Scheduling escalation to SIGKILL in 3secs from now 3: I1207 01:25:45.501837 20096 containerizer.cpp:2779] Container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 has exited 3: I1207 01:25:45.504909 20095 provisioner.cpp:598] Ignoring destroy request for unknown container c4ef18c2-6252-46d3-ae6a-2b17a5d152c2 3: I1207 01:25:45.516993 20080 master.cpp:1150] Master terminating 3: I1207 01:25:45.517904 20095 hierarchical.cpp:610] Removed agent 9badc083-05eb-44f9-91d4-aa28a1c55841-S0 3: [ OK ] PartitionTest.ReregisterSlaveNotPartitionAware (549 ms) 3: [ RUN ] PartitionTest.PartitionedSlaveReregistrationMasterFailover 3: I1207 01:25:45.526628 20080 cluster.cpp:172] Creating default 'local' authorizer 3: I1207 01:25:45.530339 20081 master.cpp:454] Master b28ac37a-3b51-4806-a6c8-575365302b76 (f9349dcbfe61) started on 172.17.0.2:42132 3: I1207 01:25:45.530365 20081 master.cpp:456] 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/zCAMxY/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/zCAMxY/master" --zk_session_timeout="10secs" 3: I1207 01:25:45.530694 20081 master.cpp:505] Master only allowing authenticated frameworks to register 3: I1207 01:25:45.530702 20081 master.cpp:511] Master only allowing authenticated agents to register 3: I1207 01:25:45.530707 20081 master.cpp:517] Master only allowing authenticated HTTP frameworks to register 3: I1207 01:25:45.530712 20081 credentials.hpp:37] Loading credentials for authentication from '/tmp/zCAMxY/credentials' 3: I1207 01:25:45.531029 20081 master.cpp:561] Using default 'crammd5' authenticator 3: I1207 01:25:45.531224 20081 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' 3: I1207 01:25:45.531424 20081 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' 3: I1207 01:25:45.531581 20081 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' 3: I1207 01:25:45.531733 20081 master.cpp:640] Authorization enabled 3: I1207 01:25:45.531963 20100 hierarchical.cpp:175] Initialized hierarchical allocator process 3: I1207 01:25:45.531972 20090 whitelist_watcher.cpp:77] No whitelist given 3: I1207 01:25:45.535177 20092 master.cpp:2212] Elected as the leading master! 3: I1207 01:25:45.535207 20092 master.cpp:1692] Recovering from registrar 3: I1207 01:25:45.535395 20101 registrar.cpp:347] Recovering registrar 3: I1207 01:25:45.536113 20101 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns 3: I1207 01:25:45.536240 20101 registrar.cpp:495] Applied 1 operations in 36086ns; attempting to update the registry 3: I1207 01:25:45.536979 20101 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1207 01:25:45.537163 20101 registrar.cpp:424] Successfully recovered registrar 3: I1207 01:25:45.537622 20085 master.cpp:1805] Recovered 0 agents from the registry (135B); allowing 10mins for agents to re-register 3: I1207 01:25:45.537688 20082 hierarchical.cpp:213] Skipping recovery of hierarchical allocator: nothing to recover 3: W1207 01:25:45.542933 20080 process.cpp:2756] Attempted to spawn already running process [email protected]:42132 3: I1207 01:25:45.543958 20080 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1207 01:25:45.544535 20080 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1207 01:25:45.544670 20080 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1207 01:25:45.544715 20080 provisioner.cpp:299] Using default backend 'copy' 3: I1207 01:25:45.546815 20080 cluster.cpp:460] Creating default 'local' authorizer 3: I1207 01:25:45.549412 20082 slave.cpp:258] Mesos agent started on (111)@172.17.0.2:42132 Build step 'Execute shell' marked build as failure Not sending mail to unregistered user [email protected] Not sending mail to unregistered user [email protected]
