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 2018/12/05 22:50:56 UTC

Build failed in Jenkins: Mesos-Reviewbot #23593

See <https://builds.apache.org/job/Mesos-Reviewbot/23593/display/redirect?page=changes>

Changes:

[vinodkone] Manually copy test reports to host fs.

------------------------------------------
[...truncated 44.03 MB...]
I1205 22:35:38.739054 20172 slave.cpp:1553] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"LgQe8x+RTkC9HDAtWkmJyQ=="},"slave_id":{"value":"bd4915a0-6332-4a61-944a-967e85594f6e-S0"},"update_oversubscribed_resources":false}
I1205 22:35:38.739666 20163 hierarchical.cpp:1566] Performed allocation for 1 agents in 1.559899ms
I1205 22:35:38.739814 20177 master.cpp:7934] Ignoring update on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483) as it reports no changes
I1205 22:35:38.740515 20177 master.cpp:9464] Sending offers [ bd4915a0-6332-4a61-944a-967e85594f6e-O0 ] to framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244
I1205 22:35:38.741243 20142 sched.cpp:914] Scheduler::resourceOffers took 139564ns
I1205 22:35:38.743317 20175 master.cpp:11463] Removing offer bd4915a0-6332-4a61-944a-967e85594f6e-O0
I1205 22:35:38.743929 20175 master.cpp:4451] Processing ACCEPT call for offers: [ bd4915a0-6332-4a61-944a-967e85594f6e-O0 ] on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483) for framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244
I1205 22:35:38.744056 20175 master.cpp:3547] Authorizing framework principal 'test-principal' to launch task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6
I1205 22:35:38.745976 20156 master.cpp:4028] Adding task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244 on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483)
I1205 22:35:38.746613 20156 master.cpp:5423] Launching task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244 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 bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483) on  new executor
I1205 22:35:38.747983 20140 slave.cpp:2019] Got assigned task '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' for framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:38.748159 20140 slave.cpp:8895] Checkpointing FrameworkInfo to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/framework.info'
I1205 22:35:38.748571 20140 slave.cpp:8906] Checkpointing framework pid 'scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244' to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/framework.pid'
I1205 22:35:38.750114 20140 slave.cpp:2393] Authorizing task '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' for framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:38.750176 20140 slave.cpp:8471] Authorizing framework principal 'test-principal' to launch task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6
I1205 22:35:38.752899 20182 slave.cpp:2836] Launching task '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' for framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:38.753034 20182 paths.cpp:752] Creating sandbox '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791' for user 'mesos'
I1205 22:35:38.754123 20182 slave.cpp:9681] Checkpointing ExecutorInfo to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/executor.info'
I1205 22:35:38.755048 20182 paths.cpp:755] Creating sandbox '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791'
I1205 22:35:38.755367 20182 slave.cpp:8981] Launching executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-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/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791'
I1205 22:35:38.756254 20182 slave.cpp:3514] Launching container 9dca38fb-6368-4b4a-8737-f70a332bb791 for executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:38.756896 20182 slave.cpp:9712] Checkpointing TaskInfo to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791/tasks/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/task.info'
I1205 22:35:38.757668 20182 slave.cpp:3033] Queued task '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' for executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:38.757778 20182 slave.cpp:993] Successfully attached '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791' to virtual path '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/latest'
I1205 22:35:38.757833 20182 slave.cpp:993] Successfully attached '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791' to virtual path '/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/latest'
I1205 22:35:38.757877 20182 slave.cpp:993] Successfully attached '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791' to virtual path '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791'
I1205 22:35:38.758544 20148 containerizer.cpp:1288] Starting container 9dca38fb-6368-4b4a-8737-f70a332bb791
I1205 22:35:38.760195 20148 containerizer.cpp:1454] Checkpointed ContainerConfig at '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/containers/9dca38fb-6368-4b4a-8737-f70a332bb791/config'
I1205 22:35:38.760238 20148 containerizer.cpp:3130] Transitioning the state of container 9dca38fb-6368-4b4a-8737-f70a332bb791 from PROVISIONING to PREPARING
I1205 22:35:38.765563 20175 containerizer.cpp:1947] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=/mesos/mesos-1.8.0/_build/src"],"shell":false,"value":"/mesos/mesos-1.8.0/_build/src/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:34244"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"1"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"999d8845-0d12-47ad-9e49-8ea4b8ecd1a6"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"bd4915a0-6332-4a61-944a-967e85594f6e-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_RECOVERY_TIMEOUT","type":"VALUE","value":"15mins"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"bd4915a0-6332-4a61-944a-967e85594f6e-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave@172.17.0.2:34244"},{"name":"MESOS_SUBSCRIPTION_BACKOFF_MAX","type":"VALUE","value":"15secs"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791"}]},"task_environment":{},"user":"mesos","working_directory":"/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791"}" --pipe_read="24" --pipe_write="26" --runtime_directory="/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/containers/9dca38fb-6368-4b4a-8737-f70a332bb791" --unshare_namespace_mnt="false"'
I1205 22:35:38.772800 20175 launcher.cpp:145] Forked child with pid '28350' for container '9dca38fb-6368-4b4a-8737-f70a332bb791'
I1205 22:35:38.772964 20175 containerizer.cpp:2052] Checkpointing container's forked pid 28350 to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791/pids/forked.pid'
I1205 22:35:38.773948 20175 containerizer.cpp:3130] Transitioning the state of container 9dca38fb-6368-4b4a-8737-f70a332bb791 from PREPARING to ISOLATING
I1205 22:35:38.776407 20160 containerizer.cpp:3130] Transitioning the state of container 9dca38fb-6368-4b4a-8737-f70a332bb791 from ISOLATING to FETCHING
I1205 22:35:38.776895 20178 fetcher.cpp:369] Starting to fetch URIs for container: 9dca38fb-6368-4b4a-8737-f70a332bb791, directory: /tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791
I1205 22:35:38.778507 20158 containerizer.cpp:3130] Transitioning the state of container 9dca38fb-6368-4b4a-8737-f70a332bb791 from FETCHING to RUNNING
I1205 22:35:39.223562 28423 exec.cpp:162] Version: 1.8.0
I1205 22:35:39.236313 20172 slave.cpp:4808] Got registration for executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 from executor(1)@172.17.0.2:34666
I1205 22:35:39.236943 20172 slave.cpp:4894] Checkpointing executor pid 'executor(1)@172.17.0.2:34666' to '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/slaves/bd4915a0-6332-4a61-944a-967e85594f6e-S0/frameworks/bd4915a0-6332-4a61-944a-967e85594f6e-0000/executors/999d8845-0d12-47ad-9e49-8ea4b8ecd1a6/runs/9dca38fb-6368-4b4a-8737-f70a332bb791/pids/libprocess.pid'
I1205 22:35:39.240669 20179 slave.cpp:3246] Sending queued task '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' to executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 at executor(1)@172.17.0.2:34666
I1205 22:35:39.241736 28430 exec.cpp:236] Executor registered on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:35:39.246270 28411 executor.cpp:184] Received SUBSCRIBED event
I1205 22:35:39.247917 28411 executor.cpp:188] Subscribed executor on a4b58fc90483
I1205 22:35:39.248162 28411 executor.cpp:184] Received LAUNCH event
I1205 22:35:39.250625 28411 executor.cpp:687] Starting task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6
I1205 22:35:39.253721 20170 slave.cpp:5274] Handling status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 from executor(1)@172.17.0.2:34666
I1205 22:35:39.255893 20152 task_status_update_manager.cpp:328] Received task status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.255951 20152 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.256770 20152 task_status_update_manager.cpp:842] Checkpointing UPDATE for task status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.257045 20152 task_status_update_manager.cpp:383] Forwarding task status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to the agent
I1205 22:35:39.257277 20160 slave.cpp:5766] Forwarding the update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to master@172.17.0.2:34244
I1205 22:35:39.257540 20160 slave.cpp:5659] Task status update manager successfully handled status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.257602 20160 slave.cpp:5675] Sending acknowledgement for status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to executor(1)@172.17.0.2:34666
I1205 22:35:39.257735 20182 master.cpp:8370] Status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 from agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483)
I1205 22:35:39.257815 20182 master.cpp:8427] Forwarding status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.258124 20182 master.cpp:10928] Updating the state of task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING)
I1205 22:35:39.258558 20160 sched.cpp:1022] Scheduler::statusUpdate took 156352ns
I1205 22:35:39.259541 20146 master.cpp:6226] Processing ACKNOWLEDGE call for status 77d133f0-b90d-4d51-af6a-f7b5308b0d28 for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244 on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:35:39.259969 20140 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.260074 20140 task_status_update_manager.cpp:842] Checkpointing ACK for task status update TASK_STARTING (Status UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.260342 20168 slave.cpp:4510] Task status update manager successfully handled status update acknowledgement (UUID: 77d133f0-b90d-4d51-af6a-f7b5308b0d28) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.273062 28411 executor.cpp:502] Running '/mesos/mesos-1.8.0/_build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
I1205 22:35:39.276697 28411 executor.cpp:702] Forked command at 28436
I1205 22:35:39.280181 20163 slave.cpp:5274] Handling status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 from executor(1)@172.17.0.2:34666
I1205 22:35:39.281977 20148 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.282060 20148 task_status_update_manager.cpp:842] Checkpointing UPDATE for task status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.282305 20148 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to the agent
I1205 22:35:39.282482 20179 slave.cpp:5766] Forwarding the update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to master@172.17.0.2:34244
I1205 22:35:39.282810 20179 slave.cpp:5659] Task status update manager successfully handled status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.282908 20179 slave.cpp:5675] Sending acknowledgement for status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 to executor(1)@172.17.0.2:34666
I1205 22:35:39.283064 20138 master.cpp:8370] Status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 from agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483)
I1205 22:35:39.283180 20138 master.cpp:8427] Forwarding status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.283624 20138 master.cpp:10928] Updating the state of task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I1205 22:35:39.284286 20138 sched.cpp:1022] Scheduler::statusUpdate took 169212ns
I1205 22:35:39.285595 20168 master.cpp:6226] Processing ACKNOWLEDGE call for status 2bcbe0cd-1624-4781-b52b-fe40c4e6217d for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 (default) at scheduler-983a9723-d0ca-442d-86d1-3d8865018ae0@172.17.0.2:34244 on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:35:39.286213 20163 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.286433 20163 task_status_update_manager.cpp:842] Checkpointing ACK for task status update TASK_RUNNING (Status UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.286978 20175 slave.cpp:4510] Task status update manager successfully handled status update acknowledgement (UUID: 2bcbe0cd-1624-4781-b52b-fe40c4e6217d) for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:39.287523 20182 slave.cpp:914] Agent terminating
I1205 22:35:39.695830 20140 hierarchical.cpp:1566] Performed allocation for 1 agents in 379736ns
I1205 22:35:40.273918 20142 master.cpp:1275] Agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483) disconnected
I1205 22:35:40.273969 20142 master.cpp:3273] Disconnecting agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483)
I1205 22:35:40.274070 20142 master.cpp:3292] Deactivating agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 at slave@172.17.0.2:34244 (a4b58fc90483)
I1205 22:35:40.274226 20152 hierarchical.cpp:801] Agent bd4915a0-6332-4a61-944a-967e85594f6e-S0 deactivated
I1205 22:35:40.274356 19605 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1205 22:35:40.275105 19605 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1205 22:35:40.275295 19605 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1205 22:35:40.275347 19605 provisioner.cpp:298] Using default backend 'copy'
W1205 22:35:40.285369 19605 process.cpp:2829] Attempted to spawn already running process files@172.17.0.2:34244
I1205 22:35:40.286180 19605 cluster.cpp:485] Creating default 'local' authorizer
I1205 22:35:40.288410 20182 slave.cpp:268] Mesos agent started on @172.17.0.2:34244
I1205 22:35:40.288452 20182 slave.cpp:269] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_destroy_timeout="1mins" --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/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/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/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="15secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/frameworks" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal" --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/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx" --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/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4" --zk_session_timeout="10secs"
I1205 22:35:40.289305 20182 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/credential'
I1205 22:35:40.289580 20182 slave.cpp:301] Agent using credential for: test-principal
I1205 22:35:40.289619 20182 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_M0HATx/http_credentials'
I1205 22:35:40.289973 20182 http.cpp:1017] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1205 22:35:40.295001 20182 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1205 22:35:40.298202 20182 slave.cpp:616] 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"}]
I1205 22:35:40.298678 20182 slave.cpp:624] Agent attributes: [  ]
I1205 22:35:40.298704 20182 slave.cpp:633] Agent hostname: a4b58fc90483
I1205 22:35:40.298913 20156 task_status_update_manager.cpp:181] Pausing sending task status updates
I1205 22:35:40.300765 20163 state.cpp:66] Recovering state from '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta'
I1205 22:35:40.300868 20163 state.cpp:711] No committed checkpointed resources found at '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta/resources/resources.info'
I1205 22:35:40.308856 20158 slave.cpp:6914] Finished recovering checkpointed state from '/tmp/SlaveRecoveryTest_0_PingTimeoutDuringRecovery_rGlcO4/meta', beginning agent recovery
I1205 22:35:40.309844 20158 slave.cpp:7393] Recovering framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.310091 20158 slave.cpp:9099] Recovering executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.311600 20168 task_status_update_manager.cpp:207] Recovering task status update manager
I1205 22:35:40.311676 20168 task_status_update_manager.cpp:215] Recovering executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.311837 20168 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6 of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.312790 20168 task_status_update_manager.cpp:818] Replaying task status update stream for task 999d8845-0d12-47ad-9e49-8ea4b8ecd1a6
I1205 22:35:40.313953 20181 containerizer.cpp:727] Recovering Mesos containers
I1205 22:35:40.314116 20181 containerizer.cpp:784] Recovering container 9dca38fb-6368-4b4a-8737-f70a332bb791 for executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.316977 20181 containerizer.cpp:1053] Recovering isolators
I1205 22:35:40.318897 20177 containerizer.cpp:1092] Recovering provisioner
I1205 22:35:40.319797 20165 provisioner.cpp:494] Provisioner recovery complete
I1205 22:35:40.322114 20138 composing.cpp:339] Finished recovering all containerizers
I1205 22:35:40.322293 20179 slave.cpp:7143] Recovering executors
I1205 22:35:40.322499 20179 slave.cpp:7167] Sending reconnect request to executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000 at executor(1)@172.17.0.2:34666
I1205 22:35:40.324606 28433 exec.cpp:282] Received reconnect request from agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:35:40.328531 20177 slave.cpp:4971] Received re-registration message from executor '999d8845-0d12-47ad-9e49-8ea4b8ecd1a6' of framework bd4915a0-6332-4a61-944a-967e85594f6e-0000
I1205 22:35:40.331638 28410 exec.cpp:259] Executor reregistered on agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:35:40.332386 20179 slave.cpp:5888] No pings from master received within 75secs
I1205 22:35:40.332618 20144 hierarchical.cpp:1566] Performed allocation for 1 agents in 282271ns
F1205 22:35:40.333025 20140 slave.cpp:1232] Check failed: state == DISCONNECTED || state == RUNNING || state == TERMINATING RECOVERING
*** Check failure stack trace: ***
I1205 22:35:40.335453 28412 executor.cpp:184] Received SUBSCRIBED event
I1205 22:35:40.335500 28412 executor.cpp:188] Subscribed executor on a4b58fc90483
    @     0x2ba7d607771a  google::LogMessage::Fail()
    @     0x2ba7d6077666  google::LogMessage::SendToLog()
    @     0x2ba7d6077068  google::LogMessage::Flush()
    @     0x2ba7d6079f7c  google::LogMessageFatal::~LogMessageFatal()
    @     0x2ba7d4c8312c  mesos::internal::slave::Slave::detected()
    @     0x2ba7d4d16e7c  _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureI6OptionINS1_10MasterInfoEEEESB_EEvRKNS_3PIDIT_EEMSD_FvT0_EOT1_ENKUlOS9_PNS_11ProcessBaseEE_clESM_SO_
    @     0x2ba7d4dbf0d5  _ZN5cpp176invokeIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS1_6FutureI6OptionINS3_10MasterInfoEEEESD_EEvRKNS1_3PIDIT_EEMSF_FvT0_EOT1_EUlOSB_PNS1_11ProcessBaseEE_ISB_SQ_EEEDTclcl7forwardISF_Efp_Espcl7forwardIT0_Efp0_EEEOSF_DpOSS_
    @     0x2ba7d4db6081  _ZN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS2_6FutureI6OptionINS4_10MasterInfoEEEESE_EEvRKNS2_3PIDIT_EEMSG_FvT0_EOT1_EUlOSC_PNS2_11ProcessBaseEE_ISC_St12_PlaceholderILi1EEEE13invoke_expandISS_St5tupleIISC_SU_EESX_IIOSR_EEILm0ELm1EEEEDTcl6invokecl7forwardIT_Efp_Espcl6expandcl3getIXT2_EEcl7forwardIT0_Efp0_EEcl7forwardIT1_Efp2_EEEEOS11_OS12_N5cpp1416integer_sequenceImIXspT2_EEEEOS13_
    @     0x2ba7d4db00c1  _ZNO6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS2_6FutureI6OptionINS4_10MasterInfoEEEESE_EEvRKNS2_3PIDIT_EEMSG_FvT0_EOT1_EUlOSC_PNS2_11ProcessBaseEE_JSC_St12_PlaceholderILi1EEEEclIJSR_EEEDTcl13invoke_expandcl4movedtdefpT1fEcl4movedtdefpT10bound_argsEcvN5cpp1416integer_sequenceImJLm0ELm1EEEE_Ecl16forward_as_tuplespcl7forwardIT_Efp_EEEEDpOS10_
    @     0x2ba7d4dacf39  _ZN5cpp176invokeIN6lambda8internal7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS4_6FutureI6OptionINS6_10MasterInfoEEEESG_EEvRKNS4_3PIDIT_EEMSI_FvT0_EOT1_EUlOSE_PNS4_11ProcessBaseEE_ISE_St12_PlaceholderILi1EEEEEIST_EEEDTclcl7forwardISI_Efp_Espcl7forwardIT0_Efp0_EEEOSI_DpOSY_
    @     0x2ba7d4dab247  _ZN6lambda8internal6InvokeIvEclINS0_7PartialIZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS5_6FutureI6OptionINS7_10MasterInfoEEEESH_EEvRKNS5_3PIDIT_EEMSJ_FvT0_EOT1_EUlOSF_PNS5_11ProcessBaseEE_JSF_St12_PlaceholderILi1EEEEEJSU_EEEvOSJ_DpOT0_
    @     0x2ba7d4da9101  _ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEE10CallableFnINS_8internal7PartialIZNS1_8dispatchIN5mesos8internal5slave5SlaveERKNS1_6FutureI6OptionINSA_10MasterInfoEEEESK_EEvRKNS1_3PIDIT_EEMSM_FvT0_EOT1_EUlOSI_S3_E_ISI_St12_PlaceholderILi1EEEEEEclEOS3_
    @     0x2ba7d5f9c225  _ZNO6lambda12CallableOnceIFvPN7process11ProcessBaseEEEclES3_
    @     0x2ba7d5f65c55  process::ProcessBase::consume()
    @     0x2ba7d5f89f78  _ZNO7process13DispatchEvent7consumeEPNS_13EventConsumerE
    @     0x557486454aa8  process::ProcessBase::serve()
    @     0x2ba7d5f62f32  process::ProcessManager::resume()
    @     0x2ba7d5f5f3ac  _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2ba7d5f84dc4  _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2ba7d5f840e5  _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2ba7d5f832a4  _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2ba7d8e39a60  (unknown)
    @     0x2ba7d95b0184  start_thread
    @     0x2ba7d98c403d  (unknown)
