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/18 16:41: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) #4336
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)/4336/display/redirect>
------------------------------------------
[...truncated 30.01 MB...]
3: I1018 16:40:59.612071 17187 master.cpp:631] Authorization enabled
3: W1018 16:40:59.612082 17187 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: I1018 16:40:59.612241 17181 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1018 16:40:59.612953 17194 whitelist_watcher.cpp:77] No whitelist given
3: I1018 16:40:59.614859 17191 master.cpp:2198] Elected as the leading master!
3: I1018 16:40:59.614881 17191 master.cpp:1687] Recovering from registrar
3: I1018 16:40:59.615025 17179 registrar.cpp:347] Recovering registrar
3: I1018 16:40:59.615487 17179 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1018 16:40:59.615566 17179 registrar.cpp:495] Applied 1 operations in 21111ns; attempting to update the registry
3: I1018 16:40:59.616008 17193 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 16:40:59.616107 17193 registrar.cpp:424] Successfully recovered registrar
3: I1018 16:40:59.616411 17193 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1018 16:40:59.616430 17187 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1018 16:40:59.620924 17178 process.cpp:3194] Attempted to spawn already running process files@172.17.0.2:39596
3: I1018 16:40:59.621713 17178 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1018 16:40:59.622145 17178 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1018 16:40:59.622251 17178 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1018 16:40:59.622277 17178 provisioner.cpp:255] Using default backend 'copy'
3: I1018 16:40:59.623864 17178 cluster.cpp:448] Creating default 'local' authorizer
3: I1018 16:40:59.625715 17188 slave.cpp:254] Mesos agent started on (825)@172.17.0.2:39596
3: I1018 16:40:59.625732 17188 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_1XCE8p/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_1XCE8p/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_1XCE8p/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_1XCE8p/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_1XCE8p/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_rX2GHn\/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_rX2GHn\/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_1XCE8p" --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_rikaVT" --zk_session_timeout="10secs"
3: I1018 16:40:59.626045 17188 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_1XCE8p/credential'
3: W1018 16:40:59.626103 17178 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:39596
3: I1018 16:40:59.626847 17178 sched.cpp:232] Version: 1.5.0
3: I1018 16:40:59.627276 17184 sched.cpp:336] New master detected at master@172.17.0.2:39596
3: I1018 16:40:59.627377 17184 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 16:40:59.627393 17184 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:39596
3: I1018 16:40:59.627493 17184 sched.cpp:853] Will retry registration in 1.009308715secs if necessary
3: I1018 16:40:59.627681 17194 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.627758 17194 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1018 16:40:59.628157 17189 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 16:40:59.628679 17189 sched.cpp:747] Framework registered with 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.628720 17189 sched.cpp:761] Scheduler::registered took 20352ns
3: I1018 16:40:59.628800 17186 hierarchical.cpp:303] Added framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.628923 17186 hierarchical.cpp:1945] No allocations performed
3: I1018 16:40:59.628952 17186 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.628976 17186 hierarchical.cpp:1488] Performed allocation for 0 agents in 84034ns
3: I1018 16:40:59.632210 17188 slave.cpp:287] Agent using credential for: test-principal
3: I1018 16:40:59.632226 17188 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_1XCE8p/http_credentials'
3: I1018 16:40:59.632432 17188 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1018 16:40:59.632576 17188 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1018 16:40:59.635586 17188 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_rX2GHn\/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_rX2GHn\/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: I1018 16:40:59.635947 17188 slave.cpp:593] Agent attributes: [ ]
3: I1018 16:40:59.635957 17188 slave.cpp:602] Agent hostname: 5c91845ce467
3: I1018 16:40:59.636107 17194 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 16:40:59.637416 17189 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rikaVT/meta'
3: I1018 16:40:59.637670 17185 status_update_manager.cpp:203] Recovering status update manager
3: I1018 16:40:59.637861 17190 containerizer.cpp:649] Recovering containerizer
3: I1018 16:40:59.639258 17189 provisioner.cpp:416] Provisioner recovery complete
3: I1018 16:40:59.639549 17189 slave.cpp:6310] Finished recovery
3: I1018 16:40:59.639883 17189 slave.cpp:6492] Querying resource estimator for oversubscribable resources
3: I1018 16:40:59.640157 17184 slave.cpp:993] New master detected at master@172.17.0.2:39596
3: I1018 16:40:59.640192 17194 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 16:40:59.640202 17184 slave.cpp:1028] Detecting new master
3: I1018 16:40:59.640317 17184 slave.cpp:6506] Received oversubscribable resources {} from the resource estimator
3: I1018 16:40:59.641887 17192 slave.cpp:1055] Authenticating with master master@172.17.0.2:39596
3: I1018 16:40:59.641942 17192 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1018 16:40:59.642191 17191 authenticatee.cpp:121] Creating new client SASL connection
3: I1018 16:40:59.642212 17188 hierarchical.cpp:1945] No allocations performed
3: I1018 16:40:59.642233 17188 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.642261 17188 hierarchical.cpp:1488] Performed allocation for 0 agents in 77390ns
3: I1018 16:40:59.642455 17182 master.cpp:7936] Authenticating slave(825)@172.17.0.2:39596
3: I1018 16:40:59.642586 17180 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1490)@172.17.0.2:39596
3: I1018 16:40:59.642823 17185 authenticator.cpp:98] Creating new server SASL connection
3: I1018 16:40:59.643018 17186 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1018 16:40:59.643038 17186 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1018 16:40:59.643127 17186 authenticator.cpp:204] Received SASL authentication start
3: I1018 16:40:59.643170 17186 authenticator.cpp:326] Authentication requires more steps
3: I1018 16:40:59.643254 17186 authenticatee.cpp:259] Received SASL authentication step
3: I1018 16:40:59.643347 17186 authenticator.cpp:232] Received SASL authentication step
3: I1018 16:40:59.643369 17186 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5c91845ce467' server FQDN: '5c91845ce467' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1018 16:40:59.643378 17186 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1018 16:40:59.643405 17186 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1018 16:40:59.643421 17186 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5c91845ce467' server FQDN: '5c91845ce467' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1018 16:40:59.643427 17186 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1018 16:40:59.643432 17186 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1018 16:40:59.643442 17186 authenticator.cpp:318] Authentication success
3: I1018 16:40:59.643548 17181 authenticatee.cpp:299] Authentication success
3: I1018 16:40:59.643565 17194 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.2:39596
3: I1018 16:40:59.643602 17187 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1490)@172.17.0.2:39596
3: I1018 16:40:59.643851 17184 slave.cpp:1147] Successfully authenticated with master master@172.17.0.2:39596
3: I1018 16:40:59.644064 17184 slave.cpp:1626] Will retry registration in 12.043697ms if necessary
3: I1018 16:40:59.644251 17191 master.cpp:5801] Received register agent message from slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.644381 17191 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1018 16:40:59.644795 17188 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.644886 17188 master.cpp:5954] Registering agent at slave(825)@172.17.0.2:39596 (5c91845ce467) with id 682b0323-d663-4b39-81aa-392b04510516-S0
3: I1018 16:40:59.645277 17180 registrar.cpp:495] Applied 1 operations in 54403ns; attempting to update the registry
3: I1018 16:40:59.645812 17180 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 16:40:59.646028 17186 master.cpp:6001] Admitted agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.646672 17181 slave.cpp:4966] Received ping from slave-observer(741)@172.17.0.2:39596
3: I1018 16:40:59.646819 17181 slave.cpp:1193] Registered with master master@172.17.0.2:39596; given agent ID 682b0323-d663-4b39-81aa-392b04510516-S0
3: I1018 16:40:59.646915 17192 status_update_manager.cpp:184] Resuming sending status updates
3: I1018 16:40:59.647086 17181 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rikaVT/meta/slaves/682b0323-d663-4b39-81aa-392b04510516-S0/slave.info'
3: I1018 16:40:59.646687 17186 master.cpp:6032] Registered agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) 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_rX2GHn\/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_rX2GHn\/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: I1018 16:40:59.647166 17190 hierarchical.cpp:593] Added agent 682b0323-d663-4b39-81aa-392b04510516-S0 (5c91845ce467) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1018 16:40:59.647439 17181 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1018 16:40:59.647595 17187 master.cpp:6817] Received update of agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) with total oversubscribed resources {}
3: I1018 16:40:59.647877 17187 master.cpp:6828] Ignoring update on agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) as it reports no changes
3: I1018 16:40:59.648847 17190 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.648880 17190 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.575436ms
3: I1018 16:40:59.649602 17184 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.650126 17191 sched.cpp:917] Scheduler::resourceOffers took 91322ns
3: I1018 16:40:59.651691 17182 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O0
3: I1018 16:40:59.651815 17182 master.cpp:4196] Processing ACCEPT call for offers: [ 682b0323-d663-4b39-81aa-392b04510516-O0 ] on agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.651959 17182 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_rX2GHn\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1018 16:40:59.652932 17182 master.cpp:2348] Dropping CREATE offer operation from framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596: Not authorized to create persistent volumes as 'test-principal'
3: I1018 16:40:59.654261 17182 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_rX2GHn/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.657135 17186 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.657173 17186 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.292157ms
3: I1018 16:40:59.657879 17181 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.658354 17187 sched.cpp:917] Scheduler::resourceOffers took 84659ns
3: W1018 16:40:59.658932 17178 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:39596
3: I1018 16:40:59.658967 17184 master.cpp:5207] Processing DECLINE call for offers: [ 682b0323-d663-4b39-81aa-392b04510516-O1 ] for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.659525 17178 sched.cpp:232] Version: 1.5.0
3: I1018 16:40:59.659718 17184 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O1
3: I1018 16:40:59.659847 17184 master.cpp:3439] Processing SUPPRESS call for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.660032 17180 sched.cpp:336] New master detected at master@172.17.0.2:39596
3: I1018 16:40:59.660105 17180 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 16:40:59.660117 17180 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:39596
3: I1018 16:40:59.660200 17180 sched.cpp:853] Will retry registration in 1.738266092secs if necessary
3: I1018 16:40:59.660349 17189 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.660413 17189 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1018 16:40:59.660569 17188 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_rX2GHn/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.660711 17188 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.660753 17193 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 16:40:59.661170 17192 hierarchical.cpp:303] Added framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.661213 17181 sched.cpp:747] Framework registered with 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.661252 17181 sched.cpp:761] Scheduler::registered took 23381ns
3: I1018 16:40:59.662614 17192 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.662648 17192 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.360491ms
3: I1018 16:40:59.663291 17187 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.663743 17190 sched.cpp:917] Scheduler::resourceOffers took 83978ns
3: I1018 16:40:59.665387 17183 hierarchical.cpp:1945] No allocations performed
3: I1018 16:40:59.665421 17183 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.665452 17183 hierarchical.cpp:1488] Performed allocation for 1 agents in 182165ns
3: I1018 16:40:59.666992 17185 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O2
3: I1018 16:40:59.667114 17185 master.cpp:4196] Processing ACCEPT call for offers: [ 682b0323-d663-4b39-81aa-392b04510516-O2 ] on agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) for framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.667253 17185 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_rX2GHn\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: I1018 16:40:59.668506 17185 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_rX2GHn\/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 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596 to agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.669026 17185 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048 to agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.670236 17188 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048
3: I1018 16:40:59.672471 17193 hierarchical.cpp:887] Updated allocation of framework 682b0323-d663-4b39-81aa-392b04510516-0001 on agent 682b0323-d663-4b39-81aa-392b04510516-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_rX2GHn/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/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_rX2GHn/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048
3: I1018 16:40:59.673813 17193 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_rX2GHn/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048, allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.676761 17192 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.676800 17192 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.340352ms
3: I1018 16:40:59.677448 17187 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.677934 17190 sched.cpp:917] Scheduler::resourceOffers took 89429ns
3: I1018 16:40:59.678557 17183 master.cpp:5207] Processing DECLINE call for offers: [ 682b0323-d663-4b39-81aa-392b04510516-O3 ] for framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.679363 17183 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O3
3: I1018 16:40:59.679493 17183 master.cpp:3439] Processing SUPPRESS call for framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.680063 17184 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_rX2GHn/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048, allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.680205 17184 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.680485 17179 master.cpp:5312] Processing REVIVE call for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.680609 17179 hierarchical.cpp:1310] Revived offers for roles { default-role } of framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.682096 17179 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.682130 17179 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.424814ms
3: I1018 16:40:59.682795 17189 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.683264 17182 sched.cpp:917] Scheduler::resourceOffers took 88595ns
3: I1018 16:40:59.684700 17185 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O4
3: I1018 16:40:59.684823 17185 master.cpp:4196] Processing ACCEPT call for offers: [ 682b0323-d663-4b39-81aa-392b04510516-O4 ] on agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.684957 17185 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_rX2GHn\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1018 16:40:59.685860 17185 master.cpp:2348] Dropping DESTROY offer operation from framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596: Not authorized to destroy persistent volumes as 'test-principal'
3: I1018 16:40:59.687221 17190 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_rX2GHn/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048, allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.690135 17183 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 16:40:59.690176 17183 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.368865ms
3: I1018 16:40:59.690827 17184 master.cpp:7766] Sending 1 offers to framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.691298 17184 sched.cpp:917] Scheduler::resourceOffers took 91279ns
3: I1018 16:40:59.691563 17178 sched.cpp:2005] Asked to stop the driver
3: I1018 16:40:59.691704 17180 sched.cpp:1187] Stopping framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.691936 17189 master.cpp:8447] Processing TEARDOWN call for framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.691951 17178 sched.cpp:2005] Asked to stop the driver
3: I1018 16:40:59.691965 17189 master.cpp:8459] Removing framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.691983 17189 master.cpp:3299] Deactivating framework 682b0323-d663-4b39-81aa-392b04510516-0000 (default) at scheduler-6ee9c962-b137-465e-a104-5ea57409def5@172.17.0.2:39596
3: I1018 16:40:59.692065 17193 sched.cpp:1187] Stopping framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.692106 17186 hierarchical.cpp:412] Deactivated framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.692842 17189 master.cpp:9389] Removing offer 682b0323-d663-4b39-81aa-392b04510516-O5
3: I1018 16:40:59.693023 17184 slave.cpp:3211] Asked to shut down framework 682b0323-d663-4b39-81aa-392b04510516-0000 by master@172.17.0.2:39596
3: I1018 16:40:59.693053 17184 slave.cpp:3226] Cannot shut down unknown framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.693334 17189 master.cpp:8447] Processing TEARDOWN call for framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.693361 17189 master.cpp:8459] Removing framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.693377 17189 master.cpp:3299] Deactivating framework 682b0323-d663-4b39-81aa-392b04510516-0001 (creator-framework) at scheduler-98d77977-6ed7-4e47-81f9-10183c6df48e@172.17.0.2:39596
3: I1018 16:40:59.693534 17192 slave.cpp:3211] Asked to shut down framework 682b0323-d663-4b39-81aa-392b04510516-0001 by master@172.17.0.2:39596
3: I1018 16:40:59.693560 17192 slave.cpp:3226] Cannot shut down unknown framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.693730 17193 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_rX2GHn/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_rX2GHn/disk1,id1:path1]:2048, allocated: {}) on agent 682b0323-d663-4b39-81aa-392b04510516-S0 from framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.693960 17193 hierarchical.cpp:355] Removed framework 682b0323-d663-4b39-81aa-392b04510516-0000
3: I1018 16:40:59.694027 17193 hierarchical.cpp:412] Deactivated framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.694299 17193 hierarchical.cpp:355] Removed framework 682b0323-d663-4b39-81aa-392b04510516-0001
3: I1018 16:40:59.694547 17178 slave.cpp:869] Agent terminating
3: I1018 16:40:59.694820 17180 master.cpp:1303] Agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467) disconnected
3: I1018 16:40:59.694846 17180 master.cpp:3336] Disconnecting agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.694928 17180 master.cpp:3355] Deactivating agent 682b0323-d663-4b39-81aa-392b04510516-S0 at slave(825)@172.17.0.2:39596 (5c91845ce467)
3: I1018 16:40:59.695050 17187 hierarchical.cpp:690] Agent 682b0323-d663-4b39-81aa-392b04510516-S0 deactivated
3: I1018 16:40:59.701545 17178 master.cpp:1145] Master terminating
3: I1018 16:40:59.702594 17190 hierarchical.cpp:626] Removed agent 682b0323-d663-4b39-81aa-392b04510516-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (99 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (11820 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1649 tests from 178 test cases ran. (490716 ms total)
3: [ PASSED ] 1648 tests.
3: [ FAILED ] 1 test, listed below:
3: [ FAILED ] SlaveTest.KillTaskUnregisteredHTTPExecutor
3:
3: 1 FAILED TEST
3: YOU HAVE 21 DISABLED TESTS
3:
3: I1018 16:40:59.763814 17195 process.cpp:1068] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 495.84 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 512.68 sec
The following tests FAILED:
3 - MesosTests (Failed)
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[1]: Leaving directory `/mesos/build'
+ docker rmi mesos-1508342140-9125
Untagged: mesos-1508342140-9125:latest
Deleted: sha256:54d5680f6ff8ab671fda19683ae20e5a6ffc4fca6c1aa26b9a99477a1fedb3c3
Deleted: sha256:03ca32965f1185f128d7cfe811e283f5d4558650411eaf3879ffcdfcecd6eb89
Deleted: sha256:3c9bef449d01f32b74cea8aae04d3efc99eda83d963d02f3bcc40552d993982a
Deleted: sha256:19357651145dc77d2dda303a8d8875e4799e181fc22590b3d43af8fda48a568f
Deleted: sha256:6a6cd3e37e00b34677267c1b3b0e088e5948b0b892164352f74dd1a5d9530309
Deleted: sha256:e5a59fbba26f319097bc4ef84d31465b87e5fd92c3e39d74e27d45eebb4d354e
Deleted: sha256:61bb2f1cba751419b60e7bce651205240e1fde1d419f13692f0822cedc111631
Deleted: sha256:c618dca4a08ee15f0b5af71e7468cb3d675a7fd88208ca62a28cb1e2311ce2ee
Deleted: sha256:de3e12511c2a62c96e02e21b2475f3e4ad53e9b95654a88759f10ac87811413e
Deleted: sha256:02fc7f318e46cbfdeabe1ce0579618bd6982d8ce8d9c036d45b817db3296fed2
Deleted: sha256:90465f99008f4b2e2fd0c697e8c28c94615fc5aac5ed9e287daa5243b19e5d91
Deleted: sha256:6d3808675c233e322d0896143baf1f6721e063ed5b3c4d4f81356cbaefd5258d
Deleted: sha256:4898a0bed17b1a17fedb94307ce1a085880498ee159c1ca518b50a93cae700b5
Deleted: sha256:161c9fc878bf17be2c2f1d6689be74d2a1d4ef965a45bdcac3a38e7e8b18ebc3
Deleted: sha256:dd799049c94b4a47c68d5c5ffb5cdc1c224acf1801fd547dbaefb345dc6cc00d
Deleted: sha256:ab564b216bb180a361bec66271a3b1812bced5763e322294fe1348d3bbab7761
Deleted: sha256:4dc276c2fa2f33b1e3289c447024b1191f278b33be69b0fea32e2582551462fa
Deleted: sha256:4893b5bbc4b6457af986b6154aea96a8d54fd101e5aec1449f9c79c4ee70dc48
Deleted: sha256:d71ef267eac3708a7249a832d74c5e01430e05e2b685ec906e4c063887638890
Deleted: sha256:112c2cd2ea82918abdbf54acaff3ba57bac19d3d554f61e6a8a8215479fb510a
Deleted: sha256:e35a416cd376ba7f96c5123858d71f8cd29608400e0830db747033f5176b41a4
Deleted: sha256:2f605cba7d967175c39d25360455db14cca4e242ef486c5ae6550b67241ef252
Deleted: sha256:78c4af33c50135e960c3b2efe25dd20e1605d8063c518e314373df6b9434c17e
Deleted: sha256:42e92bbb398f826901ed06646d22f50b99656c23ec7f87b2773ffb75aac64bfa
Deleted: sha256:67164dc6555c0ede31f59ea9f692118f12f21f18c6b0172c3c1973a1886dff4b
Deleted: sha256:cbbc963c606a4ce8dce84f586fb3ecf736bb8fa1bf7334984bc478b28c6acd4a
Deleted: sha256:7fa1ba959504a9b2a633f424ef4b10cc9e06c302b1d5f7159dab54abbc2e3e04
Deleted: sha256:eba7221a278cd8eb4116c87b33d0ca4c1e37883a5831b784733e4bc2e843395a
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) #4338
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)/4338/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) #4337
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)/4337/display/redirect?page=changes>
Changes:
[alexander] Updated jQuery and Angular versions used in Makefile.am.
------------------------------------------
[...truncated 30.01 MB...]
3: I1018 17:42:45.358240 17255 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1018 17:42:45.358266 17249 whitelist_watcher.cpp:77] No whitelist given
3: I1018 17:42:45.360599 17243 master.cpp:2198] Elected as the leading master!
3: I1018 17:42:45.360620 17243 master.cpp:1687] Recovering from registrar
3: I1018 17:42:45.360852 17245 registrar.cpp:347] Recovering registrar
3: I1018 17:42:45.361389 17245 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1018 17:42:45.361495 17245 registrar.cpp:495] Applied 1 operations in 35741ns; attempting to update the registry
3: I1018 17:42:45.361999 17245 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 17:42:45.362104 17245 registrar.cpp:424] Successfully recovered registrar
3: I1018 17:42:45.362419 17253 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1018 17:42:45.362460 17261 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1018 17:42:45.367498 17242 process.cpp:3194] Attempted to spawn already running process files@172.17.0.2:39789
3: I1018 17:42:45.368237 17242 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1018 17:42:45.368659 17242 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1018 17:42:45.368769 17242 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1018 17:42:45.368794 17242 provisioner.cpp:255] Using default backend 'copy'
3: I1018 17:42:45.370934 17242 cluster.cpp:448] Creating default 'local' authorizer
3: I1018 17:42:45.373438 17253 slave.cpp:254] Mesos agent started on (825)@172.17.0.2:39789
3: I1018 17:42:45.373461 17253 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_4AUaA5/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_4AUaA5/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_4AUaA5/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_4AUaA5/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_4AUaA5/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_yVgruX\/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_yVgruX\/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_4AUaA5" --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_bvyixw" --zk_session_timeout="10secs"
3: I1018 17:42:45.373980 17253 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_4AUaA5/credential'
3: W1018 17:42:45.374142 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:39789
3: I1018 17:42:45.374261 17253 slave.cpp:287] Agent using credential for: test-principal
3: I1018 17:42:45.374358 17253 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_4AUaA5/http_credentials'
3: I1018 17:42:45.374714 17253 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1018 17:42:45.375097 17253 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1018 17:42:45.375262 17242 sched.cpp:232] Version: 1.5.0
3: I1018 17:42:45.375964 17249 sched.cpp:336] New master detected at master@172.17.0.2:39789
3: I1018 17:42:45.376121 17249 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 17:42:45.376134 17249 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:39789
3: I1018 17:42:45.376269 17249 sched.cpp:853] Will retry registration in 113.980039ms if necessary
3: I1018 17:42:45.376533 17260 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.376627 17260 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1018 17:42:45.377197 17265 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 17:42:45.378023 17265 sched.cpp:747] Framework registered with 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.378077 17265 sched.cpp:761] Scheduler::registered took 29800ns
3: I1018 17:42:45.378142 17254 hierarchical.cpp:303] Added framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.378338 17254 hierarchical.cpp:1945] No allocations performed
3: I1018 17:42:45.378378 17254 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.378410 17254 hierarchical.cpp:1488] Performed allocation for 0 agents in 116232ns
3: I1018 17:42:45.380026 17253 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_yVgruX\/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_yVgruX\/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: I1018 17:42:45.380616 17253 slave.cpp:593] Agent attributes: [ ]
3: I1018 17:42:45.380628 17253 slave.cpp:602] Agent hostname: 43923b9b65a2
3: I1018 17:42:45.380882 17245 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 17:42:45.383206 17253 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bvyixw/meta'
3: I1018 17:42:45.383586 17264 status_update_manager.cpp:203] Recovering status update manager
3: I1018 17:42:45.383785 17249 containerizer.cpp:649] Recovering containerizer
3: I1018 17:42:45.385519 17248 provisioner.cpp:416] Provisioner recovery complete
3: I1018 17:42:45.385960 17252 slave.cpp:6310] Finished recovery
3: I1018 17:42:45.386706 17252 slave.cpp:6492] Querying resource estimator for oversubscribable resources
3: I1018 17:42:45.387020 17252 slave.cpp:6506] Received oversubscribable resources {} from the resource estimator
3: I1018 17:42:45.387230 17252 slave.cpp:993] New master detected at master@172.17.0.2:39789
3: I1018 17:42:45.387295 17252 slave.cpp:1028] Detecting new master
3: I1018 17:42:45.387435 17252 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 17:42:45.389129 17253 slave.cpp:1055] Authenticating with master master@172.17.0.2:39789
3: I1018 17:42:45.389221 17253 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1018 17:42:45.389534 17256 authenticatee.cpp:121] Creating new client SASL connection
3: I1018 17:42:45.389608 17260 hierarchical.cpp:1945] No allocations performed
3: I1018 17:42:45.389643 17260 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.389677 17260 hierarchical.cpp:1488] Performed allocation for 0 agents in 131071ns
3: I1018 17:42:45.389904 17256 master.cpp:7936] Authenticating slave(825)@172.17.0.2:39789
3: I1018 17:42:45.390076 17256 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1491)@172.17.0.2:39789
3: I1018 17:42:45.390450 17256 authenticator.cpp:98] Creating new server SASL connection
3: I1018 17:42:45.390686 17263 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1018 17:42:45.390707 17263 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1018 17:42:45.390808 17263 authenticator.cpp:204] Received SASL authentication start
3: I1018 17:42:45.390866 17263 authenticator.cpp:326] Authentication requires more steps
3: I1018 17:42:45.390970 17249 authenticatee.cpp:259] Received SASL authentication step
3: I1018 17:42:45.391170 17261 authenticator.cpp:232] Received SASL authentication step
3: I1018 17:42:45.391199 17261 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '43923b9b65a2' server FQDN: '43923b9b65a2' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1018 17:42:45.391211 17261 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1018 17:42:45.391248 17261 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1018 17:42:45.391265 17261 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '43923b9b65a2' server FQDN: '43923b9b65a2' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1018 17:42:45.391273 17261 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1018 17:42:45.391280 17261 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1018 17:42:45.391294 17261 authenticator.cpp:318] Authentication success
3: I1018 17:42:45.391444 17265 authenticatee.cpp:299] Authentication success
3: I1018 17:42:45.391475 17266 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.2:39789
3: I1018 17:42:45.391491 17261 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1491)@172.17.0.2:39789
3: I1018 17:42:45.391840 17266 slave.cpp:1147] Successfully authenticated with master master@172.17.0.2:39789
3: I1018 17:42:45.392156 17266 slave.cpp:1626] Will retry registration in 9.828469ms if necessary
3: I1018 17:42:45.392395 17258 master.cpp:5801] Received register agent message from slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.392545 17258 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1018 17:42:45.393095 17246 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.393218 17246 master.cpp:5954] Registering agent at slave(825)@172.17.0.2:39789 (43923b9b65a2) with id 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0
3: I1018 17:42:45.393712 17250 registrar.cpp:495] Applied 1 operations in 82593ns; attempting to update the registry
3: I1018 17:42:45.394487 17250 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 17:42:45.394817 17256 master.cpp:6001] Admitted agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.395736 17263 slave.cpp:4966] Received ping from slave-observer(741)@172.17.0.2:39789
3: I1018 17:42:45.395885 17263 slave.cpp:1193] Registered with master master@172.17.0.2:39789; given agent ID 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0
3: I1018 17:42:45.396281 17263 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_bvyixw/meta/slaves/7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0/slave.info'
3: I1018 17:42:45.395745 17256 master.cpp:6032] Registered agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) 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_yVgruX\/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_yVgruX\/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: I1018 17:42:45.396760 17263 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1018 17:42:45.396960 17263 master.cpp:6817] Received update of agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) with total oversubscribed resources {}
3: I1018 17:42:45.397048 17256 hierarchical.cpp:593] Added agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 (43923b9b65a2) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1018 17:42:45.397238 17263 master.cpp:6828] Ignoring update on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) as it reports no changes
3: I1018 17:42:45.396764 17257 status_update_manager.cpp:184] Resuming sending status updates
3: I1018 17:42:45.399142 17256 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.399185 17256 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.957491ms
3: I1018 17:42:45.400099 17248 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.400846 17251 sched.cpp:917] Scheduler::resourceOffers took 133241ns
3: I1018 17:42:45.402895 17262 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O0
3: I1018 17:42:45.403069 17262 master.cpp:4196] Processing ACCEPT call for offers: [ 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O0 ] on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.403298 17262 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_yVgruX\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1018 17:42:45.404667 17262 master.cpp:2348] Dropping CREATE offer operation from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789: Not authorized to create persistent volumes as 'test-principal'
3: I1018 17:42:45.406411 17258 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_yVgruX/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.410233 17246 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.410300 17246 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.890683ms
3: I1018 17:42:45.411149 17253 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.411890 17259 sched.cpp:917] Scheduler::resourceOffers took 137611ns
3: I1018 17:42:45.412634 17260 master.cpp:5207] Processing DECLINE call for offers: [ 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O1 ] for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: W1018 17:42:45.412799 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:39789
3: I1018 17:42:45.413653 17260 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O1
3: I1018 17:42:45.413754 17242 sched.cpp:232] Version: 1.5.0
3: I1018 17:42:45.413832 17260 master.cpp:3439] Processing SUPPRESS call for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.414465 17263 sched.cpp:336] New master detected at master@172.17.0.2:39789
3: I1018 17:42:45.414584 17263 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 17:42:45.414599 17263 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:39789
3: I1018 17:42:45.414702 17263 sched.cpp:853] Will retry registration in 621.228473ms if necessary
3: I1018 17:42:45.415002 17256 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.414921 17249 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_yVgruX/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.415084 17256 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1018 17:42:45.415171 17249 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.415580 17251 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 17:42:45.416045 17265 hierarchical.cpp:303] Added framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.417978 17265 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.418017 17265 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.843659ms
3: I1018 17:42:45.418407 17252 sched.cpp:747] Framework registered with 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.418455 17252 sched.cpp:761] Scheduler::registered took 26431ns
3: I1018 17:42:45.419458 17251 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.420126 17244 sched.cpp:917] Scheduler::resourceOffers took 129648ns
3: I1018 17:42:45.422121 17262 hierarchical.cpp:1945] No allocations performed
3: I1018 17:42:45.422165 17262 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.422240 17262 hierarchical.cpp:1488] Performed allocation for 1 agents in 260216ns
3: I1018 17:42:45.424417 17258 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O2
3: I1018 17:42:45.424549 17258 master.cpp:4196] Processing ACCEPT call for offers: [ 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O2 ] on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.424752 17258 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_yVgruX\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: I1018 17:42:45.426610 17258 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_yVgruX\/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 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789 to agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.427235 17258 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048 to agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.428740 17260 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048
3: I1018 17:42:45.431720 17243 hierarchical.cpp:887] Updated allocation of framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-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_yVgruX/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/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_yVgruX/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048
3: I1018 17:42:45.433501 17243 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_yVgruX/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048, allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.437079 17263 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.438055 17257 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.438184 17263 hierarchical.cpp:1488] Performed allocation for 1 agents in 2.948825ms
3: I1018 17:42:45.438935 17257 sched.cpp:917] Scheduler::resourceOffers took 136614ns
3: I1018 17:42:45.439741 17249 master.cpp:5207] Processing DECLINE call for offers: [ 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O3 ] for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.441123 17249 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O3
3: I1018 17:42:45.441536 17249 master.cpp:3439] Processing SUPPRESS call for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.441951 17248 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_yVgruX/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048, allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.442136 17248 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.442476 17261 master.cpp:5312] Processing REVIVE call for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.442605 17252 hierarchical.cpp:1310] Revived offers for roles { default-role } of framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.444488 17252 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.444525 17252 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.813157ms
3: I1018 17:42:45.445425 17252 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.446013 17244 sched.cpp:917] Scheduler::resourceOffers took 122821ns
3: I1018 17:42:45.447788 17266 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O4
3: I1018 17:42:45.447916 17266 master.cpp:4196] Processing ACCEPT call for offers: [ 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O4 ] on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.448071 17266 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_yVgruX\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
3: W1018 17:42:45.449146 17266 master.cpp:2348] Dropping DESTROY offer operation from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789: Not authorized to destroy persistent volumes as 'test-principal'
3: I1018 17:42:45.450934 17266 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_yVgruX/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048, allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.454324 17258 hierarchical.cpp:2035] No inverse offers to send out!
3: I1018 17:42:45.454367 17258 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.814201ms
3: I1018 17:42:45.455135 17260 master.cpp:7766] Sending 1 offers to framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.455736 17243 sched.cpp:917] Scheduler::resourceOffers took 116520ns
3: I1018 17:42:45.456082 17242 sched.cpp:2005] Asked to stop the driver
3: I1018 17:42:45.456182 17254 sched.cpp:1187] Stopping framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.456429 17263 master.cpp:8447] Processing TEARDOWN call for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.456452 17263 master.cpp:8459] Removing framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.456462 17263 master.cpp:3299] Deactivating framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 (default) at scheduler-5b3cdd34-ff73-47c0-9178-3b0e0905e85e@172.17.0.2:39789
3: I1018 17:42:45.456630 17242 sched.cpp:2005] Asked to stop the driver
3: I1018 17:42:45.456635 17254 hierarchical.cpp:412] Deactivated framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.456830 17249 sched.cpp:1187] Stopping framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.457406 17263 master.cpp:9389] Removing offer 7f1dad50-6eef-41d4-8e5a-8725a637aee6-O5
3: I1018 17:42:45.457797 17263 master.cpp:8447] Processing TEARDOWN call for framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.457816 17263 master.cpp:8459] Removing framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.457825 17263 master.cpp:3299] Deactivating framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 (creator-framework) at scheduler-e0344f20-baac-429d-9d87-036701e8761e@172.17.0.2:39789
3: I1018 17:42:45.457898 17251 slave.cpp:3211] Asked to shut down framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000 by master@172.17.0.2:39789
3: I1018 17:42:45.457921 17251 slave.cpp:3226] Cannot shut down unknown framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.458001 17251 slave.cpp:3211] Asked to shut down framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001 by master@172.17.0.2:39789
3: I1018 17:42:45.458024 17251 slave.cpp:3226] Cannot shut down unknown framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.458503 17248 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_yVgruX/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_yVgruX/disk1,id1:path1]:2048, allocated: {}) on agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 from framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.458715 17248 hierarchical.cpp:355] Removed framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0000
3: I1018 17:42:45.458770 17248 hierarchical.cpp:412] Deactivated framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.458974 17248 hierarchical.cpp:355] Removed framework 7f1dad50-6eef-41d4-8e5a-8725a637aee6-0001
3: I1018 17:42:45.459194 17242 slave.cpp:869] Agent terminating
3: I1018 17:42:45.459367 17243 master.cpp:1303] Agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2) disconnected
3: I1018 17:42:45.459389 17243 master.cpp:3336] Disconnecting agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.459442 17243 master.cpp:3355] Deactivating agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 at slave(825)@172.17.0.2:39789 (43923b9b65a2)
3: I1018 17:42:45.459576 17261 hierarchical.cpp:690] Agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0 deactivated
3: I1018 17:42:45.464542 17246 master.cpp:1145] Master terminating
3: I1018 17:42:45.465523 17248 hierarchical.cpp:626] Removed agent 7f1dad50-6eef-41d4-8e5a-8725a637aee6-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (118 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (11565 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1649 tests from 178 test cases ran. (343644 ms total)
3: [ PASSED ] 1647 tests.
3: [ FAILED ] 2 tests, listed below:
3: [ FAILED ] MasterTest.IgnoreOldAgentReregistration
3: [ FAILED ] OversubscriptionTest.RescindRevocableOfferWithIncreasedRevocable
3:
3: 2 FAILED TESTS
3: YOU HAVE 21 DISABLED TESTS
3:
3: I1018 17:42:45.533776 17267 process.cpp:1068] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 348.85 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 368.97 sec
The following tests FAILED:
3 - MesosTests (Failed)
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[1]: Leaving directory `/mesos/build'
+ docker rmi mesos-1508346185-6646
Untagged: mesos-1508346185-6646:latest
Deleted: sha256:25cbf4c2b73b6fe32d218cf180306c1ec5029d564a46a058d397ad6fdecd8d88
Deleted: sha256:27bf5624618ea3fe02b9f2d3b611a444cc0d589653c5582c3974757405e6bda4
Deleted: sha256:a746adc1e7c7c22cb3a38eae8044befd5aae3d38674661991385d2c4d18beba5
Deleted: sha256:12ef947c3ce468fef0a2e0f6af8dec49680e6fcfa4e63ce4797d466c8cad1501
Deleted: sha256:fd3b49a5870ca96433320d005ed07b3c7abd2b6be0748a65a4d702b7db487780
Deleted: sha256:a0e9e9b45c3a6b1b9a12d279a6d221b23dbab37a0914263ae895b2a4b077783a
Deleted: sha256:9fc6989062d57134d4a50c9a3a1189f6fc35dc86bcf2263d844fd278bcc6ea2f
Deleted: sha256:c8f9e6f2592d12cad13e4ac8d3c4546453c9a2f8d35a929baed237ee3168b3af
Deleted: sha256:31ab46bf94b92ab69b2ebd9bebba267e33f3c111f56f7af5fe0c96c03b25f89c
Deleted: sha256:bb1deea171dfef5445c7f13ba19dfc313e08e6c8735446c1cd58fbb959d7543c
Deleted: sha256:7cb78c49c82765bec1afd78969a56210f5f71d78581f1e41452705f38e28b2cd
Deleted: sha256:a4451ee79a1a63150c535bcf8e4548e6fbf7ae4c892a78e7a431b836becf3994
Deleted: sha256:a9a037295c64d9428c299796303374f61d2aaeb66020096678c6a6d58937e38c
Deleted: sha256:6ff245dccddd6f5692eed0e5ee4c12ebf9b37c30a72f12bb81e2fb4e172903ec
Deleted: sha256:5637d7d1b895a6d690b020e2936dc9d99113840e36dc0cf569ac56facd1c432d
Deleted: sha256:d08ebd100d7b07d70d72e7e77d277ed41fe7e2a3883d01132ce18c2e944c58ed
Deleted: sha256:ddcb374328e493c76ceb5e6eaf7efeddabfc09a99672f658795f7c1bfa496134
Deleted: sha256:f0bb24938a905bd96c5aa84939029b238636ed06f8dcebfd5f9509f5416e6a88
Deleted: sha256:97a4b592dde8054b4aebb25e263194554b097f91016bdb3885f09b461908d492
Deleted: sha256:5d087174115d654488263d17333af15cea4e128b7cc27cbd9bacdaac9e17983b
Deleted: sha256:ad12f5c1b62b4df075322a462fe25101b45cb54c20c7ca692760eccd560c847d
Deleted: sha256:3199e2dc9bbf57267301c589bf9aae1bbf15a248542f5eb307e6d4ca007fbf4f
Deleted: sha256:b096690497cdba52cf16d419d0eaea43b4eeeac02c527b2b8e08b2591af1cc31
Deleted: sha256:ba66ebbfd75643fb931d63147dedc88a095bcb71040cea009a21b4c28837e6ca
Deleted: sha256:53ce60e1a09b99d6e77a4ee3074b4d5c80c125adf52b70ab1590dfe4c540aa65
Deleted: sha256:74654e9bccd004f3345c71047ec9bb41193222e0df1f203b27b0d908ac42ac08
Deleted: sha256:f9d53501aeebab9ce139d20266adbb559b7e9ef1e4ce57b8c31043605f71cb14
Deleted: sha256:45b97d060de47d639c16448cba5fa88cdd3a1a63fe5489a178b2d56e5b40c30e
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user alexander@mesosphere.io