You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2018/10/16 12:03:30 UTC
Build failed in Jenkins: Mesos-Reviewbot #23480
See <https://builds.apache.org/job/Mesos-Reviewbot/23480/display/redirect?page=changes>
Changes:
[alexr] Renamed committer checklist into committer guidelines.
[alexr] Updated committer candidate guidelines.
------------------------------------------
[...truncated 39.76 MB...]
rm -f sched/.dirstamp
rm -rf appc/.libs appc/_libs
rm -f slave/containerizer/*.o
rm -f scheduler/.deps/.dirstamp
rm -f slave/containerizer/*.lo
rm -rf authentication/cram_md5/.libs authentication/cram_md5/_libs
rm -f scheduler/.dirstamp
rm -rf authentication/executor/.libs authentication/executor/_libs
rm -f slave/containerizer/mesos/*.o
rm -f secret/.deps/.dirstamp
rm -rf authentication/http/.libs authentication/http/_libs
rm -f slave/containerizer/mesos/*.lo
rm -f secret/.dirstamp
rm -rf authorizer/.libs authorizer/_libs
rm -f slave/.deps/.dirstamp
rm -f slave/containerizer/mesos/io/*.o
rm -rf authorizer/local/.libs authorizer/local/_libs
rm -f slave/.dirstamp
rm -f slave/containerizer/mesos/io/*.lo
rm -rf checks/.libs checks/_libs
rm -f slave/container_loggers/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/*.o
rm -rf common/.libs common/_libs
rm -f slave/container_loggers/.dirstamp
rm -f slave/containerizer/mesos/isolators/*.lo
rm -f slave/containerizer/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/appc/*.o
rm -rf csi/.libs csi/_libs
rm -f slave/containerizer/mesos/isolators/appc/*.lo
rm -f slave/containerizer/.dirstamp
rm -rf docker/.libs docker/_libs
rm -f slave/containerizer/mesos/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/cgroups/*.o
rm -rf examples/.libs examples/_libs
rm -f slave/containerizer/mesos/.dirstamp
rm -f slave/containerizer/mesos/isolators/cgroups/*.lo
rm -rf exec/.libs exec/_libs
rm -f slave/containerizer/mesos/io/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/*.o
rm -rf executor/.libs executor/_libs
rm -f slave/containerizer/mesos/io/.dirstamp
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/*.lo
rm -rf files/.libs files/_libs
rm -f slave/containerizer/mesos/isolators/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/*.o
rm -rf hdfs/.libs hdfs/_libs
rm -f slave/containerizer/mesos/isolators/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/*.lo
rm -rf hook/.libs hook/_libs
rm -f slave/containerizer/mesos/isolators/appc/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/volume/*.o
rm -rf internal/.libs internal/_libs
rm -f slave/containerizer/mesos/isolators/appc/.dirstamp
rm -f slave/containerizer/mesos/isolators/docker/volume/*.lo
rm -f slave/containerizer/mesos/isolators/cgroups/.deps/.dirstamp
rm -rf java/jni/.libs java/jni/_libs
rm -f slave/containerizer/mesos/isolators/filesystem/*.o
rm -f slave/containerizer/mesos/isolators/cgroups/.dirstamp
rm -rf jvm/.libs jvm/_libs
rm -f slave/containerizer/mesos/isolators/filesystem/*.lo
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/gpu/*.o
rm -rf jvm/org/apache/.libs jvm/org/apache/_libs
rm -f slave/containerizer/mesos/isolators/cgroups/subsystems/.dirstamp
rm -f slave/containerizer/mesos/isolators/gpu/*.lo
rm -rf linux/.libs linux/_libs
rm -f slave/containerizer/mesos/isolators/docker/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/linux/*.o
rm -rf linux/routing/.libs linux/routing/_libs
rm -f slave/containerizer/mesos/isolators/linux/*.lo
rm -f slave/containerizer/mesos/isolators/docker/.dirstamp
rm -rf linux/routing/diagnosis/.libs linux/routing/diagnosis/_libs
rm -f slave/containerizer/mesos/isolators/docker/volume/.deps/.dirstamp
rm -rf linux/routing/filter/.libs linux/routing/filter/_libs
rm -f slave/containerizer/mesos/isolators/namespaces/*.o
rm -f slave/containerizer/mesos/isolators/docker/volume/.dirstamp
rm -rf linux/routing/link/.libs linux/routing/link/_libs
rm -f slave/containerizer/mesos/isolators/namespaces/*.lo
rm -f slave/containerizer/mesos/isolators/filesystem/.deps/.dirstamp
rm -rf linux/routing/queueing/.libs linux/routing/queueing/_libs
rm -f slave/containerizer/mesos/isolators/network/*.o
rm -f slave/containerizer/mesos/isolators/filesystem/.dirstamp
rm -rf local/.libs local/_libs
rm -f slave/containerizer/mesos/isolators/network/*.lo
rm -f slave/containerizer/mesos/isolators/gpu/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/*.o
rm -f slave/containerizer/mesos/isolators/gpu/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/*.lo
rm -f slave/containerizer/mesos/isolators/linux/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.o
rm -rf log/.libs log/_libs
rm -f slave/containerizer/mesos/isolators/linux/.dirstamp
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/*.lo
rm -f slave/containerizer/mesos/isolators/namespaces/.deps/.dirstamp
rm -rf log/tool/.libs log/tool/_libs
rm -f slave/containerizer/mesos/isolators/posix/*.o
rm -f slave/containerizer/mesos/isolators/namespaces/.dirstamp
rm -rf logging/.libs logging/_libs
rm -f slave/containerizer/mesos/isolators/posix/*.lo
rm -f slave/containerizer/mesos/isolators/network/.deps/.dirstamp
rm -rf master/.libs master/_libs
rm -f slave/containerizer/mesos/isolators/volume/*.o
rm -f slave/containerizer/mesos/isolators/network/.dirstamp
rm -f slave/containerizer/mesos/isolators/volume/*.lo
rm -rf master/allocator/.libs master/allocator/_libs
rm -f slave/containerizer/mesos/isolators/network/cni/.deps/.dirstamp
rm -f slave/containerizer/mesos/isolators/xfs/*.o
rm -rf master/allocator/mesos/.libs master/allocator/mesos/_libs
rm -f slave/containerizer/mesos/isolators/network/cni/.dirstamp
rm -f slave/containerizer/mesos/isolators/xfs/*.lo
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.deps/.dirstamp
rm -rf master/allocator/sorter/drf/.libs master/allocator/sorter/drf/_libs
rm -f slave/containerizer/mesos/provisioner/*.o
rm -f slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.dirstamp
rm -rf master/allocator/sorter/random/.libs master/allocator/sorter/random/_libs
rm -f slave/containerizer/mesos/provisioner/*.lo
rm -f slave/containerizer/mesos/isolators/posix/.deps/.dirstamp
rm -rf master/contender/.libs master/contender/_libs
rm -f slave/containerizer/mesos/provisioner/appc/*.o
rm -f slave/containerizer/mesos/isolators/posix/.dirstamp
rm -f slave/containerizer/mesos/provisioner/appc/*.lo
rm -rf master/detector/.libs master/detector/_libs
rm -f slave/containerizer/mesos/isolators/volume/.deps/.dirstamp
rm -f slave/containerizer/mesos/provisioner/backends/*.o
rm -f slave/containerizer/mesos/provisioner/backends/*.lo
rm -f slave/containerizer/mesos/isolators/volume/.dirstamp
rm -f slave/containerizer/mesos/provisioner/docker/*.o
rm -rf messages/.libs messages/_libs
rm -f slave/containerizer/mesos/isolators/xfs/.deps/.dirstamp
rm -f slave/containerizer/mesos/provisioner/docker/*.lo
rm -rf module/.libs module/_libs
rm -f slave/containerizer/mesos/isolators/xfs/.dirstamp
rm -f slave/qos_controllers/*.o
rm -rf oci/.libs oci/_libs
rm -f slave/containerizer/mesos/provisioner/.deps/.dirstamp
rm -f slave/qos_controllers/*.lo
rm -f slave/containerizer/mesos/provisioner/.dirstamp
rm -rf posix/.libs posix/_libs
rm -f slave/resource_estimators/*.o
rm -f slave/containerizer/mesos/provisioner/appc/.deps/.dirstamp
rm -rf resource_provider/.libs resource_provider/_libs
rm -f slave/resource_estimators/*.lo
rm -f slave/containerizer/mesos/provisioner/appc/.dirstamp
rm -rf resource_provider/storage/.libs resource_provider/storage/_libs
rm -f state/*.o
rm -f slave/containerizer/mesos/provisioner/backends/.deps/.dirstamp
rm -f state/*.lo
rm -f slave/containerizer/mesos/provisioner/backends/.dirstamp
rm -rf sched/.libs sched/_libs
rm -f status_update_manager/*.o
rm -f slave/containerizer/mesos/provisioner/docker/.deps/.dirstamp
rm -rf scheduler/.libs scheduler/_libs
rm -f status_update_manager/*.lo
rm -f slave/containerizer/mesos/provisioner/docker/.dirstamp
rm -rf secret/.libs secret/_libs
rm -f tests/*.o
rm -f slave/qos_controllers/.deps/.dirstamp
rm -rf slave/.libs slave/_libs
rm -f slave/qos_controllers/.dirstamp
rm -f slave/resource_estimators/.deps/.dirstamp
rm -f slave/resource_estimators/.dirstamp
rm -f state/.deps/.dirstamp
rm -f state/.dirstamp
rm -rf slave/container_loggers/.libs slave/container_loggers/_libs
rm -f status_update_manager/.deps/.dirstamp
rm -rf slave/containerizer/.libs slave/containerizer/_libs
rm -f status_update_manager/.dirstamp
rm -rf slave/containerizer/mesos/.libs slave/containerizer/mesos/_libs
rm -f tests/.deps/.dirstamp
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 -f tests/.dirstamp
rm -rf slave/containerizer/mesos/isolators/cgroups/subsystems/.libs slave/containerizer/mesos/isolators/cgroups/subsystems/_libs
rm -f tests/common/.deps/.dirstamp
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 -f tests/common/.dirstamp
rm -rf slave/containerizer/mesos/isolators/filesystem/.libs slave/containerizer/mesos/isolators/filesystem/_libs
rm -f tests/containerizer/.deps/.dirstamp
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 -f tests/containerizer/.dirstamp
rm -rf slave/containerizer/mesos/isolators/network/cni/.libs slave/containerizer/mesos/isolators/network/cni/_libs
rm -f uri/.deps/.dirstamp
rm -f uri/.dirstamp
rm -rf slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/.libs slave/containerizer/mesos/isolators/network/cni/plugins/port_mapper/_libs
rm -f uri/fetchers/.deps/.dirstamp
rm -rf slave/containerizer/mesos/isolators/posix/.libs slave/containerizer/mesos/isolators/posix/_libs
rm -f uri/fetchers/.dirstamp
rm -rf slave/containerizer/mesos/isolators/volume/.libs slave/containerizer/mesos/isolators/volume/_libs
rm -f usage/.deps/.dirstamp
rm -rf slave/containerizer/mesos/isolators/xfs/.libs slave/containerizer/mesos/isolators/xfs/_libs
rm -f usage/.dirstamp
rm -rf slave/containerizer/mesos/provisioner/.libs slave/containerizer/mesos/provisioner/_libs
rm -f v1/.deps/.dirstamp
rm -rf slave/containerizer/mesos/provisioner/appc/.libs slave/containerizer/mesos/provisioner/appc/_libs
rm -f v1/.dirstamp
rm -f version/.deps/.dirstamp
rm -rf slave/containerizer/mesos/provisioner/backends/.libs slave/containerizer/mesos/provisioner/backends/_libs
rm -f version/.dirstamp
rm -rf slave/containerizer/mesos/provisioner/docker/.libs slave/containerizer/mesos/provisioner/docker/_libs
rm -f watcher/.deps/.dirstamp
rm -rf slave/qos_controllers/.libs slave/qos_controllers/_libs
rm -f watcher/.dirstamp
rm -f zookeeper/.deps/.dirstamp
rm -rf slave/resource_estimators/.libs slave/resource_estimators/_libs
rm -f zookeeper/.dirstamp
rm -rf state/.libs state/_libs
rm -rf status_update_manager/.libs status_update_manager/_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 tests/common/*.o
rm -f tests/containerizer/*.o
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/csi/.deps ../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 csi/.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/allocator/sorter/random/.deps master/contender/.deps master/detector/.deps messages/.deps module/.deps oci/.deps posix/.deps resource_provider/.deps resource_provider/storage/.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 status_update_manager/.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 '/tmp/SRC/build/mesos-1.8.0/_build/sub/src'
rm -f config.status config.cache config.log configure.lineno config.status.lineno
rm -f Makefile
make[1]: Leaving directory '/tmp/SRC/build/mesos-1.8.0/_build/sub'
if test -d "mesos-1.8.0"; then find "mesos-1.8.0" -type d ! -perm -200 -exec chmod u+w {} ';' && rm -rf "mesos-1.8.0" || { sleep 5 && rm -rf "mesos-1.8.0"; }; else :; fi
=============================================
mesos-1.8.0 archives ready for distribution:
mesos-1.8.0.tar.gz
=============================================
Build timed out (after 180 minutes). Marking the build as failed.
Build was aborted
Jenkins build is back to normal : Mesos-Reviewbot #23482
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23482/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Reviewbot #23481
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/23481/display/redirect?page=changes>
Changes:
[alexr] Referenced committer candidate template in guidelines.
[klueska] Updated Python library to properly import submodules.
[klueska] Moved import of '../lib' from new CLI bootstrap to pip-requirements.txt.
[alexr] Added 'received' timestamp into `process::Request`.
[alexr] Introduced `logResponse` for http handlers.
[alexr] Logged request processing time for some endpoints.
[klueska] Added Record-IO encoder and decoder to Python library.
------------------------------------------
[...truncated 77.74 MB...]
I1016 15:44:52.230276 18629 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1016 15:44:52.230500 18633 authenticator.cpp:204] Received SASL authentication start
I1016 15:44:52.230598 18633 authenticator.cpp:326] Authentication requires more steps
I1016 15:44:52.230747 18631 authenticatee.cpp:259] Received SASL authentication step
I1016 15:44:52.230975 18638 authenticator.cpp:232] Received SASL authentication step
I1016 15:44:52.231053 18638 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1016 15:44:52.231097 18638 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1016 15:44:52.231187 18638 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1016 15:44:52.231235 18638 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1016 15:44:52.231276 18638 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.231309 18638 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.231359 18638 authenticator.cpp:318] Authentication success
I1016 15:44:52.231580 18624 authenticatee.cpp:299] Authentication success
I1016 15:44:52.231724 18644 master.cpp:9752] Successfully authenticated principal 'test-principal' at slave(998)@172.17.0.2:34139
I1016 15:44:52.231814 18645 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1777)@172.17.0.2:34139
I1016 15:44:52.232169 18625 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:34139
I1016 15:44:52.232726 18625 slave.cpp:1883] Will retry registration in 4.756761ms if necessary
I1016 15:44:52.233089 18628 master.cpp:6670] Received register agent message from slave(998)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.233573 18628 master.cpp:4029] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1016 15:44:52.234480 18630 master.cpp:6737] Authorized registration of agent at slave(998)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.234623 18630 master.cpp:6852] Registering agent at slave(998)@172.17.0.2:34139 (029922c55108) with id a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0
I1016 15:44:52.235482 18636 registrar.cpp:487] Applied 1 operations in 238428ns; attempting to update the registry
I1016 15:44:52.236402 18636 registrar.cpp:544] Successfully updated the registry in 818944ns
I1016 15:44:52.236646 18646 master.cpp:6900] Admitted agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.237531 18646 master.cpp:6945] Registered agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1016 15:44:52.237772 18629 slave.cpp:1485] Registered with master master@172.17.0.2:34139; given agent ID a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0
I1016 15:44:52.237876 18633 hierarchical.cpp:605] Added agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1016 15:44:52.237974 18634 task_status_update_manager.cpp:188] Resuming sending task status updates
I1016 15:44:52.238204 18629 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_0_sWIX5L/meta/slaves/a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0/slave.info'
I1016 15:44:52.238251 18633 hierarchical.cpp:1568] Performed allocation for 1 agents in 153928ns
I1016 15:44:52.239760 18629 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"vvHJlPPyRSOARhO8Us+qnw=="},"slave_id":{"value":"a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0"},"update_oversubscribed_resources":false}
I1016 15:44:52.240744 18627 master.cpp:8006] Ignoring update on agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108) as it reports no changes
I1016 15:44:52.474220 18626 process.cpp:3569] Handling HTTP event for process 'slave(998)' with path: '/slave(998)/api/v1/resource_provider'
I1016 15:44:52.476814 18638 http.cpp:1178] HTTP POST for /slave(998)/api/v1/resource_provider from 172.17.0.2:33282
I1016 15:44:52.477783 18634 manager.cpp:736] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
I1016 15:44:52.527747 18639 slave.cpp:7649] Handling resource provider message 'SUBSCRIBE: {"id":{"value":"72e80551-4367-40f6-b8eb-aba00a32f7b4"},"name":"test","type":"org.apache.mesos.rp.test"}'
I1016 15:44:52.529321 18640 slave.cpp:915] Agent terminating
I1016 15:44:52.530432 18640 manager.cpp:161] Terminating resource provider 72e80551-4367-40f6-b8eb-aba00a32f7b4
I1016 15:44:52.531116 18645 master.cpp:1266] Agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108) disconnected
I1016 15:44:52.531183 18645 master.cpp:3332] Disconnecting agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.531321 18645 master.cpp:3351] Deactivating agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 at slave(998)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.531577 18639 hierarchical.cpp:803] Agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0 deactivated
I1016 15:44:52.546901 18623 master.cpp:1108] Master terminating
I1016 15:44:52.548039 18633 hierarchical.cpp:645] Removed agent a1a49ab3-b182-4b9b-b891-06ccc2c0da50-S0
[ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/0 (379 ms)
[ RUN ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1
I1016 15:44:52.559031 18623 cluster.cpp:173] Creating default 'local' authorizer
I1016 15:44:52.563719 18633 master.cpp:413] Master 2c6d8aa1-e060-453d-97a8-98b456b3b39b (029922c55108) started on 172.17.0.2:34139
I1016 15:44:52.563771 18633 master.cpp:416] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="hierarchical" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authentication_v0_timeout="15secs" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/T6mC67/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --memory_profiling="false" --min_allocatable_resources="cpus:0.01|mem:32" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --require_agent_domain="false" --role_sorter="drf" --root_submissions="true" --version="false" --webui_dir="/mesos/mesos-1.8.0/_inst/share/mesos/webui" --work_dir="/tmp/T6mC67/master" --zk_session_timeout="10secs"
I1016 15:44:52.564285 18633 master.cpp:465] Master only allowing authenticated frameworks to register
I1016 15:44:52.564311 18633 master.cpp:471] Master only allowing authenticated agents to register
I1016 15:44:52.564330 18633 master.cpp:477] Master only allowing authenticated HTTP frameworks to register
I1016 15:44:52.564347 18633 credentials.hpp:37] Loading credentials for authentication from '/tmp/T6mC67/credentials'
I1016 15:44:52.564750 18633 master.cpp:521] Using default 'crammd5' authenticator
I1016 15:44:52.565053 18633 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1016 15:44:52.565326 18633 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1016 15:44:52.565554 18633 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1016 15:44:52.565774 18633 master.cpp:602] Authorization enabled
I1016 15:44:52.566439 18631 hierarchical.cpp:182] Initialized hierarchical allocator process
I1016 15:44:52.566457 18638 whitelist_watcher.cpp:77] No whitelist given
I1016 15:44:52.570380 18640 master.cpp:2148] Elected as the leading master!
I1016 15:44:52.570439 18640 master.cpp:1653] Recovering from registrar
I1016 15:44:52.570701 18637 registrar.cpp:339] Recovering registrar
I1016 15:44:52.571758 18637 registrar.cpp:383] Successfully fetched the registry (0B) in 978176ns
I1016 15:44:52.571952 18637 registrar.cpp:487] Applied 1 operations in 52016ns; attempting to update the registry
I1016 15:44:52.572932 18637 registrar.cpp:544] Successfully updated the registry in 869888ns
I1016 15:44:52.573190 18637 registrar.cpp:416] Successfully recovered registrar
I1016 15:44:52.573979 18636 master.cpp:1767] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister
I1016 15:44:52.574069 18643 hierarchical.cpp:220] Skipping recovery of hierarchical allocator: nothing to recover
W1016 15:44:52.582352 18623 process.cpp:2810] Attempted to spawn already running process files@172.17.0.2:34139
I1016 15:44:52.584209 18623 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1016 15:44:52.585044 18623 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1016 15:44:52.585247 18623 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1016 15:44:52.585306 18623 provisioner.cpp:298] Using default backend 'copy'
I1016 15:44:52.588726 18623 cluster.cpp:485] Creating default 'local' authorizer
I1016 15:44:52.591792 18646 slave.cpp:267] Mesos agent started on (999)@172.17.0.2:34139
I1016 15:44:52.591836 18646 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_destroy_timeout="1mins" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/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/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_choPeJ" --zk_session_timeout="10secs"
I1016 15:44:52.592489 18646 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/credential'
I1016 15:44:52.592741 18646 slave.cpp:300] Agent using credential for: test-principal
I1016 15:44:52.592780 18646 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_fQu4mk/http_credentials'
I1016 15:44:52.593160 18646 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1016 15:44:52.593747 18646 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1016 15:44:52.596014 18646 slave.cpp:615] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I1016 15:44:52.596385 18646 slave.cpp:623] Agent attributes: [ ]
I1016 15:44:52.596412 18646 slave.cpp:632] Agent hostname: 029922c55108
I1016 15:44:52.596683 18640 task_status_update_manager.cpp:181] Pausing sending task status updates
I1016 15:44:52.598829 18632 state.cpp:66] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_choPeJ/meta'
I1016 15:44:52.599223 18630 slave.cpp:6915] Finished recovering checkpointed state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_choPeJ/meta', beginning agent recovery
I1016 15:44:52.599475 18625 task_status_update_manager.cpp:207] Recovering task status update manager
I1016 15:44:52.599972 18635 containerizer.cpp:727] Recovering Mesos containers
I1016 15:44:52.600563 18635 containerizer.cpp:1053] Recovering isolators
I1016 15:44:52.601532 18628 containerizer.cpp:1092] Recovering provisioner
I1016 15:44:52.602479 18636 provisioner.cpp:494] Provisioner recovery complete
I1016 15:44:52.603775 18630 composing.cpp:339] Finished recovering all containerizers
I1016 15:44:52.603973 18625 slave.cpp:7144] Recovering executors
I1016 15:44:52.604182 18625 slave.cpp:7297] Finished recovery
I1016 15:44:52.605594 18627 task_status_update_manager.cpp:181] Pausing sending task status updates
I1016 15:44:52.605635 18637 slave.cpp:1260] New master detected at master@172.17.0.2:34139
I1016 15:44:52.605873 18637 slave.cpp:1325] Detecting new master
I1016 15:44:52.611348 18644 slave.cpp:1352] Authenticating with master master@172.17.0.2:34139
I1016 15:44:52.611513 18644 slave.cpp:1361] Using default CRAM-MD5 authenticatee
I1016 15:44:52.612030 18643 authenticatee.cpp:121] Creating new client SASL connection
I1016 15:44:52.612540 18633 master.cpp:9720] Authenticating slave(999)@172.17.0.2:34139
I1016 15:44:52.612756 18628 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1778)@172.17.0.2:34139
I1016 15:44:52.613265 18634 authenticator.cpp:98] Creating new server SASL connection
I1016 15:44:52.613746 18638 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1016 15:44:52.613800 18638 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1016 15:44:52.613976 18638 authenticator.cpp:204] Received SASL authentication start
I1016 15:44:52.614081 18638 authenticator.cpp:326] Authentication requires more steps
I1016 15:44:52.614265 18640 authenticatee.cpp:259] Received SASL authentication step
I1016 15:44:52.614495 18642 authenticator.cpp:232] Received SASL authentication step
I1016 15:44:52.614555 18642 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1016 15:44:52.614585 18642 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1016 15:44:52.614648 18642 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1016 15:44:52.614688 18642 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1016 15:44:52.614712 18642 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.614732 18642 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.614763 18642 authenticator.cpp:318] Authentication success
I1016 15:44:52.614912 18636 authenticatee.cpp:299] Authentication success
I1016 15:44:52.615056 18645 master.cpp:9752] Successfully authenticated principal 'test-principal' at slave(999)@172.17.0.2:34139
I1016 15:44:52.615142 18629 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1778)@172.17.0.2:34139
I1016 15:44:52.615533 18632 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:34139
I1016 15:44:52.616058 18632 slave.cpp:1883] Will retry registration in 732579ns if necessary
I1016 15:44:52.616319 18625 master.cpp:6670] Received register agent message from slave(999)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.616746 18625 master.cpp:4029] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1016 15:44:52.617774 18637 master.cpp:6737] Authorized registration of agent at slave(999)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.617928 18637 master.cpp:6852] Registering agent at slave(999)@172.17.0.2:34139 (029922c55108) with id 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0
I1016 15:44:52.618077 18627 slave.cpp:1883] Will retry registration in 14.97924ms if necessary
I1016 15:44:52.618538 18637 master.cpp:6663] Ignoring register agent message from slave(999)@172.17.0.2:34139 (029922c55108) as registration is already in progress
I1016 15:44:52.618887 18627 registrar.cpp:487] Applied 1 operations in 265390ns; attempting to update the registry
I1016 15:44:52.619946 18627 registrar.cpp:544] Successfully updated the registry in 939008ns
I1016 15:44:52.620223 18634 master.cpp:6900] Admitted agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.621347 18634 master.cpp:6945] Registered agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1016 15:44:52.621650 18638 slave.cpp:1485] Registered with master master@172.17.0.2:34139; given agent ID 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0
I1016 15:44:52.621891 18636 task_status_update_manager.cpp:188] Resuming sending task status updates
I1016 15:44:52.621863 18640 hierarchical.cpp:605] Added agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1016 15:44:52.622143 18638 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_choPeJ/meta/slaves/2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0/slave.info'
I1016 15:44:52.622344 18640 hierarchical.cpp:1568] Performed allocation for 1 agents in 146563ns
I1016 15:44:52.623672 18638 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"PvugV+rdTmGXiRXr8jRhWQ=="},"slave_id":{"value":"2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0"},"update_oversubscribed_resources":false}
I1016 15:44:52.624476 18626 master.cpp:8006] Ignoring update on agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108) as it reports no changes
Build timed out (after 180 minutes). Marking the build as failed.
I1016 15:44:52.864843 18644 process.cpp:3569] Handling HTTP event for process 'slave(999)' with path: '/slave(999)/api/v1/resource_provider'
I1016 15:44:52.868582 18642 http.cpp:1178] HTTP POST for /slave(999)/api/v1/resource_provider from 172.17.0.2:33288
I1016 15:44:52.870043 18646 manager.cpp:736] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
I1016 15:44:52.920051 18632 slave.cpp:7649] Handling resource provider message 'SUBSCRIBE: {"id":{"value":"dd000ad2-be9e-4588-8cc0-884b9485a259"},"name":"test","type":"org.apache.mesos.rp.test"}'
I1016 15:44:52.921941 18623 slave.cpp:915] Agent terminating
I1016 15:44:52.922557 18623 manager.cpp:161] Terminating resource provider dd000ad2-be9e-4588-8cc0-884b9485a259
I1016 15:44:52.922966 18624 master.cpp:1266] Agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108) disconnected
I1016 15:44:52.923025 18624 master.cpp:3332] Disconnecting agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.923204 18624 master.cpp:3351] Deactivating agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 at slave(999)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.923475 18632 hierarchical.cpp:803] Agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0 deactivated
I1016 15:44:52.933125 18634 master.cpp:1108] Master terminating
I1016 15:44:52.934110 18641 hierarchical.cpp:645] Removed agent 2c6d8aa1-e060-453d-97a8-98b456b3b39b-S0
[ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 (383 ms)
[ RUN ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
I1016 15:44:52.942546 18623 cluster.cpp:173] Creating default 'local' authorizer
I1016 15:44:52.945780 18641 master.cpp:413] Master cac989a9-0ab4-40f5-b1a9-ecc1c5450850 (029922c55108) started on 172.17.0.2:34139
I1016 15:44:52.945813 18641 master.cpp:416] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="hierarchical" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authentication_v0_timeout="15secs" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/zz72K8/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --memory_profiling="false" --min_allocatable_resources="cpus:0.01|mem:32" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --require_agent_domain="false" --role_sorter="drf" --root_submissions="true" --version="false" --webui_dir="/mesos/mesos-1.8.0/_inst/share/mesos/webui" --work_dir="/tmp/zz72K8/master" --zk_session_timeout="10secs"
I1016 15:44:52.946260 18641 master.cpp:465] Master only allowing authenticated frameworks to register
I1016 15:44:52.946288 18641 master.cpp:471] Master only allowing authenticated agents to register
I1016 15:44:52.946308 18641 master.cpp:477] Master only allowing authenticated HTTP frameworks to register
I1016 15:44:52.946324 18641 credentials.hpp:37] Loading credentials for authentication from '/tmp/zz72K8/credentials'
I1016 15:44:52.946616 18641 master.cpp:521] Using default 'crammd5' authenticator
I1016 15:44:52.946806 18641 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1016 15:44:52.947026 18641 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1016 15:44:52.947211 18641 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1016 15:44:52.947392 18641 master.cpp:602] Authorization enabled
I1016 15:44:52.948012 18632 whitelist_watcher.cpp:77] No whitelist given
I1016 15:44:52.948040 18636 hierarchical.cpp:182] Initialized hierarchical allocator process
I1016 15:44:52.951762 18645 master.cpp:2148] Elected as the leading master!
I1016 15:44:52.951803 18645 master.cpp:1653] Recovering from registrar
I1016 15:44:52.952034 18646 registrar.cpp:339] Recovering registrar
I1016 15:44:52.952903 18646 registrar.cpp:383] Successfully fetched the registry (0B) in 815104ns
I1016 15:44:52.953081 18646 registrar.cpp:487] Applied 1 operations in 47867ns; attempting to update the registry
I1016 15:44:52.953790 18646 registrar.cpp:544] Successfully updated the registry in 633856ns
I1016 15:44:52.953935 18646 registrar.cpp:416] Successfully recovered registrar
I1016 15:44:52.954448 18644 master.cpp:1767] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister
I1016 15:44:52.954483 18626 hierarchical.cpp:220] Skipping recovery of hierarchical allocator: nothing to recover
W1016 15:44:52.960535 18623 process.cpp:2810] Attempted to spawn already running process files@172.17.0.2:34139
I1016 15:44:52.961920 18623 containerizer.cpp:305] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1016 15:44:52.962471 18623 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1016 15:44:52.962630 18623 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1016 15:44:52.962679 18623 provisioner.cpp:298] Using default backend 'copy'
I1016 15:44:52.965229 18623 cluster.cpp:485] Creating default 'local' authorizer
I1016 15:44:52.967473 18644 slave.cpp:267] Mesos agent started on (1000)@172.17.0.2:34139
I1016 15:44:52.967500 18644 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authentication_timeout_max="1mins" --authentication_timeout_min="5secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_destroy_timeout="1mins" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.8.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ZvO8KK" --zk_session_timeout="10secs"
I1016 15:44:52.968024 18644 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/credential'
I1016 15:44:52.968258 18644 slave.cpp:300] Agent using credential for: test-principal
I1016 15:44:52.968295 18644 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_1MSfLm/http_credentials'
I1016 15:44:52.968572 18644 http.cpp:1038] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1016 15:44:52.969067 18644 disk_profile_adaptor.cpp:80] Creating default disk profile adaptor module
I1016 15:44:52.970520 18644 slave.cpp:615] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I1016 15:44:52.970746 18644 slave.cpp:623] Agent attributes: [ ]
I1016 15:44:52.970765 18644 slave.cpp:632] Agent hostname: 029922c55108
I1016 15:44:52.970952 18624 task_status_update_manager.cpp:181] Pausing sending task status updates
I1016 15:44:52.972632 18640 state.cpp:66] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ZvO8KK/meta'
I1016 15:44:52.972877 18638 slave.cpp:6915] Finished recovering checkpointed state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ZvO8KK/meta', beginning agent recovery
I1016 15:44:52.973079 18629 task_status_update_manager.cpp:207] Recovering task status update manager
I1016 15:44:52.973454 18635 containerizer.cpp:727] Recovering Mesos containers
I1016 15:44:52.973860 18635 containerizer.cpp:1053] Recovering isolators
I1016 15:44:52.974647 18632 containerizer.cpp:1092] Recovering provisioner
I1016 15:44:52.975430 18641 provisioner.cpp:494] Provisioner recovery complete
I1016 15:44:52.976198 18638 composing.cpp:339] Finished recovering all containerizers
I1016 15:44:52.976359 18629 slave.cpp:7144] Recovering executors
I1016 15:44:52.976507 18629 slave.cpp:7297] Finished recovery
I1016 15:44:52.977366 18628 task_status_update_manager.cpp:181] Pausing sending task status updates
I1016 15:44:52.977392 18630 slave.cpp:1260] New master detected at master@172.17.0.2:34139
I1016 15:44:52.977527 18630 slave.cpp:1325] Detecting new master
I1016 15:44:52.978833 18634 slave.cpp:1352] Authenticating with master master@172.17.0.2:34139
I1016 15:44:52.978943 18634 slave.cpp:1361] Using default CRAM-MD5 authenticatee
I1016 15:44:52.979312 18625 authenticatee.cpp:121] Creating new client SASL connection
I1016 15:44:52.979676 18626 master.cpp:9720] Authenticating slave(1000)@172.17.0.2:34139
I1016 15:44:52.979849 18636 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1779)@172.17.0.2:34139
I1016 15:44:52.980166 18632 authenticator.cpp:98] Creating new server SASL connection
I1016 15:44:52.980420 18642 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1016 15:44:52.980458 18642 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1016 15:44:52.980603 18624 authenticator.cpp:204] Received SASL authentication start
I1016 15:44:52.980674 18624 authenticator.cpp:326] Authentication requires more steps
I1016 15:44:52.980792 18624 authenticatee.cpp:259] Received SASL authentication step
I1016 15:44:52.980957 18645 authenticator.cpp:232] Received SASL authentication step
I1016 15:44:52.981005 18645 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1016 15:44:52.981029 18645 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1016 15:44:52.981078 18645 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1016 15:44:52.981104 18645 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '029922c55108' server FQDN: '029922c55108' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1016 15:44:52.981125 18645 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.981148 18645 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1016 15:44:52.981179 18645 authenticator.cpp:318] Authentication success
I1016 15:44:52.981302 18637 authenticatee.cpp:299] Authentication success
I1016 15:44:52.981444 18644 master.cpp:9752] Successfully authenticated principal 'test-principal' at slave(1000)@172.17.0.2:34139
I1016 15:44:52.981475 18640 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1779)@172.17.0.2:34139
I1016 15:44:52.981834 18631 slave.cpp:1452] Successfully authenticated with master master@172.17.0.2:34139
I1016 15:44:52.982252 18631 slave.cpp:1883] Will retry registration in 8.694706ms if necessary
I1016 15:44:52.982448 18643 master.cpp:6670] Received register agent message from slave(1000)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.982771 18643 master.cpp:4029] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1016 15:44:52.983685 18630 master.cpp:6737] Authorized registration of agent at slave(1000)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.983806 18630 master.cpp:6852] Registering agent at slave(1000)@172.17.0.2:34139 (029922c55108) with id cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0
I1016 15:44:52.984478 18635 registrar.cpp:487] Applied 1 operations in 171928ns; attempting to update the registry
I1016 15:44:52.985272 18635 registrar.cpp:544] Successfully updated the registry in 0ns
I1016 15:44:52.985477 18632 master.cpp:6900] Admitted agent cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0 at slave(1000)@172.17.0.2:34139 (029922c55108)
I1016 15:44:52.986263 18632 master.cpp:6945] Registered agent cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0 at slave(1000)@172.17.0.2:34139 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1016 15:44:52.986347 18642 slave.cpp:1485] Registered with master master@172.17.0.2:34139; given agent ID cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0
I1016 15:44:52.986502 18644 task_status_update_manager.cpp:188] Resuming sending task status updates
I1016 15:44:52.986773 18642 slave.cpp:1505] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_ZvO8KK/meta/slaves/cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0/slave.info'
I1016 15:44:52.986773 18624 hierarchical.cpp:605] Added agent cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0 (029922c55108) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I1016 15:44:52.987138 18624 hierarchical.cpp:1568] Performed allocation for 1 agents in 133362ns
I1016 15:44:52.988037 18642 slave.cpp:1554] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"Gy1USd90SLGeF5LtsBLLMQ=="},"slave_id":{"value":"cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0"},"update_oversubscribed_resources":false}
I1016 15:44:52.988770 18642 master.cpp:8006] Ignoring update on agent cac989a9-0ab4-40f5-b1a9-ecc1c5450850-S0 at slave(1000)@172.17.0.2:34139 (029922c55108) as it reports no changes
Build was aborted
++ docker rmi --force mesos-1539697908-10466