You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@openwhisk.apache.org by gi...@git.apache.org on 2017/09/15 10:13:06 UTC
[GitHub] saurabh1284 opened a new issue #2753: wsk action invoke errors out with exceeded its time limits of 60000 milliseconds
saurabh1284 opened a new issue #2753: wsk action invoke errors out with exceeded its time limits of 60000 milliseconds
URL: https://github.com/apache/incubator-openwhisk/issues/2753
## Environment details:
* Distributed deployment, Ubuntu 14.04
* Docker version 1.12.0
## Steps to reproduce the issue:
1. Pulled a new image as = docker pull galaxyfoam/ubuntu-ffmpeg
2. Able to create containers using this image
3. Created action = wsk action create test1 test1.py --docker galaxyfoam/ubuntu-ffmpeg
4. But invoke action returns following error =
{
"error": "The action exceeded its time limits of 60000 milliseconds during initialization."
}
5. cat test1.py
def main(args):
name = args.get("name", "XYZ123")
greeting = "Hello " + name + "!"
print(greeting)
return {"greeting": greeting}
6. However, When I created action without --docker image option, it worked fine.
## Provide the expected results and outputs:
{
"greeting": "Hello XYZ123!"
}
## Provide the actual results and outputs:
{
"error": "The action exceeded its time limits of 60000 milliseconds during initialization."
}
## Additional information you deem important:
invoker log have =
[2017-09-15T08:07:55.906Z] [INFO] [#tid_300549] [SimpleExec] Running command: /usr/bin/docker run -e __OW_API_HOST=https://10.11.12.33:443 -e SERVICE_IGNORE=true --name wsk0_15120_whisksystemtest1001_20170915T080753424Z -c 256 -m 256m --memory-swap 256m --cap-drop NET_RAW --cap-drop NET_ADMIN --ulimit nofile=1024:1024 --pids-limit 1024 --net bridge -d galaxyfoam/ubuntu-ffmpeg
[2017-09-15T08:08:02.367Z] [INFO] [#tid_300549] [SimpleExec] Done running command: /usr/bin/docker run -e __OW_API_HOST=https://10.11.12.33:443 -e SERVICE_IGNORE=true --name wsk0_15120_whisksystemtest1001_20170915T080753424Z -c 256 -m 256m --memory-swap 256m --cap-drop NET_RAW --cap-drop NET_ADMIN --ulimit nofile=1024:1024 --pids-limit 1024 --net bridge -d galaxyfoam/ubuntu-ffmpeg
[2017-09-15T08:08:02.368Z] [INFO] [#tid_300549] [ContainerUtils] [marker:invoker_docker.run_finish:9851:6436]
[2017-09-15T08:08:02.403Z] [WARN] [#tid_300549] [ContainerPool] Docker operation took 6443 milliseconds
[2017-09-15T08:08:02.563Z] [INFO] [#tid_300549] [ContainerPool] finished trying to make container, 0 more containers to start
[2017-09-15T08:08:02.563Z] [INFO] [#tid_300549] [ContainerPool] Obtained cold container 12a0e8c120bfa4290ea1afeb917287515b211e78451ceb6d7b9a770a971c7267 - about to initialize
[2017-09-15T08:08:02.569Z] [INFO] [#tid_300549] [Invoker] sending initialization to container [wsk0_15120_whisksystemtest1001_20170915T080753424Z] [12a0e8c120bfa4290ea1afeb917287515b211e78451ceb6d7b9a770a971c7267] [172.17.0.4:8080] [marker:invoker_activationInit_start:9863]
[2017-09-15T08:09:06.902Z] [INFO] [#tid_300549] [Invoker] initialization result: Timeout() [marker:invoker_activationInit_finish:74412:64546]
[2017-09-15T08:09:06.943Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 15 more times
[2017-09-15T08:09:07.046Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 14 more times
[2017-09-15T08:09:07.061Z] [INFO] [#tid_300549] [Invoker] posted completion of activation e4e6436d9c8c402bb339113c8489df55
[2017-09-15T08:09:07.147Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 13 more times
[2017-09-15T08:09:07.248Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 12 more times
[2017-09-15T08:09:07.350Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 11 more times
[2017-09-15T08:09:07.452Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 10 more times
[2017-09-15T08:09:07.553Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 9 more times
[2017-09-15T08:09:07.654Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 8 more times
[2017-09-15T08:09:07.756Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 7 more times
[2017-09-15T08:09:07.857Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 6 more times
[2017-09-15T08:09:07.958Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 5 more times
[2017-09-15T08:09:08.059Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 4 more times
[2017-09-15T08:09:08.160Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 3 more times
[2017-09-15T08:09:08.263Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 2 more times
[2017-09-15T08:09:08.363Z] [INFO] [#tid_300549] [Invoker] log cursor has not advanced, trying 1 more times
And working case has expected log =
[2017-09-15T08:13:32.127Z] [INFO] [#tid_300567] [SimpleExec] Running command: /usr/bin/docker run -e __OW_API_HOST=https://10.11.12.33:443 -e SERVICE_IGNORE=true --name wsk0_15123_whisksystemtest1001_20170915T081332102Z -c 256 -m 256m --memory-swap 256m --cap-drop NET_RAW --cap-drop NET_ADMIN --ulimit nofile=1024:1024 --pids-limit 1024 --net bridge -d 10.11.12.33:5000/whisk/python2action:latest
[2017-09-15T08:13:41.423Z] [INFO] [#tid_300567] [SimpleExec] Done running command: /usr/bin/docker run -e __OW_API_HOST=https://10.11.12.33:443 -e SERVICE_IGNORE=true --name wsk0_15123_whisksystemtest1001_20170915T081332102Z -c 256 -m 256m --memory-swap 256m --cap-drop NET_RAW --cap-drop NET_ADMIN --ulimit nofile=1024:1024 --pids-limit 1024 --net bridge -d 10.11.12.33:5000/whisk/python2action:latest
[2017-09-15T08:13:41.424Z] [INFO] [#tid_300567] [ContainerUtils] [marker:invoker_docker.run_finish:9932:9316]
[2017-09-15T08:13:41.430Z] [WARN] [#tid_300567] [ContainerPool] Docker operation took 9326 milliseconds
[2017-09-15T08:13:41.432Z] [INFO] [#tid_300567] [ContainerPool] finished trying to make container, 0 more containers to start
[2017-09-15T08:13:41.436Z] [INFO] [#tid_300567] [ContainerPool] Obtained cold container be182df8ed8a910f3c566cf16800181f22d4fea596218e2c44926c14bf5bed31 - about to initialize
[2017-09-15T08:13:41.439Z] [INFO] [#tid_300567] [Invoker] sending initialization to container [wsk0_15123_whisksystemtest1001_20170915T081332102Z] [be182df8ed8a910f3c566cf16800181f22d4fea596218e2c44926c14bf5bed31] [172.17.0.5:8080] [marker:invoker_activationInit_start:9950]
[2017-09-15T08:13:50.554Z] [INFO] [#tid_300567] [Invoker] initialization result: ok [marker:invoker_activationInit_finish:19060:9107]
-> docker images | grep ubuntu
ibmcom/swift-ubuntu 3.1.1 39995571098d 12 weeks ago 1.189 GB
galaxyfoam/ubuntu-ffmpeg latest 80a2b7da57ec 2 years ago 1.06 GB
-> docker images | grep python
python latest 26acbad26a2c 43 hours ago 689.7 MB
10.11.12.33:5000/whisk/python3action latest 4b9c9ecd7050 7 weeks ago 289.1 MB
python3action latest 4b9c9ecd7050 7 weeks ago 289.1 MB
10.11.12.33:5000/whisk/python2action latest 683739a640ed 7 weeks ago 293.3 MB
python2action latest 683739a640ed 7 weeks ago 293.3 MB
python 3.6.1-alpine ddd6300d05a3 11 weeks ago 88.66 MB
python 2.7.12-alpine 9c8c07c0f9b7 10 months ago 72.22 MB
I am using this setup from last couple of months and all other behaviours are working fine.
Please suggest.
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
With regards,
Apache Git Services