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/16 23:50:33 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) #4328
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)/4328/display/redirect?page=changes>
Changes:
[bmahler] Added protobuf install handler benchmark.
------------------------------------------
[...truncated 30.03 MB...]
3: I1016 23:50:24.834251 17265 master.cpp:1687] Recovering from registrar
3: I1016 23:50:24.834385 17245 registrar.cpp:347] Recovering registrar
3: I1016 23:50:24.834967 17245 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1016 23:50:24.835114 17245 registrar.cpp:495] Applied 1 operations in 62906ns; attempting to update the registry
3: I1016 23:50:24.835788 17245 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1016 23:50:24.835919 17245 registrar.cpp:424] Successfully recovered registrar
3: I1016 23:50:24.836284 17255 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1016 23:50:24.836370 17243 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1016 23:50:24.841838 17242 process.cpp:3194] Attempted to spawn already running process files@172.17.0.2:40885
3: I1016 23:50:24.842815 17242 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1016 23:50:24.843338 17242 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1016 23:50:24.843467 17242 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1016 23:50:24.843495 17242 provisioner.cpp:255] Using default backend 'copy'
3: I1016 23:50:24.845263 17242 cluster.cpp:448] Creating default 'local' authorizer
3: I1016 23:50:24.847476 17255 slave.cpp:254] Mesos agent started on (825)@172.17.0.2:40885
3: I1016 23:50:24.847506 17255 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_kDO3db/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_kDO3db/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_kDO3db/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_kDO3db/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_kDO3db/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_u4yHVD\/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_u4yHVD\/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_kDO3db" --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_eOTRzp" --zk_session_timeout="10secs"
3: I1016 23:50:24.847905 17255 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_kDO3db/credential'
3: W1016 23:50:24.848042 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:40885
3: I1016 23:50:24.848062 17255 slave.cpp:287] Agent using credential for: test-principal
3: I1016 23:50:24.848079 17255 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_kDO3db/http_credentials'
3: I1016 23:50:24.848289 17255 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1016 23:50:24.848441 17255 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1016 23:50:24.848896 17242 sched.cpp:232] Version: 1.5.0
3: I1016 23:50:24.849459 17246 sched.cpp:336] New master detected at master@172.17.0.2:40885
3: I1016 23:50:24.849568 17246 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1016 23:50:24.849582 17246 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:40885
3: I1016 23:50:24.849695 17246 sched.cpp:853] Will retry registration in 1.12874584secs if necessary
3: I1016 23:50:24.849874 17253 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.849951 17253 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1016 23:50:24.850421 17259 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1016 23:50:24.851019 17263 sched.cpp:747] Framework registered with b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.851073 17263 sched.cpp:761] Scheduler::registered took 23402ns
3: I1016 23:50:24.851228 17244 hierarchical.cpp:303] Added framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.851369 17244 hierarchical.cpp:1943] No allocations performed
3: I1016 23:50:24.851398 17244 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.851428 17244 hierarchical.cpp:1486] Performed allocation for 0 agents in 90467ns
3: I1016 23:50:24.851779 17255 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_u4yHVD\/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_u4yHVD\/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: I1016 23:50:24.852181 17255 slave.cpp:593] Agent attributes: [ ]
3: I1016 23:50:24.852191 17255 slave.cpp:602] Agent hostname: 4806542b2319
3: I1016 23:50:24.852350 17249 status_update_manager.cpp:177] Pausing sending status updates
3: I1016 23:50:24.854099 17248 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_eOTRzp/meta'
3: I1016 23:50:24.854413 17254 status_update_manager.cpp:203] Recovering status update manager
3: I1016 23:50:24.854743 17252 containerizer.cpp:649] Recovering containerizer
3: I1016 23:50:24.856250 17243 provisioner.cpp:416] Provisioner recovery complete
3: I1016 23:50:24.856535 17249 slave.cpp:6310] Finished recovery
3: I1016 23:50:24.856974 17249 slave.cpp:6492] Querying resource estimator for oversubscribable resources
3: I1016 23:50:24.857262 17262 slave.cpp:993] New master detected at master@172.17.0.2:40885
3: I1016 23:50:24.857281 17255 status_update_manager.cpp:177] Pausing sending status updates
3: I1016 23:50:24.857321 17262 slave.cpp:1028] Detecting new master
3: I1016 23:50:24.857429 17262 slave.cpp:6506] Received oversubscribable resources {} from the resource estimator
3: I1016 23:50:24.858893 17247 slave.cpp:1055] Authenticating with master master@172.17.0.2:40885
3: I1016 23:50:24.858961 17247 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1016 23:50:24.859275 17266 authenticatee.cpp:121] Creating new client SASL connection
3: I1016 23:50:24.859308 17265 hierarchical.cpp:1943] No allocations performed
3: I1016 23:50:24.859346 17265 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.859377 17265 hierarchical.cpp:1486] Performed allocation for 0 agents in 113435ns
3: I1016 23:50:24.859573 17253 master.cpp:7936] Authenticating slave(825)@172.17.0.2:40885
3: I1016 23:50:24.859685 17246 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1489)@172.17.0.2:40885
3: I1016 23:50:24.859931 17261 authenticator.cpp:98] Creating new server SASL connection
3: I1016 23:50:24.860157 17256 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1016 23:50:24.860178 17256 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1016 23:50:24.860277 17256 authenticator.cpp:204] Received SASL authentication start
3: I1016 23:50:24.860324 17256 authenticator.cpp:326] Authentication requires more steps
3: I1016 23:50:24.860446 17252 authenticatee.cpp:259] Received SASL authentication step
3: I1016 23:50:24.860602 17257 authenticator.cpp:232] Received SASL authentication step
3: I1016 23:50:24.860630 17257 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4806542b2319' server FQDN: '4806542b2319' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1016 23:50:24.860640 17257 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1016 23:50:24.860672 17257 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1016 23:50:24.860689 17257 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4806542b2319' server FQDN: '4806542b2319' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1016 23:50:24.860699 17257 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1016 23:50:24.860704 17257 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1016 23:50:24.860718 17257 authenticator.cpp:318] Authentication success
3: I1016 23:50:24.860827 17264 authenticatee.cpp:299] Authentication success
3: I1016 23:50:24.860906 17263 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.2:40885
3: I1016 23:50:24.860913 17258 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1489)@172.17.0.2:40885
3: I1016 23:50:24.861057 17264 slave.cpp:1147] Successfully authenticated with master master@172.17.0.2:40885
3: I1016 23:50:24.861284 17264 slave.cpp:1626] Will retry registration in 8.397794ms if necessary
3: I1016 23:50:24.861500 17250 master.cpp:5801] Received register agent message from slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.861652 17250 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1016 23:50:24.862095 17255 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.862222 17255 master.cpp:5954] Registering agent at slave(825)@172.17.0.2:40885 (4806542b2319) with id b42c0c84-5d6a-4a92-87eb-b30a27132367-S0
3: I1016 23:50:24.862686 17248 registrar.cpp:495] Applied 1 operations in 66638ns; attempting to update the registry
3: I1016 23:50:24.863299 17248 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1016 23:50:24.863523 17265 master.cpp:6001] Admitted agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.864223 17246 slave.cpp:4966] Received ping from slave-observer(741)@172.17.0.2:40885
3: I1016 23:50:24.864378 17246 slave.cpp:1193] Registered with master master@172.17.0.2:40885; given agent ID b42c0c84-5d6a-4a92-87eb-b30a27132367-S0
3: I1016 23:50:24.864475 17256 status_update_manager.cpp:184] Resuming sending status updates
3: I1016 23:50:24.864665 17246 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_eOTRzp/meta/slaves/b42c0c84-5d6a-4a92-87eb-b30a27132367-S0/slave.info'
3: I1016 23:50:24.864287 17265 master.cpp:6032] Registered agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) 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_u4yHVD\/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_u4yHVD\/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: I1016 23:50:24.864923 17261 hierarchical.cpp:593] Added agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 (4806542b2319) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1016 23:50:24.865077 17246 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1016 23:50:24.865255 17252 master.cpp:6817] Received update of agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) with total oversubscribed resources {}
3: I1016 23:50:24.865509 17252 master.cpp:6828] Ignoring update on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) as it reports no changes
3: I1016 23:50:24.866714 17261 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.866755 17261 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.616702ms
3: I1016 23:50:24.867533 17257 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.868106 17243 sched.cpp:917] Scheduler::resourceOffers took 105464ns
3: I1016 23:50:24.869928 17263 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O0
3: I1016 23:50:24.870060 17263 master.cpp:4196] Processing ACCEPT call for offers: [ b42c0c84-5d6a-4a92-87eb-b30a27132367-O0 ] on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.870230 17263 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_u4yHVD\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1016 23:50:24.871248 17263 master.cpp:2348] Dropping CREATE offer operation from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885: Not authorized to create persistent volumes as 'test-principal'
3: I1016 23:50:24.872635 17263 hierarchical.cpp:1161] 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_u4yHVD/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; ports:[31000-32000], allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.875891 17254 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.875938 17254 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.460364ms
3: I1016 23:50:24.876658 17260 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.877199 17247 sched.cpp:917] Scheduler::resourceOffers took 99693ns
3: W1016 23:50:24.877843 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:40885
3: I1016 23:50:24.877887 17248 master.cpp:5207] Processing DECLINE call for offers: [ b42c0c84-5d6a-4a92-87eb-b30a27132367-O1 ] for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.878527 17242 sched.cpp:232] Version: 1.5.0
3: I1016 23:50:24.878793 17248 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O1
3: I1016 23:50:24.878935 17248 master.cpp:3439] Processing SUPPRESS call for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.879040 17252 sched.cpp:336] New master detected at master@172.17.0.2:40885
3: I1016 23:50:24.879132 17252 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1016 23:50:24.879148 17252 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:40885
3: I1016 23:50:24.879257 17252 sched.cpp:853] Will retry registration in 1.886654054secs if necessary
3: I1016 23:50:24.879407 17261 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.879482 17261 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1016 23:50:24.879513 17259 hierarchical.cpp:1161] 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_u4yHVD/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; ports:[31000-32000], allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.879685 17259 hierarchical.cpp:1273] Suppressed offers for roles { default-role } of framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.879870 17244 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1016 23:50:24.880265 17249 hierarchical.cpp:303] Added framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.880398 17251 sched.cpp:747] Framework registered with b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.880439 17251 sched.cpp:761] Scheduler::registered took 14749ns
3: I1016 23:50:24.881836 17249 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.881876 17249 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.500407ms
3: I1016 23:50:24.882609 17264 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.883177 17245 sched.cpp:917] Scheduler::resourceOffers took 111417ns
3: I1016 23:50:24.884804 17263 hierarchical.cpp:1943] No allocations performed
3: I1016 23:50:24.884840 17263 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.884872 17263 hierarchical.cpp:1486] Performed allocation for 1 agents in 158640ns
3: I1016 23:50:24.886670 17262 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O2
3: I1016 23:50:24.886791 17262 master.cpp:4196] Processing ACCEPT call for offers: [ b42c0c84-5d6a-4a92-87eb-b30a27132367-O2 ] on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.886932 17262 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_u4yHVD\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: I1016 23:50:24.888471 17253 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_u4yHVD\/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 b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885 to agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.889060 17253 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048 to agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.890429 17246 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048
3: I1016 23:50:24.893018 17265 hierarchical.cpp:887] Updated allocation of framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-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_u4yHVD/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/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_u4yHVD/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048
3: I1016 23:50:24.894528 17265 hierarchical.cpp:1161] 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_u4yHVD/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048, allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.897894 17257 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.897943 17257 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.689304ms
3: I1016 23:50:24.898659 17261 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.899219 17259 sched.cpp:917] Scheduler::resourceOffers took 106953ns
3: I1016 23:50:24.899891 17244 master.cpp:5207] Processing DECLINE call for offers: [ b42c0c84-5d6a-4a92-87eb-b30a27132367-O3 ] for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.900846 17244 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O3
3: I1016 23:50:24.901007 17244 master.cpp:3439] Processing SUPPRESS call for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.901723 17258 hierarchical.cpp:1161] 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_u4yHVD/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048, allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.901911 17258 hierarchical.cpp:1273] Suppressed offers for roles { default-role } of framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.902349 17251 master.cpp:5312] Processing REVIVE call for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.902505 17251 hierarchical.cpp:1308] Revived offers for roles { default-role } of framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.904247 17251 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.904294 17251 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.651735ms
3: I1016 23:50:24.905114 17245 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.905760 17245 sched.cpp:917] Scheduler::resourceOffers took 128459ns
3: I1016 23:50:24.907444 17263 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O4
3: I1016 23:50:24.907569 17263 master.cpp:4196] Processing ACCEPT call for offers: [ b42c0c84-5d6a-4a92-87eb-b30a27132367-O4 ] on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.907732 17263 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_u4yHVD\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1016 23:50:24.908761 17263 master.cpp:2348] Dropping DESTROY offer operation from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885: Not authorized to destroy persistent volumes as 'test-principal'
3: I1016 23:50:24.910352 17256 hierarchical.cpp:1161] 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_u4yHVD/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048, allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.913528 17253 hierarchical.cpp:2033] No inverse offers to send out!
3: I1016 23:50:24.913571 17253 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.564058ms
3: I1016 23:50:24.914350 17265 master.cpp:7766] Sending 1 offers to framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.914952 17248 sched.cpp:917] Scheduler::resourceOffers took 109156ns
3: I1016 23:50:24.915269 17242 sched.cpp:2005] Asked to stop the driver
3: I1016 23:50:24.915397 17252 sched.cpp:1187] Stopping framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.915649 17257 master.cpp:8447] Processing TEARDOWN call for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.915675 17257 master.cpp:8459] Removing framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.915685 17257 master.cpp:3299] Deactivating framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 (default) at scheduler-d18b0a64-a0fc-4d1e-ba05-afdde62716b7@172.17.0.2:40885
3: I1016 23:50:24.915729 17242 sched.cpp:2005] Asked to stop the driver
3: I1016 23:50:24.915803 17261 hierarchical.cpp:412] Deactivated framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.915828 17244 sched.cpp:1187] Stopping framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.916847 17257 master.cpp:9389] Removing offer b42c0c84-5d6a-4a92-87eb-b30a27132367-O5
3: I1016 23:50:24.917088 17262 slave.cpp:3211] Asked to shut down framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000 by master@172.17.0.2:40885
3: I1016 23:50:24.917116 17262 slave.cpp:3226] Cannot shut down unknown framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.917415 17257 master.cpp:8447] Processing TEARDOWN call for framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.917440 17257 master.cpp:8459] Removing framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.917491 17257 master.cpp:3299] Deactivating framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 (creator-framework) at scheduler-6171d780-c8f2-4a60-b6d0-57aaec448e86@172.17.0.2:40885
3: I1016 23:50:24.917570 17258 hierarchical.cpp:1161] 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_u4yHVD/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_u4yHVD/disk1,id1:path1]:2048, allocated: {}) on agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 from framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.917711 17253 slave.cpp:3211] Asked to shut down framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001 by master@172.17.0.2:40885
3: I1016 23:50:24.917740 17253 slave.cpp:3226] Cannot shut down unknown framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.917798 17258 hierarchical.cpp:355] Removed framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0000
3: I1016 23:50:24.917870 17258 hierarchical.cpp:412] Deactivated framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.918097 17258 hierarchical.cpp:355] Removed framework b42c0c84-5d6a-4a92-87eb-b30a27132367-0001
3: I1016 23:50:24.918325 17252 slave.cpp:869] Agent terminating
3: I1016 23:50:24.918489 17243 master.cpp:1303] Agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319) disconnected
3: I1016 23:50:24.918509 17243 master.cpp:3336] Disconnecting agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.918560 17243 master.cpp:3355] Deactivating agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 at slave(825)@172.17.0.2:40885 (4806542b2319)
3: I1016 23:50:24.918725 17249 hierarchical.cpp:690] Agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0 deactivated
3: I1016 23:50:24.924720 17242 master.cpp:1145] Master terminating
3: I1016 23:50:24.925695 17255 hierarchical.cpp:626] Removed agent b42c0c84-5d6a-4a92-87eb-b30a27132367-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (106 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (12301 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1649 tests from 178 test cases ran. (385578 ms total)
3: [ PASSED ] 1648 tests.
3: [ FAILED ] 1 test, listed below:
3: [ FAILED ] DockerFetcherPluginTest.INTERNET_CURL_FetchBlob
3:
3: 1 FAILED TEST
3: YOU HAVE 21 DISABLED TESTS
3:
3: I1016 23:50:25.002949 17267 process.cpp:1068] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 390.16 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 409.95 sec
The following tests FAILED:
3 - MesosTests (Failed)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1508195584-30999
Untagged: mesos-1508195584-30999:latest
Deleted: sha256:3515a426ed33782fcb7f8fcdd85f6b746856fd139fe3bd8bc615b9579bd54282
Deleted: sha256:2f9f46561005cd1f91296c2cf96bae105fa684cc30252360ad3796c676d8653a
Deleted: sha256:c4aa4b375353f98c029e34b5e2832a7abe813e7a5b8a240b529bb7b028a6ae12
Deleted: sha256:854f6329c3ee478e3ce7e73f26774a5602ec9bc04b71bf8ceaf53cd2a1017e1d
Deleted: sha256:bd8d3cc3216b65870b66dac453b770bed9bcbef96b8f2686f6743a955c3c24c9
Deleted: sha256:dd4f1964022c9aaf26c47374c043b4ab3dba8fdf334352dd7c6ff1d1cb5cff77
Deleted: sha256:bb4c369748c9fc469a02454ff60a6ef563aec442c5e91ff392cd876064e8682f
Deleted: sha256:046da92547f35034801c44b39d225c8d423ab06957d2a72f2f47894ec928ce87
Deleted: sha256:f8d2985e8e5a9b46bfcf14abafefe0624a65ea544d62fb1b719f40c075d8d1b1
Deleted: sha256:d4e320378664ac943f8c4c053bbb66d8a2b7443fa6b606e88a972a983539e17d
Deleted: sha256:50fc9d754382f0290e53c90ce5793dcd8f4101087ba181812007b87b79bbc5ad
Deleted: sha256:9e1330c5cbe6bc29377b27f7bc6d1847cf3ea651560f14eecfea748c9258c278
Deleted: sha256:f23dac6eda5e77cbfa70155d8abb60cbc8657e47585752778638b00547f0fb92
Deleted: sha256:43dc0598e99c523f43c711b02a81b97f813106afcb22a8fc429b977f6f8b925b
Deleted: sha256:5ea8e72c0ccd20c44cb198714b2de937e6c462ca841585a4e4487115676493ac
Deleted: sha256:fdb31f6242c6fda14d61089d91b68471806d9fcf415769dd66096589d72e67d2
Deleted: sha256:06cd21a6d7c617ea33937336856becdea0167d91d9dbd8c8903d80b4a3782d84
Deleted: sha256:3d06c8535293dd51d21ac76f30e37caa785e25b21ab30055b61e6b9e9b55dbd8
Deleted: sha256:b8146d5b95dae6494675ec1a158355864dd4c18b19e55050df4f6313c93deb59
Deleted: sha256:56c3deab6edbc3dd8d02bb501482cb383bc214e905def642e3b62eb34603224f
Deleted: sha256:e940f84312ab45d47a4d69278872839a2c0fbeeea30e7bdac762c64eabdf10ba
Deleted: sha256:481a30f17a4cc9ac373cb7fe02f6084172ac27c2f37c247146c8da11a7c0fbb9
Deleted: sha256:68cb4e7713fd53245610fc1f9e285d62a8f0c20727262ff46edebbfc96357b35
Deleted: sha256:3e1b3d5fc991b16c7c7466270e96690bf0d7ad81d71360b456e1d6d7131629a0
Deleted: sha256:1e78a1b250bfd6f946522a7571d7249b4cd6f2a09ca8858f5bd986cdee442cef
Deleted: sha256:12f7e169e6f52a0f61fdae64407c97cc4adfb4cd04b7c5186861389805854a49
Deleted: sha256:450a210ccc01b1de9a02a0856db38693256fe62bfa18f7e32c4ece0b10741ba8
Deleted: sha256:03c6c49ab7542f5b3665cb04b9385b12fcda9fe9d357f63f6950efd6114ed21f
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) #4330
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)/4330/display/redirect?page=changes>
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) #4329
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)/4329/display/redirect>
------------------------------------------
[...truncated 30.01 MB...]
3: I1017 01:04:38.851800 17256 master.cpp:1687] Recovering from registrar
3: I1017 01:04:38.851940 17248 registrar.cpp:347] Recovering registrar
3: I1017 01:04:38.852527 17250 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1017 01:04:38.852733 17250 registrar.cpp:495] Applied 1 operations in 24984ns; attempting to update the registry
3: I1017 01:04:38.853327 17250 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1017 01:04:38.853453 17250 registrar.cpp:424] Successfully recovered registrar
3: I1017 01:04:38.853874 17247 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1017 01:04:38.853896 17249 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1017 01:04:38.859107 17243 process.cpp:3194] Attempted to spawn already running process files@172.17.0.3:33370
3: I1017 01:04:38.860033 17243 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1017 01:04:38.860570 17243 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1017 01:04:38.860700 17243 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1017 01:04:38.860730 17243 provisioner.cpp:255] Using default backend 'copy'
3: I1017 01:04:38.862650 17243 cluster.cpp:448] Creating default 'local' authorizer
3: I1017 01:04:38.864914 17249 slave.cpp:254] Mesos agent started on (825)@172.17.0.3:33370
3: I1017 01:04:38.864933 17249 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_TbpcKb/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_TbpcKb/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_TbpcKb/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_TbpcKb/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_TbpcKb/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_bigQF2\/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_bigQF2\/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_TbpcKb" --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_WVR0c7" --zk_session_timeout="10secs"
3: I1017 01:04:38.865396 17249 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_TbpcKb/credential'
3: W1017 01:04:38.865526 17243 process.cpp:3194] Attempted to spawn already running process version@172.17.0.3:33370
3: I1017 01:04:38.865568 17249 slave.cpp:287] Agent using credential for: test-principal
3: I1017 01:04:38.865583 17249 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_TbpcKb/http_credentials'
3: I1017 01:04:38.865828 17249 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1017 01:04:38.866010 17249 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1017 01:04:38.866585 17243 sched.cpp:232] Version: 1.5.0
3: I1017 01:04:38.867097 17246 sched.cpp:336] New master detected at master@172.17.0.3:33370
3: I1017 01:04:38.867202 17246 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1017 01:04:38.867215 17246 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.3:33370
3: I1017 01:04:38.867331 17246 sched.cpp:853] Will retry registration in 423.923424ms if necessary
3: I1017 01:04:38.867537 17245 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.867616 17245 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1017 01:04:38.868086 17261 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1017 01:04:38.868654 17266 sched.cpp:747] Framework registered with 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.868719 17266 sched.cpp:761] Scheduler::registered took 25103ns
3: I1017 01:04:38.868824 17255 hierarchical.cpp:303] Added framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.868968 17255 hierarchical.cpp:1943] No allocations performed
3: I1017 01:04:38.869007 17255 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.869035 17255 hierarchical.cpp:1486] Performed allocation for 0 agents in 93766ns
3: I1017 01:04:38.869738 17249 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_bigQF2\/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_bigQF2\/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: I1017 01:04:38.870182 17249 slave.cpp:593] Agent attributes: [ ]
3: I1017 01:04:38.870193 17249 slave.cpp:602] Agent hostname: 27c1ff04f334
3: I1017 01:04:38.870388 17257 status_update_manager.cpp:177] Pausing sending status updates
3: I1017 01:04:38.871984 17267 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_WVR0c7/meta'
3: I1017 01:04:38.872248 17244 status_update_manager.cpp:203] Recovering status update manager
3: I1017 01:04:38.872453 17256 containerizer.cpp:649] Recovering containerizer
3: I1017 01:04:38.874109 17266 provisioner.cpp:416] Provisioner recovery complete
3: I1017 01:04:38.874539 17257 slave.cpp:6310] Finished recovery
3: I1017 01:04:38.875236 17257 slave.cpp:6492] Querying resource estimator for oversubscribable resources
3: I1017 01:04:38.875555 17249 slave.cpp:993] New master detected at master@172.17.0.3:33370
3: I1017 01:04:38.875560 17254 status_update_manager.cpp:177] Pausing sending status updates
3: I1017 01:04:38.875628 17249 slave.cpp:1028] Detecting new master
3: I1017 01:04:38.875735 17249 slave.cpp:6506] Received oversubscribable resources {} from the resource estimator
3: I1017 01:04:38.877311 17251 slave.cpp:1055] Authenticating with master master@172.17.0.3:33370
3: I1017 01:04:38.877370 17251 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1017 01:04:38.877647 17245 authenticatee.cpp:121] Creating new client SASL connection
3: I1017 01:04:38.877724 17252 hierarchical.cpp:1943] No allocations performed
3: I1017 01:04:38.877764 17252 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.877794 17252 hierarchical.cpp:1486] Performed allocation for 0 agents in 107724ns
3: I1017 01:04:38.877969 17248 master.cpp:7936] Authenticating slave(825)@172.17.0.3:33370
3: I1017 01:04:38.878098 17258 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1489)@172.17.0.3:33370
3: I1017 01:04:38.878433 17259 authenticator.cpp:98] Creating new server SASL connection
3: I1017 01:04:38.878687 17246 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1017 01:04:38.878715 17246 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1017 01:04:38.878811 17246 authenticator.cpp:204] Received SASL authentication start
3: I1017 01:04:38.878864 17246 authenticator.cpp:326] Authentication requires more steps
3: I1017 01:04:38.878952 17246 authenticatee.cpp:259] Received SASL authentication step
3: I1017 01:04:38.879052 17246 authenticator.cpp:232] Received SASL authentication step
3: I1017 01:04:38.879076 17246 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '27c1ff04f334' server FQDN: '27c1ff04f334' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1017 01:04:38.879084 17246 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1017 01:04:38.879112 17246 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1017 01:04:38.879129 17246 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '27c1ff04f334' server FQDN: '27c1ff04f334' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1017 01:04:38.879137 17246 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1017 01:04:38.879142 17246 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1017 01:04:38.879153 17246 authenticator.cpp:318] Authentication success
3: I1017 01:04:38.879272 17247 authenticatee.cpp:299] Authentication success
3: I1017 01:04:38.879329 17261 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.3:33370
3: I1017 01:04:38.879357 17246 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1489)@172.17.0.3:33370
3: I1017 01:04:38.879637 17255 slave.cpp:1147] Successfully authenticated with master master@172.17.0.3:33370
3: I1017 01:04:38.879905 17255 slave.cpp:1626] Will retry registration in 6.396983ms if necessary
3: I1017 01:04:38.880117 17263 master.cpp:5801] Received register agent message from slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.880244 17263 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1017 01:04:38.880689 17249 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.880807 17249 master.cpp:5954] Registering agent at slave(825)@172.17.0.3:33370 (27c1ff04f334) with id 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0
3: I1017 01:04:38.881273 17267 registrar.cpp:495] Applied 1 operations in 59495ns; attempting to update the registry
3: I1017 01:04:38.881784 17267 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1017 01:04:38.882019 17245 master.cpp:6001] Admitted agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.882679 17248 slave.cpp:4966] Received ping from slave-observer(741)@172.17.0.3:33370
3: I1017 01:04:38.882838 17248 slave.cpp:1193] Registered with master master@172.17.0.3:33370; given agent ID 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0
3: I1017 01:04:38.882964 17256 status_update_manager.cpp:184] Resuming sending status updates
3: I1017 01:04:38.882746 17245 master.cpp:6032] Registered agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) 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_bigQF2\/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_bigQF2\/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: I1017 01:04:38.883216 17248 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_WVR0c7/meta/slaves/50ca02dd-247d-4097-98cd-3eb720b03ba0-S0/slave.info'
3: I1017 01:04:38.883390 17258 hierarchical.cpp:593] Added agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 (27c1ff04f334) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1017 01:04:38.883672 17248 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1017 01:04:38.883860 17264 master.cpp:6817] Received update of agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) with total oversubscribed resources {}
3: I1017 01:04:38.884135 17264 master.cpp:6828] Ignoring update on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) as it reports no changes
3: I1017 01:04:38.885177 17258 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.885215 17258 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.63615ms
3: I1017 01:04:38.885972 17262 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.886520 17262 sched.cpp:917] Scheduler::resourceOffers took 100473ns
3: I1017 01:04:38.888665 17250 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O0
3: I1017 01:04:38.888828 17250 master.cpp:4196] Processing ACCEPT call for offers: [ 50ca02dd-247d-4097-98cd-3eb720b03ba0-O0 ] on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.889022 17250 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_bigQF2\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1017 01:04:38.890069 17250 master.cpp:2348] Dropping CREATE offer operation from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370: Not authorized to create persistent volumes as 'test-principal'
3: I1017 01:04:38.891518 17263 hierarchical.cpp:1161] 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_bigQF2/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.894557 17249 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.894609 17249 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.485085ms
3: I1017 01:04:38.895339 17253 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.895900 17244 sched.cpp:917] Scheduler::resourceOffers took 98595ns
3: W1017 01:04:38.896574 17243 process.cpp:3194] Attempted to spawn already running process version@172.17.0.3:33370
3: I1017 01:04:38.896651 17251 master.cpp:5207] Processing DECLINE call for offers: [ 50ca02dd-247d-4097-98cd-3eb720b03ba0-O1 ] for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.897279 17243 sched.cpp:232] Version: 1.5.0
3: I1017 01:04:38.897657 17251 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O1
3: I1017 01:04:38.897814 17248 sched.cpp:336] New master detected at master@172.17.0.3:33370
3: I1017 01:04:38.897845 17251 master.cpp:3439] Processing SUPPRESS call for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.897898 17248 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1017 01:04:38.897912 17248 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.3:33370
3: I1017 01:04:38.898000 17248 sched.cpp:853] Will retry registration in 542.834406ms if necessary
3: I1017 01:04:38.898164 17264 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.898227 17264 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1017 01:04:38.898494 17252 hierarchical.cpp:1161] 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_bigQF2/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.898674 17252 hierarchical.cpp:1273] Suppressed offers for roles { default-role } of framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.898747 17262 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1017 01:04:38.899224 17247 hierarchical.cpp:303] Added framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.899277 17246 sched.cpp:747] Framework registered with 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.899320 17246 sched.cpp:761] Scheduler::registered took 25301ns
3: I1017 01:04:38.901087 17247 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.901124 17247 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.760842ms
3: I1017 01:04:38.901839 17260 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.902631 17261 sched.cpp:917] Scheduler::resourceOffers took 186265ns
3: I1017 01:04:38.904376 17250 hierarchical.cpp:1943] No allocations performed
3: I1017 01:04:38.904431 17250 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.904466 17250 hierarchical.cpp:1486] Performed allocation for 1 agents in 190142ns
3: I1017 01:04:38.906277 17249 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O2
3: I1017 01:04:38.906411 17249 master.cpp:4196] Processing ACCEPT call for offers: [ 50ca02dd-247d-4097-98cd-3eb720b03ba0-O2 ] on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.906563 17249 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_bigQF2\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: I1017 01:04:38.907995 17249 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_bigQF2\/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 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370 to agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.908568 17249 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048 to agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.909746 17245 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048
3: I1017 01:04:38.912375 17256 hierarchical.cpp:887] Updated allocation of framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-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_bigQF2/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/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_bigQF2/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048
3: I1017 01:04:38.913877 17256 hierarchical.cpp:1161] 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_bigQF2/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048, allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.916918 17248 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.916963 17248 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.535651ms
3: I1017 01:04:38.917681 17258 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.918293 17264 sched.cpp:917] Scheduler::resourceOffers took 114715ns
3: I1017 01:04:38.918957 17252 master.cpp:5207] Processing DECLINE call for offers: [ 50ca02dd-247d-4097-98cd-3eb720b03ba0-O3 ] for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.920199 17252 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O3
3: I1017 01:04:38.920380 17252 master.cpp:3439] Processing SUPPRESS call for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.921083 17262 hierarchical.cpp:1161] 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_bigQF2/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048, allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.921252 17262 hierarchical.cpp:1273] Suppressed offers for roles { default-role } of framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.921614 17257 master.cpp:5312] Processing REVIVE call for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.921756 17257 hierarchical.cpp:1308] Revived offers for roles { default-role } of framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.923354 17257 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.923391 17257 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.539636ms
3: I1017 01:04:38.924142 17260 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.924765 17261 sched.cpp:917] Scheduler::resourceOffers took 124322ns
3: I1017 01:04:38.926445 17255 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O4
3: I1017 01:04:38.926569 17255 master.cpp:4196] Processing ACCEPT call for offers: [ 50ca02dd-247d-4097-98cd-3eb720b03ba0-O4 ] on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.926710 17255 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_bigQF2\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1017 01:04:38.927659 17255 master.cpp:2348] Dropping DESTROY offer operation from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370: Not authorized to destroy persistent volumes as 'test-principal'
3: I1017 01:04:38.929257 17244 hierarchical.cpp:1161] 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_bigQF2/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048, allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.932235 17249 hierarchical.cpp:2033] No inverse offers to send out!
3: I1017 01:04:38.932286 17249 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.504133ms
3: I1017 01:04:38.933039 17245 master.cpp:7766] Sending 1 offers to framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.933627 17256 sched.cpp:917] Scheduler::resourceOffers took 107208ns
3: I1017 01:04:38.933949 17243 sched.cpp:2005] Asked to stop the driver
3: I1017 01:04:38.934083 17251 sched.cpp:1187] Stopping framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.934343 17248 master.cpp:8447] Processing TEARDOWN call for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.934378 17248 master.cpp:8459] Removing framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.934393 17248 master.cpp:3299] Deactivating framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 (default) at scheduler-89c5afb7-a49e-4a2f-a65c-14fc263ec3d1@172.17.0.3:33370
3: I1017 01:04:38.934399 17243 sched.cpp:2005] Asked to stop the driver
3: I1017 01:04:38.934458 17258 sched.cpp:1187] Stopping framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.934516 17252 hierarchical.cpp:412] Deactivated framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.935439 17248 master.cpp:9389] Removing offer 50ca02dd-247d-4097-98cd-3eb720b03ba0-O5
3: I1017 01:04:38.935650 17265 slave.cpp:3211] Asked to shut down framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000 by master@172.17.0.3:33370
3: I1017 01:04:38.935683 17265 slave.cpp:3226] Cannot shut down unknown framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.936019 17248 master.cpp:8447] Processing TEARDOWN call for framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.936043 17248 master.cpp:8459] Removing framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.936053 17248 master.cpp:3299] Deactivating framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 (creator-framework) at scheduler-88015a88-67f0-417f-b0c6-a94262e9a98d@172.17.0.3:33370
3: I1017 01:04:38.936266 17245 slave.cpp:3211] Asked to shut down framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001 by master@172.17.0.3:33370
3: I1017 01:04:38.936298 17245 slave.cpp:3226] Cannot shut down unknown framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.936230 17257 hierarchical.cpp:1161] 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_bigQF2/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bigQF2/disk1,id1:path1]:2048, allocated: {}) on agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 from framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.936465 17257 hierarchical.cpp:355] Removed framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0000
3: I1017 01:04:38.936518 17257 hierarchical.cpp:412] Deactivated framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.936810 17257 hierarchical.cpp:355] Removed framework 50ca02dd-247d-4097-98cd-3eb720b03ba0-0001
3: I1017 01:04:38.937044 17243 slave.cpp:869] Agent terminating
3: I1017 01:04:38.937201 17262 master.cpp:1303] Agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334) disconnected
3: I1017 01:04:38.937225 17262 master.cpp:3336] Disconnecting agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.937289 17262 master.cpp:3355] Deactivating agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 at slave(825)@172.17.0.3:33370 (27c1ff04f334)
3: I1017 01:04:38.937474 17263 hierarchical.cpp:690] Agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0 deactivated
3: I1017 01:04:38.943198 17243 master.cpp:1145] Master terminating
3: I1017 01:04:38.944239 17259 hierarchical.cpp:626] Removed agent 50ca02dd-247d-4097-98cd-3eb720b03ba0-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (106 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (13611 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1649 tests from 178 test cases ran. (338429 ms total)
3: [ PASSED ] 1648 tests.
3: [ FAILED ] 1 test, listed below:
3: [ FAILED ] MasterTest.IgnoreOldAgentReregistration
3:
3: 1 FAILED TEST
3: YOU HAVE 21 DISABLED TESTS
3:
3: I1017 01:04:39.010540 17268 process.cpp:1068] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 342.86 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 362.76 sec
The following tests FAILED:
3 - MesosTests (Failed)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1508200167-24061
Untagged: mesos-1508200167-24061:latest
Deleted: sha256:85b532888e238014f5d8c2614162063b5146a09d3aa2eedcf7f1da53f23e2a86
Deleted: sha256:c22ecc5a2023ac29238afaf14767e7f1d6df8ec2ad04bb1be9e15d865fde9f2a
Deleted: sha256:d03f511722a3670244e5a516fe1586f7050d5b310a5ba2646e177a4ebb01c9dd
Deleted: sha256:2cefa5b4b443d173536930346f6e32a1599ed83581b37abc7bca9ded5b54fe35
Deleted: sha256:63437f4bb11e621b5ba387c8384dcccec93571391915d2c714116fc96a2f84de
Deleted: sha256:a960d29e617ca83484bea481902738e64b13696a4511dc185339de1ea7f3dbef
Deleted: sha256:7cc5060b03c8a8be8a2b690e7d820c5af666b1d499e517a7a074b72440c17413
Deleted: sha256:d7cd110ca7e5761e3ec21e4db9d651075b3649523e4abc65322511d05a7c8b38
Deleted: sha256:5bba52528ff645d278d805753d8ca8a4b6fc2fb6a053b644beff6f6f2470c69b
Deleted: sha256:bd1a7439b998e78c1cfc26b665be75febfcf820a9a38a4c8b1df5fcc83fbac11
Deleted: sha256:cef53845eb4225a2a0d374bbd53c15738f3a2dfcc6f9174609f110a96e3e8f0e
Deleted: sha256:fe9a1443f88cd61eda2d4503ea27ded1cdf61fffb13acb647f2d8eb3feedd12b
Deleted: sha256:34cfefd1cab0338ae33863640747130497909aa7b0d8454c951d233ad5a09a92
Deleted: sha256:3796a16bbc59519b014382c0a8817306bdcce4d306db04be56fd1769b60aeb82
Deleted: sha256:dad5d1dbd58f8681c72d08d672d4b42a545e498509a7a73a35e639052b803b21
Deleted: sha256:12d6c0b2d0ee6830331433215f09d9e9bc9ade00ab69009394458e9d08869ff4
Deleted: sha256:9c1c723bb8bc5f4047cbe424fd8cb917926950506881ea54498143bdae31d14c
Deleted: sha256:6bee9b6596ea395513f353c5cf19342620cb0afae803b7a681e8416ac8bfcaea
Deleted: sha256:2ace4a8da246e6b107273de81f10e9e417798ad612d02411eab0a0eb2429712b
Deleted: sha256:3aa8e51ae9c27cc0ca8bffe1edb900d19dc538adc505bfcef3679ee36b3a4926
Deleted: sha256:0af8ba927ac1a2146ced570c291f8acf18228be84c0dfe209aaa42facbbf38d8
Deleted: sha256:7a6a3a7caf6ad4dcfb0757f33f7245e6f304cd69431137aff7cc64dbfef4332d
Deleted: sha256:f1b8f18e46df1a4058f74194ed96003da5b56523d40621fd48bed1c844350369
Deleted: sha256:467bcc54bb5f8132ef3444676fcfefb3187005df195f7a8de43640086117421b
Deleted: sha256:40be1f5d611601371443d589c2b46ed43f387664ae10f52ced8a4fd980e0682a
Deleted: sha256:d558be6c93ff88224f31329a36d6e41e8a90371bd3f70d8fc2a2172eb39050a3
Deleted: sha256:d409331a58f9765ea321b0401bbf16b20c0eee8c443e18a79564be9b7adb76b6
Deleted: sha256:8a7c1669a81953e456873bda2801aa7494785364d5d7acd9ad844cfb8bea6ff6
Build step 'Execute shell' marked build as failure