I1205 22:35:41.273973 28425 exec.cpp:518] Agent exited, but framework has checkpointing enabled. Waiting 15mins to reconnect with agent bd4915a0-6332-4a61-944a-967e85594f6e-S0
I1205 22:50:41.275562 28423 exec.cpp:499] Recovery timeout of 15mins exceeded; Shutting down
I1205 22:50:41.275735 28423 exec.cpp:445] Executor asked to shutdown
I1205 22:50:41.276684 28431 executor.cpp:184] Received SHUTDOWN event
I1205 22:50:41.276785 28431 executor.cpp:805] Shutting down
I1205 22:50:41.276856 28431 executor.cpp:918] Sending SIGTERM to process tree at pid 28436
I1205 22:50:41.297613 28431 executor.cpp:931] Sent SIGTERM to the following process trees:
[ 
-+- 28436 sh -c sleep 1000 
 \--- 28462 sleep 1000 
]
I1205 22:50:41.297721 28431 executor.cpp:935] Scheduling escalation to SIGKILL in 3secs from now
I1205 22:50:41.312661 28433 executor.cpp:1003] Command terminated with signal Terminated (pid: 28436)
W1205 22:50:41.323835 28434 process.cpp:1890] Failed to send 'mesos.internal.StatusUpdateMessage' to '172.17.0.2:34244', connect: Failed to connect to 172.17.0.2:34244: Connection refused
I1205 22:50:42.320749 28434 process.cpp:927] Stopped the socket accept loop


