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 20:59:35 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) #4339
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)/4339/display/redirect?page=changes>
Changes:
[bmahler] Mesos UI: fixed use of undefined variable for the pailer title.
[alexr] Fixed flakyness in 'SlaveTest.ExecutorShutdownGracePeriod'.
[alexr] Removed a stray trailing parenthesis from a validation error.
[alexr] Send TASK_STARTING from the built-in executors.
[alexr] Fix unit tests that were broken by the additional TASK_STARTING update.
------------------------------------------
[...truncated 29.96 MB...]
3: type: ANY
3: }
3: creator_principals {
3: type: NONE
3: }
3: }
3: " --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="false" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/ttScsC/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --roles="default-role" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/ttScsC/master" --zk_session_timeout="10secs"
3: I1018 20:57:11.018616 17266 master.cpp:498] Master allowing unauthenticated frameworks to register
3: I1018 20:57:11.018630 17266 master.cpp:502] Master only allowing authenticated agents to register
3: I1018 20:57:11.018636 17266 master.cpp:508] Master only allowing authenticated HTTP frameworks to register
3: I1018 20:57:11.018653 17266 credentials.hpp:37] Loading credentials for authentication from '/tmp/ttScsC/credentials'
3: I1018 20:57:11.018965 17266 master.cpp:552] Using default 'crammd5' authenticator
3: I1018 20:57:11.019197 17266 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1018 20:57:11.019455 17266 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1018 20:57:11.019587 17266 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1018 20:57:11.019776 17266 master.cpp:631] Authorization enabled
3: W1018 20:57:11.019790 17266 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 20:57:11.019937 17247 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1018 20:57:11.020020 17255 whitelist_watcher.cpp:77] No whitelist given
3: I1018 20:57:11.023324 17256 master.cpp:2198] Elected as the leading master!
3: I1018 20:57:11.023347 17256 master.cpp:1687] Recovering from registrar
3: I1018 20:57:11.023433 17258 registrar.cpp:347] Recovering registrar
3: I1018 20:57:11.023967 17258 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
3: I1018 20:57:11.024075 17258 registrar.cpp:495] Applied 1 operations in 21069ns; attempting to update the registry
3: I1018 20:57:11.024623 17258 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 20:57:11.024793 17258 registrar.cpp:424] Successfully recovered registrar
3: I1018 20:57:11.025190 17244 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1018 20:57:11.025200 17254 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1018 20:57:11.031368 17242 process.cpp:3194] Attempted to spawn already running process files@172.17.0.2:34475
3: I1018 20:57:11.032361 17242 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1018 20:57:11.032980 17242 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1018 20:57:11.033110 17242 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1018 20:57:11.033145 17242 provisioner.cpp:255] Using default backend 'copy'
3: I1018 20:57:11.035218 17242 cluster.cpp:448] Creating default 'local' authorizer
3: I1018 20:57:11.037655 17254 slave.cpp:254] Mesos agent started on (825)@172.17.0.2:34475
3: I1018 20:57:11.037688 17254 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_B86Rz6/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_B86Rz6/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_B86Rz6/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_B86Rz6/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_B86Rz6/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_hw9MNr\/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_hw9MNr\/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_B86Rz6" --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_5R1Obh" --zk_session_timeout="10secs"
3: I1018 20:57:11.038134 17254 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_B86Rz6/credential'
3: W1018 20:57:11.038146 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:34475
3: I1018 20:57:11.038276 17254 slave.cpp:287] Agent using credential for: test-principal
3: I1018 20:57:11.038293 17254 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_B86Rz6/http_credentials'
3: I1018 20:57:11.038517 17254 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1018 20:57:11.038671 17254 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1018 20:57:11.039149 17242 sched.cpp:232] Version: 1.5.0
3: I1018 20:57:11.039553 17266 sched.cpp:336] New master detected at master@172.17.0.2:34475
3: I1018 20:57:11.039641 17266 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 20:57:11.039655 17266 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:34475
3: I1018 20:57:11.039741 17266 sched.cpp:853] Will retry registration in 423.923424ms if necessary
3: I1018 20:57:11.039952 17260 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.040020 17260 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1018 20:57:11.040422 17259 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 20:57:11.040920 17259 sched.cpp:747] Framework registered with 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.040976 17259 sched.cpp:761] Scheduler::registered took 36404ns
3: I1018 20:57:11.041052 17264 hierarchical.cpp:303] Added framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.041203 17264 hierarchical.cpp:1488] Performed allocation for 0 agents in 48660ns
3: I1018 20:57:11.042040 17254 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_hw9MNr\/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_hw9MNr\/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 20:57:11.042440 17254 slave.cpp:593] Agent attributes: [ ]
3: I1018 20:57:11.042451 17254 slave.cpp:602] Agent hostname: bef6cf64d449
3: I1018 20:57:11.042585 17244 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 20:57:11.044019 17250 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_5R1Obh/meta'
3: I1018 20:57:11.044368 17247 status_update_manager.cpp:203] Recovering status update manager
3: I1018 20:57:11.044560 17247 containerizer.cpp:649] Recovering containerizer
3: I1018 20:57:11.046169 17243 provisioner.cpp:416] Provisioner recovery complete
3: I1018 20:57:11.046566 17244 slave.cpp:6310] Finished recovery
3: I1018 20:57:11.047443 17249 slave.cpp:993] New master detected at master@172.17.0.2:34475
3: I1018 20:57:11.047458 17254 status_update_manager.cpp:177] Pausing sending status updates
3: I1018 20:57:11.047493 17249 slave.cpp:1028] Detecting new master
3: I1018 20:57:11.049372 17250 slave.cpp:1055] Authenticating with master master@172.17.0.2:34475
3: I1018 20:57:11.049438 17250 slave.cpp:1064] Using default CRAM-MD5 authenticatee
3: I1018 20:57:11.049657 17245 hierarchical.cpp:1488] Performed allocation for 0 agents in 99958ns
3: I1018 20:57:11.049707 17266 authenticatee.cpp:121] Creating new client SASL connection
3: I1018 20:57:11.050091 17245 master.cpp:7936] Authenticating slave(825)@172.17.0.2:34475
3: I1018 20:57:11.050272 17261 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1490)@172.17.0.2:34475
3: I1018 20:57:11.050514 17260 authenticator.cpp:98] Creating new server SASL connection
3: I1018 20:57:11.050779 17256 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1018 20:57:11.050803 17256 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1018 20:57:11.050904 17256 authenticator.cpp:204] Received SASL authentication start
3: I1018 20:57:11.050953 17256 authenticator.cpp:326] Authentication requires more steps
3: I1018 20:57:11.051043 17256 authenticatee.cpp:259] Received SASL authentication step
3: I1018 20:57:11.051177 17252 authenticator.cpp:232] Received SASL authentication step
3: I1018 20:57:11.051205 17252 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bef6cf64d449' server FQDN: 'bef6cf64d449' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1018 20:57:11.051214 17252 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1018 20:57:11.051239 17252 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1018 20:57:11.051254 17252 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bef6cf64d449' server FQDN: 'bef6cf64d449' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1018 20:57:11.051259 17252 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1018 20:57:11.051265 17252 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1018 20:57:11.051276 17252 authenticator.cpp:318] Authentication success
3: I1018 20:57:11.051422 17246 authenticatee.cpp:299] Authentication success
3: I1018 20:57:11.051486 17263 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.2:34475
3: I1018 20:57:11.051501 17252 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1490)@172.17.0.2:34475
3: I1018 20:57:11.051678 17246 slave.cpp:1147] Successfully authenticated with master master@172.17.0.2:34475
3: I1018 20:57:11.051893 17246 slave.cpp:1626] Will retry registration in 6.396983ms if necessary
3: I1018 20:57:11.052116 17262 master.cpp:5801] Received register agent message from slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.052258 17262 master.cpp:3838] Authorizing agent with principal 'test-principal'
3: I1018 20:57:11.052781 17253 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.052933 17253 master.cpp:5954] Registering agent at slave(825)@172.17.0.2:34475 (bef6cf64d449) with id 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0
3: I1018 20:57:11.053447 17249 registrar.cpp:495] Applied 1 operations in 62984ns; attempting to update the registry
3: I1018 20:57:11.054049 17249 registrar.cpp:552] Successfully updated the registry in 0ns
3: I1018 20:57:11.054265 17257 master.cpp:6001] Admitted agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.055028 17266 slave.cpp:1193] Registered with master master@172.17.0.2:34475; given agent ID 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0
3: I1018 20:57:11.055168 17247 status_update_manager.cpp:184] Resuming sending status updates
3: I1018 20:57:11.055325 17266 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_5R1Obh/meta/slaves/529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0/slave.info'
3: I1018 20:57:11.054966 17257 master.cpp:6032] Registered agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) 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_hw9MNr\/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_hw9MNr\/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 20:57:11.055528 17261 hierarchical.cpp:593] Added agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 (bef6cf64d449) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; ports:[31000-32000] (allocated: {})
3: I1018 20:57:11.055732 17266 slave.cpp:1262] Forwarding total oversubscribed resources {}
3: I1018 20:57:11.055902 17259 master.cpp:6817] Received update of agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) with total oversubscribed resources {}
3: I1018 20:57:11.056139 17259 master.cpp:6828] Ignoring update on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) as it reports no changes
3: I1018 20:57:11.057272 17261 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.563163ms
3: I1018 20:57:11.058053 17256 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.058635 17243 sched.cpp:917] Scheduler::resourceOffers took 106892ns
3: I1018 20:57:11.060354 17264 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O0
3: I1018 20:57:11.060477 17264 master.cpp:4196] Processing ACCEPT call for offers: [ 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O0 ] on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.060645 17264 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_hw9MNr\/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 20:57:11.061681 17246 master.cpp:2348] Dropping CREATE offer operation from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475: Not authorized to create persistent volumes as 'test-principal'
3: I1018 20:57:11.063128 17246 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_hw9MNr/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.066226 17265 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.473731ms
3: I1018 20:57:11.066951 17255 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.067503 17251 sched.cpp:917] Scheduler::resourceOffers took 97651ns
3: W1018 20:57:11.068140 17242 process.cpp:3194] Attempted to spawn already running process version@172.17.0.2:34475
3: I1018 20:57:11.068234 17249 master.cpp:5207] Processing DECLINE call for offers: [ 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O1 ] for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.068856 17242 sched.cpp:232] Version: 1.5.0
3: I1018 20:57:11.069223 17249 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O1
3: I1018 20:57:11.069322 17266 sched.cpp:336] New master detected at master@172.17.0.2:34475
3: I1018 20:57:11.069407 17266 sched.cpp:351] No credentials provided. Attempting to register without authentication
3: I1018 20:57:11.069402 17249 master.cpp:3439] Processing SUPPRESS call for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.069424 17266 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.2:34475
3: I1018 20:57:11.069538 17266 sched.cpp:853] Will retry registration in 542.834406ms if necessary
3: I1018 20:57:11.069732 17261 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.069806 17261 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }'
3: I1018 20:57:11.069907 17260 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_hw9MNr/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; ports:[31000-32000], allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.070068 17260 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.070209 17258 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1018 20:57:11.070744 17248 hierarchical.cpp:303] Added framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.070824 17263 sched.cpp:747] Framework registered with 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.070865 17263 sched.cpp:761] Scheduler::registered took 17887ns
3: I1018 20:57:11.073503 17248 hierarchical.cpp:1488] Performed allocation for 1 agents in 2.629814ms
3: I1018 20:57:11.074203 17264 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.074723 17264 sched.cpp:917] Scheduler::resourceOffers took 99473ns
3: I1018 20:57:11.076333 17246 hierarchical.cpp:1488] Performed allocation for 1 agents in 123766ns
3: I1018 20:57:11.078092 17253 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O2
3: I1018 20:57:11.078212 17253 master.cpp:4196] Processing ACCEPT call for offers: [ 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O2 ] on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.078349 17253 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_hw9MNr\/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 20:57:11.079843 17247 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_hw9MNr\/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 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475 to agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.080437 17247 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048 to agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.081647 17259 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048
3: I1018 20:57:11.084306 17249 hierarchical.cpp:887] Updated allocation of framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-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_hw9MNr/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/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_hw9MNr/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048
3: I1018 20:57:11.085839 17249 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_hw9MNr/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048, allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.089316 17256 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.67744ms
3: I1018 20:57:11.090051 17261 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.090636 17260 sched.cpp:917] Scheduler::resourceOffers took 112115ns
3: I1018 20:57:11.091392 17258 master.cpp:5207] Processing DECLINE call for offers: [ 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O3 ] for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.092355 17258 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O3
3: I1018 20:57:11.092497 17258 master.cpp:3439] Processing SUPPRESS call for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.093147 17244 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_hw9MNr/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048, allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.093309 17244 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.093647 17263 master.cpp:5312] Processing REVIVE call for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.093780 17263 hierarchical.cpp:1310] Revived offers for roles { default-role } of framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.095401 17263 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.515102ms
3: I1018 20:57:11.096175 17264 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.096740 17254 sched.cpp:917] Scheduler::resourceOffers took 117583ns
3: I1018 20:57:11.098403 17252 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O4
3: I1018 20:57:11.098526 17252 master.cpp:4196] Processing ACCEPT call for offers: [ 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O4 ] on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.098664 17252 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_hw9MNr\/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 20:57:11.099591 17252 master.cpp:2348] Dropping DESTROY offer operation from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475: Not authorized to destroy persistent volumes as 'test-principal'
3: I1018 20:57:11.101282 17250 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_hw9MNr/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048, allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.104461 17247 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.512401ms
3: I1018 20:57:11.105231 17259 master.cpp:7766] Sending 1 offers to framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.105777 17249 sched.cpp:917] Scheduler::resourceOffers took 100338ns
3: I1018 20:57:11.106113 17242 sched.cpp:2005] Asked to stop the driver
3: I1018 20:57:11.106230 17266 sched.cpp:1187] Stopping framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.106480 17256 master.cpp:8447] Processing TEARDOWN call for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.106509 17256 master.cpp:8459] Removing framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.106521 17256 master.cpp:3299] Deactivating framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 (default) at scheduler-cde73cae-812e-419d-940b-90758cbce0e8@172.17.0.2:34475
3: I1018 20:57:11.106619 17242 sched.cpp:2005] Asked to stop the driver
3: I1018 20:57:11.106673 17243 hierarchical.cpp:412] Deactivated framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.106714 17258 sched.cpp:1187] Stopping framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.107641 17256 master.cpp:9389] Removing offer 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-O5
3: I1018 20:57:11.107833 17254 slave.cpp:3211] Asked to shut down framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000 by master@172.17.0.2:34475
3: I1018 20:57:11.107864 17254 slave.cpp:3226] Cannot shut down unknown framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.108163 17256 master.cpp:8447] Processing TEARDOWN call for framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.108192 17256 master.cpp:8459] Removing framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.108202 17256 master.cpp:3299] Deactivating framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 (creator-framework) at scheduler-dbe684d2-2904-4ca3-b124-dad756deac03@172.17.0.2:34475
3: I1018 20:57:11.108398 17252 slave.cpp:3211] Asked to shut down framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001 by master@172.17.0.2:34475
3: I1018 20:57:11.108428 17252 slave.cpp:3226] Cannot shut down unknown framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.108484 17244 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_hw9MNr/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_hw9MNr/disk1,id1:path1]:2048, allocated: {}) on agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 from framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.108687 17244 hierarchical.cpp:355] Removed framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0000
3: I1018 20:57:11.108773 17244 hierarchical.cpp:412] Deactivated framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.108971 17244 hierarchical.cpp:355] Removed framework 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-0001
3: I1018 20:57:11.109264 17242 slave.cpp:869] Agent terminating
3: I1018 20:57:11.109434 17243 master.cpp:1303] Agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449) disconnected
3: I1018 20:57:11.109458 17243 master.cpp:3336] Disconnecting agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.109508 17243 master.cpp:3355] Deactivating agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 at slave(825)@172.17.0.2:34475 (bef6cf64d449)
3: I1018 20:57:11.109593 17263 hierarchical.cpp:690] Agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0 deactivated
3: I1018 20:57:11.115875 17242 master.cpp:1145] Master terminating
3: I1018 20:57:11.116950 17247 hierarchical.cpp:626] Removed agent 529a997e-ddf8-4c4b-8d4e-8d611e5ba5b0-S0
3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (111 ms)
3: [----------] 34 tests from DiskResource/PersistentVolumeTest (12088 ms total)
3:
3: [----------] Global test environment tear-down
3: [==========] 1649 tests from 178 test cases ran. (418329 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: I1018 20:57:11.189795 17267 process.cpp:1068] Failed to accept socket: future discarded
3/3 Test #3: MesosTests .......................***Failed 423.29 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 443.38 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-1508357955-10273
Untagged: mesos-1508357955-10273:latest
Deleted: sha256:ac3025a250dd74f7cfe434b729ddea14391d077d37a31dd9c2a0cec803ce9b4c
Deleted: sha256:79639e6926be8a3fde82c4819aabb87be0b56babcb3a23d9d8380b6c57ddeb37
Deleted: sha256:37bb8727a151dd9b518090de23c4f23ac1a5cce9fdf87fa2d195ab0e140c054a
Deleted: sha256:679f73184ae57c329079b12ccf1af37aac8bf2fc4ca652623e04f5ef10f9cc6e
Deleted: sha256:b767c9e4a5044c5fb630f66ac5a51b8deacc0e36cb64fd8935eaa2fe5ff827aa
Deleted: sha256:3a3a5ebe868d2ed5d6ef9b55226ead71f78bca27bdd1880c2b769db1a334bf97
Deleted: sha256:59f96fdec2ba4d9669aec7e5357e60bd23e26b9f26aedfc37e5076a6108db295
Deleted: sha256:ee47e4670699caf7dd5774a3acc083e6c253b319312d7206e4674d62dabbf823
Deleted: sha256:bdec25ae83b976b90f2ca05be2749994894d8450835dd2a31af20d43a7ec8362
Deleted: sha256:e1185e27aa1a4af717d407343c9aa2544b6d960c7014c9cea71715ff89e7e7e4
Deleted: sha256:f16067502d2e04a60ce707aeab019ca2d7e33620364fcfc7e352e9e0230e9087
Deleted: sha256:f8a3ed94cf618ef401032d587818cbcf8eea68492b71d8278d37ad02216fa51e
Deleted: sha256:89b141ffe2569fae77f2b8b1d03da70b3341642712028433f90f6cc5431d8d91
Deleted: sha256:0fdc312e0a44f50778eab55c9927c3653b5bd357f01f562fe347b9d950f02266
Deleted: sha256:2629fcf5db2ff233e4b1feee328b55ee1403b814e865cae72497f0252d669ece
Deleted: sha256:085c6d82c7a403b9fd0098af76304297b29307f4f50587531084a0d7d873ec53
Deleted: sha256:897a00f81bd43af2a37b05255542c441acca55a02670cf2feed3097143889910
Deleted: sha256:6ce4a3f49a4105a7d1c1cc83149fcd170ceb6b85ee1595433cb1018d6b00baf4
Deleted: sha256:4ff5883146e66eeaa86b4543486976b1f561aadcb9a22442d82ece9d2c9800d9
Deleted: sha256:f3e0ecff98aacb594ce5ce3b430ea8f7e42d6d9de4d1cfd5e3859a9664139c1a
Deleted: sha256:0e6775c26aaae61d4b0f592eb616d0b2a2ecd7fd6f44d6512de871c699d5b4fc
Deleted: sha256:b0b066ff56d701fdf13cb76bd3e24709aa558a470f9ffc132917b1fc59730c3d
Deleted: sha256:e3feca77900e3418e2a8efdd5f6286acd6d2b4d43aadb311f52b1355e21fda9c
Deleted: sha256:91110fbf4b5a6d07120629d7e760b57f5a08766e9c647220a6b92a2e669695cd
Deleted: sha256:ac934e9fb1413fdea7bcb9e176f6835a2b56e86f4c15a8b5486cdb54e7cff945
Deleted: sha256:d041d07cb1f445d140c04d3d2fc7e4d73c55bce004619b3b41a58a0c5d95ef8b
Deleted: sha256:9b27a71f37670d6c75cc507d7be638aa02abe4ffb8c6018617460342c6e3f2b5
Deleted: sha256:e4d4523a8970f1dd00f68cfbb181185602294e9cba9b790c1bd9d9fd057fd529
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) #4340
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)/4340/display/redirect?page=changes>