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/11/20 04:34:02 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4476
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4476/display/redirect?page=changes>
Changes:
[benjamin.hindman] Added support for enum's to hashset and hashmap.
[benjamin.hindman] Added a state machine abstraction.
[benjamin.hindman] Added http::Server.
[benjamin.hindman] Factored out HttpProxy and SocketManager header.
------------------------------------------
[...truncated 31.83 MB...]
3: I1120 04:33:53.898424 29324 executor.cpp:637] Starting task f2d309db-392f-4798-a2ce-a3a74853ddd8
3: I1120 04:33:53.901398 29008 slave.cpp:4517] Handling status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 from executor(1)@172.17.0.2:40383
3: I1120 04:33:53.903856 29002 status_update_manager.cpp:323] Received status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.903965 29002 status_update_manager.cpp:500] Creating StatusUpdate stream for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.904860 29002 status_update_manager.cpp:377] Forwarding update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to the agent
3: I1120 04:33:53.905280 29005 slave.cpp:4998] Forwarding the update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to master@172.17.0.2:36164
3: I1120 04:33:53.905606 29005 slave.cpp:4892] Status update manager successfully handled status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.905674 29005 slave.cpp:4908] Sending acknowledgement for status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to executor(1)@172.17.0.2:40383
3: I1120 04:33:53.906003 28992 master.cpp:7247] Status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 from agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:53.906086 28992 master.cpp:7309] Forwarding status update TASK_STARTING (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.906386 28992 master.cpp:9502] Updating the state of task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING)
3: I1120 04:33:53.906766 28997 sched.cpp:1029] Scheduler::statusUpdate took 113304ns
3: I1120 04:33:53.907219 29009 master.cpp:5791] Processing ACKNOWLEDGE call ea642490-bcf1-46c0-9224-aac09496a747 for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (default) at scheduler-00cc5340-a7bb-4b01-9300-86e7ade9cf58@172.17.0.2:36164 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: I1120 04:33:53.907635 28995 status_update_manager.cpp:395] Received status update acknowledgement (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.907932 28995 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: ea642490-bcf1-46c0-9224-aac09496a747) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.913800 29324 executor.cpp:477] Running '/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
3: I1120 04:33:53.917155 29324 executor.cpp:650] Forked command at 29326
3: I1120 04:33:53.921196 28996 slave.cpp:4517] Handling status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 from executor(1)@172.17.0.2:40383
3: I1120 04:33:53.923569 28988 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.923734 28988 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to the agent
3: I1120 04:33:53.924065 29001 slave.cpp:4998] Forwarding the update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to master@172.17.0.2:36164
3: I1120 04:33:53.924504 29001 slave.cpp:4892] Status update manager successfully handled status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.924573 29001 slave.cpp:4908] Sending acknowledgement for status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 to executor(1)@172.17.0.2:40383
3: I1120 04:33:53.924779 28994 master.cpp:7247] Status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 from agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:53.924886 28994 master.cpp:7309] Forwarding status update TASK_RUNNING (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.925302 28994 master.cpp:9502] Updating the state of task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1120 04:33:53.925555 29002 sched.cpp:1029] Scheduler::statusUpdate took 91090ns
3: I1120 04:33:53.926017 29005 master.cpp:5791] Processing ACKNOWLEDGE call ea5244b5-1d5a-4be0-8125-48c9234adce3 for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (default) at scheduler-00cc5340-a7bb-4b01-9300-86e7ade9cf58@172.17.0.2:36164 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: I1120 04:33:53.926609 28997 status_update_manager.cpp:395] Received status update acknowledgement (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.927029 28997 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: ea5244b5-1d5a-4be0-8125-48c9234adce3) for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:53.936023 29003 process.cpp:3501] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot'
3: I1120 04:33:53.937314 29004 http.cpp:851] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot'
3: W1120 04:33:53.957686 19985 process.cpp:2754] Attempted to spawn already running process version@172.17.0.2:36164
3: I1120 04:33:53.958673 19985 sched.cpp:232] Version: 1.5.0
3: I1120 04:33:53.959584 28987 sched.cpp:336] New master detected at master@172.17.0.2:36164
3: I1120 04:33:53.959758 28987 sched.cpp:396] Authenticating with master master@172.17.0.2:36164
3: I1120 04:33:53.959774 28987 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1120 04:33:53.960134 28988 authenticatee.cpp:121] Creating new client SASL connection
3: I1120 04:33:53.960597 29001 master.cpp:8285] Authenticating scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:53.960731 29005 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1555)@172.17.0.2:36164
3: I1120 04:33:53.961177 28994 authenticator.cpp:98] Creating new server SASL connection
3: I1120 04:33:53.961473 28992 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1120 04:33:53.961513 28992 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1120 04:33:53.961669 28995 authenticator.cpp:204] Received SASL authentication start
3: I1120 04:33:53.961760 28995 authenticator.cpp:326] Authentication requires more steps
3: I1120 04:33:53.961952 28993 authenticatee.cpp:259] Received SASL authentication step
3: I1120 04:33:53.962141 29003 authenticator.cpp:232] Received SASL authentication step
3: I1120 04:33:53.962203 29003 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4cc4b698a2bf' server FQDN: '4cc4b698a2bf' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1120 04:33:53.962216 29003 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1120 04:33:53.962275 29003 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1120 04:33:53.962294 29003 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '4cc4b698a2bf' server FQDN: '4cc4b698a2bf' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1120 04:33:53.962306 29003 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1120 04:33:53.962311 29003 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1120 04:33:53.962326 29003 authenticator.cpp:318] Authentication success
3: I1120 04:33:53.962446 29009 authenticatee.cpp:299] Authentication success
3: I1120 04:33:53.962574 28996 master.cpp:8315] Successfully authenticated principal 'test-principal' at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:53.962637 29009 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1555)@172.17.0.2:36164
3: I1120 04:33:53.962827 28991 sched.cpp:502] Successfully authenticated with master master@172.17.0.2:36164
3: I1120 04:33:53.962873 28991 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.2:36164
3: I1120 04:33:53.963045 28991 sched.cpp:857] Will retry registration in 36.581649ms if necessary
3: I1120 04:33:53.963351 29000 master.cpp:2961] Received SUBSCRIBE call for framework 'default' at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:53.963452 29000 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ default-role }'
3: I1120 04:33:53.964092 28989 master.cpp:3041] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT, SHARED_RESOURCES ]
3: I1120 04:33:53.964735 28990 hierarchical.cpp:306] Added framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.964752 29006 sched.cpp:751] Framework registered with 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.964820 29006 sched.cpp:765] Scheduler::registered took 44200ns
3: I1120 04:33:53.967015 28990 hierarchical.cpp:1457] Performed allocation for 1 agents in 2.069416ms
3: I1120 04:33:53.967998 28998 master.cpp:8115] Sending 1 offers to framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:53.968742 28987 sched.cpp:921] Scheduler::resourceOffers took 140076ns
3: I1120 04:33:53.971441 28988 master.cpp:10024] Removing offer 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-O1
3: I1120 04:33:53.971628 28988 master.cpp:4228] Processing ACCEPT call for offers: [ 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-O1 ] on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf) for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:53.971752 28988 master.cpp:3597] Authorizing framework principal 'test-principal' to launch task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0
3: I1120 04:33:53.974593 28994 master.cpp:10770] Adding task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 with resources [{"allocation_info":{"role":"default-role"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"name":"mem","scalar":{"value":256.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"test-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"shared":{},"type":"SCALAR"}] on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:53.975574 28994 master.cpp:4976] Launching task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164 with resources [{"allocation_info":{"role":"default-role"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"name":"mem","scalar":{"value":256.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"test-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"shared":{},"type":"SCALAR"}] on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:53.976696 28995 slave.cpp:1803] Got assigned task '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.977250 28993 hierarchical.cpp:1132] Recovered disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk2]:2048; mem(allocated: default-role):1664; ports(allocated: default-role):[31000-32000] (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1>, allocated: cpus(allocated: default-role):2; mem(allocated: default-role):384; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<2>) on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 from framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.977421 28995 slave.cpp:2071] Authorizing task '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.977483 28995 slave.cpp:7262] Authorizing framework principal 'test-principal' to launch task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0
3: I1120 04:33:53.978411 28999 slave.cpp:2239] Launching task '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.979068 28999 paths.cpp:621] Trying to chown '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610' to user 'mesos'
3: I1120 04:33:53.979313 28999 slave.cpp:7736] Launching executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 with resources [{"allocation_info":{"role":"default-role"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610'
3: I1120 04:33:53.980386 28999 slave.cpp:2467] Queued task '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' for executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.980474 28999 slave.cpp:958] Successfully attached '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610' to virtual path '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/latest'
3: I1120 04:33:53.980510 28999 slave.cpp:958] Successfully attached '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610' to virtual path '/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/latest'
3: I1120 04:33:53.980535 28999 slave.cpp:958] Successfully attached '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610' to virtual path '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610'
3: I1120 04:33:53.980913 28999 slave.cpp:2930] Launching container 59e1eb6d-2de0-4156-8cba-ebe802707610 for executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:53.981267 29009 containerizer.cpp:1149] Starting container 59e1eb6d-2de0-4156-8cba-ebe802707610
3: I1120 04:33:53.981757 29009 containerizer.cpp:2818] Transitioning the state of container 59e1eb6d-2de0-4156-8cba-ebe802707610 from PROVISIONING to PREPARING
3: I1120 04:33:53.982527 28991 posix.cpp:250] Adding symlink from '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1/volumes/roles/default-role/id1' to '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610/path1' for persistent volume disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048 of container 59e1eb6d-2de0-4156-8cba-ebe802707610
3: I1120 04:33:53.986562 28987 containerizer.cpp:1768] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:36164"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn\/slaves\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0\/frameworks\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001\/executors\/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0\/runs\/59e1eb6d-2de0-4156-8cba-ebe802707610"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiI1OWUxZWI2ZC0yZGUwLTQxNTYtOGNiYS1lYmU4MDI3MDc2MTAiLCJlaWQiOiI1ZGYwYzQ5ZC0xYWM3LTRmZjAtODgyNS00N2QzN2YxYjcxYTAiLCJmaWQiOiI0YjBlZmU0YS0zMGZjLTRhNDgtODQ2NC0yYWU4NTIwOGJhOWEtMDAwMSJ9.J7JBFol-1fYofSOYf4mXMWU28Xx1wfNaHfxI3kh-3ks"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"5df0c49d-1ac7-4ff0-8825-47d37f1b71a0"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(871)@172.17.0.2:36164"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn\/slaves\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0\/frameworks\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001\/executors\/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0\/runs\/59e1eb6d-2de0-4156-8cba-ebe802707610"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn\/slaves\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0\/frameworks\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001\/executors\/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0\/runs\/59e1eb6d-2de0-4156-8cba-ebe802707610"}" --pipe_read="16" --pipe_write="17" --runtime_directory="/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_xVYfmY/containers/59e1eb6d-2de0-4156-8cba-ebe802707610" --unshare_namespace_mnt="false"'
3: I1120 04:33:53.989970 28987 launcher.cpp:140] Forked child with pid '29327' for container '59e1eb6d-2de0-4156-8cba-ebe802707610'
3: I1120 04:33:53.990578 28987 containerizer.cpp:2818] Transitioning the state of container 59e1eb6d-2de0-4156-8cba-ebe802707610 from PREPARING to ISOLATING
3: I1120 04:33:53.992534 28999 containerizer.cpp:2818] Transitioning the state of container 59e1eb6d-2de0-4156-8cba-ebe802707610 from ISOLATING to FETCHING
3: I1120 04:33:53.992871 29009 fetcher.cpp:379] Starting to fetch URIs for container: 59e1eb6d-2de0-4156-8cba-ebe802707610, directory: /tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610
3: I1120 04:33:53.993798 28991 containerizer.cpp:2818] Transitioning the state of container 59e1eb6d-2de0-4156-8cba-ebe802707610 from FETCHING to RUNNING
3: I1120 04:33:54.283190 29338 exec.cpp:162] Version: 1.5.0
3: I1120 04:33:54.297818 29006 slave.cpp:4063] Got registration for executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from executor(1)@172.17.0.2:34073
3: I1120 04:33:54.302536 29010 slave.cpp:2669] Sending queued task '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' to executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 at executor(1)@172.17.0.2:34073
3: I1120 04:33:54.305344 29349 exec.cpp:237] Executor registered on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: I1120 04:33:54.310636 29331 executor.cpp:171] Received SUBSCRIBED event
3: I1120 04:33:54.312441 29331 executor.cpp:175] Subscribed executor on 4cc4b698a2bf
3: I1120 04:33:54.312855 29331 executor.cpp:171] Received LAUNCH event
3: I1120 04:33:54.315594 29331 executor.cpp:637] Starting task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0
3: I1120 04:33:54.319579 28987 slave.cpp:4517] Handling status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from executor(1)@172.17.0.2:34073
3: I1120 04:33:54.322221 29006 status_update_manager.cpp:323] Received status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.322284 29006 status_update_manager.cpp:500] Creating StatusUpdate stream for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.323427 29006 status_update_manager.cpp:377] Forwarding update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to the agent
3: I1120 04:33:54.323922 29001 slave.cpp:4998] Forwarding the update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to master@172.17.0.2:36164
3: I1120 04:33:54.324309 29001 slave.cpp:4892] Status update manager successfully handled status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.324388 29001 slave.cpp:4908] Sending acknowledgement for status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to executor(1)@172.17.0.2:34073
3: I1120 04:33:54.324623 28992 master.cpp:7247] Status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.324688 28992 master.cpp:7309] Forwarding status update TASK_STARTING (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.324888 28992 master.cpp:9502] Updating the state of task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (latest state: TASK_STARTING, status update state: TASK_STARTING)
3: I1120 04:33:54.325321 29003 sched.cpp:1029] Scheduler::statusUpdate took 148683ns
3: I1120 04:33:54.325863 29005 master.cpp:5791] Processing ACKNOWLEDGE call 55feec70-9c45-460a-94b2-ff0331c1855b for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: I1120 04:33:54.326505 28993 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.326943 28993 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: 55feec70-9c45-460a-94b2-ff0331c1855b) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.336316 29331 executor.cpp:477] Running '/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
3: I1120 04:33:54.340242 29331 executor.cpp:650] Forked command at 29355
3: I1120 04:33:54.345314 29008 slave.cpp:4517] Handling status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from executor(1)@172.17.0.2:34073
3: I1120 04:33:54.348045 29007 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.348282 29007 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to the agent
3: I1120 04:33:54.348739 28998 slave.cpp:4998] Forwarding the update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to master@172.17.0.2:36164
3: I1120 04:33:54.349130 28998 slave.cpp:4892] Status update manager successfully handled status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.349196 28998 slave.cpp:4908] Sending acknowledgement for status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 to executor(1)@172.17.0.2:34073
3: I1120 04:33:54.349759 28989 master.cpp:7247] Status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.349900 28989 master.cpp:7309] Forwarding status update TASK_RUNNING (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.350451 28989 master.cpp:9502] Updating the state of task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
3: I1120 04:33:54.350849 29006 sched.cpp:1029] Scheduler::statusUpdate took 124500ns
3: I1120 04:33:54.351292 29001 master.cpp:5791] Processing ACKNOWLEDGE call 4e643d59-61b2-4d56-8049-88cea5042353 for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: I1120 04:33:54.351727 29003 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.352083 29005 slave.cpp:3801] Status update manager successfully handled status update acknowledgement (UUID: 4e643d59-61b2-4d56-8049-88cea5042353) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.359622 28993 process.cpp:3501] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot'
3: I1120 04:33:54.361079 28994 http.cpp:851] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot'
3: I1120 04:33:54.390161 19985 sched.cpp:2009] Asked to stop the driver
3: I1120 04:33:54.390321 28991 sched.cpp:1191] Stopping framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.390677 29009 master.cpp:8792] Processing TEARDOWN call for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (default) at scheduler-00cc5340-a7bb-4b01-9300-86e7ade9cf58@172.17.0.2:36164
3: I1120 04:33:54.390727 29009 master.cpp:8804] Removing framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (default) at scheduler-00cc5340-a7bb-4b01-9300-86e7ade9cf58@172.17.0.2:36164
3: I1120 04:33:54.390743 29009 master.cpp:3331] Deactivating framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (default) at scheduler-00cc5340-a7bb-4b01-9300-86e7ade9cf58@172.17.0.2:36164
3: I1120 04:33:54.390841 19985 sched.cpp:2009] Asked to stop the driver
3: I1120 04:33:54.390919 28998 hierarchical.cpp:419] Deactivated framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.390996 28992 sched.cpp:1191] Stopping framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.391175 28989 slave.cpp:3267] Asked to shut down framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 by master@172.17.0.2:36164
3: I1120 04:33:54.391279 28989 slave.cpp:3292] Shutting down framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.391350 28989 slave.cpp:5874] Shutting down executor 'f2d309db-392f-4798-a2ce-a3a74853ddd8' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 at executor(1)@172.17.0.2:40383
3: I1120 04:33:54.391423 29009 master.cpp:9502] Updating the state of task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
3: I1120 04:33:54.392760 28996 hierarchical.cpp:1132] Recovered cpus(allocated: default-role):1; mem(allocated: default-role):128; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1> (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1>, allocated: cpus(allocated: default-role):1; mem(allocated: default-role):256; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1>) on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 from framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.392426 29009 master.cpp:9596] Removing task f2d309db-392f-4798-a2ce-a3a74853ddd8 with resources [{"allocation_info":{"role":"default-role"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"test-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"shared":{},"type":"SCALAR"}] of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.393479 29317 exec.cpp:435] Executor asked to shutdown
3: I1120 04:33:54.393541 29001 hierarchical.cpp:358] Removed framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.393708 28992 containerizer.cpp:2254] Destroying container fc99da37-1f00-4442-ae73-f6595b68e1b2 in RUNNING state
3: I1120 04:33:54.393739 28992 containerizer.cpp:2818] Transitioning the state of container fc99da37-1f00-4442-ae73-f6595b68e1b2 from RUNNING to DESTROYING
3: I1120 04:33:54.393774 29009 master.cpp:8792] Processing TEARDOWN call for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:54.393841 29009 master.cpp:8804] Removing framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:54.393867 29009 master.cpp:3331] Deactivating framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (default) at scheduler-0199fde5-22b3-4b90-af0b-aab5ca872848@172.17.0.2:36164
3: I1120 04:33:54.393965 29319 executor.cpp:171] Received SHUTDOWN event
3: I1120 04:33:54.393996 29010 hierarchical.cpp:419] Deactivated framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.394007 29319 executor.cpp:747] Shutting down
3: I1120 04:33:54.394076 29319 executor.cpp:854] Sending SIGTERM to process tree at pid 29326
3: I1120 04:33:54.394073 29009 master.cpp:9502] Updating the state of task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 (latest state: TASK_KILLED, status update state: TASK_KILLED)
3: I1120 04:33:54.394078 28988 slave.cpp:3267] Asked to shut down framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 by master@172.17.0.2:36164
3: I1120 04:33:54.394129 28988 slave.cpp:3292] Shutting down framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.394155 28992 launcher.cpp:156] Asked to destroy container fc99da37-1f00-4442-ae73-f6595b68e1b2
3: I1120 04:33:54.394176 28988 slave.cpp:5874] Shutting down executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 at executor(1)@172.17.0.2:34073
3: I1120 04:33:54.395081 29342 exec.cpp:435] Executor asked to shutdown
3: I1120 04:33:54.395534 29345 executor.cpp:171] Received SHUTDOWN event
3: I1120 04:33:54.395593 29345 executor.cpp:747] Shutting down
3: I1120 04:33:54.394981 29009 master.cpp:9596] Removing task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 with resources [{"allocation_info":{"role":"default-role"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"name":"mem","scalar":{"value":256.0},"type":"SCALAR"},{"allocation_info":{"role":"default-role"},"disk":{"persistence":{"id":"id1","principal":"test-principal"},"source":{"path":{"root":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M\/disk1"},"type":"PATH"},"volume":{"container_path":"path1","mode":"RW"}},"name":"disk","reservations":[{"role":"default-role","type":"STATIC"}],"scalar":{"value":2048.0},"shared":{},"type":"SCALAR"}] of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.395664 29345 executor.cpp:854] Sending SIGTERM to process tree at pid 29355
3: I1120 04:33:54.396445 29007 hierarchical.cpp:1132] Recovered cpus(allocated: default-role):1; mem(allocated: default-role):256; disk(allocated: default-role)(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1> (total: cpus:2; mem:2048; ports:[31000-32000]; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk2]:2048; disk(reservations: [(STATIC,default-role)])[PATH:/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_Dfpo5M/disk1,id1:path1]<SHARED>:2048<1>, allocated: {}) on agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 from framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.397152 29007 hierarchical.cpp:358] Removed framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.401998 29345 executor.cpp:867] Sent SIGTERM to the following process trees:
3: [
3: --- 29355 mesos-containerizer launch --help=false --launch_info={"command":{"shell":true,"value":"echo abc > path1\/file2 && sleep 1000"},"environment":{"variables":[{"name":"PATH","type":"VALUE","value":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(871)@172.17.0.2:36164"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.2:36164"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn\/slaves\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0\/frameworks\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001\/executors\/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0\/runs\/59e1eb6d-2de0-4156-8cba-ebe802707610"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiI1OWUxZWI2ZC0yZGUwLTQxNTYtOGNiYS1lYmU4MDI3MDc2MTAiLCJlaWQiOiI1ZGYwYzQ5ZC0xYWM3LTRmZjAtODgyNS00N2QzN2YxYjcxYTAiLCJmaWQiOiI0YjBlZmU0YS0zMGZjLTRhNDgtODQ2NC0yYWU4NTIwOGJhOWEtMDAwMSJ9.J7JBFol-1fYofSOYf4mXMWU28Xx1wfNaHfxI3kh-3ks"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"5df0c49d-1ac7-4ff0-8825-47d37f1b71a0"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001"},{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn\/slaves\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0\/frameworks\/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001\/executors\/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0\/runs\/59e1eb6d-2de0-4156-8cba-ebe802707610"}]}} --unshare_namespace_mnt=false
3: ]
3: I1120 04:33:54.402019 29345 executor.cpp:871] Scheduling escalation to SIGKILL in 3secs from now
3: I1120 04:33:54.415124 29006 slave.cpp:5130] Got exited event for executor(1)@172.17.0.2:40383
3: I1120 04:33:54.482658 29348 executor.cpp:929] Command terminated with signal Terminated (pid: 29355)
3: I1120 04:33:54.487566 28989 slave.cpp:4517] Handling status update TASK_KILLED (UUID: c2a6966d-b7e3-4559-9b1e-e44424502b60) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 from executor(1)@172.17.0.2:34073
3: W1120 04:33:54.487651 28989 slave.cpp:4586] Ignoring status update TASK_KILLED (UUID: c2a6966d-b7e3-4559-9b1e-e44424502b60) for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 for terminating framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.492991 29005 containerizer.cpp:2705] Container fc99da37-1f00-4442-ae73-f6595b68e1b2 has exited
3: I1120 04:33:54.496441 29001 provisioner.cpp:490] Ignoring destroy request for unknown container fc99da37-1f00-4442-ae73-f6595b68e1b2
3: I1120 04:33:54.497763 28993 slave.cpp:5539] Executor 'f2d309db-392f-4798-a2ce-a3a74853ddd8' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 terminated with signal Killed
3: I1120 04:33:54.497846 28993 slave.cpp:5643] Cleaning up executor 'f2d309db-392f-4798-a2ce-a3a74853ddd8' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000 at executor(1)@172.17.0.2:40383
3: I1120 04:33:54.498354 28994 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000/executors/f2d309db-392f-4798-a2ce-a3a74853ddd8/runs/fc99da37-1f00-4442-ae73-f6595b68e1b2' for gc 6.99999423514963days in the future
3: I1120 04:33:54.498579 28993 slave.cpp:5750] Cleaning up framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.498636 28994 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000/executors/f2d309db-392f-4798-a2ce-a3a74853ddd8' for gc 6.9999942308days in the future
3: I1120 04:33:54.498925 29001 containerizer.cpp:2254] Destroying container 59e1eb6d-2de0-4156-8cba-ebe802707610 in RUNNING state
3: I1120 04:33:54.498962 28997 status_update_manager.cpp:285] Closing status update streams for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.498975 29001 containerizer.cpp:2818] Transitioning the state of container 59e1eb6d-2de0-4156-8cba-ebe802707610 from RUNNING to DESTROYING
3: I1120 04:33:54.499030 28997 status_update_manager.cpp:531] Cleaning up status update stream for task f2d309db-392f-4798-a2ce-a3a74853ddd8 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000
3: I1120 04:33:54.499017 28987 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0000' for gc 6.99999422630815days in the future
3: I1120 04:33:54.499392 29001 launcher.cpp:156] Asked to destroy container 59e1eb6d-2de0-4156-8cba-ebe802707610
3: I1120 04:33:54.507633 28999 hierarchical.cpp:1457] Performed allocation for 1 agents in 258112ns
3: I1120 04:33:54.516180 29006 slave.cpp:5130] Got exited event for executor(1)@172.17.0.2:34073
3: I1120 04:33:54.596266 28991 containerizer.cpp:2705] Container 59e1eb6d-2de0-4156-8cba-ebe802707610 has exited
3: I1120 04:33:54.599426 29001 provisioner.cpp:490] Ignoring destroy request for unknown container 59e1eb6d-2de0-4156-8cba-ebe802707610
3: I1120 04:33:54.600467 29009 slave.cpp:5539] Executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 terminated with signal Killed
3: I1120 04:33:54.600523 29009 slave.cpp:5643] Cleaning up executor '5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001 at executor(1)@172.17.0.2:34073
3: I1120 04:33:54.600996 28989 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0/runs/59e1eb6d-2de0-4156-8cba-ebe802707610' for gc 6.99999304759111days in the future
3: I1120 04:33:54.601059 29009 slave.cpp:5750] Cleaning up framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.601197 28989 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001/executors/5df0c49d-1ac7-4ff0-8825-47d37f1b71a0' for gc 6.99999304443259days in the future
3: I1120 04:33:54.601392 29005 status_update_manager.cpp:285] Closing status update streams for framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.601397 28989 gc.cpp:90] Scheduling '/tmp/DiskResource_PersistentVolumeTest_SharedPersistentVolumeMultipleFrameworks_1_6IAOIn/slaves/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0/frameworks/4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001' for gc 6.99999304089185days in the future
3: I1120 04:33:54.601485 29005 status_update_manager.cpp:531] Cleaning up status update stream for task 5df0c49d-1ac7-4ff0-8825-47d37f1b71a0 of framework 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-0001
3: I1120 04:33:54.602056 29008 slave.cpp:883] Agent terminating
3: I1120 04:33:54.602396 29008 master.cpp:1309] Agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf) disconnected
3: I1120 04:33:54.602437 29008 master.cpp:3368] Disconnecting agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.602555 29008 master.cpp:3387] Deactivating agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 at slave(871)@172.17.0.2:36164 (4cc4b698a2bf)
3: I1120 04:33:54.602774 28999 hierarchical.cpp:697] Agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0 deactivated
3: I1120 04:33:54.613776 19985 master.cpp:1151] Master terminating
3: I1120 04:33:54.615934 29004 hierarchical.cpp:633] Removed agent 4b0efe4a-30fc-4a48-8464-2ae85208ba9a-S0
3: [ OK ] DiskResource/PersistentVolumeTest.SharedPersistentVolumeMultipleFrameworks/1 (1117 ms)
3: [ RUN ] DiskResource/PersistentVolumeTest.SharedPersistentVolumeMasterFailover/0
3: I1120 04:33:54.628795 19985 cluster.cpp:162] Creating default 'local' authorizer
3: I1120 04:33:54.634238 28992 master.cpp:448] Master 3cbad34f-dd38-4c1c-9be5-c7489640005a (4cc4b698a2bf) started on 172.17.0.2:36164
3: I1120 04:33:54.634290 28992 master.cpp:450] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/bSlHTM/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" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/bSlHTM/master" --zk_session_timeout="10secs"
3: I1120 04:33:54.634801 28992 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1120 04:33:54.634815 28992 master.cpp:505] Master only allowing authenticated agents to register
3: I1120 04:33:54.634825 28992 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1120 04:33:54.634846 28992 credentials.hpp:37] Loading credentials for authentication from '/tmp/bSlHTM/credentials'
3: I1120 04:33:54.635351 28992 master.cpp:555] Using default 'crammd5' authenticator
3: I1120 04:33:54.635614 28992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1120 04:33:54.635823 28992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1120 04:33:54.636039 28992 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1120 04:33:54.636243 28992 master.cpp:634] Authorization enabled
3: I1120 04:33:54.636482 28994 hierarchical.cpp:173] Initialized hierarchical allocator process
3: I1120 04:33:54.636772 28995 whitelist_watcher.cpp:77] No whitelist given
3: I1120 04:33:54.640334 29009 master.cpp:2213] Elected as the leading master!
3: I1120 04:33:54.640374 29009 master.cpp:1693] Recovering from registrar
3: I1120 04:33:54.640624 29000 registrar.cpp:347] Recovering registrar
3: I1120 04:33:54.641607 29000 registrar.cpp:391] Successfully fetched the registry (0B) in 922880ns
3: I1120 04:33:54.641808 29000 registrar.cpp:495] Applied 1 operations in 63407ns; attempting to update the registry
3: I1120 04:33:54.642808 29000 registrar.cpp:552] Successfully updated the registry in 910848ns
3: I1120 04:33:54.643018 29000 registrar.cpp:424] Successfully recovered registrar
3: I1120 04:33:54.643633 28993 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1120 04:33:54.643664 29001 hierarchical.cpp:211] Skipping recovery of hierarchical allocator: nothing to recover
3: W1120 04:33:54.653105 19985 process.cpp:2754] Attempted to spawn already running process files@172.17.0.2:36164
3: I1120 04:33:54.654651 19985 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1120 04:33:54.655578 19985 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1120 04:33:54.655793 19985 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1120 04:33:54.655855 19985 provisioner.cpp:255] Using default backend 'copy'
3: I1120 04:33:54.658905 19985 cluster.cpp:448] Creating default 'local' authorizer
3: I1120 04:33:54.662283 28993 slave.cpp:262] Mesos agent started on (872)@172.17.0.2:36164
write /dev/stdout: resource temporarily unavailable
+ docker rmi mesos-1511150064-67
Error response from daemon: conflict: unable to remove repository reference "mesos-1511150064-67" (must force) - container 4cc4b698a2bf is using its referenced image a351773fb5aa
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user benjamin.hindman@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4478
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%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4478/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4477
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%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4477/display/redirect?page=changes>
Changes:
[alexr] Revert "Added safe downcasts for Socket.".
------------------------------------------
[...truncated 168.56 KB...]
Preparing to unpack .../libev4_1%3a4.15-3_amd64.deb ...
Unpacking libev4 (1:4.15-3) ...
Selecting previously unselected package libev-dev.
Preparing to unpack .../libev-dev_1%3a4.15-3_amd64.deb ...
Unpacking libev-dev (1:4.15-3) ...
Selecting previously unselected package libsvn-dev.
Preparing to unpack .../libsvn-dev_1.8.8-1ubuntu3.3_amd64.deb ...
Unpacking libsvn-dev (1.8.8-1ubuntu3.3) ...
Setting up libapr1:amd64 (1.5.0-1) ...
Setting up libaprutil1:amd64 (1.5.3-1) ...
Setting up libcurl3-nss:amd64 (7.35.0-1ubuntu2.12) ...
Setting up libevent-2.0-5:amd64 (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libevent-core-2.0-5:amd64 (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libevent-extra-2.0-5:amd64 (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libevent-openssl-2.0-5:amd64 (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libevent-pthreads-2.0-5:amd64 (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libgssrpc4:amd64 (1.12+dfsg-2ubuntu5.3) ...
Setting up libkadm5clnt-mit9:amd64 (1.12+dfsg-2ubuntu5.3) ...
Setting up libkdb5-7:amd64 (1.12+dfsg-2ubuntu5.3) ...
Setting up libkadm5srv-mit9:amd64 (1.12+dfsg-2ubuntu5.3) ...
Setting up mysql-common (5.5.58-0ubuntu0.14.04.1) ...
Setting up libmysqlclient18:amd64 (5.5.58-0ubuntu0.14.04.1) ...
Setting up libpcrecpp0:amd64 (1:8.31-2ubuntu2.3) ...
Setting up libpython2.7:amd64 (2.7.6-8ubuntu0.3) ...
Setting up libexpat1-dev:amd64 (2.1.0-4ubuntu1.4) ...
Setting up libpython2.7-dev:amd64 (2.7.6-8ubuntu0.3) ...
Setting up libserf-1-1:amd64 (1.3.3-1ubuntu0.1) ...
Setting up libsvn1:amd64 (1.8.8-1ubuntu3.3) ...
Setting up libgnutlsxx27:amd64 (2.12.23-12ubuntu2.8) ...
Setting up comerr-dev (2.1-1.42.9-3ubuntu1.3) ...
Setting up krb5-multidev (1.12+dfsg-2ubuntu5.3) ...
Setting up uuid-dev (2.20.1-5.1ubuntu20.9) ...
Setting up libsctp-dev (1.0.15+dfsg-1) ...
Setting up libapr1-dev (1.5.0-1) ...
Setting up libldap2-dev:amd64 (2.4.31-1+nmu2ubuntu8.4) ...
Setting up libpcre3-dev:amd64 (1:8.31-2ubuntu2.3) ...
Setting up libsqlite3-dev:amd64 (3.8.2-1ubuntu2.1) ...
Setting up libpq5 (9.3.20-0ubuntu0.14.04) ...
Setting up zlib1g-dev:amd64 (1:1.2.8.dfsg-1ubuntu1) ...
Setting up libssl-dev:amd64 (1.0.1f-1ubuntu2.23) ...
Setting up libpq-dev (9.3.20-0ubuntu0.14.04) ...
Setting up libmysqlclient-dev (5.5.58-0ubuntu0.14.04.1) ...
Setting up libaprutil1-dev (1.5.3-1) ...
Setting up pkg-config (0.26-1ubuntu4) ...
Setting up libidn11-dev (1.28-1ubuntu2.2) ...
Setting up libkrb5-dev (1.12+dfsg-2ubuntu5.3) ...
Setting up libnspr4-dev (2:4.13.1-0ubuntu0.14.04.1) ...
Setting up libnss3-dev:amd64 (2:3.28.4-0ubuntu0.14.04.3) ...
Setting up libgpg-error-dev (1.12-0.2ubuntu1) ...
Setting up libgcrypt11-dev (1.5.3-2ubuntu4.5) ...
Setting up libtasn1-6-dev (3.4-3ubuntu0.5) ...
Setting up libp11-kit-dev (0.20.2-2ubuntu2) ...
Setting up libgnutls-dev (2.12.23-12ubuntu2.8) ...
Setting up librtmp-dev (2.4+20121230.gitdf6c518-1ubuntu0.1) ...
Setting up libcurl4-nss-dev:amd64 (7.35.0-1ubuntu2.12) ...
Setting up libevent-dev (2.0.21-stable-1ubuntu1.14.04.2) ...
Setting up libpython-dev:amd64 (2.7.5-5ubuntu3) ...
Setting up libsasl2-dev (2.1.25.dfsg1-17build1) ...
Setting up libssl-doc (1.0.1f-1ubuntu2.23) ...
Setting up python2.7-dev (2.7.6-8ubuntu0.3) ...
Setting up python-dev (2.7.5-5ubuntu3) ...
Setting up python-six (1.5.2-1ubuntu1) ...
Setting up libev4 (1:4.15-3) ...
Setting up libev-dev (1:4.15-3) ...
Setting up libsvn-dev (1.8.8-1ubuntu3.3) ...
Processing triggers for libc-bin (2.19-0ubuntu6.13) ...
---> 7c730f788ee2
Removing intermediate container e4808db37898
Step 6/20 : RUN apt-get install -y wget curl sed
---> Running in 13adf36d900e
Reading package lists...
Building dependency tree...
Reading state information...
sed is already the newest version.
The following NEW packages will be installed:
curl libcurl3 wget
0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded.
Need to get 566 kB of archives.
After this operation, 1527 kB of additional disk space will be used.
Get:1 http://archive.ubuntu.com/ubuntu/ trusty-updates/main libcurl3 amd64 7.35.0-1ubuntu2.12 [173 kB]
Get:2 http://archive.ubuntu.com/ubuntu/ trusty-updates/main wget amd64 1.15-1ubuntu1.14.04.3 [270 kB]
Get:3 http://archive.ubuntu.com/ubuntu/ trusty-updates/main curl amd64 7.35.0-1ubuntu2.12 [123 kB]
[91mdebconf: unable to initialize frontend: Dialog
debconf: (TERM is not set, so the dialog frontend is not usable.)
debconf: falling back to frontend: Readline
[0m[91mdebconf: unable to initialize frontend: Readline
debconf: (This frontend requires a controlling tty.)
debconf: falling back to frontend: Teletype
[0m[91mdpkg-preconfigure: unable to re-open stdin:
[0mFetched 566 kB in 1s (491 kB/s)
Selecting previously unselected package libcurl3:amd64.
(Reading database ... 31101 files and directories currently installed.)
Preparing to unpack .../libcurl3_7.35.0-1ubuntu2.12_amd64.deb ...
Unpacking libcurl3:amd64 (7.35.0-1ubuntu2.12) ...
Selecting previously unselected package wget.
Preparing to unpack .../wget_1.15-1ubuntu1.14.04.3_amd64.deb ...
Unpacking wget (1.15-1ubuntu1.14.04.3) ...
Selecting previously unselected package curl.
Preparing to unpack .../curl_7.35.0-1ubuntu2.12_amd64.deb ...
Unpacking curl (7.35.0-1ubuntu2.12) ...
Setting up libcurl3:amd64 (7.35.0-1ubuntu2.12) ...
Setting up wget (1.15-1ubuntu1.14.04.3) ...
Setting up curl (7.35.0-1ubuntu2.12) ...
Processing triggers for libc-bin (2.19-0ubuntu6.13) ...
---> a954de2720eb
Removing intermediate container 13adf36d900e
Step 7/20 : RUN apt-get install -y openjdk-7-jdk
---> Running in afff74516387
Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
libice-dev libpthread-stubs0-dev libsm-dev libx11-dev libx11-doc libxau-dev
libxcb1-dev libxdmcp-dev libxt-dev x11proto-core-dev x11proto-input-dev
x11proto-kb-dev xorg-sgml-doctools xtrans-dev
Suggested packages:
libice-doc libsm-doc libxcb-doc libxt-doc openjdk-7-demo openjdk-7-source
visualvm
The following NEW packages will be installed:
libice-dev libpthread-stubs0-dev libsm-dev libx11-dev libx11-doc libxau-dev
libxcb1-dev libxdmcp-dev libxt-dev openjdk-7-jdk x11proto-core-dev
x11proto-input-dev x11proto-kb-dev xorg-sgml-doctools xtrans-dev
0 upgraded, 15 newly installed, 0 to remove and 0 not upgraded.
Need to get 19.9 MB of archives.
After this operation, 39.0 MB of additional disk space will be used.
Get:1 http://archive.ubuntu.com/ubuntu/ trusty/main xorg-sgml-doctools all 1:1.11-1 [12.9 kB]
Get:2 http://archive.ubuntu.com/ubuntu/ trusty-updates/main x11proto-core-dev all 7.0.26-1~ubuntu2 [700 kB]
Get:3 http://archive.ubuntu.com/ubuntu/ trusty/main libice-dev amd64 2:1.0.8-2 [57.6 kB]
Get:4 http://archive.ubuntu.com/ubuntu/ trusty/main libpthread-stubs0-dev amd64 0.3-4 [4068 B]
Get:5 http://archive.ubuntu.com/ubuntu/ trusty/main libsm-dev amd64 2:1.2.1-2 [19.9 kB]
Get:6 http://archive.ubuntu.com/ubuntu/ trusty/main libxau-dev amd64 1:1.0.8-1 [11.1 kB]
Get:7 http://archive.ubuntu.com/ubuntu/ trusty/main libxdmcp-dev amd64 1:1.1.1-1 [26.9 kB]
Get:8 http://archive.ubuntu.com/ubuntu/ trusty/main x11proto-input-dev all 2.3-1 [139 kB]
Get:9 http://archive.ubuntu.com/ubuntu/ trusty/main x11proto-kb-dev all 1.0.6-2 [269 kB]
Get:10 http://archive.ubuntu.com/ubuntu/ trusty-updates/main xtrans-dev all 1.3.5-1~ubuntu14.04.2 [70.7 kB]
Get:11 http://archive.ubuntu.com/ubuntu/ trusty/main libxcb1-dev amd64 1.10-2ubuntu1 [76.6 kB]
Get:12 http://archive.ubuntu.com/ubuntu/ trusty/main libx11-dev amd64 2:1.6.2-1ubuntu2 [629 kB]
Get:13 http://archive.ubuntu.com/ubuntu/ trusty/main libx11-doc all 2:1.6.2-1ubuntu2 [1448 kB]
Get:14 http://archive.ubuntu.com/ubuntu/ trusty/main libxt-dev amd64 1:1.1.4-1 [455 kB]
Get:15 http://archive.ubuntu.com/ubuntu/ trusty-updates/main openjdk-7-jdk amd64 7u151-2.6.11-0ubuntu1.14.04.1 [15.9 MB]
[91mdebconf: unable to initialize frontend: Dialog
debconf: (TERM is not set, so the dialog frontend is not usable.)
debconf: falling back to frontend: Readline
[0m[91mdebconf: unable to initialize frontend: Readline
debconf: (This frontend requires a controlling tty.)
debconf: falling back to frontend: Teletype
[0m[91mdpkg-preconfigure: unable to re-open stdin:
[0mFetched 19.9 MB in 7s (2616 kB/s)
Selecting previously unselected package xorg-sgml-doctools.
(Reading database ... 31126 files and directories currently installed.)
Preparing to unpack .../xorg-sgml-doctools_1%3a1.11-1_all.deb ...
Unpacking xorg-sgml-doctools (1:1.11-1) ...
Selecting previously unselected package x11proto-core-dev.
Preparing to unpack .../x11proto-core-dev_7.0.26-1~ubuntu2_all.deb ...
Unpacking x11proto-core-dev (7.0.26-1~ubuntu2) ...
Selecting previously unselected package libice-dev:amd64.
Preparing to unpack .../libice-dev_2%3a1.0.8-2_amd64.deb ...
Unpacking libice-dev:amd64 (2:1.0.8-2) ...
Selecting previously unselected package libpthread-stubs0-dev:amd64.
Preparing to unpack .../libpthread-stubs0-dev_0.3-4_amd64.deb ...
Unpacking libpthread-stubs0-dev:amd64 (0.3-4) ...
Selecting previously unselected package libsm-dev:amd64.
Preparing to unpack .../libsm-dev_2%3a1.2.1-2_amd64.deb ...
Unpacking libsm-dev:amd64 (2:1.2.1-2) ...
Selecting previously unselected package libxau-dev:amd64.
Preparing to unpack .../libxau-dev_1%3a1.0.8-1_amd64.deb ...
Unpacking libxau-dev:amd64 (1:1.0.8-1) ...
Selecting previously unselected package libxdmcp-dev:amd64.
Preparing to unpack .../libxdmcp-dev_1%3a1.1.1-1_amd64.deb ...
Unpacking libxdmcp-dev:amd64 (1:1.1.1-1) ...
Selecting previously unselected package x11proto-input-dev.
Preparing to unpack .../x11proto-input-dev_2.3-1_all.deb ...
Unpacking x11proto-input-dev (2.3-1) ...
Selecting previously unselected package x11proto-kb-dev.
Preparing to unpack .../x11proto-kb-dev_1.0.6-2_all.deb ...
Unpacking x11proto-kb-dev (1.0.6-2) ...
Selecting previously unselected package xtrans-dev.
Preparing to unpack .../xtrans-dev_1.3.5-1~ubuntu14.04.2_all.deb ...
Unpacking xtrans-dev (1.3.5-1~ubuntu14.04.2) ...
Selecting previously unselected package libxcb1-dev:amd64.
Preparing to unpack .../libxcb1-dev_1.10-2ubuntu1_amd64.deb ...
Unpacking libxcb1-dev:amd64 (1.10-2ubuntu1) ...
Selecting previously unselected package libx11-dev:amd64.
Preparing to unpack .../libx11-dev_2%3a1.6.2-1ubuntu2_amd64.deb ...
Unpacking libx11-dev:amd64 (2:1.6.2-1ubuntu2) ...
Selecting previously unselected package libx11-doc.
Preparing to unpack .../libx11-doc_2%3a1.6.2-1ubuntu2_all.deb ...
Unpacking libx11-doc (2:1.6.2-1ubuntu2) ...
Selecting previously unselected package libxt-dev:amd64.
Preparing to unpack .../libxt-dev_1%3a1.1.4-1_amd64.deb ...
Unpacking libxt-dev:amd64 (1:1.1.4-1) ...
Selecting previously unselected package openjdk-7-jdk:amd64.
Preparing to unpack .../openjdk-7-jdk_7u151-2.6.11-0ubuntu1.14.04.1_amd64.deb ...
Unpacking openjdk-7-jdk:amd64 (7u151-2.6.11-0ubuntu1.14.04.1) ...
Setting up xorg-sgml-doctools (1:1.11-1) ...
Setting up x11proto-core-dev (7.0.26-1~ubuntu2) ...
Setting up libice-dev:amd64 (2:1.0.8-2) ...
Setting up libpthread-stubs0-dev:amd64 (0.3-4) ...
Setting up libsm-dev:amd64 (2:1.2.1-2) ...
Setting up libxau-dev:amd64 (1:1.0.8-1) ...
Setting up libxdmcp-dev:amd64 (1:1.1.1-1) ...
Setting up x11proto-input-dev (2.3-1) ...
Setting up x11proto-kb-dev (1.0.6-2) ...
Setting up xtrans-dev (1.3.5-1~ubuntu14.04.2) ...
Setting up libxcb1-dev:amd64 (1.10-2ubuntu1) ...
Setting up libx11-dev:amd64 (2:1.6.2-1ubuntu2) ...
Setting up libx11-doc (2:1.6.2-1ubuntu2) ...
Setting up libxt-dev:amd64 (1:1.1.4-1) ...
Setting up openjdk-7-jdk:amd64 (7u151-2.6.11-0ubuntu1.14.04.1) ...
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/appletviewer to provide /usr/bin/appletviewer (appletviewer) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/extcheck to provide /usr/bin/extcheck (extcheck) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/idlj to provide /usr/bin/idlj (idlj) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jar to provide /usr/bin/jar (jar) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jarsigner to provide /usr/bin/jarsigner (jarsigner) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/javac to provide /usr/bin/javac (javac) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/javadoc to provide /usr/bin/javadoc (javadoc) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/javah to provide /usr/bin/javah (javah) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/javap to provide /usr/bin/javap (javap) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jcmd to provide /usr/bin/jcmd (jcmd) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jconsole to provide /usr/bin/jconsole (jconsole) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jdb to provide /usr/bin/jdb (jdb) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jhat to provide /usr/bin/jhat (jhat) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jinfo to provide /usr/bin/jinfo (jinfo) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jmap to provide /usr/bin/jmap (jmap) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jps to provide /usr/bin/jps (jps) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jrunscript to provide /usr/bin/jrunscript (jrunscript) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jsadebugd to provide /usr/bin/jsadebugd (jsadebugd) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jstack to provide /usr/bin/jstack (jstack) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jstat to provide /usr/bin/jstat (jstat) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/jstatd to provide /usr/bin/jstatd (jstatd) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/native2ascii to provide /usr/bin/native2ascii (native2ascii) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/rmic to provide /usr/bin/rmic (rmic) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/schemagen to provide /usr/bin/schemagen (schemagen) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/serialver to provide /usr/bin/serialver (serialver) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/wsgen to provide /usr/bin/wsgen (wsgen) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/wsimport to provide /usr/bin/wsimport (wsimport) in auto mode
update-alternatives: using /usr/lib/jvm/java-7-openjdk-amd64/bin/xjc to provide /usr/bin/xjc (xjc) in auto mode
---> bf02325bce62
Removing intermediate container afff74516387
Step 8/20 : RUN adduser --disabled-password --gecos '' mesos
---> Running in c48d1349420a
Adding user `mesos' ...
Adding new group `mesos' (1000) ...
Adding new user `mesos' (1000) with group `mesos' ...
Creating home directory `/home/mesos' ...
Copying files from `/etc/skel' ...
failed to get digest sha256:bf02325bce624a2706f7d7cb8d1d560d14830915916841e214e01b6d0850fb3e: open /var/lib/docker/image/aufs/imagedb/content/sha256/bf02325bce624a2706f7d7cb8d1d560d14830915916841e214e01b6d0850fb3e: no such file or directory
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user benjamin.hindman@gmail.com