[FAIL]: 1 shard(s) have failed tests
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.8.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.8.0/_build'
make: *** [distcheck] Error 1
+ docker rmi --force mesos-1544043866-27586
Untagged: mesos-1544043866-27586:latest
Deleted: sha256:cdbef2c0952795c6d88d173934d90508ee782cc95fa190abf73cb40f06e389e9
Deleted: sha256:93f85e1421ecada021ded19cde442eb18799b23041939b73378cd31826c139bd
Deleted: sha256:8da59d539a3bd87e392537635007d9394b6443dc4c6aebb67300a76a4691da80
Deleted: sha256:6803aa6914787833898b6af9a1f867d0372e614c003dea4932bd3b32e64a7c0f
Deleted: sha256:eabb511b45fb71abe368ee0779049e909104510e0448810fb1ee1dd3bd12f802
Deleted: sha256:80927f3d6a97046486027f8915d17d77a692b928ee53f63b6c0cebea763ef629
Deleted: sha256:66db2e2a3b37cfa26760d0193bb93818773588620c37fa0f359f124cc06b2f8e
Deleted: sha256:ea63117ea53e789024942e248294bbda13917d8dc59db8a08ee1972812e9fd20
Deleted: sha256:c71b109c819298b8f106861e0f95f331743179de961b5e08c9ff496c69be4eca
Deleted: sha256:cfb8420219843dd252208036deb8aa0c609d9da27bfc31e9fee249e31b550cac
Deleted: sha256:dd4b7823ca0fede6f96009231681a77913ae492029a9821e19246e17057123b0
Deleted: sha256:aff419b5cb0c9cba7bfda9b5cbd2926d334a0aaae9c320499652f22a96fdea82
Deleted: sha256:95473614d743b8f8b6b37e1f2b7e3b24c72d13cfda554ba14c8b95c763b6d8db
Deleted: sha256:c58cd239f4651848e03a12f2a4885827199f0724aeefc1ba1a5b4685fe23b747
Deleted: sha256:22211ef9a43ae2da497c12414c0c70d125a71f59a0d1f2daec1b593b8dcf153f
Deleted: sha256:9af5237d33da12b4481cdcf1a5d0b69067715c1da75b91759eb9869286cbd9bd
Deleted: sha256:bdfd164f8702faf1fe19c5a928bf513e78129e192b3013f0dc383a0c64dd7f0b
Deleted: sha256:5108f9937bfa53f83453337dd7bbdb616cc54074a2aa11e20d0ba62b2e3f5763
Deleted: sha256:3f1b91c4f989f02b180f04c506c6cf75013217ab6e3157c3885b4901aef88036
Deleted: sha256:397985a1cb8968888df61e8f7f0fcb27b93a9939533967e75fe489e8a2156a4d
Deleted: sha256:0b8fbb5d7d3247b94f58073569df9441946996d046dd42468035363daec49c75
Deleted: sha256:9b0357f2321520c9f0ac0ba5a94ce2751d4163e3ea6789554a7bf70ef0811bbc
Deleted: sha256:69dcd21bda8b562e7c78d806193689ef1e28fd7920e0e6ddcd27e3e8fa06986e
Deleted: sha256:77abbcaa880e49765aa77c4f38af4b53111505d245bc0b733fb1589421656618
Deleted: sha256:faf0bd3137a2dbd7a8adb760f11412ef7ded3b70f21890cb36159fbd12377948
Deleted: sha256:300311b3eda173c66ea8de13d1b0f22fe7d8ef455a38e4f951b48292981094da
Deleted: sha256:e7a2a185052f2a2e29b9c36133aab7205b3f5be5f653db35d3d1fbf364424f15
Deleted: sha256:0074106850878c5c2b16681d83aa8f745da9caa6289fbe588ea48ad2f1a43ad9
Deleted: sha256:2011582fd6d4da72e87e54a2980f67f45fe9aad1f4b40045ddf44a0945991833
Deleted: sha256:ee4d82afe70a5d8390d6530cf80d5dd9a26a946ab855f8e7614c6782e2e4709f

