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/10/30 13:10:07 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4376
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4376/display/redirect?page=changes>
Changes:
[alexr] Stopped awaiting the connected event in ports isolator tests.
------------------------------------------
[...truncated 29.97 MB...]
3: I1030 13:09:07.438323 17288 hierarchical.cpp:355] Removed framework 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-0000
3: I1030 13:09:07.438372 17288 hierarchical.cpp:412] Deactivated framework 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-0001
3: I1030 13:09:07.438554 17288 hierarchical.cpp:355] Removed framework 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-0001
3: I1030 13:09:07.438803 17267 slave.cpp:869] Agent terminating
3: I1030 13:09:07.438982 17268 master.cpp:1303] Agent 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-S0 at slave(824)@172.17.0.2:36345 (f407f4c249cd) disconnected
3: I1030 13:09:07.439003 17268 master.cpp:3336] Disconnecting agent 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-S0 at slave(824)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.439057 17268 master.cpp:3355] Deactivating agent 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-S0 at slave(824)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.439173 17279 hierarchical.cpp:690] Agent 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-S0 deactivated
3: I1030 13:09:07.446218 17267 master.cpp:1145] Master terminating
3: I1030 13:09:07.447242 17285 hierarchical.cpp:626] Removed agent 8424f16e-51d2-4b7e-afdf-7e549a70e4a4-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/0 (103 ms)
3: [ RUN ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1
3: I1030 13:09:07.453964 17267 cluster.cpp:162] Creating default 'local' authorizer
3: I1030 13:09:07.458668 17270 master.cpp:445] Master 0415db6a-c158-48b4-b1c1-f635b3a7fa2d (f407f4c249cd) started on 172.17.0.2:36345
3: I1030 13:09:07.458689 17270 master.cpp:447] Flags at startup: --acls="create_volumes {
3: principals {
3: values: "creator-principal"
3: }
3: roles {
3: type: ANY
3: }
3: }
3: create_volumes {
3: principals {
3: type: ANY
3: }
3: roles {
3: type: NONE
3: }
3: }
3: destroy_volumes {
3: principals {
3: type: ANY
3: }
3: creator_principals {
3: type: NONE
3: }
3: }
3: " --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="false" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/wPo5Vi/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --roles="default-role" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/wPo5Vi/master" --zk_session_timeout="10secs"
3: I1030 13:09:07.459110 17270 master.cpp:498] Master allowing unauthenticated frameworks to register
3: I1030 13:09:07.459116 17270 master.cpp:502] Master only allowing authenticated agents to register
3: I1030 13:09:07.459120 17270 master.cpp:508] Master only allowing authenticated HTTP frameworks to register
3: I1030 13:09:07.459125 17270 credentials.hpp:37] Loading credentials for authentication from '/tmp/wPo5Vi/credentials'
3: I1030 13:09:07.459403 17270 master.cpp:552] Using default 'crammd5' authenticator
3: I1030 13:09:07.459553 17270 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1030 13:09:07.459728 17270 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1030 13:09:07.459867 17270 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1030 13:09:07.459997 17270 master.cpp:631] Authorization enabled
3: W1030 13:09:07.460016 17270 master.cpp:694] The '--roles' flag is deprecated. This flag will be removed in the future. See the Mesos 0.27 upgrade notes for more information
3: I1030 13:09:07.460233 17282 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1030 13:09:07.460254 17287 whitelist_watcher.cpp:77] No whitelist given
3: I1030 13:09:07.462815 17284 master.cpp:2198] Elected as the leading master!
3: I1030 13:09:07.462863 17284 master.cpp:1687] Recovering from registrar
3: I1030 13:09:07.463075 17278 registrar.cpp:347] Recovering registrar
3: I1030 13:09:07.463798 17277 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1030 13:09:07.463963 17277 registrar.cpp:495] Applied 1 operations in 38350ns; attempting to update the registry
3: I1030 13:09:07.464721 17277 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1030 13:09:07.464892 17277 registrar.cpp:424] Successfully recovered registrar
3: I1030 13:09:07.465451 17271 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1030 13:09:07.465495 17268 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1030 13:09:07.471853 17267 process.cpp:3193] Attempted to spawn already running process files@172.17.0.2:36345
3: I1030 13:09:07.472898 17267 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1030 13:09:07.473567 17267 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1030 13:09:07.473704 17267 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1030 13:09:07.473737 17267 provisioner.cpp:255] Using default backend 'copy'
3: I1030 13:09:07.476055 17267 cluster.cpp:448] Creating default 'local' authorizer
3: I1030 13:09:07.478348 17268 slave.cpp:254] Mesos agent started on (825)@172.17.0.2:36345
3: I1030 13:09:07.478368 17268 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/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/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/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/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/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/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/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/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/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="[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk2"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe" --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/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_c1fkCV" --zk_session_timeout="10secs"
3: I1030 13:09:07.478751 17268 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/credential'
3: W1030 13:09:07.478878 17267 process.cpp:3193] Attempted to spawn already running process version@172.17.0.2:36345
3: I1030 13:09:07.478889 17268 slave.cpp:287] Agent using credential for: test-principal
3: I1030 13:09:07.478919 17268 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_9YFHYe/http_credentials'
3: I1030 13:09:07.479125 17268 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1030 13:09:07.479277 17268 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1030 13:09:07.479748 17267 sched.cpp:232] Version: 1.5.0
3: I1030 13:09:07.480279 17288 sched.cpp:336] New master detected at master@172.17.0.2:36345
3: I1030 13:09:07.480371 17288 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1030 13:09:07.480386 17288 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:36345
3: I1030 13:09:07.480484 17288 sched.cpp:853] Will retry registration in 1.175585917secs if necessary
3: I1030 13:09:07.480682 17286 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.480759 17286 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1030 13:09:07.481246 17285 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1030 13:09:07.481896 17285 sched.cpp:747] Framework registered with 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.481940 17285 sched.cpp:761] Scheduler::registered took 20478ns
3: I1030 13:09:07.482031 17283 hierarchical.cpp:303] Added framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.482251 17283 hierarchical.cpp:1488] Performed allocation for 0 agents in 91477ns
3: I1030 13:09:07.482641 17268 slave.cpp:585] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk2"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1030 13:09:07.483048 17268 slave.cpp:593] Agent attributes: [ ]
3: I1030 13:09:07.483057 17268 slave.cpp:602] Agent hostname: f407f4c249cd
3: I1030 13:09:07.483203 17277 status_update_manager.cpp:177] Pausing sending status updates
3: I1030 13:09:07.484619 17281 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_c1fkCV/meta'
3: I1030 13:09:07.484897 17282 status_update_manager.cpp:203] Recovering status update manager
3: I1030 13:09:07.485146 17280 containerizer.cpp:662] Recovering containerizer
3: I1030 13:09:07.486722 17271 provisioner.cpp:416] Provisioner recovery complete
3: I1030 13:09:07.487056 17283 slave.cpp:6322] Finished recovery
3: I1030 13:09:07.487818 17268 status_update_manager.cpp:177] Pausing sending status updates
3: I1030 13:09:07.487824 17279 slave.cpp:993] New master detected at master@172.17.0.2:36345
3: I1030 13:09:07.487872 17279 slave.cpp:1028] Detecting new master
3: I1030 13:09:07.489538 17272 slave.cpp:1055] Authenticating with master master@172.17.0.2:36345
3: I1030 13:09:07.489598 17272 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1030 13:09:07.489871 17275 authenticatee.cpp:121] Creating new client SASL connection
3: I1030 13:09:07.489990 17270 hierarchical.cpp:1488] Performed allocation for 0 agents in 66543ns
3: I1030 13:09:07.490175 17290 master.cpp:7952] Authenticating slave(825)@172.17.0.2:36345
3: I1030 13:09:07.490285 17288 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1492)@172.17.0.2:36345
3: I1030 13:09:07.490568 17284 authenticator.cpp:98] Creating new server SASL connection
3: I1030 13:09:07.490772 17286 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1030 13:09:07.490792 17286 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1030 13:09:07.490931 17274 authenticator.cpp:204] Received SASL authentication start
3: I1030 13:09:07.490988 17274 authenticator.cpp:326] Authentication requires more steps
3: I1030 13:09:07.491096 17280 authenticatee.cpp:259] Received SASL authentication step
3: I1030 13:09:07.491205 17280 authenticator.cpp:232] Received SASL authentication step
3: I1030 13:09:07.491236 17280 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f407f4c249cd' server FQDN: 'f407f4c249cd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1030 13:09:07.491245 17280 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1030 13:09:07.491274 17280 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1030 13:09:07.491299 17280 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f407f4c249cd' server FQDN: 'f407f4c249cd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1030 13:09:07.491308 17280 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1030 13:09:07.491313 17280 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1030 13:09:07.491324 17280 authenticator.cpp:318] Authentication success
3: I1030 13:09:07.491447 17278 authenticatee.cpp:299] Authentication success
3: I1030 13:09:07.491539 17276 master.cpp:7982] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.2:36345
3: I1030 13:09:07.491586 17291 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1492)@172.17.0.2:36345
3: I1030 13:09:07.491829 17285 slave.cpp:1147] Successfully authenticated with master master@172.17.0.2:36345
3: I1030 13:09:07.492110 17285 slave.cpp:1626] Will retry registration in 3.012867ms if necessary
3: I1030 13:09:07.492333 17289 master.cpp:5801] Received register agent message from slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.492496 17289 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1030 13:09:07.492908 17279 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.493010 17279 master.cpp:5954] Registering agent at slave(825)@172.17.0.2:36345 (f407f4c249cd) with id 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0
3: I1030 13:09:07.493471 17281 registrar.cpp:495] Applied 1 operations in 69398ns; attempting to update the registry
3: I1030 13:09:07.494071 17281 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1030 13:09:07.494320 17270 master.cpp:6001] Admitted agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.495282 17286 slave.cpp:1193] Registered with master master@172.17.0.2:36345; given agent ID 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0
3: I1030 13:09:07.495437 17273 status_update_manager.cpp:184] Resuming sending status updates
3: I1030 13:09:07.495585 17286 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_c1fkCV/meta/slaves/0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0/slave.info'
3: I1030 13:09:07.495230 17270 master.cpp:6032] Registered agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk2"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1030 13:09:07.495846 17284 hierarchical.cpp:593] Added agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 (f407f4c249cd) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1030 13:09:07.496068 17286 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1030 13:09:07.496260 17286 master.cpp:6833] Received update of agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) with total oversubscribed resources {}
3: I1030 13:09:07.496505 17286 master.cpp:6844] Ignoring update on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) as it reports no changes
3: I1030 13:09:07.497795 17284 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.720229ms
3: I1030 13:09:07.498692 17278 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.499255 17271 sched.cpp:917] Scheduler::resourceOffers took 101231ns
3: I1030 13:09:07.501247 17276 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O0
3: I1030 13:09:07.501374 17276 master.cpp:4196] Processing ACCEPT call for offers: [ 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O0 ] on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.501534 17276 master.cpp:3758] Authorizing principal 'test-principal' to create volumes '[{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"test-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1030 13:09:07.502557 17276 master.cpp:2348] Dropping CREATE offer operation from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345: Not authorized to create persistent volumes as 'test-principal'
3: I1030 13:09:07.504004 17268 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.507491 17269 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.809764ms
3: I1030 13:09:07.508203 17272 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.508718 17275 sched.cpp:917] Scheduler::resourceOffers took 104805ns
3: W1030 13:09:07.509373 17267 process.cpp:3193] Attempted to spawn already running process version@172.17.0.2:36345
3: I1030 13:09:07.509527 17290 master.cpp:5207] Processing DECLINE call for offers: [ 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O1 ] for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.510067 17267 sched.cpp:232] Version: 1.5.0
3: I1030 13:09:07.510511 17270 sched.cpp:336] New master detected at master@172.17.0.2:36345
3: I1030 13:09:07.510535 17290 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O1
3: I1030 13:09:07.510596 17270 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1030 13:09:07.510610 17270 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:36345
3: I1030 13:09:07.510689 17290 master.cpp:3439] Processing SUPPRESS call for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.510691 17270 sched.cpp:853] Will retry registration in 1.718420324secs if necessary
3: I1030 13:09:07.510895 17290 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.510963 17290 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1030 13:09:07.511164 17274 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.511332 17274 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.511546 17271 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1030 13:09:07.511986 17283 hierarchical.cpp:303] Added framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.512079 17285 sched.cpp:747] Framework registered with 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.512122 17285 sched.cpp:761] Scheduler::registered took 17984ns
3: I1030 13:09:07.513834 17283 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.708504ms
3: I1030 13:09:07.515058 17291 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.515700 17287 sched.cpp:917] Scheduler::resourceOffers took 116278ns
3: I1030 13:09:07.517387 17289 hierarchical.cpp:1488] Performed allocation for 1 agents in 137498ns
3: I1030 13:09:07.519230 17279 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O2
3: I1030 13:09:07.519352 17279 master.cpp:4196] Processing ACCEPT call for offers: [ 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O2 ] on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.519505 17279 master.cpp:3758] Authorizing principal 'creator-principal' to create volumes '[{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"creator-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: I1030 13:09:07.520970 17279 master.cpp:4639] Applying CREATE operation for volumes [{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"creator-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}] from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345 to agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.521564 17279 master.cpp:9351] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048 to agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.522723 17288 slave.cpp:3531] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048
3: I1030 13:09:07.526047 17273 hierarchical.cpp:887] Updated allocation of framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from cpus(allocated: default-role):2; mem(allocated: default-role):2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; ports(allocated: default-role):[31000-32000] to cpus(allocated: default-role):2; mem(allocated: default-role):2048; ports(allocated: default-role):[31000-32000]; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048
3: I1030 13:09:07.527693 17273 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; ports(allocated: default-role):[31000-32000]; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048, allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.531229 17284 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.524544ms
3: I1030 13:09:07.531997 17270 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.532562 17270 sched.cpp:917] Scheduler::resourceOffers took 103492ns
3: I1030 13:09:07.533351 17278 master.cpp:5207] Processing DECLINE call for offers: [ 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O3 ] for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.534617 17278 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O3
3: I1030 13:09:07.534832 17278 master.cpp:3439] Processing SUPPRESS call for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.535214 17271 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; ports(allocated: default-role):[31000-32000]; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048, allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.535390 17271 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.535704 17277 master.cpp:5312] Processing REVIVE call for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.535841 17277 hierarchical.cpp:1310] Revived offers for roles { default-role } of framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.537519 17277 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.556056ms
3: I1030 13:09:07.538548 17291 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.539191 17287 sched.cpp:917] Scheduler::resourceOffers took 111800ns
3: I1030 13:09:07.541024 17289 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O4
3: I1030 13:09:07.541173 17289 master.cpp:4196] Processing ACCEPT call for offers: [ 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O4 ] on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.541322 17289 master.cpp:3810] Authorizing principal 'test-principal' to destroy volumes '[{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"creator-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1030 13:09:07.542429 17289 master.cpp:2348] Dropping DESTROY offer operation from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345: Not authorized to destroy persistent volumes as 'test-principal'
3: I1030 13:09:07.544004 17281 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; ports(allocated: default-role):[31000-32000]; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048, allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.547266 17288 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.509739ms
3: I1030 13:09:07.548040 17273 master.cpp:7782] Sending 1 offers to framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.548600 17273 sched.cpp:917] Scheduler::resourceOffers took 116287ns
3: I1030 13:09:07.548912 17267 sched.cpp:2005] Asked to stop the driver
3: I1030 13:09:07.549059 17286 sched.cpp:1187] Stopping framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.549474 17284 master.cpp:8463] Processing TEARDOWN call for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.549505 17284 master.cpp:8475] Removing framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.549517 17284 master.cpp:3299] Deactivating framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 (default) at scheduler-79d12358-2af2-4631-b44c-ca2724bf1f5b@172.17.0.2:36345
3: I1030 13:09:07.549531 17267 sched.cpp:2005] Asked to stop the driver
3: I1030 13:09:07.549641 17278 hierarchical.cpp:412] Deactivated framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.549649 17271 sched.cpp:1187] Stopping framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.550598 17284 master.cpp:9405] Removing offer 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-O5
3: I1030 13:09:07.550873 17272 slave.cpp:3211] Asked to shut down framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000 by master@172.17.0.2:36345
3: I1030 13:09:07.550902 17272 slave.cpp:3226] Cannot shut down unknown framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.551110 17284 master.cpp:8463] Processing TEARDOWN call for framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.551138 17284 master.cpp:8475] Removing framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.551149 17284 master.cpp:3299] Deactivating framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 (creator-framework) at scheduler-24abc76c-9a51-44c0-a835-5b4b7b20f914@172.17.0.2:36345
3: I1030 13:09:07.551329 17273 slave.cpp:3211] Asked to shut down framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001 by master@172.17.0.2:36345
3: I1030 13:09:07.551359 17273 slave.cpp:3226] Cannot shut down unknown framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.551396 17285 hierarchical.cpp:1163] Recovered cpus(allocated: default-role):2; mem(allocated: default-role):2048; ports(allocated: default-role):[31000-32000]; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bLdYfC/disk1,id1:path1]:2048, allocated: {}) on agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 from framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.551602 17285 hierarchical.cpp:355] Removed framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0000
3: I1030 13:09:07.551657 17285 hierarchical.cpp:412] Deactivated framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.551868 17285 hierarchical.cpp:355] Removed framework 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-0001
3: I1030 13:09:07.552184 17267 slave.cpp:869] Agent terminating
3: I1030 13:09:07.552399 17277 master.cpp:1303] Agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd) disconnected
3: I1030 13:09:07.552424 17277 master.cpp:3336] Disconnecting agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.552482 17277 master.cpp:3355] Deactivating agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 at slave(825)@172.17.0.2:36345 (f407f4c249cd)
3: I1030 13:09:07.552592 17282 hierarchical.cpp:690] Agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0 deactivated
3: I1030 13:09:07.558743 17267 master.cpp:1145] Master terminating
3: I1030 13:09:07.560394 17269 hierarchical.cpp:626] Removed agent 0415db6a-c158-48b4-b1c1-f635b3a7fa2d-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (111 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (12011 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1650 tests from 178 test cases ran. (458617 ms total)
3: [ PASSED ] 1650 tests.
3:
3: YOU HAVE 21 DISABLED TESTS
3:
3: I1030 13:09:07.627116 17292 process.cpp:1067] Failed to accept socket: future discarded
3/3 Test #3: MesosTests ....................... Passed 462.97 sec
100% tests passed, 0 tests failed out of 3
Total Test time (real) = 483.01 sec
make[3]: Leaving directory `/mesos/build'
[100%] Built target check
make[2]: Leaving directory `/mesos/build'
/usr/local/bin/cmake -E cmake_progress_start /mesos/build/CMakeFiles 0
make[1]: Leaving directory `/mesos/build'
+ docker rmi mesos-1509366487-475
Error response from daemon: no such file or directory
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4377
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4377/display/redirect>