[
https://issues.apache.org/jira/browse/MESOS-6132?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15471222#comment-15471222
]
Arslan Qadeer commented on MESOS-6132:
--------------------------------------
Using --work_dir=/tmp/mesos_slave instead of --work_dir=$/tmp/mesos-slave
solved the issue.
> Mesos 1.0.1 marathon 1.1.1 deployment fails no such image, container or task
> ----------------------------------------------------------------------------
>
> Key: MESOS-6132
> URL: https://issues.apache.org/jira/browse/MESOS-6132
> Project: Mesos
> Issue Type: Bug
> Affects Versions: 1.0.1
> Reporter: Arslan Qadeer
> Priority: Blocker
> Fix For: 1.0.1
>
>
> Trying to launch docker containers with marathon on bridged network but they
> fail. I have tried to pull containers manually but it did not work too.
> Here are some logs from Mesos Salve/Master and Marathon.
> Mesos Slave Logs:
> "sudo ./bin/mesos-slave.sh --ip=<IP OF SLAVE> --master=zk://<IP OF
> ZOOKEEPER>:2181/mesos --advertise_ip=<IP OF SLAVE>
> --docker_socket=/var/run/docker.sock --work_dir=$/tmp/mesos-slave
> --containerizers=docker --executor_registration_timeout=5mins
> --isolation=docker/runtime"
> I0907 06:02:58.206800 5820 slave.cpp:1495] Got assigned task
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545 for framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 [23/9246]
> I0907 06:02:58.208921 5820 slave.cpp:1614] Launching task
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545 for framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 [22/9246]
> I0907 06:02:58.210595 5820 paths.cpp:528] Trying to chown
> '$/tmp/mesos-slave/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185ee[21/9246]
> xecutors/helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545/runs/0a52cc6d-499d-487d-983a-d3d8e62213e2'
> to user 'aio'
> [20/9246]
> I0907 06:02:58.214004 5820 slave.cpp:5674] Launching executor
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 with[19/9246]
> s cpus(*):0.1; mem(*):32 in work directory
> '$/tmp/mesos-slave/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000/executor[18/9246]
> rld.43c00fb5-74e2-11e6-80f0-a2e45809a545/runs/0a52cc6d-499d-487d-983a-d3d8e62213e2'
>
> [17/9246]
> I0907 06:02:58.216660 5820 slave.cpp:1840] Queuing task
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' for executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' [16/9246]
> ork d034dd41-d32c-4e81-a168-070c2185eefe-0000
>
> [15/9246]
> I0907 06:02:58.217999 5817 docker.cpp:1042] Starting container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2' for task
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' (and exe[14/9246]
> I0907 06:02:58.217999 5817 docker.cpp:1042] Starting container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2' for task
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' (and exe[14/9246$
> lloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545') of framework
> 'd034dd41-d32c-4e81-a168-070c2185eefe-0000'
> I0907 06:03:02.005821 5820 docker.cpp:658] Checkpointing pid 5853 to
> '$/tmp/mesos-slave/meta/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-07$
> c2185eefe-0000/executors/helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545/runs/0a52cc6d-499d-487d-983a-d3d8e62213e2/pids/forked.pid'
> I0907 06:03:02.057451 5814 slave.cpp:2828] Got registration for executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000
> from executor(1)@192.168.50.14:59541
> I0907 06:03:02.059079 5814 docker.cpp:1443] Ignoring updating container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2' with resources passed to update is
> identical to existing resources
> I0907 06:03:02.059430 5814 slave.cpp:2005] Sending queued task
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' to executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' of
> framework d034dd41-d32c-4e81-a168-070c2185eefe-0000 at
> executor(1)@192.168.50.14:59541
> I0907 06:03:07.500459 5815 slave.cpp:3211] Handling status update
> TASK_FAILED (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for task
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a5$
> 5 of framework d034dd41-d32c-4e81-a168-070c2185eefe-0000 from
> executor(1)@192.168.50.14:59541
> E0907 06:03:07.539857 5820 slave.cpp:3456] Failed to update resources for
> container 0a52cc6d-499d-487d-983a-d3d8e62213e2 of executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809$
> 545' running task helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545 on status
> update for terminal task, destroying container: Failed to run 'docker -H
> unix:///var/run/docker.sock i$
> spect
> mesos-9b5505a5-71d9-47cd-a810-898bb24be347-S0.0a52cc6d-499d-487d-983a-d3d8e62213e2':
> exited with status 1; stderr='Error: No such image, container or task:
> mesos-9b5505a5-7$d9-47cd-a810-898bb24be347-S0.0a52cc6d-499d-487d-983a-d3d8e62213e2
> '
> I0907 06:03:07.540410 5820 docker.cpp:1852] Destroying container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2'
> I0907 06:03:07.540549 5820 docker.cpp:1938] Sending SIGTERM to executor with
> pid: 5853
> I0907 06:03:07.540467 5814 status_update_manager.cpp:320] Received status
> update TASK_FAILED (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for task
> helloworld.43c00fb5-74e2-11e6-$0f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.543401 5814 status_update_manager.cpp:825] Checkpointing
> UPDATE for status update TASK_FAILED (UUID:
> ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for task
> helloworld.43c$0fb5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.555461 5820 docker.cpp:1980] Running docker stop on container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2'
> I0907 06:03:07.557958 5816 slave.cpp:3732] executor(1)@192.168.50.14:59541
> exited
> I0907 06:03:07.642285 5821 docker.cpp:2132] Executor for container
> '0a52cc6d-499d-487d-983a-d3d8e62213e2' has exited
> I0907 06:03:07.644544 5821 slave.cpp:4089] Executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 terminated with sign$l Terminated
> I0907 06:03:07.703641 5818 slave.cpp:3604] Forwarding the update TASK_FAILED
> (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for task
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a54$
> of framework d034dd41-d32c-4e81-a168-070c2185eefe-0000 to
> [email protected]:5050
> I0907 06:03:07.704087 5818 slave.cpp:3514] Sending acknowledgement for
> status update TASK_FAILED (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for
> task helloworld.43c00fb5-74e2-1$
> e6-80f0-a2e45809a545 of framework d034dd41-d32c-4e81-a168-070c2185eefe-0000
> to executor(1)@192.168.50.14:59541
> E0907 06:03:07.704627 5822 process.cpp:2105] Failed to shutdown socket with
> fd 11: Transport endpoint is not connected
> I0907 06:03:07.743113 5814 status_update_manager.cpp:392] Received status
> update acknowledgement (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c) for task
> helloworld.43c00fb5-74e2-1$
> e6-80f0-a2e45809a545 of framework d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.743348 5814 status_update_manager.cpp:825] Checkpointing ACK
> for status update TASK_FAILED (UUID: ed6f0a0c-0687-4039-93e7-c14be4a9ec8c)
> for task helloworld.43c00f$
> 5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.804318 5814 slave.cpp:4193] Cleaning up executor
> 'helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 at execu$
> or(1)@192.168.50.14:59541
> I0907 06:03:07.805060 5814 slave.cpp:4281] Cleaning up framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.805099 5819 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000/executors$
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545/runs/0a52cc6d-499d-487d-983a-d3d8e62213e2'
> for gc 6.99999068706074days in the future
> I0907 06:03:07.805243 5819 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000/executors$
> helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' for gc 6.99999068475852days
> in the future
> I0907 06:03:07.805344 5819 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/meta/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000/exec$
> tors/helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545/runs/0a52cc6d-499d-487d-983a-d3d8e62213e2'
> for gc 6.99999068390222days in the future
> I0907 06:03:07.805438 5819 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/meta/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000/exec$
> tors/helloworld.43c00fb5-74e2-11e6-80f0-a2e45809a545' for gc
> 6.99999068312593days in the future
> I0907 06:03:07.805673 5820 status_update_manager.cpp:282] Closing status
> update streams for framework d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:03:07.805923 5817 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000'
> for gc 6$
> 99999067363259days in the future
> I0907 06:03:07.806212 5818 gc.cpp:55] Scheduling
> '$/tmp/mesos-slave/meta/slaves/9b5505a5-71d9-47cd-a810-898bb24be347-S0/frameworks/d034dd41-d32c-4e81-a168-070c2185eefe-0000'
> for
> gc 6.99999066995259days in the future
> Mesos Master Logs:
> "./bin/mesos-master.sh --advertise_ip=192.168.50.10
> --zk=zk://192.168.50.10:2181/mesos --port=5050 --quorum=1
> --registry=in_memory --work_dir=$/tmp/mesos_master"
> I0907 06:06:39.715235 419 master.cpp:4046] Processing REVIVE call for
> framework d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> scheduler-91481722-8a3f-4297-97b7-a8c5e88
> [email protected]:41351
> I0907 06:06:39.715349 419 hierarchical.cpp:1022] Removed offer filters for
> framework d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:06:39.716269 419 master.cpp:5725] Sending 1 offers to framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> scheduler-91481722-8a3f-4297-97b7-a8c5e885e56e@1
> 27.0.1.1:41351
> I0907 06:06:39.770603 416 master.cpp:3342] Processing ACCEPT call for
> offers: [ 9b5505a5-71d9-47cd-a810-898bb24be347-O54 ] on agent
> 9b5505a5-71d9-47cd-a810-898bb24be347-S0 at sl
> ave(1)@192.168.50.14:5051 (edge2.plumgrid.com) for framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> [email protected]:41351
> I0907 06:06:39.772132 416 master.cpp:7447] Adding task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 with resources cpus(*):1;
> mem(*):128 on agent 9b5505a5-71d9-47cd-a810-898b
> b24be347-S0 (edge2.plumgrid.com)
> I0907 06:06:39.772290 416 master.cpp:3831] Launching task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at sc
> [email protected]:41351 with resources
> cpus(*):1; mem(*):128 on agent 9b5505a5-71d9-47cd-a810-898bb24be347-S0 at
> slave(1)@192.168.50.14:5051 (
> edge2.plumgrid.com)
> I0907 06:06:40.471755 418 master.cpp:5725] Sending 1 offers to framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> scheduler-91481722-8a3f-4297-97b7-a8c5e885e56e@1
> 27.0.1.1:41351
> I0907 06:06:40.475045 415 master.cpp:3951] Processing DECLINE call for
> offers: [ 9b5505a5-71d9-47cd-a810-898bb24be347-O55 ] for framework
> d034dd41-d32c-4e81-a168-070c2185eefe-00
> 00 (marathon) at
> [email protected]:41351
> I0907 06:06:47.039434 420 http.cpp:381] HTTP GET for /master/state from
> 192.168.50.1:33520 with User-Agent='Mozilla/5.0 (Macintosh; Intel Mac OS X
> 10_11_4) AppleWebKit/537.36 (K
> HTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36'
> I0907 06:06:48.750298 418 master.cpp:5137] Status update TASK_FAILED (UUID:
> 7d401455-72c5-42a0-90b6-40ab849f6075) for task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 of fra
> mework d034dd41-d32c-4e81-a168-070c2185eefe-0000 from agent
> 9b5505a5-71d9-47cd-a810-898bb24be347-S0 at slave(1)@192.168.50.14:5051
> (edge2.plumgrid.com)
> I0907 06:06:48.750366 418 master.cpp:5199] Forwarding status update
> TASK_FAILED (UUID: 7d401455-72c5-42a0-90b6-40ab849f6075) for task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809
> a545 of framework d034dd41-d32c-4e81-a168-070c2185eefe-0000
> I0907 06:06:48.750640 418 master.cpp:6841] Updating the state of task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (lat
> est state: TASK_FAILED, status update state: TASK_FAILED)
> I0907 06:06:48.811859 419 master.cpp:4262] Processing ACKNOWLEDGE call
> 7d401455-72c5-42a0-90b6-40ab849f6075 for task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 of framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> [email protected]:41351 on agent
> 9b5505a5-71d9-47cd-a810-898bb24be347-S0
> I0907 06:06:48.811954 419 master.cpp:6907] Removing task
> helloworld.c4f4b0f5-74e2-11e6-80f0-a2e45809a545 with resources cpus(*):1;
> mem(*):128 of framework d034dd41-d32c-4e81-a16
> 8-070c2185eefe-0000 on agent 9b5505a5-71d9-47cd-a810-898bb24be347-S0 at
> slave(1)@192.168.50.14:5051 (edge2.plumgrid.com)
> I0907 06:06:49.482637 415 master.cpp:5725] Sending 1 offers to framework
> d034dd41-d32c-4e81-a168-070c2185eefe-0000 (marathon) at
> scheduler-91481722-8a3f-4297-97b7-a8c5e885e56e@1
> 27.0.1.1:41351
> I0907 06:06:49.485888 421 master.cpp:3951] Processing DECLINE call for
> offers: [ 9b5505a5-71d9-47cd-a810-898bb24be347-O56 ] for framework
> d034dd41-d32c-4e81-a168-070c2185eefe-00
> 00 (marathon) at
> [email protected]:41351
> Marathon Logs:
> "MESOS_NATIVE_JAVA_LIBRARY=/home/aio/mesos-1.0.1/build/src/.libs/libmesos.so
> bin/start --master zk://192.168.50.10:2181/mesos --zk
> zk://192.168.50.10:2181/marathon --event_subscriber http_callback
> --task_launch_timeout 300000"
> [2016-09-07 06:11:42,148] INFO [/helloworld]: new app detected
> (mesosphere.marathon.upgrade.GroupVersioningUtil$:ForkJoinPool-2-worker-13)
> [141/10000]
> [2016-09-07 06:11:42,150] INFO Computed new deployment plan:
>
> [140/10000]
> DeploymentPlan 2016-09-07T10:11:42.148Z
>
> [139/10000]
> step 1:
>
> [138/10000]
> * Start(App(/helloworld, image="tutum/hello-world")), instances=0)
>
> [137/10000]
> step 2:
>
> [136/10000]
> * Scale(App(/helloworld, image="tutum/hello-world")), instances=1)
>
> [135/10000]
> (mesosphere.marathon.state.GroupManager:ForkJoinPool-2-worker-13)
>
> [134/10000]
> [2016-09-07 06:11:42,150] INFO Deploy plan with force=false:
>
> [133/10000]
> DeploymentPlan 2016-09-07T10:11:42.148Z
>
> [132/10000]
> step 1:
>
> [131/10000]
> * Start(App(/helloworld, image="tutum/hello-world")), instances=0)
>
> [130/10000]
> step 2:
>
> [129/10000]
> * Scale(App(/helloworld, image="tutum/hello-world")), instances=1)
>
> [128/10000]
>
> (mesosphere.marathon.MarathonSchedulerService$$EnhancerByGuice$$7b7c577c:ForkJoinPool-2-worker-13)
>
> [127/10000]
> [2016-09-07 06:11:42,150] INFO [/helloworld] storing new app version
> 2016-09-07T10:11:42.148Z
> (mesosphere.marathon.state.GroupManager:ForkJoinPool-2-worker-13)
> [126/10000]
> [2016-09-07 06:11:42,217] INFO Starting app /helloworld
> (mesosphere.marathon.SchedulerActions:marathon-akka.actor.default-dispatcher-30)
> [125/10000]
> [2016-09-07 06:11:42,217] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-53)
> [124/10000]
> [2016-09-07 06:11:42,217] INFO Already running 0 instances of /helloworld.
> Not scaling.
> (mesosphere.marathon.SchedulerActions:marathon-akka.actor.default-dispatcher-30)[123/10000]
> [2016-09-07 06:11:42,217] INFO Successfully started 0 instances of
> /helloworld
> (mesosphere.marathon.upgrade.AppStartActor:marathon-akka.actor.default-dispatcher-55)
> [122/10000]
> [2016-09-07 06:11:42,217] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-41)
> [121/10000]
> [2016-09-07 06:11:42,217] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-30)
> [120/10000]
> [2016-09-07 06:11:42,220] INFO Started appTaskLaunchActor for /helloworld
> version 2016-09-07T10:11:42.148Z with initial count 1
> (mesosphere.marathon.core.launchqueue.im[119/10000]
> auncherActor:marathon-akka.actor.default-dispatcher-56)
>
> [118/10000]
> [2016-09-07 06:11:42,220] INFO activating matcher
> ActorOfferMatcher(Actor[akka://marathon/user/launchQueue/1/2-helloworld#-434864973]).
> (mesosphere.marathon.core.matche[117/10000]
> mpl.OfferMatcherManagerActor:marathon-akka.actor.default-dispatcher-18)
>
> [116/10000]
> [2016-09-07 06:11:42,220] INFO Received offers WANTED notification
> (mesosphere.marathon.core.flow.impl.ReviveOffersActor:marathon-akka.actor.default-dispatcher-18)
> [115/10000]
> [2016-09-07 06:11:42,220] INFO => revive offers NOW, canceling any scheduled
> revives
> (mesosphere.marathon.core.flow.impl.ReviveOffersActor:marathon-akka.actor.default-d[114/10000]
> 8)
>
> [113/10000]
> [2016-09-07 06:11:42,220] INFO 2 further revives still needed. Repeating
> reviveOffers according to --revive_offers_repetitions 3
> (mesosphere.marathon.core.flow.impl.Rev[112/10000]
> tor:marathon-akka.actor.default-dispatcher-18)
>
> [111/10000]
> [2016-09-07 06:11:42,221] INFO => Schedule next revive at
> 2016-09-07T10:11:47.220Z in 5000 milliseconds, adhering to
> --min_revive_offers_interval 5000 (ms) (mesosphere.[110/10000]
> re.flow.impl.ReviveOffersActor:marathon-akka.actor.default-dispatcher-45)
>
> [109/10000]
> [2016-09-07 06:11:42,227] INFO Processing
> LaunchEphemeral(LaunchedEphemeral(task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545],AgentInfo(edge2.plumgrid.com,Some(9b5[108/10000]
> 47cd-a810-898bb24be347-S0),Buffer()),2016-09-07T10:11:42.148Z,Status(2016-09-07T10:11:42.226Z,None,None),List()))
> for task [helloworld.794398bd-74e3-11e6-80f0-a2e45809a[107/10000]
> phere.marathon.core.launcher.impl.OfferProcessorImpl:ForkJoinPool-2-worker-13)
>
> [106/10000]
> [2016-09-07 06:11:42,227] INFO Request Launch for task
> 'helloworld.794398bd-74e3-11e6-80f0-a2e45809a545', version
> '2016-09-07T10:11:42.148Z'. 1 tasksToLaunch, 0 in flig[105/10000]
> rmed. not backing off
> (mesosphere.marathon.core.launchqueue.impl.AppTaskLauncherActor:marathon-akka.actor.default-dispatcher-56)
> [104/10000]
> [2016-09-07 06:11:42,227] INFO No tasks left to launch. Stop receiving offers
> for /helloworld, 2016-09-07T10:11:42.148Z
> (mesosphere.marathon.core.launchqueue.impl.AppTa[103/10000]
> ctor:marathon-akka.actor.default-dispatcher-56)
>
> [102/10000]
> [2016-09-07 06:11:42,227] INFO removing matcher
> ActorOfferMatcher(Actor[akka://marathon/user/launchQueue/1/2-helloworld#-434864973])
> (mesosphere.marathon.core.matcher.m[101/10000]
> .OfferMatcherManagerActor:marathon-akka.actor.default-dispatcher-56)
>
> [100/10000]
> [2016-09-07 06:11:42,228] INFO Received offers NOT WANTED notification,
> canceling 2 revives
> (mesosphere.marathon.core.flow.impl.ReviveOffersActor:marathon-akka.actor.def[99/10000]
> tcher-56)
>
> [98/10000]
> [2016-09-07 06:11:42,228] INFO Finished processing
> 9b5505a5-71d9-47cd-a810-898bb24be347-O126. Matched 1 ops after 2 passes.
> cpus(*) 3.0; mem(*) 6832.0; disk(*) 79158.0; [97/10000]
> 1000->32000 left.
> (mesosphere.marathon.core.matcher.manager.impl.OfferMatcherManagerActor:marathon-akka.actor.default-dispatcher-56)
> [96/10000]
> [2016-09-07 06:11:42,253] INFO receiveTaskUpdate: updating status of task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545]
> (mesosphere.marathon.core.launchqueue.impl.Ap[95/10000]
> herActor:marathon-akka.actor.default-dispatcher-18)
>
> [94/10000]
> [2016-09-07 06:11:42,255] INFO Task launch for 'task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545]' was accepted. 0
> tasksToLaunch, 0 in flight, 1 confirmed. not bac[93/10000]
> mesosphere.marathon.core.launchqueue.impl.AppTaskLauncherActor:marathon-akka.actor.default-dispatcher-55)
> [92/10000]
> [2016-09-07 06:11:42,277] INFO Updated groups/apps according to deployment
> plan fb9a07c1-c317-4bcf-8e59-d1783683fa71
> (mesosphere.marathon.state.GroupManager:ForkJoinPool[91/10000]
> 3)
>
> [90/10000]
> [2016-09-07 06:11:42,277] INFO Deployment acknowledged. Waiting to get
> processed:
> [89/10000]
> DeploymentPlan 2016-09-07T10:11:42.148Z
>
> [88/10000]
> step 1:
>
> [87/10000]
> * Start(App(/helloworld, image="tutum/hello-world")), instances=0)
>
> [86/10000]
> step 2:
>
> [85/10000]
> * Scale(App(/helloworld, image="tutum/hello-world")), instances=1)
>
> [84/10000]
> (mesosphere.marathon.state.GroupManager:ForkJoinPool-2-worker-3)
>
> [83/10000]
> [2016-09-07 06:11:42,277] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-55)
> [82/10000]
> [2016-09-07 06:11:42,277] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-18)
> [81/10000]
> [2016-09-07 06:11:42,278] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "POST //192.168.50.10:8080/v2/apps HTTP/1.1" 201 880
> "http://192.168.50.10:8080/ui/"; "Mozill[80/10000]
> intosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36" 13
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a[79/10000]
> 1010311355-37)
>
> [78/10000]
> [2016-09-07 06:11:42,320] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "GET //192.168.50.10:8080/ui/img/icons/icon-small-app.svg HTTP/1.1" 200 1519
> "http://192.168[77/10000]
> 0/ui/main.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_4)
> AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosR[76/10000]
> $EnhancerByGuice$$7a66064c:qtp1010311355-36)
>
> [75/10000]
> [2016-09-07 06:11:42,320] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "GET //192.168.50.10:8080/ui/img/icons/icon-mini-ellipse-white.svg HTTP/1.1"
> 200 976 "http:/[74/10000]
> 0.10:8080/ui/main.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_4)
> AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.htt[73/10000]
> uestLog$$EnhancerByGuice$$7a66064c:qtp1010311355-40)
>
> [72/10000]
> [2016-09-07 06:11:42,277] INFO Updated groups/apps according to deployment
> plan fb9a07c1-c317-4bcf-8e59-d1783683fa71
> (mesosphere.marathon.state.GroupManager:ForkJoinPool[91/10000$
> 3)
> [2016-09-07 06:11:42,277] INFO Deployment acknowledged. Waiting to get
> processed:
> DeploymentPlan 2016-09-07T10:11:42.148Z
> step 1:
> * Start(App(/helloworld, image="tutum/hello-world")), instances=0)
> step 2:
> * Scale(App(/helloworld, image="tutum/hello-world")), instances=1)
> (mesosphere.marathon.state.GroupManager:ForkJoinPool-2-worker-3)
> [2016-09-07 06:11:42,277] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-55)
> [2016-09-07 06:11:42,277] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-18)
> [2016-09-07 06:11:42,278] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "POST //192.168.50.10:8080/v2/apps HTTP/1.1" 201 880
> "http://192.168.50.10:8080/ui/"; "Mozilla/5.0 (Mac
> intosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36" 13
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064c:qtp
> 1010311355-37)
> [2016-09-07 06:11:42,320] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "GET //192.168.50.10:8080/ui/img/icons/icon-small-app.svg HTTP/1.1" 200 1519
> "http://192.168.50.10:808
> 0/ui/main.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_4)
> AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$
> $EnhancerByGuice$$7a66064c:qtp1010311355-36)
> [2016-09-07 06:11:42,320] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "GET //192.168.50.10:8080/ui/img/icons/icon-mini-ellipse-white.svg HTTP/1.1"
> 200 976 "http://192.168.5
> 0.10:8080/ui/main.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_4)
> AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosReq
> uestLog$$EnhancerByGuice$$7a66064c:qtp1010311355-40)
> [2016-09-07 06:11:42,320] INFO 192.168.50.1 - - [07/Sep/2016:10:11:42 +0000]
> "GET //192.168.50.10:8080/ui/img/icons/icon-mini-deploying-color.png
> HTTP/1.1" 200 1144 "http://192.16
> 8.50.10:8080/ui/main.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_4)
> AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.Chao$
> RequestLog$$EnhancerByGuice$$7a66064c:qtp1010311355-34)
> [2016-09-07 06:11:46,053] INFO 192.168.50.1 - - [07/Sep/2016:10:11:46 +0000]
> "GET //192.168.50.10:8080/v2/deployments HTTP/1.1" 200 376
> "http://192.168.50.10:8080/ui/"; "Mozilla/5$
> 0 (Macintosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064$
> :qtp1010311355-68)
> [2016-09-07 06:11:46,053] INFO 192.168.50.1 - - [07/Sep/2016:10:11:46 +0000]
> "GET //192.168.50.10:8080/v2/queue HTTP/1.1" 200 12
> "http://192.168.50.10:8080/ui/"; "Mozilla/5.0 (Mac$
> ntosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064c:qtp10$
> 0311355-66)
> [2016-09-07 06:11:46,055] INFO 192.168.50.1 - - [07/Sep/2016:10:11:46 +0000]
> "GET
> //192.168.50.10:8080/v2/groups?embed=group.groups&embed=group.apps&embed=group.apps.deployments&$
> mbed=group.apps.counts&embed=group.apps.readiness HTTP/1.1" 200 1090
> "http://192.168.50.10:8080/ui/"; "Mozilla/5.0 (Macintosh; Intel Mac OS X
> 10_11_4) AppleWebKit/537.36 (KHTML, l$
> ke Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064c:qtp1010311355-33)
> [2016-09-07 06:11:51,052] INFO 192.168.50.1 - - [07/Sep/2016:10:11:51 +0000]
> "GET //192.168.50.10:8080/v2/deployments HTTP/1.1" 200 376
> "http://192.168.50.10:8080/ui/"; "Mozilla/5$
> 0 (Macintosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064$
> :qtp1010311355-40)
> [2016-09-07 06:11:51,053] INFO 192.168.50.1 - - [07/Sep/2016:10:11:51 +0000]
> "GET //192.168.50.10:8080/v2/queue HTTP/1.1" 200 12
> "http://192.168.50.10:8080/ui/"; "Mozilla/5.0 (Mac$
> ntosh; Intel Mac OS X 10_11_4) AppleWebKit/537.36 (KHTML, like Gecko)
> Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064c:qtp10$
> 0311355-37)
> [2016-09-07 06:11:51,058] INFO 192.168.50.1 - - [07/Sep/2016:10:11:51 +0000]
> "GET
> //192.168.50.10:8080/v2/groups?embed=group.groups&embed=group.apps&embed=group.apps.deployments&$
> mbed=group.apps.counts&embed=group.apps.readiness HTTP/1.1" 200 1090
> "http://192.168.50.10:8080/ui/"; "Mozilla/5.0 (Macintosh; Intel Mac OS X
> 10_11_4) AppleWebKit/537.36 (KHTML, l$
> ke Gecko) Chrome/52.0.2743.116 Safari/537.36"
> (mesosphere.chaos.http.ChaosRequestLog$$EnhancerByGuice$$7a66064c:qtp1010311355-36)
> [2016-09-07 06:11:51,492] INFO Received status update for task
> helloworld.794398bd-74e3-11e6-80f0-a2e45809a545: TASK_FAILED (Container
> exited with status 125) (mesosphere.maratho$
> .MarathonScheduler$$EnhancerByGuice$$3a82e0a2:Thread-189)
> [2016-09-07 06:11:51,509] INFO Removed app [/helloworld] from tracker
> (mesosphere.marathon.core.task.tracker.TaskTracker$TasksByApp$:marathon-akka.actor.default-dispatcher-53)
> [2016-09-07 06:11:51,510] INFO Increasing delay. Task launch delay for
> [/helloworld] changed from [0 milliseconds] to [1 seconds].
> (mesosphere.marathon.core.launchqueue.impl.Rate$
> imiter$:marathon-akka.actor.default-dispatcher-55)
> [2016-09-07 06:11:51,510] INFO receiveTaskUpdate: task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545] finished
> (mesosphere.marathon.core.launchqueue.impl.AppTaskLauncherActor:$
> arathon-akka.actor.default-dispatcher-53)
> [2016-09-07 06:11:51,511] INFO Sending event notification for task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545] of app [/helloworld]:
> TASK_FAILED (mesosphere.marathon.core.t$
> sk.update.impl.steps.PostToEventStreamStepImpl$$EnhancerByGuice$$8b5bf639:marathon-akka.actor.default-dispatcher-52)
> [2016-09-07 06:11:51,511] INFO POSTing to all endpoints.
> (mesosphere.marathon.event.http.HttpEventActor:marathon-akka.actor.default-dispatcher-30)
> [2016-09-07 06:11:51,512] WARN New task [task
> [helloworld.794398bd-74e3-11e6-80f0-a2e45809a545]] failed during app
> /helloworld scaling, queueing another task (mesosphere.marathon$
> upgrade.TaskStartActor:marathon-akka.actor.default-dispatcher-30)
> Following JSON was used to launch containers:
> {
> "id": "helloworld",
> "cpus": 1,
> "mem": 128,
> "instances": 1,
> "ipAddress": {},
> "container": {
> "type": "DOCKER",
> "docker": {
> "image": "tutum/hello-world",
> "forcePullImage": true,
> "network": "BRIDGE"
> }
> }
> }
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
