You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/05/26 19:06:51 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3730

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3730/display/redirect?page=changes>

Changes:

[vinodkone] Made the executor driver drop some messages when not connected.

------------------------------------------
[...truncated 27.48 MB...]
rm -f local/*.lo
rm -f log/*.o
rm -f log/*.lo
rm -f log/tool/*.o
rm -f log/tool/*.lo
rm -f logging/*.o
rm -f logging/*.lo
rm -f master/*.o
rm -f master/*.lo
rm -f master/allocator/*.o
rm -f master/allocator/*.lo
rm -f master/allocator/mesos/*.o
rm -f master/allocator/mesos/*.lo
rm -f master/allocator/sorter/drf/*.o
rm -f master/allocator/sorter/drf/*.lo
rm -f master/contender/*.o
rm -f master/contender/*.lo
rm -f master/detector/*.o
rm -f master/detector/*.lo
rm -f messages/*.o
rm -f messages/*.lo
rm -f module/*.o
rm -f module/*.lo
rm -f oci/*.o
rm -f oci/*.lo
rm -f posix/*.o
rm -f posix/*.lo
rm -f sched/*.o
rm -f sched/*.lo
rm -f scheduler/*.o
rm -f scheduler/*.lo
rm -f secret/*.o
rm -f secret/*.lo
rm -f slave/*.o
rm -f slave/*.lo
rm -f slave/container_loggers/*.o
rm -f slave/container_loggers/*.lo
rm -f slave/containerizer/*.o
rm -f slave/containerizer/*.lo
rm -f slave/containerizer/mesos/*.o
rm -f slave/containerizer/mesos/*.lo
rm -f slave/containerizer/mesos/io/*.o
rm -f slave/containerizer/mesos/io/*.lo
rm -f slave/containerizer/mesos/isolators/*.o
rm -f slave/containerizer/mesos/isolators/*.lo
rm -f slave/containerizer/mesos/isolators/appc/*.o
rm -f slave/containerizer/mesos/isolators/appc/*.lo
rm -f slave/containerizer/mesos/isolators/cgroups/*.o
rm -f slave/containerizer/mesos/isolators/cgroups/*.lo
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/*.o
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/*.lo
rm -f slave/containerizer/mesos/isolators/docker/*.o
rm -f slave/containerizer/mesos/isolators/docker/*.lo
rm -f slave/containerizer/mesos/isolators/docker/volume/*.o
rm -f slave/containerizer/mesos/isolators/docker/volume/*.lo
rm -f slave/containerizer/mesos/isolators/filesystem/*.o
rm -f slave/containerizer/mesos/isolators/filesystem/*.lo
rm -f slave/containerizer/mesos/isolators/gpu/*.o
rm -f slave/containerizer/mesos/isolators/gpu/*.lo
rm -f slave/containerizer/mesos/isolators/linux/*.o
rm -f slave/containerizer/mesos/isolators/linux/*.lo
rm -f slave/containerizer/mesos/isolators/namespaces/*.o
rm -f slave/containerizer/mesos/isolators/namespaces/*.lo
rm -f slave/containerizer/mesos/isolators/network/*.o
rm -f slave/containerizer/mesos/isolators/network/*.lo
rm -f slave/containerizer/mesos/isolators/network/cni/*.o
rm -f slave/containerizer/mesos/isolators/network/cni/*.lo
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.o
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.lo
rm -f slave/containerizer/mesos/isolators/posix/*.o
rm -f slave/containerizer/mesos/isolators/posix/*.lo
rm -f slave/containerizer/mesos/isolators/volume/*.o
rm -f slave/containerizer/mesos/isolators/volume/*.lo
rm -f slave/containerizer/mesos/isolators/xfs/*.o
rm -f slave/containerizer/mesos/isolators/xfs/*.lo
rm -f slave/containerizer/mesos/provisioner/*.o
rm -f slave/containerizer/mesos/provisioner/*.lo
rm -f slave/containerizer/mesos/provisioner/appc/*.o
rm -rf ../include/mesos/.libs ../include/mesos/_libs
rm -f slave/containerizer/mesos/provisioner/appc/*.lo
rm -rf ../include/mesos/agent/.libs ../include/mesos/agent/_libs
rm -f slave/containerizer/mesos/provisioner/backends/*.o
rm -rf ../include/mesos/allocator/.libs ../include/mesos/allocator/_libs
rm -rf ../include/mesos/appc/.libs ../include/mesos/appc/_libs
rm -f slave/containerizer/mesos/provisioner/backends/*.lo
rm -rf ../include/mesos/authentication/.libs ../include/mesos/authentication/_libs
rm -rf ../include/mesos/authorizer/.libs ../include/mesos/authorizer/_libs
rm -f slave/containerizer/mesos/provisioner/docker/*.o
rm -rf ../include/mesos/docker/.libs ../include/mesos/docker/_libs
rm -rf ../include/mesos/executor/.libs ../include/mesos/executor/_libs
rm -f slave/containerizer/mesos/provisioner/docker/*.lo
rm -rf ../include/mesos/fetcher/.libs ../include/mesos/fetcher/_libs
rm -rf ../include/mesos/maintenance/.libs ../include/mesos/maintenance/_libs
rm -f slave/qos_controllers/*.o
rm -rf ../include/mesos/master/.libs ../include/mesos/master/_libs
rm -rf ../include/mesos/module/.libs ../include/mesos/module/_libs
rm -rf ../include/mesos/oci/.libs ../include/mesos/oci/_libs
rm -f slave/qos_controllers/*.lo
rm -rf ../include/mesos/quota/.libs ../include/mesos/quota/_libs
rm -rf ../include/mesos/resource_provider/.libs ../include/mesos/resource_provider/_libs
rm -f slave/resource_estimators/*.o
rm -rf ../include/mesos/scheduler/.libs ../include/mesos/scheduler/_libs
rm -rf ../include/mesos/slave/.libs ../include/mesos/slave/_libs
rm -f slave/resource_estimators/*.lo
rm -rf ../include/mesos/state/.libs ../include/mesos/state/_libs
rm -rf ../include/mesos/uri/.libs ../include/mesos/uri/_libs
rm -f state/*.o
rm -rf ../include/mesos/v1/.libs ../include/mesos/v1/_libs
rm -f state/*.lo
rm -rf ../include/mesos/v1/agent/.libs ../include/mesos/v1/agent/_libs
rm -f tests/*.o
rm -rf ../include/mesos/v1/allocator/.libs ../include/mesos/v1/allocator/_libs
rm -rf ../include/mesos/v1/executor/.libs ../include/mesos/v1/executor/_libs
rm -rf ../include/mesos/v1/maintenance/.libs ../include/mesos/v1/maintenance/_libs
rm -rf ../include/mesos/v1/master/.libs ../include/mesos/v1/master/_libs
rm -rf ../include/mesos/v1/quota/.libs ../include/mesos/v1/quota/_libs
rm -rf ../include/mesos/v1/resource_provider/.libs ../include/mesos/v1/resource_provider/_libs
rm -rf ../include/mesos/v1/scheduler/.libs ../include/mesos/v1/scheduler/_libs
rm -rf appc/.libs appc/_libs
rm -rf authentication/cram_md5/.libs authentication/cram_md5/_libs
rm -rf authentication/executor/.libs authentication/executor/_libs
rm -rf authentication/http/.libs authentication/http/_libs
rm -rf authorizer/.libs authorizer/_libs
rm -rf authorizer/local/.libs authorizer/local/_libs
rm -rf checks/.libs checks/_libs
rm -rf common/.libs common/_libs
rm -rf docker/.libs docker/_libs
rm -rf examples/.libs examples/_libs
rm -rf exec/.libs exec/_libs
rm -rf executor/.libs executor/_libs
rm -rf files/.libs files/_libs
rm -rf hdfs/.libs hdfs/_libs
rm -rf hook/.libs hook/_libs
rm -rf internal/.libs internal/_libs
rm -rf java/jni/.libs java/jni/_libs
rm -rf jvm/.libs jvm/_libs
rm -rf jvm/org/apache/.libs jvm/org/apache/_libs
rm -rf linux/.libs linux/_libs
rm -rf linux/routing/.libs linux/routing/_libs
rm -rf linux/routing/diagnosis/.libs linux/routing/diagnosis/_libs
rm -rf linux/routing/filter/.libs linux/routing/filter/_libs
rm -rf linux/routing/link/.libs linux/routing/link/_libs
rm -rf linux/routing/queueing/.libs linux/routing/queueing/_libs
rm -rf local/.libs local/_libs
rm -rf log/.libs log/_libs
rm -rf log/tool/.libs log/tool/_libs
rm -rf logging/.libs logging/_libs
rm -rf master/.libs master/_libs
rm -rf master/allocator/.libs master/allocator/_libs
rm -rf master/allocator/mesos/.libs master/allocator/mesos/_libs
rm -rf master/allocator/sorter/drf/.libs master/allocator/sorter/drf/_libs
rm -rf master/contender/.libs master/contender/_libs
rm -rf master/detector/.libs master/detector/_libs
rm -rf messages/.libs messages/_libs
rm -rf module/.libs module/_libs
rm -rf oci/.libs oci/_libs
rm -rf posix/.libs posix/_libs
rm -rf sched/.libs sched/_libs
rm -rf scheduler/.libs scheduler/_libs
rm -rf secret/.libs secret/_libs
rm -rf slave/.libs slave/_libs
rm -rf slave/container_loggers/.libs slave/container_loggers/_libs
rm -rf slave/containerizer/.libs slave/containerizer/_libs
rm -rf slave/containerizer/mesos/.libs slave/containerizer/mesos/_libs
rm -rf slave/containerizer/mesos/io/.libs slave/containerizer/mesos/io/_libs
rm -rf slave/containerizer/mesos/isolators/.libs slave/containerizer/mesos/isolators/_libs
rm -rf slave/containerizer/mesos/isolators/appc/.libs slave/containerizer/mesos/isolators/appc/_libs
rm -rf slave/containerizer/mesos/isolators/cgroups/.libs slave/containerizer/mesos/isolators/cgroups/_libs
rm -rf slave/containerizer/mesos/isolators/cgroups/subsystems/.libs slave/containerizer/mesos/isolators/cgroups/subsystems/_libs
rm -rf slave/containerizer/mesos/isolators/docker/.libs slave/containerizer/mesos/isolators/docker/_libs
rm -rf slave/containerizer/mesos/isolators/docker/volume/.libs slave/containerizer/mesos/isolators/docker/volume/_libs
rm -rf slave/containerizer/mesos/isolators/filesystem/.libs slave/containerizer/mesos/isolators/filesystem/_libs
rm -rf slave/containerizer/mesos/isolators/gpu/.libs slave/containerizer/mesos/isolators/gpu/_libs
rm -rf slave/containerizer/mesos/isolators/linux/.libs slave/containerizer/mesos/isolators/linux/_libs
rm -rf slave/containerizer/mesos/isolators/namespaces/.libs slave/containerizer/mesos/isolators/namespaces/_libs
rm -rf slave/containerizer/mesos/isolators/network/.libs slave/containerizer/mesos/isolators/network/_libs
rm -rf slave/containerizer/mesos/isolators/network/cni/.libs slave/containerizer/mesos/isolators/network/cni/_libs
rm -rf slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.libs slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/_libs
rm -rf slave/containerizer/mesos/isolators/posix/.libs slave/containerizer/mesos/isolators/posix/_libs
rm -rf slave/containerizer/mesos/isolators/volume/.libs slave/containerizer/mesos/isolators/volume/_libs
rm -rf slave/containerizer/mesos/isolators/xfs/.libs slave/containerizer/mesos/isolators/xfs/_libs
rm -f tests/common/*.o
rm -rf slave/containerizer/mesos/provisioner/.libs slave/containerizer/mesos/provisioner/_libs
rm -rf slave/containerizer/mesos/provisioner/appc/.libs slave/containerizer/mesos/provisioner/appc/_libs
rm -f tests/containerizer/*.o
rm -rf slave/containerizer/mesos/provisioner/backends/.libs slave/containerizer/mesos/provisioner/backends/_libs
rm -rf slave/containerizer/mesos/provisioner/docker/.libs slave/containerizer/mesos/provisioner/docker/_libs
rm -rf slave/qos_controllers/.libs slave/qos_controllers/_libs
rm -rf slave/resource_estimators/.libs slave/resource_estimators/_libs
rm -rf state/.libs state/_libs
rm -rf uri/.libs uri/_libs
rm -rf uri/fetchers/.libs uri/fetchers/_libs
rm -rf usage/.libs usage/_libs
rm -rf v1/.libs v1/_libs
rm -rf version/.libs version/_libs
rm -rf watcher/.libs watcher/_libs
rm -rf zookeeper/.libs zookeeper/_libs
rm -f uri/*.o
rm -f uri/*.lo
rm -f uri/fetchers/*.o
rm -f uri/fetchers/*.lo
rm -f usage/*.o
rm -f usage/*.lo
rm -f v1/*.o
rm -f v1/*.lo
rm -f version/*.o
rm -f version/*.lo
rm -f watcher/*.o
rm -f watcher/*.lo
rm -f zookeeper/*.o
rm -f zookeeper/*.lo
rm -rf ../include/mesos/.deps ../include/mesos/agent/.deps ../include/mesos/allocator/.deps ../include/mesos/appc/.deps ../include/mesos/authentication/.deps ../include/mesos/authorizer/.deps ../include/mesos/docker/.deps ../include/mesos/executor/.deps ../include/mesos/fetcher/.deps ../include/mesos/maintenance/.deps ../include/mesos/master/.deps ../include/mesos/module/.deps ../include/mesos/oci/.deps ../include/mesos/quota/.deps ../include/mesos/resource_provider/.deps ../include/mesos/scheduler/.deps ../include/mesos/slave/.deps ../include/mesos/state/.deps ../include/mesos/uri/.deps ../include/mesos/v1/.deps ../include/mesos/v1/agent/.deps ../include/mesos/v1/allocator/.deps ../include/mesos/v1/executor/.deps ../include/mesos/v1/maintenance/.deps ../include/mesos/v1/master/.deps ../include/mesos/v1/quota/.deps ../include/mesos/v1/resource_provider/.deps ../include/mesos/v1/scheduler/.deps appc/.deps authentication/cram_md5/.deps authentication/executor/.deps authentication/http/.deps authorizer/.deps authorizer/local/.deps checks/.deps cli/.deps common/.deps docker/.deps examples/.deps exec/.deps executor/.deps files/.deps hdfs/.deps hook/.deps internal/.deps java/jni/.deps jvm/.deps jvm/org/apache/.deps launcher/.deps linux/.deps linux/routing/.deps linux/routing/diagnosis/.deps linux/routing/filter/.deps linux/routing/link/.deps linux/routing/queueing/.deps local/.deps log/.deps log/tool/.deps logging/.deps master/.deps master/allocator/.deps master/allocator/mesos/.deps master/allocator/sorter/drf/.deps master/contender/.deps master/detector/.deps messages/.deps module/.deps oci/.deps posix/.deps sched/.deps scheduler/.deps secret/.deps slave/.deps slave/container_loggers/.deps slave/containerizer/.deps slave/containerizer/mesos/.deps slave/containerizer/mesos/io/.deps slave/containerizer/mesos/isolators/.deps slave/containerizer/mesos/isolators/appc/.deps slave/containerizer/mesos/isolators/cgroups/.deps slave/containerizer/mesos/isolators/cgroups/subsystems/.deps slave/containerizer/mesos/isolators/docker/.deps slave/containerizer/mesos/isolators/docker/volume/.deps slave/containerizer/mesos/isolators/filesystem/.deps slave/containerizer/mesos/isolators/gpu/.deps slave/containerizer/mesos/isolators/linux/.deps slave/containerizer/mesos/isolators/namespaces/.deps slave/containerizer/mesos/isolators/network/.deps slave/containerizer/mesos/isolators/network/cni/.deps slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.deps slave/containerizer/mesos/isolators/posix/.deps slave/containerizer/mesos/isolators/volume/.deps slave/containerizer/mesos/isolators/xfs/.deps slave/containerizer/mesos/provisioner/.deps slave/containerizer/mesos/provisioner/appc/.deps slave/containerizer/mesos/provisioner/backends/.deps slave/containerizer/mesos/provisioner/docker/.deps slave/qos_controllers/.deps slave/resource_estimators/.deps state/.deps tests/.deps tests/common/.deps tests/containerizer/.deps uri/.deps uri/fetchers/.deps usage/.deps v1/.deps version/.deps watcher/.deps zookeeper/.deps
rm -f Makefile
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
rm -f config.status config.cache config.log configure.lineno config.status.lineno
rm -f Makefile
ERROR: files left in build directory after distclean:
./src/core
make[1]: *** [distcleancheck] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495823109-22038
Untagged: mesos-1495823109-22038:latest
Deleted: sha256:b135c6a41db9d292f6393b7415263bfa5a4459caf50eb1d1a22a0925e50198b1
Deleted: sha256:3355cb16ffdb7425d559216706ed30d4dc42eea1d3a289dbe0cbc433e7904632
Deleted: sha256:c37c3fcf09ead0f15b40a90863edd0ff6fa67d410a3e33ec349bf6a35d20f968
Deleted: sha256:011cb7cd524e8739604b85aae4e03f2ce56ed503e226f1bd4606fbcf38022c5c
Deleted: sha256:e57fda0f9c025209f417e059c97386df96003733accc6de5e5767e04d15e13f5
Deleted: sha256:74bbe121250be8f0079b1cc926de546f1451c00e3ddab46388bb3869a1bac5d4
Deleted: sha256:42fbb0bd3198ec4bb155dd89beb9429e87f838e3a66eaa7e929a00628f881398
Deleted: sha256:d71cc20e5d915f0466c9d4b78b3607a55a727b0e6f046ef78628fbe19f5dec1f
Deleted: sha256:8850f579df4432c7e937e96a60d6f0c9124b64abb883d90f5c9a9020c92bed07
Deleted: sha256:86e9f6f2580b56a693bd4dbc1d081dcb2ef590b4a0c672e8c984d071aa605c52
Deleted: sha256:b74eabdb349ceaf9c9810b7aa4b513aed94c4a65db4b398c7b846d4d303f7178
Deleted: sha256:e22db96d7bd3152ec64d733b13f0db1e438aea7c2df84ec73dfd51f9e2d7d522
Deleted: sha256:e04f4891406d9dd9d563907ec4eb169c62319d3a74e25d823fa4bdb127cfdbfe
Deleted: sha256:c0b5726057ef3228ce76bdba5db6433e2ff4fab4162b37ed5c4ee697dad8ace5
Deleted: sha256:51822e17fd301df63032a00b8129cc0c9bcaa9aa31f4cda74ca1b1fd4b922c5c
Deleted: sha256:968de7ea111c2f3e919f2b8543b0e3abf7984165f10e7ed8c49c959e26247c03
Deleted: sha256:48b17b581a8377eb474cd603fd77a6d304c4441e5e5d123cda8f96785d42af34
Deleted: sha256:8cec181f91705540aca8e9f0d5f8afcffe9b430fd0c6a00f6f6caab9703cdd25
Deleted: sha256:925194c084ebb8df4a807212bd55f643b59912240b3a31812c628e4666910d23
Deleted: sha256:a9bf78d378eb7a1014a7dd5edc073f9d444509edcbd2c4b7b6bd4d5bc994107d
Deleted: sha256:1e3fe90ba045cc48858bbc495fea5f5dc5eb49f645cd9d2a9be96cdd695b042b
Deleted: sha256:ea79f8bddadee34ef931a19ac5c5c6479311c2130984dd3190f89c04b8773f81
Deleted: sha256:4f9fbe1ddfe5b4a88763183d7935be54618a3f4d3c58945bcd5caa46bcb8df79
Deleted: sha256:95a4cd0ccc43d27976149a3c83a939044a5d44506b475e13707551ed05945228
Deleted: sha256:be37b23d5ea16a2f0249fbab846edd25c602b650dc5481e04f006454f126c9c8
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3736

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3736/display/redirect?page=changes>


Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3735

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3735/display/redirect?page=changes>

Changes:

[bmahler] Added new agent flag 'executor_reregistration_timeout'.

[bmahler] Added 'executor_reregister_timeout' agent flag to the tests.

[bmahler] Added MESOS-7540 to the 1.3.1 CHANGELOG.

[bmahler] Introduced executor reconnect retries on the agent.

[bmahler] Added MESOS-7569 to the CHANGELOG.

[bmahler] Made the executor driver drop some messages when not connected.

[bmahler] Don't crash when re-registering executor from an unknown framework.

[bmahler] Don't crash the agent when an unknown executor re-registers.

[bmahler] Added logging of executor re-registration messages.

------------------------------------------
[...truncated 4.35 MB...]
I0527 04:52:02.743190  1724 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1; mem(*)(allocated: *):128 (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: {}) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.743235  1721 slave.cpp:4598] Status update manager successfully handled status update TASK_FINISHED (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000

Received an UPDATE event
Task 2 is in state TASK_RUNNING
I0527 04:52:02.744194  1719 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.744720  1728 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler

Received an UPDATE event
Task 3 is in state TASK_RUNNING
Received an ACKNOWLEDGED event
I0527 04:52:02.745812  1732 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.746107  1732 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.783196  1860 executor.cpp:192] Version: 1.3.0
I0527 04:52:02.783857  1717 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.784394  1717 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.784633  1717 master.cpp:5194] Processing ACKNOWLEDGE call 4ed1d8a5-c18b-44e6-a88c-a768996d89d6 for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1
I0527 04:52:02.785166  1726 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 4ed1d8a5-c18b-44e6-a88c-a768996d89d6) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.785464  1726 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.785765  1728 slave.cpp:4704] Forwarding the update TASK_FINISHED (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.785910  1718 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.785954  1728 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 4ed1d8a5-c18b-44e6-a88c-a768996d89d6) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.786114  1718 master.cpp:5194] Processing ACKNOWLEDGE call 04ec4236-84b6-4085-aa97-5385acb0bdcd for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1
I0527 04:52:02.786365  1719 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 04ec4236-84b6-4085-aa97-5385acb0bdcd) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.786661  1719 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.786784  1718 master.cpp:6469] Status update TASK_FINISHED (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.786847  1718 master.cpp:6537] Forwarding status update TASK_FINISHED (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.786921  1717 slave.cpp:4704] Forwarding the update TASK_FINISHED (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.787068  1717 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 04ec4236-84b6-4085-aa97-5385acb0bdcd) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.787323  1718 master.cpp:8568] Updating the state of task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0527 04:52:02.787518  1718 master.cpp:6469] Status update TASK_FINISHED (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.787578  1718 master.cpp:6537] Forwarding status update TASK_FINISHED (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.787932  1718 master.cpp:8568] Updating the state of task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0527 04:52:02.788921  1730 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler

Received an UPDATE event
Task 2 is in state TASK_FINISHED
I0527 04:52:02.790061  1731 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.790464  1731 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler

Received an UPDATE event
Task 3 is in state TASK_FINISHED
I0527 04:52:02.791404  1726 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.792053  1721 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.793715  1718 process.cpp:3731] Handling HTTP event for process 'slave(2)' with path: '/slave(2)/api/v1/executor'
I0527 04:52:02.795042  1729 http.cpp:1115] HTTP POST for /slave(2)/api/v1/executor from 172.17.0.4:45088
I0527 04:52:02.795321  1729 slave.cpp:3574] Received Subscribe request for HTTP executor 'default' of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.797412  1717 slave.cpp:2529] Sending queued task '0' to executor 'default' of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (via HTTP)
I0527 04:52:02.797839  1717 slave.cpp:2529] Sending queued task '1' to executor 'default' of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (via HTTP)
Received a SUBSCRIBED event
Starting task 0
Finishing task 0
Starting task 1
Finishing task 1
I0527 04:52:02.806504  1717 process.cpp:3731] Handling HTTP event for process 'slave(2)' with path: '/slave(2)/api/v1/executor'
I0527 04:52:02.807299  1717 process.cpp:3731] Handling HTTP event for process 'slave(2)' with path: '/slave(2)/api/v1/executor'
I0527 04:52:02.807849  1725 http.cpp:1115] HTTP POST for /slave(2)/api/v1/executor from 172.17.0.4:45089
I0527 04:52:02.808025  1725 slave.cpp:4264] Handling status update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.808759  1725 process.cpp:3731] Handling HTTP event for process 'slave(2)' with path: '/slave(2)/api/v1/executor'
I0527 04:52:02.810017  1727 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.810096  1727 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.810102  1725 http.cpp:1115] HTTP POST for /slave(2)/api/v1/executor from 172.17.0.4:45089
I0527 04:52:02.810257  1725 slave.cpp:4264] Handling status update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.810710  1725 process.cpp:3731] Handling HTTP event for process 'slave(2)' with path: '/slave(2)/api/v1/executor'
I0527 04:52:02.810849  1727 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.811173  1725 slave.cpp:4704] Forwarding the update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.811368  1725 slave.cpp:4598] Status update manager successfully handled status update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.811583  1725 http.cpp:1115] HTTP POST for /slave(2)/api/v1/executor from 172.17.0.4:45089
I0527 04:52:02.811564  1724 master.cpp:6469] Status update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.811694  1724 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.811763  1725 slave.cpp:4264] Handling status update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.812150  1724 master.cpp:8568] Updating the state of task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0527 04:52:02.813474  1721 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.813627  1726 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.813719  1726 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.813755  1725 http.cpp:1115] HTTP POST for /slave(2)/api/v1/executor from 172.17.0.4:45089
I0527 04:52:02.813889  1725 slave.cpp:4264] Handling status update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000

Received an UPDATE event
Task 0 is in state TASK_RUNNING
I0527 04:52:02.814509  1726 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.814700  1720 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.814895  1731 slave.cpp:4704] Forwarding the update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.815048  1726 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.815142  1731 slave.cpp:4598] Status update manager successfully handled status update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.815316  1730 master.cpp:6469] Status update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.815387  1730 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.815719  1731 slave.cpp:4598] Status update manager successfully handled status update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.815810  1730 master.cpp:8568] Updating the state of task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
Received an ACKNOWLEDGED event
I0527 04:52:02.816648  1722 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.816931  1729 slave.cpp:4598] Status update manager successfully handled status update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
Received an ACKNOWLEDGED event
I0527 04:52:02.818037  1717 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler
Received an ACKNOWLEDGED event

Received an UPDATE event
Task 1 is in state TASK_RUNNING
I0527 04:52:02.819178  1727 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
Received an ACKNOWLEDGED event
I0527 04:52:02.831784  1717 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.832285  1717 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.832643  1717 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.833022  1717 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.833235  1717 master.cpp:5194] Processing ACKNOWLEDGE call 1f87073e-f804-4195-92ae-e75f02a9b479 for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1
I0527 04:52:02.833323  1717 master.cpp:8662] Removing task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):128 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.833978  1732 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.834226  1732 status_update_manager.cpp:531] Cleaning up status update stream for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.834684  1720 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 1f87073e-f804-4195-92ae-e75f02a9b479) for task 2 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.834760  1720 slave.cpp:7382] Completing task 2
I0527 04:52:02.835227  1726 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.835371  1726 master.cpp:5194] Processing ACKNOWLEDGE call 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1
I0527 04:52:02.835425  1726 master.cpp:8662] Removing task 3 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):128 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.835849  1723 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.836004  1723 status_update_manager.cpp:531] Cleaning up status update stream for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.836030  1726 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.836129  1726 master.cpp:5194] Processing ACKNOWLEDGE call aeee7b81-15f3-4758-81e5-3223733c6267 for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0
I0527 04:52:02.836341  1722 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 7990b6ce-9b15-48eb-b3d1-b31299b9ca1e) for task 3 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.836390  1722 slave.cpp:7382] Completing task 3
I0527 04:52:02.836387  1731 status_update_manager.cpp:395] Received status update acknowledgement (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.836472  1726 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.836567  1726 master.cpp:5194] Processing ACKNOWLEDGE call d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0
I0527 04:52:02.836737  1731 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.837242  1723 slave.cpp:4704] Forwarding the update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.837359  1731 status_update_manager.cpp:395] Received status update acknowledgement (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.837424  1723 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: aeee7b81-15f3-4758-81e5-3223733c6267) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.837579  1729 master.cpp:6469] Status update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.837628  1729 master.cpp:6537] Forwarding status update TASK_FINISHED (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.837682  1731 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:02.837988  1730 slave.cpp:4704] Forwarding the update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:02.838057  1729 master.cpp:8568] Updating the state of task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0527 04:52:02.838165  1730 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: d9aa8ceb-34e9-4a77-ad15-4b0077e13fcd) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.838577  1729 master.cpp:6469] Status update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.838636  1729 master.cpp:6537] Forwarding status update TASK_FINISHED (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.838860  1720 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1; mem(*)(allocated: *):128 (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):1; mem(*)(allocated: *):128) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.838990  1729 master.cpp:8568] Updating the state of task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0527 04:52:02.839383  1726 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.839587  1720 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1; mem(*)(allocated: *):128 (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: {}) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000

Received an UPDATE event
Task 0 is in state TASK_FINISHED
I0527 04:52:02.840323  1718 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.840680  1718 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler

Received an UPDATE event
Task 1 is in state TASK_FINISHED
I0527 04:52:02.841475  1732 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:02.842325  1731 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.879642  1722 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:02.880702  1724 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.880879  1724 master.cpp:5194] Processing ACKNOWLEDGE call a7095910-bfa0-43b6-91b3-babe1e1639be for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0
I0527 04:52:02.880957  1724 master.cpp:8662] Removing task 0 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):128 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.881544  1720 status_update_manager.cpp:395] Received status update acknowledgement (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.881814  1720 status_update_manager.cpp:531] Cleaning up status update stream for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.881937  1721 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:02.882097  1721 master.cpp:5194] Processing ACKNOWLEDGE call fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2 for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0
I0527 04:52:02.882154  1721 master.cpp:8662] Removing task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):128 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:02.882241  1731 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: a7095910-bfa0-43b6-91b3-babe1e1639be) for task 0 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.882336  1731 slave.cpp:7382] Completing task 0
I0527 04:52:02.882985  1718 status_update_manager.cpp:395] Received status update acknowledgement (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.883254  1718 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.883643  1728 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: fc68da7b-43a9-4b0a-b8c5-715acf0cfcb2) for task 1 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:02.883699  1728 slave.cpp:7382] Completing task 1
I0527 04:52:03.013886  1731 hierarchical.cpp:2084] Filtered offer with cpus(*):1; mem(*):10112; disk(*):3701220; ports(*):[31000-32000] on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 for role * of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.014991  1731 hierarchical.cpp:1940] No inverse offers to send out!
I0527 04:52:03.015077  1731 hierarchical.cpp:1434] Performed allocation for 3 agents in 2.487196ms
I0527 04:52:03.015939  1725 master.cpp:7305] Sending 2 offers to framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++))
I0527 04:52:03.019084  1719 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.4:57328/master/api/v1/scheduler

Received an OFFERS event
Received offer 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O3 with cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000]
Received offer 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O4 with cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000]
I0527 04:52:03.020956  1725 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:03.021292  1725 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:03.022841  1718 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:03.059762  1722 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:03.060799  1719 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
W0527 04:52:03.060953  1719 master.cpp:3733] Implicitly declining offers: [ 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O3 ] in ACCEPT call for framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 as the launch operation specified no tasks
I0527 04:52:03.061631  1719 master.cpp:3875] Processing ACCEPT call for offers: [ 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O3 ] on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18) for framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++))
I0527 04:52:03.062659  1719 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
W0527 04:52:03.062762  1719 master.cpp:3733] Implicitly declining offers: [ 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O4 ] in ACCEPT call for framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 as the launch operation specified no tasks
I0527 04:52:03.063308  1719 master.cpp:3875] Processing ACCEPT call for offers: [ 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-O4 ] on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18) for framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++))
I0527 04:52:03.064894  1721 hierarchical.cpp:850] Updated allocation of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 from cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000]
I0527 04:52:03.065865  1721 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: {}) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.065933  1721 hierarchical.cpp:1151] Framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 filtered agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 for 5secs
I0527 04:52:03.068142  1721 hierarchical.cpp:850] Updated allocation of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000]
I0527 04:52:03.069031  1721 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):10240; disk(*)(allocated: *):3701220; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: {}) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.069090  1721 hierarchical.cpp:1151] Framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 filtered agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 for 5secs
I0527 04:52:03.119361  1879 executor.cpp:192] Version: 1.3.0
I0527 04:52:03.126776  1728 process.cpp:3731] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0527 04:52:03.128674  1725 http.cpp:1115] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:45090
I0527 04:52:03.128975  1725 slave.cpp:3574] Received Subscribe request for HTTP executor 'default' of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.130663  1725 slave.cpp:2529] Sending queued task '4' to executor 'default' of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (via HTTP)
Received a SUBSCRIBED event
Starting task 4
Finishing task 4
I0527 04:52:03.140503  1727 process.cpp:3731] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0527 04:52:03.141798  1725 process.cpp:3731] Handling HTTP event for process 'slave(1)' with path: '/slave(1)/api/v1/executor'
I0527 04:52:03.142212  1725 http.cpp:1115] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:45091
I0527 04:52:03.142391  1725 slave.cpp:4264] Handling status update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.143525  1718 http.cpp:1115] HTTP POST for /slave(1)/api/v1/executor from 172.17.0.4:45091
I0527 04:52:03.143718  1718 slave.cpp:4264] Handling status update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.144594  1729 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.144644  1729 status_update_manager.cpp:500] Creating StatusUpdate stream for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.145237  1729 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:03.145548  1732 slave.cpp:4704] Forwarding the update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:03.145781  1732 slave.cpp:4598] Status update manager successfully handled status update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.145985  1730 master.cpp:6469] Status update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 at slave(1)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.146067  1730 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.146520  1730 master.cpp:8568] Updating the state of task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_RUNNING)
I0527 04:52:03.146608  1721 status_update_manager.cpp:323] Received status update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.147210  1729 slave.cpp:4598] Status update manager successfully handled status update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.147469  1725 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1; mem(*)(allocated: *):128 (total: cpus(*):2; mem(*):10240; disk(*):3701220; ports(*):[31000-32000], allocated: {}) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 from framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
Received an ACKNOWLEDGED event
I0527 04:52:03.148080  1721 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler
Received an ACKNOWLEDGED event

Received an UPDATE event
Task 4 is in state TASK_RUNNING
I0527 04:52:03.149103  1729 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:03.150341  1729 process.cpp:3731] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0527 04:52:03.187425  1732 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:45080
I0527 04:52:03.187607  1732 master.cpp:5194] Processing ACKNOWLEDGE call 8d68fb32-02fd-4a0f-8232-9311d10053e1 for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (Event Call Scheduler using libprocess (C++)) on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2
I0527 04:52:03.187875  1728 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.188202  1728 status_update_manager.cpp:377] Forwarding update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to the agent
I0527 04:52:03.188513  1730 slave.cpp:4704] Forwarding the update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 to master@172.17.0.4:57328
I0527 04:52:03.188686  1730 slave.cpp:3510] Status update manager successfully handled status update acknowledgement (UUID: 8d68fb32-02fd-4a0f-8232-9311d10053e1) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.188832  1728 master.cpp:6469] Status update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 from agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 at slave(1)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.188882  1728 master.cpp:6537] Forwarding status update TASK_FINISHED (UUID: 2ba8ce1f-d954-4d14-b0e3-6f22a2e214a7) for task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
I0527 04:52:03.189203  1728 master.cpp:8568] Updating the state of task 4 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 (latest state: TASK_FINISHED, status update state: TASK_FINISHED)
I0527 04:52:03.190354  1717 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.4:57328/master/api/v1/scheduler

Received an UPDATE event
Task 4 is in state TASK_FINISHED
I0527 04:52:03.191332  1731 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.4:57328/master/api/v1/scheduler
I0527 04:52:03.191962  1717 master.cpp:1155] Master terminating
I0527 04:52:03.192144  1717 master.cpp:8662] Removing task 4 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):128 of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 at slave(1)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.192586  1717 master.cpp:8691] Removing executor 'default' with resources {} of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2 at slave(1)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.192894  1724 hierarchical.cpp:558] Removed agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S2
I0527 04:52:03.193342  1717 master.cpp:8691] Removing executor 'default' with resources {} of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1 at slave(3)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.193804  1729 hierarchical.cpp:558] Removed agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S1
I0527 04:52:03.193801  1717 master.cpp:8691] Removing executor 'default' with resources {} of framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000 on agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0 at slave(2)@172.17.0.4:57328 (6140f89c9e18)
I0527 04:52:03.194353  1729 hierarchical.cpp:558] Removed agent 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-S0
I0527 04:52:03.194874  1729 hierarchical.cpp:325] Removed framework 6bdcda4c-9ed2-4fd2-aa63-1259b67b4a2c-0000
Build timed out (after 300 minutes). Marking the build as failed.
Build was aborted
++ docker rmi mesos-1495858445-26841
Error response from daemon: conflict: unable to remove repository reference "mesos-1495858445-26841" (must force) - container 6140f89c9e18 is using its referenced image d06d060e4d10
Not sending mail to unregistered user neil.conway@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3734

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3734/display/redirect?page=changes>

Changes:

[bmahler] Added a test for the optional executor reconnect retry in the agent.

[bmahler] Added a test for shutting down executors that re-register.

[bmahler] Added a test for ignoring executor re-registrations.

------------------------------------------
[...truncated 27.35 MB...]
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0527 03:13:34.924027  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:34.924626  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:34.924739  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:34.924780  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:34.928993  5677 slave.cpp:232] Mesos agent started on (748)@172.17.0.4:51691
I0527 03:13:34.929026  5677 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_LBWDu7"
I0527 03:13:34.929567  5677 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E/credential'
I0527 03:13:34.929807  5677 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:34.929841  5677 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_W2js0E/http_credentials'
I0527 03:13:34.930218  5677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:34.930462  5677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:34.931716  5677 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:34.931818  5677 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:34.931845  5677 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:34.932054  5674 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:34.933821  5680 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_LBWDu7/meta'
I0527 03:13:34.934286  5682 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:34.934775  5672 containerizer.cpp:582] Recovering containerizer
I0527 03:13:34.936617  5674 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:34.937150  5675 slave.cpp:6083] Finished recovery
I0527 03:13:34.937602  5675 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:34.937834  5679 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:34.940987  5671 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/containers'
I0527 03:13:34.942487  5672 http.cpp:1115] HTTP GET for /slave(748)/containers from 172.17.0.4:45983
I0527 03:13:34.942571  5672 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:13:34.947033  5681 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (35 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0527 03:13:34.959866  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:34.960471  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:34.960588  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:34.960628  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:34.964846  5676 slave.cpp:232] Mesos agent started on (749)@172.17.0.4:51691
I0527 03:13:34.964897  5676 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_l0wPLh"
I0527 03:13:34.965459  5676 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP/credential'
I0527 03:13:34.965715  5676 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:34.965740  5676 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_YZXsnP/http_credentials'
I0527 03:13:34.966006  5676 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:34.966266  5676 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:34.967667  5676 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:34.967739  5676 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:34.967752  5676 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:34.967989  5679 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:34.970019  5671 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_l0wPLh/meta'
I0527 03:13:34.970423  5674 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:34.970728  5673 containerizer.cpp:582] Recovering containerizer
I0527 03:13:34.972553  5681 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:34.972995  5682 slave.cpp:6083] Finished recovery
I0527 03:13:34.973551  5682 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:34.973909  5681 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:34.977061  5678 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics'
I0527 03:13:34.978525  5676 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics from 172.17.0.4:45984
I0527 03:13:34.978617  5676 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 03:13:34.981582  5684 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (34 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0527 03:13:34.994648  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:34.995242  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:34.995368  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:34.995419  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:34.999342  5673 slave.cpp:232] Mesos agent started on (750)@172.17.0.4:51691
I0527 03:13:34.999374  5673 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_7lOZps"
I0527 03:13:35.000026  5673 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z/credential'
I0527 03:13:35.000267  5673 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:35.000301  5673 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aw7h7Z/http_credentials'
I0527 03:13:35.000610  5673 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:35.000805  5673 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:35.002475  5673 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:35.002575  5673 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:35.002602  5673 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:35.002800  5670 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:35.004396  5683 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_7lOZps/meta'
I0527 03:13:35.004729  5685 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:35.004987  5674 containerizer.cpp:582] Recovering containerizer
I0527 03:13:35.006850  5672 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:35.007378  5681 slave.cpp:6083] Finished recovery
I0527 03:13:35.007932  5681 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:35.008244  5673 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:35.011677  5670 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/monitor/statistics.json'
I0527 03:13:35.013120  5673 http.cpp:1115] HTTP GET for /slave(750)/monitor/statistics.json from 172.17.0.4:45985
I0527 03:13:35.013200  5673 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 03:13:35.016228  5675 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0527 03:13:35.027829  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:35.028247  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:35.028332  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:35.028362  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:35.031883  5672 slave.cpp:232] Mesos agent started on (751)@172.17.0.4:51691
I0527 03:13:35.031960  5672 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_31TnqD"
I0527 03:13:35.032415  5672 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb/credential'
I0527 03:13:35.032626  5672 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:35.032656  5672 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_sIsadb/http_credentials'
I0527 03:13:35.032974  5672 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:35.033148  5672 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:35.035048  5672 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:35.035145  5672 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:35.035162  5672 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:35.035326  5682 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:35.036628  5678 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_31TnqD/meta'
I0527 03:13:35.036995  5671 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:35.037340  5672 containerizer.cpp:582] Recovering containerizer
I0527 03:13:35.039006  5673 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:35.039373  5683 slave.cpp:6083] Finished recovery
I0527 03:13:35.040050  5683 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:35.040338  5678 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:35.043375  5679 process.cpp:3730] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/containers'
I0527 03:13:35.044733  5684 http.cpp:1115] HTTP GET for /slave(751)/containers from 172.17.0.4:45986
I0527 03:13:35.044793  5684 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:13:35.047298  5678 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0527 03:13:35.058557  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:35.059175  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:35.059306  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:35.059356  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:35.061518  5651 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:13:35.063174  5671 slave.cpp:232] Mesos agent started on (752)@172.17.0.4:51691
I0527 03:13:35.063200  5671 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_x4N8KO"
I0527 03:13:35.063587  5671 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm/credential'
I0527 03:13:35.063722  5671 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:35.063746  5671 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4f5KCm/http_credentials'
I0527 03:13:35.063962  5671 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:35.064101  5671 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:35.065225  5671 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:35.065291  5671 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:35.065304  5671 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:35.065443  5677 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:35.066823  5672 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_x4N8KO/meta'
I0527 03:13:35.067122  5671 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:35.067350  5682 containerizer.cpp:582] Recovering containerizer
I0527 03:13:35.068572  5675 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:35.068930  5673 slave.cpp:6083] Finished recovery
I0527 03:13:35.069403  5673 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:35.069660  5681 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:35.071753  5683 process.cpp:3730] Handling HTTP event for process 'slave(752)' with path: '/slave(752)/monitor/statistics'
I0527 03:13:35.072790  5673 http.cpp:1115] HTTP GET for /slave(752)/monitor/statistics from 172.17.0.4:45987
I0527 03:13:35.072849  5673 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 03:13:35.076318  5673 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0527 03:13:35.089316  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:35.089920  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:35.090035  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:35.090086  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:35.092089  5651 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:13:35.093973  5675 slave.cpp:232] Mesos agent started on (753)@172.17.0.4:51691
I0527 03:13:35.094004  5675 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_7nQtp0"
I0527 03:13:35.094516  5675 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly/credential'
I0527 03:13:35.094717  5675 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:35.094748  5675 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_eK34ly/http_credentials'
I0527 03:13:35.095052  5675 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:35.095209  5675 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:35.096848  5675 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:35.096943  5675 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:35.096961  5675 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:35.097122  5671 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:35.098681  5683 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_7nQtp0/meta'
I0527 03:13:35.099056  5680 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:35.099313  5682 containerizer.cpp:582] Recovering containerizer
I0527 03:13:35.101274  5680 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:35.101802  5670 slave.cpp:6083] Finished recovery
I0527 03:13:35.102663  5670 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:35.102995  5676 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:35.105654  5682 process.cpp:3730] Handling HTTP event for process 'slave(753)' with path: '/slave(753)/monitor/statistics.json'
I0527 03:13:35.107152  5670 http.cpp:1115] HTTP GET for /slave(753)/monitor/statistics.json from 172.17.0.4:45988
I0527 03:13:35.107255  5670 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 03:13:35.111138  5678 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0527 03:13:35.123108  5651 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:13:35.123556  5651 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:13:35.123649  5651 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:13:35.123684  5651 provisioner.cpp:255] Using default backend 'copy'
I0527 03:13:35.125149  5651 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:13:35.126478  5670 slave.cpp:232] Mesos agent started on (754)@172.17.0.4:51691
I0527 03:13:35.126499  5670 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bCKkpc"
I0527 03:13:35.126888  5670 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK/credential'
I0527 03:13:35.127059  5670 slave.cpp:265] Agent using credential for: test-principal
I0527 03:13:35.127084  5670 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Fs6vrK/http_credentials'
I0527 03:13:35.127310  5670 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:13:35.127450  5670 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:13:35.128614  5670 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:13:35.128686  5670 slave.cpp:544] Agent attributes: [  ]
I0527 03:13:35.128703  5670 slave.cpp:549] Agent hostname: e40aefcbd186
I0527 03:13:35.128844  5674 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:13:35.130040  5682 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bCKkpc/meta'
I0527 03:13:35.130360  5685 status_update_manager.cpp:203] Recovering status update manager
I0527 03:13:35.130569  5673 containerizer.cpp:582] Recovering containerizer
I0527 03:13:35.131788  5684 provisioner.cpp:416] Provisioner recovery complete
I0527 03:13:35.132143  5683 slave.cpp:6083] Finished recovery
I0527 03:13:35.132565  5683 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:13:35.132794  5671 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:13:35.134799  5684 process.cpp:3730] Handling HTTP event for process 'slave(754)' with path: '/slave(754)/containers'
I0527 03:13:35.135843  5675 http.cpp:1115] HTTP GET for /slave(754)/containers from 172.17.0.4:45989
I0527 03:13:35.135906  5675 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:13:35.138883  5670 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (27 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (293 ms total)

[----------] Global test environment tear-down
[==========] 1576 tests from 175 test cases ran. (580022 ms total)
[  PASSED  ] 1575 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0527 03:13:35.205246  5686 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495851959-9174
Untagged: mesos-1495851959-9174:latest
Deleted: sha256:7ff0f15cf8a79684c11f200f118928b90e7a45644adda350b4bdfb34ee6fbb10
Deleted: sha256:97ba3fd9e3ed7c0064c651d7e89c7fbfc0d64d46a952f6f8127885fa57eba109
Deleted: sha256:2e0e97803d32cb917f308905f79c65f6bd517d428806bb4a6c1f6e94cf173df2
Deleted: sha256:bdf1e55781645f06c862ba0e9b0b2a8135b30390df1ff5d6a1dd6bf7c5ca114c
Deleted: sha256:dfe7dd006727ca4c2ad84b528de935c8d6e641deec7ee81003855a444de6ba22
Deleted: sha256:31f753ee9756fc27f2bd4add01c74cdec67ef04d5be57d04ee6529815c810fa8
Deleted: sha256:306cada20d66d505865bb0a57123c5395e2092c66dcf143da775f7736182cc6f
Deleted: sha256:3e505938f8026c0c97375490f429dcead41adbbce968973e9b0a8028ebe2108a
Deleted: sha256:5a2a24d3581266c7d093554b95e5350da8d8f0788ef8483cfd0de162af3f8bd3
Deleted: sha256:ed4f2f0d35530a3648acb4c65b4575d6008f13442a86b0caa9bfbbd520dac773
Deleted: sha256:774df54f45ff7f960ddff31447bada1e269bec2e1943aabbfa15d56bb5dfc1b4
Deleted: sha256:4cbb8f451f2d8a52ed2851161c6160af7c1e515bab91c591065ede78ad5fe6b3
Deleted: sha256:2ddcd6ffe2e172d415a38113edc0741c06e8052e480525fe89919dab128d7e7c
Deleted: sha256:4b8c38f58409b0b059a6adb76dc0f8ebd97122c7035756758d93b59ff71706e8
Deleted: sha256:bd57239b4a9331a49aa7cf85596c8b242c0cbddf562fd4f82ff1e28d5ca7ee75
Deleted: sha256:3783a92b72bda45376676fb4fa8b08673e6b9146287aae27d953b4000813143b
Deleted: sha256:dcd67d1085d54b4f14345e62c73432bd4bf7ca3f08a30e5ce6eb7fb089351173
Deleted: sha256:eaa18fa7bf834b1eca58297e94e238cb06238bbcbe00d8022d2888660de8ecfe
Deleted: sha256:266c15a4a8f2c5ee85c50623d2f038380f668aca8a94403e268b9a26b49f38f0
Deleted: sha256:c2e1bf3b7bfcce9d3b31553b0aee8356acb2f87fba0a706cca2adc385e88d2d3
Deleted: sha256:5eab48b90653a72175ba2718ff1ccc4325f601c7c2e53681ed7620857d4d533d
Deleted: sha256:9b6f4a130a38e60c997f14330dac19dbc4734c026229c3bc18bd3b9d9fa3f2d4
Deleted: sha256:62b18d7d2ec5b2751ff014905c76d668341fafe91cd5e7c77aef1cc18b032d0a
Deleted: sha256:eea40997fc43b7d230bc823b6609235e9605bb526423955035d73826764e2e28
Deleted: sha256:0ef31704d0eacd96d646ccdb48e4b4a31bb6d6ede754cdaf7d801065f3d96f97
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3733

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3733/display/redirect?page=changes>

Changes:

[bmahler] Don't crash when re-registering executor from an unknown framework.

[bmahler] Don't crash the agent when an unknown executor re-registers.

[bmahler] Removed a use of the 'default' switch case.

[bmahler] Added logging of executor re-registration messages.

[bmahler] Avoided use of [] operator for read only map access.

[bmahler] Minor logging cleanup to put open/close quotes on the same line.

------------------------------------------
[...truncated 27.26 MB...]
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0527 00:56:30.650916  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.651358  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.651451  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.651484  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.654615  5680 slave.cpp:232] Mesos agent started on (744)@172.17.0.3:58204
I0527 00:56:30.654662  5680 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dEHsyb"
I0527 00:56:30.655086  5680 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp/credential'
I0527 00:56:30.655267  5680 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.655289  5680 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_DNGawp/http_credentials'
I0527 00:56:30.655580  5680 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.655732  5680 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.656870  5680 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.656940  5680 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.656955  5680 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.657095  5682 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.658530  5688 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dEHsyb/meta'
I0527 00:56:30.659086  5677 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.659417  5684 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.661077  5684 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.661586  5681 slave.cpp:6083] Finished recovery
I0527 00:56:30.662142  5681 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.662457  5684 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.664901  5682 process.cpp:3730] Handling HTTP event for process 'slave(744)' with path: '/slave(744)/containers'
I0527 00:56:30.666412  5677 http.cpp:1115] HTTP GET for /slave(744)/containers from 172.17.0.3:39704
I0527 00:56:30.666550  5677 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 00:56:30.670229  5654 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0527 00:56:30.683070  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.683629  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.683746  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.683789  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.687463  5688 slave.cpp:232] Mesos agent started on (745)@172.17.0.3:58204
I0527 00:56:30.687486  5688 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_SDReB5"
I0527 00:56:30.687971  5688 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj/credential'
I0527 00:56:30.688113  5688 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.688143  5688 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_mlr2Dj/http_credentials'
I0527 00:56:30.688393  5688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.688541  5688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.689656  5688 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.689725  5688 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.689743  5688 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.689884  5679 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.691318  5674 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_SDReB5/meta'
I0527 00:56:30.691579  5680 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.691841  5676 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.693275  5677 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.693648  5674 slave.cpp:6083] Finished recovery
I0527 00:56:30.694236  5674 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.694631  5682 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.697158  5686 process.cpp:3730] Handling HTTP event for process 'slave(745)' with path: '/slave(745)/monitor/statistics'
I0527 00:56:30.698580  5686 http.cpp:1115] HTTP GET for /slave(745)/monitor/statistics from 172.17.0.3:39705
I0527 00:56:30.698686  5686 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 00:56:30.701272  5682 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0527 00:56:30.713584  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.714195  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.714323  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.714371  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.718477  5673 slave.cpp:232] Mesos agent started on (746)@172.17.0.3:58204
I0527 00:56:30.718508  5673 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qjAaYZ"
I0527 00:56:30.719106  5673 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d/credential'
I0527 00:56:30.719306  5673 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.719337  5673 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mdWT5d/http_credentials'
I0527 00:56:30.719739  5673 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.719964  5673 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.721662  5673 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.721765  5673 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.721791  5673 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.721977  5684 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.723551  5682 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qjAaYZ/meta'
I0527 00:56:30.723820  5680 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.724048  5682 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.725525  5681 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.725982  5682 slave.cpp:6083] Finished recovery
I0527 00:56:30.726424  5682 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.726691  5677 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.729444  5685 process.cpp:3730] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/monitor/statistics.json'
I0527 00:56:30.730998  5687 http.cpp:1115] HTTP GET for /slave(746)/monitor/statistics.json from 172.17.0.3:39708
I0527 00:56:30.731086  5687 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 00:56:30.733901  5684 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (32 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0527 00:56:30.746464  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.747071  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.747187  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.747228  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.751118  5675 slave.cpp:232] Mesos agent started on (747)@172.17.0.3:58204
I0527 00:56:30.751140  5675 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_iC8WFU"
I0527 00:56:30.751551  5675 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8/credential'
I0527 00:56:30.751684  5675 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.751704  5675 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MKG1S8/http_credentials'
I0527 00:56:30.751911  5675 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.752029  5675 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.753118  5675 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.753212  5675 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.753229  5675 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.753437  5681 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.754778  5685 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_iC8WFU/meta'
I0527 00:56:30.755142  5679 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.755388  5687 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.757138  5678 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.757593  5684 slave.cpp:6083] Finished recovery
I0527 00:56:30.758028  5684 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.758287  5680 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.760550  5680 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0527 00:56:30.761898  5675 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.3:39711
I0527 00:56:30.761993  5675 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 00:56:30.764899  5679 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0527 00:56:30.776907  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.777514  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.777628  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.777668  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.779973  5654 cluster.cpp:448] Creating default 'local' authorizer
I0527 00:56:30.781565  5679 slave.cpp:232] Mesos agent started on (748)@172.17.0.3:58204
I0527 00:56:30.781590  5679 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_8Hc2HP"
I0527 00:56:30.782107  5679 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3/credential'
I0527 00:56:30.782310  5679 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.782341  5679 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_6cl0Z3/http_credentials'
I0527 00:56:30.782654  5679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.782824  5679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.784395  5679 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.784493  5679 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.784509  5679 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.784696  5677 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.786365  5676 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_8Hc2HP/meta'
I0527 00:56:30.786718  5678 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.787009  5674 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.789072  5674 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.789569  5688 slave.cpp:6083] Finished recovery
I0527 00:56:30.790272  5688 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.790632  5676 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.793081  5686 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0527 00:56:30.794397  5679 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.3:39714
I0527 00:56:30.794509  5679 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 00:56:30.798413  5678 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0527 00:56:30.809031  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.809491  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.809586  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.809617  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.811553  5654 cluster.cpp:448] Creating default 'local' authorizer
I0527 00:56:30.813066  5684 slave.cpp:232] Mesos agent started on (749)@172.17.0.3:58204
I0527 00:56:30.813097  5684 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QYL34K"
I0527 00:56:30.813644  5684 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ/credential'
I0527 00:56:30.813822  5684 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.813849  5684 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_anPpsZ/http_credentials'
I0527 00:56:30.814131  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.814329  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.815951  5684 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.816049  5684 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.816067  5684 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.816257  5676 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.817742  5673 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QYL34K/meta'
I0527 00:56:30.818189  5685 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.818416  5678 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.819931  5685 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.820422  5677 slave.cpp:6083] Finished recovery
I0527 00:56:30.820847  5677 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.821076  5687 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.823494  5676 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0527 00:56:30.824874  5678 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.3:39716
I0527 00:56:30.824965  5678 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 00:56:30.828801  5678 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0527 00:56:30.841604  5654 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:56:30.842255  5654 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:56:30.842386  5654 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:56:30.842437  5654 provisioner.cpp:255] Using default backend 'copy'
I0527 00:56:30.844579  5654 cluster.cpp:448] Creating default 'local' authorizer
I0527 00:56:30.846488  5683 slave.cpp:232] Mesos agent started on (750)@172.17.0.3:58204
I0527 00:56:30.846513  5683 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OS5DMG"
I0527 00:56:30.846863  5683 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV/credential'
I0527 00:56:30.846999  5683 slave.cpp:265] Agent using credential for: test-principal
I0527 00:56:30.847020  5683 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_0cc8eV/http_credentials'
I0527 00:56:30.847219  5683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:56:30.847417  5683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:56:30.848475  5683 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:56:30.848542  5683 slave.cpp:544] Agent attributes: [  ]
I0527 00:56:30.848554  5683 slave.cpp:549] Agent hostname: e1a6274cbb83
I0527 00:56:30.848668  5680 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:56:30.849985  5681 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OS5DMG/meta'
I0527 00:56:30.850396  5680 status_update_manager.cpp:203] Recovering status update manager
I0527 00:56:30.850738  5683 containerizer.cpp:582] Recovering containerizer
I0527 00:56:30.852325  5681 provisioner.cpp:416] Provisioner recovery complete
I0527 00:56:30.852892  5683 slave.cpp:6083] Finished recovery
I0527 00:56:30.853418  5683 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:56:30.853642  5677 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:56:30.855607  5680 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0527 00:56:30.856879  5688 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.3:39719
I0527 00:56:30.856946  5688 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 00:56:30.861055  5677 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (32 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (285 ms total)

[----------] Global test environment tear-down
[==========] 1573 tests from 175 test cases ran. (468227 ms total)
[  PASSED  ] 1572 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0527 00:56:30.924795  5689 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495843815-12756
Untagged: mesos-1495843815-12756:latest
Deleted: sha256:f7ae5debb34efa12335f82913dbe25b4a3dc1bce90302e01c2a44e3a1c45f5d3
Deleted: sha256:49f678aad941d2b3f5202ef16b51ef1c71198dfd0817026869cfc5493175cfe7
Deleted: sha256:c34a1fa571a189fc1c9936b9db48285a12c4dfb8a5139af1e35084977fca6d09
Deleted: sha256:b758d9193137b56c250676f52660026fbf92bcad4c3bbd697561a6c93d239566
Deleted: sha256:ddfb1bae752504109b6596fbf5fd9c436a37513ac3e9728994ae07ef4f130774
Deleted: sha256:593e75f4f5b7aafe340f824a196cc4d44093bc0d6a6b734c72eec0bc81fb16cc
Deleted: sha256:5b24d2c1b8a0619c8a3ed4494a2c4a94ca9a4c4c104e512601584b457c367569
Deleted: sha256:59757ff9a6e0f5015702fc51564a83961477796a08c59fbf778d4febde5c09d3
Deleted: sha256:afc165f58b86e2e60952d4ea8712a9a098a36564b9664ab9aa6cd691e22ed4db
Deleted: sha256:94f25da1930211d3f24c678c5a645a09a4562a88898136d6e2f6fd0fd98ac601
Deleted: sha256:6e61abd949053ddbbbaac6a65ca0c9bf8d0f6e0afa9159dd4343585197179de2
Deleted: sha256:606c23feca78b4ee8aee4dff353663e18cc9a2a3e14f7d65317877b99eb57e25
Deleted: sha256:505b2f2133da7f80ac1bb82cf0a17bdb6d5f1c98d46cddb5aed0295089fa9c8f
Deleted: sha256:22c59625a3cfa083136cde23c033eebd91bea62299289fa18ff8399bf72a8cc4
Deleted: sha256:d42ff0cc2ec05a25c6c90121931fdedb9249215df41623508255c86b9045bd76
Deleted: sha256:dcd26a6ed72a2edef683d8fb42a4fee5397ce15e319539d47d00224a0784c5bc
Deleted: sha256:1ea169f450a85db48c9b867f92e18c1022c99b0c87dedabe4fd38ccf5891e119
Deleted: sha256:85bc10a56da26c7ab8dbb29a075f637b476395a4ea546c75bf22dd2f61bb6ae2
Deleted: sha256:ca1be8907a702f724c91ab8dcc43b1d327c8fe3bc4087677404eb15019a0ffed
Deleted: sha256:402ba30c88fb94e815345ee7bc7fb3c186e3698a70c86c5472ef4eb172e8a48e
Deleted: sha256:644a9dd40ca14e93fa9cd34e73017fd4494ded52e2a20ed23dbba20c2f16bc5a
Deleted: sha256:2e87dfef78ca66614edf998c21294e1431439cea2c569ea8cc939df4b89956c9
Deleted: sha256:02b0a1792077ec8c9c470fcaa2e4f667f23160722f929711f4b586d13279291b
Deleted: sha256:8d3a3e71d31db324d22ae45c4f4508ff0d6ed9e60de487d472b1382fe924bcbd
Deleted: sha256:4fa9d61d8cf8a1206e20e8fb5873ac8a9d6e7ac75ae75caff1702df30c41b7a5
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3732

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3732/display/redirect?page=changes>

Changes:

[neil.conway] Fixed flakiness in MasterTest.EndpointsForHalfRemovedSlave.

------------------------------------------
[...truncated 27.23 MB...]
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0526 23:06:26.870352  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:26.870973  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:26.871110  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:26.871162  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:26.875087  5856 slave.cpp:232] Mesos agent started on (744)@172.17.0.3:44596
I0526 23:06:26.875118  5856 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_a89dtP"
I0526 23:06:26.875655  5856 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ/credential'
I0526 23:06:26.875895  5856 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:26.875918  5856 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RzS8qJ/http_credentials'
I0526 23:06:26.876173  5856 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:26.876380  5856 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:26.877691  5856 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:26.877763  5856 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:26.877777  5856 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:26.877918  5863 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:26.879825  5864 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_a89dtP/meta'
I0526 23:06:26.880201  5855 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:26.880445  5851 containerizer.cpp:582] Recovering containerizer
I0526 23:06:26.882539  5856 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:26.883026  5868 slave.cpp:6073] Finished recovery
I0526 23:06:26.883582  5868 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:26.883921  5870 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:26.887058  5857 process.cpp:3730] Handling HTTP event for process 'slave(744)' with path: '/slave(744)/containers'
I0526 23:06:26.888629  5854 http.cpp:1115] HTTP GET for /slave(744)/containers from 172.17.0.3:52694
I0526 23:06:26.888717  5854 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:06:26.892791  5869 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0526 23:06:26.904466  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:26.905014  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:26.905124  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:26.905159  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:26.908798  5872 slave.cpp:232] Mesos agent started on (745)@172.17.0.3:44596
I0526 23:06:26.908859  5872 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Ufl3wr"
I0526 23:06:26.909370  5872 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl/credential'
I0526 23:06:26.909588  5872 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:26.909611  5872 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rc32zl/http_credentials'
I0526 23:06:26.909859  5872 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:26.910064  5872 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:26.911394  5872 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:26.911469  5872 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:26.911487  5872 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:26.911628  5873 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:26.913342  5852 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Ufl3wr/meta'
I0526 23:06:26.913794  5858 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:26.914012  5850 containerizer.cpp:582] Recovering containerizer
I0526 23:06:26.915784  5864 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:26.916415  5857 slave.cpp:6073] Finished recovery
I0526 23:06:26.916913  5857 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:26.917347  5859 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:26.920064  5863 process.cpp:3730] Handling HTTP event for process 'slave(745)' with path: '/slave(745)/monitor/statistics'
I0526 23:06:26.921468  5868 http.cpp:1115] HTTP GET for /slave(745)/monitor/statistics from 172.17.0.3:52696
I0526 23:06:26.921563  5868 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 23:06:26.924723  5865 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0526 23:06:26.936764  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:26.937315  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:26.937434  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:26.937476  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:26.940959  5864 slave.cpp:232] Mesos agent started on (746)@172.17.0.3:44596
I0526 23:06:26.940984  5864 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_kcYsU3"
I0526 23:06:26.941426  5864 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X/credential'
I0526 23:06:26.941632  5864 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:26.941653  5864 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NBnf2X/http_credentials'
I0526 23:06:26.941941  5864 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:26.942111  5864 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:26.943491  5864 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:26.943569  5864 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:26.943583  5864 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:26.943752  5863 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:26.945240  5873 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_kcYsU3/meta'
I0526 23:06:26.945755  5853 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:26.946094  5867 containerizer.cpp:582] Recovering containerizer
I0526 23:06:26.947698  5867 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:26.948097  5864 slave.cpp:6073] Finished recovery
I0526 23:06:26.948632  5864 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:26.948962  5856 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:26.952173  5862 process.cpp:3730] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/monitor/statistics.json'
I0526 23:06:26.953744  5866 http.cpp:1115] HTTP GET for /slave(746)/monitor/statistics.json from 172.17.0.3:52698
I0526 23:06:26.953841  5866 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 23:06:26.956665  5869 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0526 23:06:26.968464  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:26.969030  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:26.969148  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:26.969197  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:26.972903  5853 slave.cpp:232] Mesos agent started on (747)@172.17.0.3:44596
I0526 23:06:26.972931  5853 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_WtRUAG"
I0526 23:06:26.973367  5853 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA/credential'
I0526 23:06:26.973546  5853 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:26.973567  5853 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3J0rNA/http_credentials'
I0526 23:06:26.973886  5853 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:26.974054  5853 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:26.975491  5853 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:26.975564  5853 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:26.975577  5853 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:26.975731  5867 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:26.977236  5850 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_WtRUAG/meta'
I0526 23:06:26.977684  5859 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:26.977965  5865 containerizer.cpp:582] Recovering containerizer
I0526 23:06:26.980204  5851 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:26.980607  5858 slave.cpp:6073] Finished recovery
I0526 23:06:26.981205  5858 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:26.981534  5864 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:26.984634  5864 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0526 23:06:26.986151  5852 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.3:52706
I0526 23:06:26.986240  5852 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:06:26.988966  5862 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0526 23:06:26.999503  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:26.999989  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:27.000087  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:27.000118  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:27.001747  5831 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:06:27.003340  5866 slave.cpp:232] Mesos agent started on (748)@172.17.0.3:44596
I0526 23:06:27.003381  5866 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_D5CfAj"
I0526 23:06:27.003903  5866 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd/credential'
I0526 23:06:27.004112  5866 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:27.004132  5866 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4SkpRd/http_credentials'
I0526 23:06:27.004369  5866 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:27.004603  5866 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:27.005827  5866 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:27.005898  5866 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:27.005918  5866 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:27.006067  5872 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:27.007423  5857 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_D5CfAj/meta'
I0526 23:06:27.007804  5859 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:27.008038  5863 containerizer.cpp:582] Recovering containerizer
I0526 23:06:27.009704  5852 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:27.010143  5855 slave.cpp:6073] Finished recovery
I0526 23:06:27.010740  5855 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:27.011063  5868 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:27.013380  5850 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0526 23:06:27.014765  5869 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.3:52710
I0526 23:06:27.014854  5869 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 23:06:27.018337  5850 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0526 23:06:27.028895  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:27.029459  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:27.029563  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:27.029598  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:27.031443  5831 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:06:27.032980  5860 slave.cpp:232] Mesos agent started on (749)@172.17.0.3:44596
I0526 23:06:27.032999  5860 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_bsEmRW"
I0526 23:06:27.033454  5860 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR/credential'
I0526 23:06:27.033700  5860 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:27.033723  5860 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q05ScR/http_credentials'
I0526 23:06:27.033977  5860 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:27.034152  5860 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:27.035485  5860 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:27.035557  5860 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:27.035568  5860 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:27.035738  5866 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:27.037041  5861 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_bsEmRW/meta'
I0526 23:06:27.037389  5858 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:27.037648  5855 containerizer.cpp:582] Recovering containerizer
I0526 23:06:27.039419  5864 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:27.039747  5861 slave.cpp:6073] Finished recovery
I0526 23:06:27.040208  5861 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:27.040491  5857 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:27.043131  5854 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0526 23:06:27.044502  5855 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.3:52712
I0526 23:06:27.044582  5855 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 23:06:27.048226  5872 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0526 23:06:27.058301  5831 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:06:27.058797  5831 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:06:27.058894  5831 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:06:27.058943  5831 provisioner.cpp:255] Using default backend 'copy'
I0526 23:06:27.060608  5831 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:06:27.062170  5865 slave.cpp:232] Mesos agent started on (750)@172.17.0.3:44596
I0526 23:06:27.062188  5865 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_CJl1pA"
I0526 23:06:27.062628  5865 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu/credential'
I0526 23:06:27.062815  5865 slave.cpp:265] Agent using credential for: test-principal
I0526 23:06:27.062836  5865 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_4FqWPu/http_credentials'
I0526 23:06:27.063088  5865 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:06:27.063259  5865 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:06:27.064448  5865 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:06:27.064517  5865 slave.cpp:544] Agent attributes: [  ]
I0526 23:06:27.064528  5865 slave.cpp:549] Agent hostname: 238edbf9276e
I0526 23:06:27.064664  5872 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:06:27.066131  5864 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_CJl1pA/meta'
I0526 23:06:27.066404  5861 status_update_manager.cpp:203] Recovering status update manager
I0526 23:06:27.066723  5857 containerizer.cpp:582] Recovering containerizer
I0526 23:06:27.068655  5855 provisioner.cpp:416] Provisioner recovery complete
I0526 23:06:27.069121  5860 slave.cpp:6073] Finished recovery
I0526 23:06:27.069753  5860 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:06:27.070029  5858 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:06:27.072473  5866 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0526 23:06:27.074003  5870 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.3:52714
I0526 23:06:27.074074  5870 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:06:27.077354  5861 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (29 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (386 ms total)

[----------] Global test environment tear-down
[==========] 1577 tests from 176 test cases ran. (460155 ms total)
[  PASSED  ] 1576 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0526 23:06:27.137925  5874 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495837591-30964
Untagged: mesos-1495837591-30964:latest
Deleted: sha256:b538246139e68889f9f666f7e752f35fe3e8fc7f987963cba7b2de710833d8b1
Deleted: sha256:48b0ca2f9b14e1157bcba19e44a640220ebceec0cf3cafc832bcd1924972d3cf
Deleted: sha256:bfcec823a86c84d693c2c24d94aa3efb8843b698ec4c3879b592485a7d1bc6ef
Deleted: sha256:c37b8ec22e015516e8f21da152b8499cd655b74a2c384d3b4810c223edf8097a
Deleted: sha256:e0886ef507fc7d32a1be475301962d4734dd1702adf1fc1ad503cbe700e9f930
Deleted: sha256:80ca69be69937c4e604b78b40e161a76aef480ed8342f8d138237e57e854b840
Deleted: sha256:338b25f02c0934391e24186807a2bfb6710ec5278b2b5c849598f800dd5021ab
Deleted: sha256:7a9ec719810957044cb84369d0f0aaa5f93ac6fb5fd2ec23908111713682d6d5
Deleted: sha256:05acb5c0139335981fe5b9f1010432cb7fd35fdbc1c111dee464d3cddd28f576
Deleted: sha256:dfc54059aaad97dc23ead154f9a69b04c4bc8744c571771fd47cbce99c363b75
Deleted: sha256:9e8eb2a01d9b8f1cc423cd31b6c6100ae51b25e227cf9c13116f0c7e62b7ce0b
Deleted: sha256:271fee3e460d188994e8b812a839ea41cc6f9533734e76552db1f728efadd061
Deleted: sha256:6659ba2bca7acf288ff2b9ca1308b56ffd3f83cf6f06b6d58a0b4f0267c36ff8
Deleted: sha256:5726be25c32838a7699dce189369f71f10ab501a1b59f0ad7f05cecc3026d2d3
Deleted: sha256:f8e8448ca8d356018acd3f3cffff5aa33aae666caac63aa4dd7b4a720b9824db
Deleted: sha256:c6427811fa8c30189e5eaebf91b575fa972b5c6419e6e7179c60b3aa2217b4a2
Deleted: sha256:325b8c90f84d17b4edc3afc5e4799b3c42db2dfac8a5311de565843047fdd670
Deleted: sha256:ee6a823eaba8f17cf36322366543c010d2aa39b40238e00fa4c9994e728d1fd8
Deleted: sha256:7c336b470a384a08f8c1864650375dfdbd2b7257a85db46566d5a547e0bcf0b9
Deleted: sha256:8b15dc820b003f24571928180f3cde9dc979995cd2f9e38b09799f9168b4c3ac
Deleted: sha256:d46523905ad4be2f13fc54490ebee552a48559984569fd83912d1fc6be2df1c9
Deleted: sha256:4fb65d81f35fd40b3044cfe5b27b3acde610bbe14fa6dff8855439ca9f66da9d
Deleted: sha256:d72a5a062a7317de7e08f6366d0b545255aa662ba9a096525dd6a9f701821d92
Deleted: sha256:ed5939db448f559d2756f8d53cc5062d388f720ffa1fb20464e9d3bf24238728
Deleted: sha256:ae4638cb33ccb863886fce404546704aa60bae9c81196766ee5ee0a5cab47b0e
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3731

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3731/display/redirect?page=changes>

Changes:

[anand] Update vendored protobuf tar.gz to 3.3.0.

[anand] Remove unnecessary patch after protobuf upgrade to 3.3.0.

[anand] Update 3rdparty build to support protobuf 3.3.0.

[anand] Update related tests in stout to support protobuf 3.3.0.

[anand] Updated Mesos build library to use protobuf 3.3.0.

[anand] Added a test for evolving large protobuf message.

[anand] Updated LICENSE information for protobuf 3.3.0.

------------------------------------------
[...truncated 27.26 MB...]
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0526 21:31:33.953361  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:33.953874  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:33.953990  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:33.954035  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:33.957235  5684 slave.cpp:232] Mesos agent started on (744)@172.17.0.2:33004
I0526 21:31:33.957553  5684 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_wBtbZG"
I0526 21:31:33.958441  5684 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp/credential'
I0526 21:31:33.958807  5684 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:33.958910  5684 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ROVVp/http_credentials'
I0526 21:31:33.959354  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:33.959534  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:33.960865  5684 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:33.960942  5684 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:33.960961  5684 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:33.961182  5686 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:33.962698  5686 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_wBtbZG/meta'
I0526 21:31:33.963088  5675 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:33.963332  5678 containerizer.cpp:582] Recovering containerizer
I0526 21:31:33.965020  5674 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:33.965399  5677 slave.cpp:6073] Finished recovery
I0526 21:31:33.966128  5677 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:33.966521  5677 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:33.969358  5683 process.cpp:3730] Handling HTTP event for process 'slave(744)' with path: '/slave(744)/containers'
I0526 21:31:33.970669  5683 http.cpp:1115] HTTP GET for /slave(744)/containers from 172.17.0.2:39376
I0526 21:31:33.970751  5683 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 21:31:33.974488  5676 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0526 21:31:33.985013  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:33.985520  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:33.985641  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:33.985687  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:33.988863  5677 slave.cpp:232] Mesos agent started on (745)@172.17.0.2:33004
I0526 21:31:33.988888  5677 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_GAvwYA"
I0526 21:31:33.989341  5677 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j/credential'
I0526 21:31:33.989538  5677 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:33.989563  5677 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Jzrp0j/http_credentials'
I0526 21:31:33.989816  5677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:33.989986  5677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:33.991335  5677 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:33.991407  5677 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:33.991422  5677 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:33.991592  5683 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:33.993392  5678 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_GAvwYA/meta'
I0526 21:31:33.993808  5688 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:33.993996  5688 containerizer.cpp:582] Recovering containerizer
I0526 21:31:33.995792  5688 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:33.996279  5688 slave.cpp:6073] Finished recovery
I0526 21:31:33.996757  5688 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:33.997357  5688 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.000082  5688 process.cpp:3730] Handling HTTP event for process 'slave(745)' with path: '/slave(745)/monitor/statistics'
I0526 21:31:34.001543  5681 http.cpp:1115] HTTP GET for /slave(745)/monitor/statistics from 172.17.0.2:39377
I0526 21:31:34.001621  5681 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 21:31:34.003981  5683 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0526 21:31:34.017318  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:34.018055  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:34.018180  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:34.018226  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:34.022639  5681 slave.cpp:232] Mesos agent started on (746)@172.17.0.2:33004
I0526 21:31:34.022671  5681 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Y3VZhv"
I0526 21:31:34.023207  5681 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe/credential'
I0526 21:31:34.023563  5681 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:34.023586  5681 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fOaXoe/http_credentials'
I0526 21:31:34.023891  5681 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:34.024073  5681 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:34.025439  5681 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:34.025511  5681 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:34.025528  5681 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:34.025728  5678 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:34.027298  5689 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Y3VZhv/meta'
I0526 21:31:34.027664  5681 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:34.027976  5685 containerizer.cpp:582] Recovering containerizer
I0526 21:31:34.029731  5683 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:34.030125  5679 slave.cpp:6073] Finished recovery
I0526 21:31:34.030758  5679 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:34.031097  5687 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.033931  5689 process.cpp:3730] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/monitor/statistics.json'
I0526 21:31:34.035343  5676 http.cpp:1115] HTTP GET for /slave(746)/monitor/statistics.json from 172.17.0.2:39378
I0526 21:31:34.035549  5676 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 21:31:34.037741  5683 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (32 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0526 21:31:34.048384  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:34.048925  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:34.049044  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:34.049160  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:34.052438  5682 slave.cpp:232] Mesos agent started on (747)@172.17.0.2:33004
I0526 21:31:34.052471  5682 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gPMxWp"
I0526 21:31:34.053071  5682 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88/credential'
I0526 21:31:34.053345  5682 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:34.053375  5682 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_zEMG88/http_credentials'
I0526 21:31:34.053730  5682 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:34.053933  5682 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:34.055799  5682 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:34.055915  5682 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:34.055941  5682 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:34.056124  5686 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:34.058030  5681 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gPMxWp/meta'
I0526 21:31:34.058514  5689 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:34.058748  5675 containerizer.cpp:582] Recovering containerizer
I0526 21:31:34.060451  5685 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:34.060956  5684 slave.cpp:6073] Finished recovery
I0526 21:31:34.061545  5684 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:34.061946  5682 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.064817  5689 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0526 21:31:34.066200  5676 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.2:39379
I0526 21:31:34.066293  5676 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 21:31:34.068660  5655 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0526 21:31:34.081533  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:34.082298  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:34.082430  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:34.082476  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:34.084776  5655 cluster.cpp:448] Creating default 'local' authorizer
I0526 21:31:34.087121  5679 slave.cpp:232] Mesos agent started on (748)@172.17.0.2:33004
I0526 21:31:34.087148  5679 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_43NtVk"
I0526 21:31:34.087743  5679 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4/credential'
I0526 21:31:34.087978  5679 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:34.088007  5679 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_dUeMc4/http_credentials'
I0526 21:31:34.088349  5679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:34.088577  5679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:34.090590  5679 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:34.090710  5679 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:34.090735  5679 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:34.090878  5683 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:34.092922  5677 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_43NtVk/meta'
I0526 21:31:34.093220  5688 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:34.093538  5688 containerizer.cpp:582] Recovering containerizer
I0526 21:31:34.095221  5675 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:34.095681  5685 slave.cpp:6073] Finished recovery
I0526 21:31:34.096323  5685 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:34.096622  5676 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.099365  5680 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0526 21:31:34.101152  5687 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.2:39380
I0526 21:31:34.101244  5687 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 21:31:34.104284  5689 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (35 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0526 21:31:34.117476  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:34.118242  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:34.118372  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:34.118418  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:34.120859  5655 cluster.cpp:448] Creating default 'local' authorizer
I0526 21:31:34.123198  5686 slave.cpp:232] Mesos agent started on (749)@172.17.0.2:33004
I0526 21:31:34.123239  5686 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_4xnTgg"
I0526 21:31:34.123750  5686 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ/credential'
I0526 21:31:34.123991  5686 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:34.124016  5686 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_r9T2DZ/http_credentials'
I0526 21:31:34.124289  5686 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:34.124518  5686 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:34.125705  5686 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:34.125773  5686 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:34.125785  5686 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:34.127369  5686 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:34.128044  5686 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_4xnTgg/meta'
I0526 21:31:34.128549  5679 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:34.128722  5679 containerizer.cpp:582] Recovering containerizer
I0526 21:31:34.130432  5681 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:34.130851  5679 slave.cpp:6073] Finished recovery
I0526 21:31:34.131419  5679 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:34.131718  5684 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.134811  5685 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0526 21:31:34.136124  5680 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.2:39381
I0526 21:31:34.136199  5680 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 21:31:34.139822  5675 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (36 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0526 21:31:34.154971  5655 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 21:31:34.155721  5655 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 21:31:34.155851  5655 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 21:31:34.155897  5655 provisioner.cpp:255] Using default backend 'copy'
I0526 21:31:34.158193  5655 cluster.cpp:448] Creating default 'local' authorizer
I0526 21:31:34.160424  5684 slave.cpp:232] Mesos agent started on (750)@172.17.0.2:33004
I0526 21:31:34.160596  5684 slave.cpp:233] 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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_BrKWZb"
I0526 21:31:34.161355  5684 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV/credential'
I0526 21:31:34.161737  5684 slave.cpp:265] Agent using credential for: test-principal
I0526 21:31:34.161928  5684 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_O5W8sV/http_credentials'
I0526 21:31:34.162353  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 21:31:34.162539  5684 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 21:31:34.163810  5684 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 21:31:34.163887  5684 slave.cpp:544] Agent attributes: [  ]
I0526 21:31:34.163909  5684 slave.cpp:549] Agent hostname: 3752e73da496
I0526 21:31:34.164196  5678 status_update_manager.cpp:177] Pausing sending status updates
I0526 21:31:34.165894  5684 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_BrKWZb/meta'
I0526 21:31:34.167359  5675 status_update_manager.cpp:203] Recovering status update manager
I0526 21:31:34.167678  5675 containerizer.cpp:582] Recovering containerizer
I0526 21:31:34.171818  5675 provisioner.cpp:416] Provisioner recovery complete
I0526 21:31:34.172859  5675 slave.cpp:6073] Finished recovery
I0526 21:31:34.173759  5675 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 21:31:34.174180  5686 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 21:31:34.177572  5677 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0526 21:31:34.179246  5677 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.2:39382
I0526 21:31:34.179319  5677 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 21:31:34.184476  5655 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (44 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (304 ms total)

[----------] Global test environment tear-down
[==========] 1573 tests from 175 test cases ran. (449583 ms total)
[  PASSED  ] 1572 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0526 21:31:34.256851  5690 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495831681-8916
Untagged: mesos-1495831681-8916:latest
Deleted: sha256:12b41ff9c781e3334f5c12ec736662c35c896e863368c7a8b92f1b65a6e45439
Deleted: sha256:0a7d321761c690e4cbc81bbfd332037e9bb4040d45ce1fb29a057d5d8fba002a
Deleted: sha256:72f5c08a57bfff46daf3df8f554200918e26cd8d2950c9e3fbbd55c8b1fa9ca3
Deleted: sha256:90223d6dd6f6cd1e1ed4e228f014ff0fe36d961714bb55ffabf403d36726c40d
Deleted: sha256:884ba7e2644fe6e71476536b62691c51f2fb18e28f72fc5eb3e74f8a6014865c
Deleted: sha256:d8fe07488b860b30515737079537dc2b66d71b6eb9cf03485b99113bfbed4035
Deleted: sha256:1148864b2100bd36e8389d8c02a3b69c58cd96e06e83dd7f79a5f90d109a6512
Deleted: sha256:13c00c94a735ecd31fde12260a3c30acaf606bf53b0b7cf592185bf163fa9da7
Deleted: sha256:2b646a4abe1cab76e053aed89d211cfc79ba2f1d71d4b2e0018d2cd867174ee6
Deleted: sha256:42ec8b3abd785b445f97dc7dd6fbc48ebed0c026b618ac73de010a21eb44e3ea
Deleted: sha256:aca6a42f4475eac33114a55562731eef1524fc6c0444a0a0155c086a0410dfe0
Deleted: sha256:9ed5988185c42edfd816ebade16c4ada72afcca08d717898f3b209a47c2b82c5
Deleted: sha256:21ab22e54e14fa201165f5cc1dc3853bf5bf7c8f82e8f00007eabf429548eee9
Deleted: sha256:e060ef2608dcb2e25f0fbd9bba0f2cdcf88b19898e9a5058cdbe14c811472833
Deleted: sha256:b0c5836274fc17792258abf1ac5b18ed233c05875b041a6bac4c0f94204be034
Deleted: sha256:c096eb1a92d44491d47a8dd680bf84a70dc157e4ebeb7b1707ba94a9dda79e52
Deleted: sha256:980232bee0cdecce44f5dd9df7b3b6ceadaa243418b532b0e8e2d8f44996185c
Deleted: sha256:77f142d1bb48e70365d4ca802f8fc5d95aa59951ae4dc322ab3a4b1265e270c7
Deleted: sha256:d9b8fa261f3e7285aab3a79e08a3c680eb71016862c273e5ed73a84816663891
Deleted: sha256:60a9c29a5472c5735485ced580bc6de2ab3e76df6daaaf18a9f9f3785338fa0b
Deleted: sha256:c9159d7b8b2f38576ed8e5ea9614e161ec57de42a43c24a3746f9670d828ac22
Deleted: sha256:250b4a9561514df8f7ba2b6c404928c9d583336d9f16aa8a47fe1759780f5117
Deleted: sha256:f1bde2ef41de65b65364bb8940f2a56074adda5cfa3f23935351755408d3c04e
Deleted: sha256:1ef59e838395b553f369848156fd30bf9bdfa70966643e586def3f18378880c0
Deleted: sha256:58d265f39c83fe6be2098f932129c50a7176e2c9d46275008c78588ef1edd5d6
Build step 'Execute shell' marked build as failure