See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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.06 MB...] 3: I1018 16:22:45.874143 15904 master.cpp:1687] Recovering from registrar 3: I1018 16:22:45.874295 15909 registrar.cpp:347] Recovering registrar 3: I1018 16:22:45.874894 15909 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns 3: I1018 16:22:45.875015 15909 registrar.cpp:495] Applied 1 operations in 43602ns; attempting to update the registry 3: I1018 16:22:45.875551 15909 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1018 16:22:45.875655 15909 registrar.cpp:424] Successfully recovered registrar 3: I1018 16:22:45.875972 15901 master.cpp:1791] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register 3: I1018 16:22:45.876018 15903 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover 3: W1018 16:22:45.881705 15888 process.cpp:3194] Attempted to spawn already running process [email protected]:44264 3: I1018 16:22:45.882629 15888 containerizer.cpp:292] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1018 16:22:45.883133 15888 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1018 16:22:45.883260 15888 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1018 16:22:45.883292 15888 provisioner.cpp:255] Using default backend 'copy' 3: I1018 16:22:45.885280 15888 cluster.cpp:448] Creating default 'local' authorizer 3: I1018 16:22:45.887569 15903 slave.cpp:254] Mesos agent started on (825)@172.17.0.3:44264 3: W1018 16:22:45.888121 15888 process.cpp:3194] Attempted to spawn already running process [email protected]:44264 3: I1018 16:22:45.887614 15903 slave.cpp:255] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_uc9s7a/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_uc9s7a/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_uc9s7a/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_uc9s7a/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_uc9s7a/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_mk8paT\/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_mk8paT\/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_uc9s7a" --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_KXTV81" --zk_session_timeout="10secs" 3: I1018 16:22:45.888164 15903 credentials.hpp:86] Loading credential for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_uc9s7a/credential' 3: I1018 16:22:45.888319 15903 slave.cpp:287] Agent using credential for: test-principal 3: I1018 16:22:45.888339 15903 credentials.hpp:37] Loading credentials for authentication from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_uc9s7a/http_credentials' 3: I1018 16:22:45.888587 15903 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1018 16:22:45.888825 15903 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' 3: I1018 16:22:45.889101 15888 sched.cpp:232] Version: 1.5.0 3: I1018 16:22:45.889739 15897 sched.cpp:336] New master detected at [email protected]:44264 3: I1018 16:22:45.889849 15897 sched.cpp:351] No credentials provided. Attempting to register without authentication 3: I1018 16:22:45.889869 15897 sched.cpp:820] Sending SUBSCRIBE call to [email protected]:44264 3: I1018 16:22:45.889989 15897 sched.cpp:853] Will retry registration in 1.381921954secs if necessary 3: I1018 16:22:45.890178 15891 master.cpp:2929] Received SUBSCRIBE call for framework 'default' at [email protected]:44264 3: I1018 16:22:45.890202 15891 master.cpp:2263] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }' 3: I1018 16:22:45.890703 15898 master.cpp:3009] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ] 3: I1018 16:22:45.891389 15892 sched.cpp:747] Framework registered with ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.891430 15892 sched.cpp:761] Scheduler::registered took 24815ns 3: I1018 16:22:45.891475 15902 hierarchical.cpp:303] Added framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.891631 15902 hierarchical.cpp:1945] No allocations performed 3: I1018 16:22:45.891665 15902 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.891693 15902 hierarchical.cpp:1488] Performed allocation for 0 agents in 104958ns 3: I1018 16:22:45.892179 15903 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_mk8paT\/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_mk8paT\/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:22:45.892539 15903 slave.cpp:593] Agent attributes: [ ] 3: I1018 16:22:45.892549 15903 slave.cpp:602] Agent hostname: c0a3db16a5c7 3: I1018 16:22:45.892705 15909 status_update_manager.cpp:177] Pausing sending status updates 3: I1018 16:22:45.894219 15908 state.cpp:64] Recovering state from '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_KXTV81/meta' 3: I1018 16:22:45.894568 15893 status_update_manager.cpp:203] Recovering status update manager 3: I1018 16:22:45.894773 15894 containerizer.cpp:649] Recovering containerizer 3: I1018 16:22:45.895978 15901 provisioner.cpp:416] Provisioner recovery complete 3: I1018 16:22:45.896271 15909 slave.cpp:6310] Finished recovery 3: I1018 16:22:45.896761 15909 slave.cpp:6492] Querying resource estimator for oversubscribable resources 3: I1018 16:22:45.897073 15903 status_update_manager.cpp:177] Pausing sending status updates 3: I1018 16:22:45.897073 15905 slave.cpp:993] New master detected at [email protected]:44264 3: I1018 16:22:45.897156 15905 slave.cpp:1028] Detecting new master 3: I1018 16:22:45.897326 15905 slave.cpp:6506] Received oversubscribable resources {} from the resource estimator 3: I1018 16:22:45.898799 15900 slave.cpp:1055] Authenticating with master [email protected]:44264 3: I1018 16:22:45.898878 15900 slave.cpp:1064] Using default CRAM-MD5 authenticatee 3: I1018 16:22:45.899183 15906 authenticatee.cpp:121] Creating new client SASL connection 3: I1018 16:22:45.899186 15904 hierarchical.cpp:1945] No allocations performed 3: I1018 16:22:45.899230 15904 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.899256 15904 hierarchical.cpp:1488] Performed allocation for 0 agents in 105589ns 3: I1018 16:22:45.899467 15897 master.cpp:7936] Authenticating slave(825)@172.17.0.3:44264 3: I1018 16:22:45.899575 15895 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1489)@172.17.0.3:44264 3: I1018 16:22:45.899801 15911 authenticator.cpp:98] Creating new server SASL connection 3: I1018 16:22:45.900005 15891 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1018 16:22:45.900029 15891 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1018 16:22:45.900135 15899 authenticator.cpp:204] Received SASL authentication start 3: I1018 16:22:45.900185 15899 authenticator.cpp:326] Authentication requires more steps 3: I1018 16:22:45.900285 15894 authenticatee.cpp:259] Received SASL authentication step 3: I1018 16:22:45.900395 15898 authenticator.cpp:232] Received SASL authentication step 3: I1018 16:22:45.900426 15898 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'c0a3db16a5c7' server FQDN: 'c0a3db16a5c7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1018 16:22:45.900436 15898 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1018 16:22:45.900475 15898 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1018 16:22:45.900490 15898 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'c0a3db16a5c7' server FQDN: 'c0a3db16a5c7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1018 16:22:45.900497 15898 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1018 16:22:45.900502 15898 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1018 16:22:45.900514 15898 authenticator.cpp:318] Authentication success 3: I1018 16:22:45.900594 15889 authenticatee.cpp:299] Authentication success 3: I1018 16:22:45.900691 15907 master.cpp:7966] Successfully authenticated principal 'test-principal' at slave(825)@172.17.0.3:44264 3: I1018 16:22:45.900746 15892 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1489)@172.17.0.3:44264 3: I1018 16:22:45.900885 15896 slave.cpp:1147] Successfully authenticated with master [email protected]:44264 3: I1018 16:22:45.901119 15896 slave.cpp:1626] Will retry registration in 13.730351ms if necessary 3: I1018 16:22:45.901316 15890 master.cpp:5801] Received register agent message from slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.901350 15890 master.cpp:3838] Authorizing agent with principal 'test-principal' 3: I1018 16:22:45.901876 15908 master.cpp:5861] Authorized registration of agent at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.902005 15908 master.cpp:5954] Registering agent at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) with id ec4ede52-ec13-4087-83af-c5258a079523-S0 3: I1018 16:22:45.902382 15905 registrar.cpp:495] Applied 1 operations in 94182ns; attempting to update the registry 3: I1018 16:22:45.903014 15905 registrar.cpp:552] Successfully updated the registry in 0ns 3: I1018 16:22:45.903232 15904 master.cpp:6001] Admitted agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.903908 15895 slave.cpp:4966] Received ping from slave-observer(741)@172.17.0.3:44264 3: I1018 16:22:45.904085 15899 slave.cpp:1193] Registered with master [email protected]:44264; given agent ID ec4ede52-ec13-4087-83af-c5258a079523-S0 3: I1018 16:22:45.904176 15894 status_update_manager.cpp:184] Resuming sending status updates 3: I1018 16:22:45.904013 15904 master.cpp:6032] Registered agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 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_mk8paT\/disk1"},"type":"PATH"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"type":"SCALAR"},{"disk":{"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroErrors while running CTest make[3]: *** [CMakeFiles/check] Error 8 make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make: *** [check] Error 2 y_1_mk8paT\/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:22:45.904368 15899 slave.cpp:1213] Checkpointing SlaveInfo to '/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_KXTV81/meta/slaves/ec4ede52-ec13-4087-83af-c5258a079523-S0/slave.info' 3: I1018 16:22:45.904500 15911 hierarchical.cpp:593] Added agent ec4ede52-ec13-4087-83af-c5258a079523-S0 (c0a3db16a5c7) with cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; ports:[31000-32000] (allocated: {}) 3: I1018 16:22:45.904788 15899 slave.cpp:1262] Forwarding total oversubscribed resources {} 3: I1018 16:22:45.904947 15889 master.cpp:6817] Received update of agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) with total oversubscribed resources {} 3: I1018 16:22:45.905170 15889 master.cpp:6828] Ignoring update on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) as it reports no changes 3: I1018 16:22:45.906044 15911 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.906076 15911 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.408253ms 3: I1018 16:22:45.906764 15898 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.907275 15907 sched.cpp:917] Scheduler::resourceOffers took 108219ns 3: I1018 16:22:45.909302 15901 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O0 3: I1018 16:22:45.909449 15901 master.cpp:4196] Processing ACCEPT call for offers: [ ec4ede52-ec13-4087-83af-c5258a079523-O0 ] on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.909622 15901 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_mk8paT\/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:22:45.910652 15901 master.cpp:2348] Dropping CREATE offer operation from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264: Not authorized to create persistent volumes as 'test-principal' 3: I1018 16:22:45.912104 15903 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_mk8paT/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; ports:[31000-32000], allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.914963 15910 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.915017 15910 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.332328ms 3: I1018 16:22:45.915758 15900 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.916379 15906 sched.cpp:917] Scheduler::resourceOffers took 120700ns 3: W1018 16:22:45.917016 15888 process.cpp:3194] Attempted to spawn already running process [email protected]:44264 3: I1018 16:22:45.917047 15897 master.cpp:5207] Processing DECLINE call for offers: [ ec4ede52-ec13-4087-83af-c5258a079523-O1 ] for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.917584 15888 sched.cpp:232] Version: 1.5.0 3: I1018 16:22:45.917834 15897 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O1 3: I1018 16:22:45.917959 15897 master.cpp:3439] Processing SUPPRESS call for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.918009 15889 sched.cpp:336] New master detected at [email protected]:44264 3: I1018 16:22:45.918092 15889 sched.cpp:351] No credentials provided. Attempting to register without authentication 3: I1018 16:22:45.918104 15889 sched.cpp:820] Sending SUBSCRIBE call to [email protected]:44264 3: I1018 16:22:45.918192 15889 sched.cpp:853] Will retry registration in 982.846905ms if necessary 3: I1018 16:22:45.918319 15911 master.cpp:2929] Received SUBSCRIBE call for framework 'creator-framework' at [email protected]:44264 3: I1018 16:22:45.918336 15911 master.cpp:2263] Authorizing framework principal 'creator-principal' to receive offers for roles '{ default-role }' 3: I1018 16:22:45.918385 15891 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_mk8paT/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; ports:[31000-32000], allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.918529 15891 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.918682 15907 master.cpp:3009] Subscribing framework creator-framework with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ] 3: I1018 16:22:45.919003 15902 hierarchical.cpp:303] Added framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.919117 15896 sched.cpp:747] Framework registered with ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.919157 15896 sched.cpp:761] Scheduler::registered took 23743ns 3: I1018 16:22:45.920342 15902 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.920374 15902 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.259728ms 3: I1018 16:22:45.921172 15912 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.921634 15890 sched.cpp:917] Scheduler::resourceOffers took 93674ns 3: I1018 16:22:45.923391 15903 hierarchical.cpp:1945] No allocations performed 3: I1018 16:22:45.923441 15903 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.923475 15903 hierarchical.cpp:1488] Performed allocation for 1 agents in 217776ns 3: I1018 16:22:45.925196 15910 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O2 3: I1018 16:22:45.925312 15910 master.cpp:4196] Processing ACCEPT call for offers: [ ec4ede52-ec13-4087-83af-c5258a079523-O2 ] on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) for framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.925441 15910 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_mk8paT\/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:22:45.926699 15910 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_mk8paT\/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 ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 to agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.927192 15910 master.cpp:9335] Sending updated checkpointed resources disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 to agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.928213 15894 slave.cpp:3519] Updated checkpointed resources from {} to disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 3: I1018 16:22:45.930505 15899 hierarchical.cpp:887] Updated allocation of framework ec4ede52-ec13-4087-83af-c5258a079523-0001 on agent ec4ede52-ec13-4087-83af-c5258a079523-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_mk8paT/disk1]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/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_mk8paT/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 3: I1018 16:22:45.931809 15899 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_mk8paT/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048, allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.934542 15889 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.934583 15889 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.309015ms 3: I1018 16:22:45.935159 15898 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.935597 15911 sched.cpp:917] Scheduler::resourceOffers took 92581ns 3: I1018 16:22:45.936297 15909 master.cpp:5207] Processing DECLINE call for offers: [ ec4ede52-ec13-4087-83af-c5258a079523-O3 ] for framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.937428 15909 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O3 3: I1018 16:22:45.937593 15909 master.cpp:3439] Processing SUPPRESS call for framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.937963 15907 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_mk8paT/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048, allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.938113 15907 hierarchical.cpp:1275] Suppressed offers for roles { default-role } of framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.938482 15892 master.cpp:5312] Processing REVIVE call for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.938652 15892 hierarchical.cpp:1310] Revived offers for roles { default-role } of framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.940376 15892 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.940415 15892 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.623337ms 3: I1018 16:22:45.941226 15912 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.941901 15890 sched.cpp:917] Scheduler::resourceOffers took 126137ns 3: I1018 16:22:45.943600 15908 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O4 3: I1018 16:22:45.943747 15908 master.cpp:4196] Processing ACCEPT call for offers: [ ec4ede52-ec13-4087-83af-c5258a079523-O4 ] on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.943929 15908 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_mk8paT\/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:22:45.945055 15908 master.cpp:2348] Dropping DESTROY offer operation from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264: Not authorized to destroy persistent volumes as 'test-principal' 3: I1018 16:22:45.946591 15900 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_mk8paT/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048, allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.949374 15910 hierarchical.cpp:2035] No inverse offers to send out! 3: I1018 16:22:45.949414 15910 hierarchical.cpp:1488] Performed allocation for 1 agents in 1.325852ms 3: I1018 16:22:45.950011 15894 master.cpp:7766] Sending 1 offers to framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.950459 15899 sched.cpp:917] Scheduler::resourceOffers took 94854ns 3: I1018 16:22:45.950727 15888 sched.cpp:2005] Asked to stop the driver 3: I1018 16:22:45.950804 15897 sched.cpp:1187] Stopping framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.950981 15888 sched.cpp:2005] Asked to stop the driver 3: I1018 16:22:45.950992 15889 master.cpp:8447] Processing TEARDOWN call for framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.951012 15889 master.cpp:8459] Removing framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.951030 15889 master.cpp:3299] Deactivating framework ec4ede52-ec13-4087-83af-c5258a079523-0000 (default) at [email protected]:44264 3: I1018 16:22:45.951045 15891 sched.cpp:1187] Stopping framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.951216 15909 hierarchical.cpp:412] Deactivated framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.951902 15889 master.cpp:9389] Removing offer ec4ede52-ec13-4087-83af-c5258a079523-O5 3: I1018 16:22:45.952133 15903 slave.cpp:3211] Asked to shut down framework ec4ede52-ec13-4087-83af-c5258a079523-0000 by [email protected]:44264 3: I1018 16:22:45.952165 15903 slave.cpp:3226] Cannot shut down unknown framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.952441 15889 master.cpp:8447] Processing TEARDOWN call for framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.952472 15889 master.cpp:8459] Removing framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.952484 15889 master.cpp:3299] Deactivating framework ec4ede52-ec13-4087-83af-c5258a079523-0001 (creator-framework) at [email protected]:44264 3: I1018 16:22:45.952673 15910 slave.cpp:3211] Asked to shut down framework ec4ede52-ec13-4087-83af-c5258a079523-0001 by [email protected]:44264 3: I1018 16:22:45.952697 15910 slave.cpp:3226] Cannot shut down unknown framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.952810 15907 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_mk8paT/disk2]:2048; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048 (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_BadACLDropCreateAndDestroy_1_mk8paT/disk1,id1:path1]:2048, allocated: {}) on agent ec4ede52-ec13-4087-83af-c5258a079523-S0 from framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.953012 15907 hierarchical.cpp:355] Removed framework ec4ede52-ec13-4087-83af-c5258a079523-0000 3: I1018 16:22:45.953063 15907 hierarchical.cpp:412] Deactivated framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.953254 15907 hierarchical.cpp:355] Removed framework ec4ede52-ec13-4087-83af-c5258a079523-0001 3: I1018 16:22:45.953466 15888 slave.cpp:869] Agent terminating 3: I1018 16:22:45.953675 15897 master.cpp:1303] Agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) disconnected 3: I1018 16:22:45.953697 15897 master.cpp:3336] Disconnecting agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.953755 15897 master.cpp:3355] Deactivating agent ec4ede52-ec13-4087-83af-c5258a079523-S0 at slave(825)@172.17.0.3:44264 (c0a3db16a5c7) 3: I1018 16:22:45.953941 15892 hierarchical.cpp:690] Agent ec4ede52-ec13-4087-83af-c5258a079523-S0 deactivated 3: I1018 16:22:45.959254 15888 master.cpp:1145] Master terminating 3: I1018 16:22:45.960286 15910 hierarchical.cpp:626] Removed agent ec4ede52-ec13-4087-83af-c5258a079523-S0 3: [ OK ] DiskResource/PersistentVolumeTest.BadACLDropCreateAndDestroy/1 (101 ms) 3: [----------] 34 tests from DiskResource/PersistentVolumeTest (20145 ms total) 3: 3: [----------] Global test environment tear-down 3: [==========] 1649 tests from 178 test cases ran. (358666 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 16:22:46.039207 15913 process.cpp:1068] Failed to accept socket: future discarded 3/3 Test #3: MesosTests .......................***Failed 363.34 sec 67% tests passed, 1 tests failed out of 3 Total Test time (real) = 383.40 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-1508342142-10652 Untagged: mesos-1508342142-10652:latest Deleted: sha256:a5f80e56fac732527ca2b495cbc7af6b6065be9bb363c7de5b3c97b2270b0c74 Deleted: sha256:d9e152fa18d42fad94d0349716ca0fc76c31d009c1c60135939f138a82674740 Deleted: sha256:4cb1bdff9e851640a40571b0688babd469ba8bc945430489e7b2e428e310faf1 Deleted: sha256:530e0ec22ffb3ce31f4de2fe75283d483f4638d7a7cd77cde0aeb029b11bd263 Deleted: sha256:521bc87eae013593bfcfd486dd9d4ebaca5d0cb8938609b88192954b59edec0e Deleted: sha256:df42d38e3b3616ff7978e20693d38e6cc1374db6f229d96bb74afb5552c25e3b Deleted: sha256:ccac412af39260f3208ba250a07384b950dd30c5b285201550f58c349e6e51a2 Deleted: sha256:872b0f268301909fb6654e10dbf3e16b455ad18ca2740f865511485b36bbfa9c Deleted: sha256:150da36b91c931075a61e479e7fe28e5cd0c21e7c317cc05cb054a1cf7c2cf9b Deleted: sha256:bc7b4c106829c29126006945d20b39d6c52999fb5ac5e31c02ebb95992345a34 Deleted: sha256:3249c52d297067a26b74eff4919c8df07909961ff8cdbf614fb0cd7189f6c4bd Deleted: sha256:de840c6ec8ba10c1886944d2885d6f0266874f2c2858f49dd3b502537966ad0c Deleted: sha256:48c9ebba7846711c09059ff763eee729d8faeb3317ed45c6fbbfad5c5b9050dd Deleted: sha256:6bff68a0433f3b303093990d38d22db6f3ed1e8863dd2dc6179a6a813a86ec97 Deleted: sha256:0a9ddea801bac1fa76f3c381a8a74b6bb86c868d2c1b751390b1691db44fc790 Deleted: sha256:dc35237e5b5f3157a7b01cf0bf63a825257f718ef2f651d2b0a0b0fa2947035b Deleted: sha256:817f8f29e45a231977eab2d9be6d49c292c59e7e9f0ddfcab4d847f3571382fd Deleted: sha256:42a05dc46d22712540f244841397fed52183a2c02d75c4b8e6c771a354334cee Deleted: sha256:9b9e26626f6b7babc8a71c047b3727e2487aacc885a7844b9e4e3eb5c15b61ff Deleted: sha256:94acada16196083f82b8d4272ac608067c37b57f9e73e301e39d6bfed5268f33 Deleted: sha256:e2364a10283aec0d2ca669d1215ffd563a9a715deaeffd4ba034481c055a45b6 Deleted: sha256:4081471dea952b2cfaa6e2715b9b78f5dc2bd60e29d05567d25abee14b923d68 Deleted: sha256:42247965d7477ab013b7e82a15acae82cee1d2a2f340c8d47dd09245da491c7b Deleted: sha256:7f7df1c2f0f74e17bb15622973fc56cfcddc4dec75fb5eb4a18605318ac2ba5f Deleted: sha256:f5f54f3c3115a8ca850d5da2d4d2095835cbddc93b7dc7e0a6cfd09a98c819ad Deleted: sha256:bc26bfbbaf3300bab37f5f39f0f4a5bf3b51a04f4b4b008de3e0c70469155aff Deleted: sha256:6eae3c92f46e56a847762aad291119ddf6501165f183660d1194caa076fe91d1 Deleted: sha256:4c7912703c7bbb1d5da90ecf7d829ff19f613147e068579519e16955cc819433 Build step 'Execute shell' marked build as failure