12-05-18_21:04:22 - Running <https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py>
Checking if review 69096 needs verification
Skipping blocking review 69096
Checking if review 69493 needs verification
Latest review timestamp: 2018-12-05 18:22:13
Latest diff timestamp: 2018-12-05 13:58:18
Checking if review 69098 needs verification
Latest review timestamp: 2018-10-20 13:11:38
Latest diff timestamp: 2018-10-20 06:01:51
Checking if review 69344 needs verification
Skipping blocking review 69344
Checking if review 69162 needs verification
Skipping blocking review 69162
Checking if review 69307 needs verification
Latest review timestamp: 2018-11-29 01:43:25
Latest diff timestamp: 2018-12-01 02:45:09
This patch has been updated since its last review, needs verification.
Verifying review 69307
Applying review 69307
/usr/bin/python3 support/apply-reviews.py -n -r 69307
Traceback (most recent call last):
  File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 186, in verify_review
    % (command, build_output)])
  File "/usr/lib/python3.5/subprocess.py", line 581, in check_call
    raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['bash', '-c', "set -o pipefail; export OS='ubuntu:14.04' BUILDTOOL='autotools' COMPILER='gcc' CONFIGURATION='--verbose --disable-libtool-wrappers' ENVIRONMENT='GLOG_v=1 MESOS_VERBOSE=1'; ./support/docker-build.sh 2>&1 | tee build_69307"]' returned non-zero exit status 2

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 294, in <module>
    main()
  File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 288, in main
    verify_review(review_request, handler)
  File "<https://builds.apache.org/job/Mesos-Reviewbot/ws/support/verify-reviews.py",> line 201, in verify_review
    output = open(build_output).read().decode(sys.stdout.encoding)
AttributeError: 'str' object has no attribute 'decode'
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Reviewbot #23594

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23594/display/redirect?page=changes>