Attachment 835622 Details for Bug 1040780 – node platform.log

node platform.log

platform.log (text/plain), 18.44 KB, created by Lei Zhang on 2013-12-12 05:58:49 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Lei Zhang

Created: 2013-12-12 05:58:49 UTC

Size: 18.44 KB

patch

obsolete

>December 11 22:55:11 INFO Shell command 'useradd -u 1000                     -d /var/lib/openshift/52a9339cd49bdabe67000007                     -s /usr/bin/oo-trap-user                     -c 'OpenShift guest'                     -m                     -k /etc/openshift/skel                     52a9339cd49bdabe67000007 -G ""' ran. rc=0 out=
>December 11 22:55:11 INFO The file context database is being reloaded.
>December 11 22:55:12 INFO Shell command 'ip link show dev eth0' ran. rc=0 out=2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc htb state UP qlen 1000
>    link/ether 12:31:39:25:20:0e brd ff:ff:ff:ff:ff:ff
>
>December 11 22:55:12 INFO Shell command 'tc -s class show dev eth0 classid 1:3e8' ran. rc=0 out=
>December 11 22:55:12 INFO Shell command 'cat /tmp/tc-batch20131211-1074-1lrm71z | tc -force -batch' ran. rc=0 out=
>December 11 22:55:12 INFO Shell command 'ip -o -4 route get 54.196.44.111' ran. rc=0 out=54.196.44.111 via 10.73.30.1 dev eth0  src 10.73.30.252 \    cache  mtu 1500 advmss 1460 hoplimit 64
>
>December 11 22:55:12 INFO Shell command '/sbin/service openshift-sni-proxy condreload' ran. rc=0 out=Reloading haproxy15: 
>
>December 11 22:55:12 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): none
>
>December 11 22:55:12 INFO Shell command 'setquota --always-resolve -u 52a9339cd49bdabe67000007 0 1048576 0 80000 -a /var' ran. rc=0 out=
>December 11 22:55:13 INFO Shell command 'oo-iptables-port-proxy removeproxy 38031 38032 38033 38034 38035' ran. rc=0 out=
>December 11 22:55:14 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/ssh-keygen -N '' -f /var/lib/openshift/52a9339cd49bdabe67000007/.openshift_ssh/id_rsa\""' ran. rc=0 out=Generating public/private rsa key pair.
>Your identification has been saved in /var/lib/openshift/52a9339cd49bdabe67000007/.openshift_ssh/id_rsa.
>Your public key has been saved in /var/lib/openshift/52a9339cd49bdabe67000007/.openshift_ssh/id_rsa.pub.
>The key fingerprint is:
>d7:57:93:ad:2e:93:31:2b:b0:f5:23:53:b6:00:48:4e 52a9339cd49bdabe67000007@ip-10-73-30-252
>The key's randomart image is:
>+--[ RSA 2048]----+
>|      E          |
>|     + .        o|
>|      o .      oo|
>|         . .   o.|
>|        S + * o  |
>|         = = O   |
>|        . + O .  |
>|           + +   |
>|                 |
>+-----------------+
>
>December 11 22:55:14 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): 
>     Filesystem  blocks   quota   limit   grace   files   quota   limit   grace
>     /dev/xvde2      80       0 1048576              27       0   80000        
>
>December 11 22:55:17 INFO Creating cartridge directory 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:17 INFO Shell command '/bin/cp -ad /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/versions /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/lib /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/bin /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/metadata /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/README.md /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/logs /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/COPYRIGHT /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/LICENSE /var/lib/openshift/.cartridge_repository/redhat-nodejs/0.0.9/env /var/lib/openshift/52a9339cd49bdabe67000007/nodejs' ran. rc=0 out=
>December 11 22:55:17 INFO Cartridge nodejs recorded as primary within gear 52a9339cd49bdabe67000007
>December 11 22:55:17 INFO Created cartridge directory 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:17 INFO Creating 1 private endpoints for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:17 INFO IPs already allocated for 8080 in gear 52a9339cd49bdabe67000007: []
>December 11 22:55:17 INFO Created private endpoint for cart nodejs in gear 52a9339cd49bdabe67000007: [OPENSHIFT_NODEJS_IP=127.1.244.1, OPENSHIFT_NODEJS_PORT=8080]
>December 11 22:55:17 INFO Shell command '/usr/sbin/lsof -i @127.1.244.1:8080' ran. rc=1 out=
>December 11 22:55:17 INFO Running setup for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:18 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/oo-erb -S 2 -- /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/env/OPENSHIFT_NODEJS_LOG_DIR.erb > /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/env/OPENSHIFT_NODEJS_LOG_DIR\""' ran. rc=0 out=
>December 11 22:55:18 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/oo-erb -S 2 -- /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/env/OPENSHIFT_NODEJS_PID_DIR.erb > /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/env/OPENSHIFT_NODEJS_PID_DIR\""' ran. rc=0 out=
>December 11 22:55:18 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/setup --version 0.6\""' ran. rc=0 out=
>December 11 22:55:18 INFO Ran /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/setup --version 0.6 for 52a9339cd49bdabe67000007/nodejs
>
>December 11 22:55:18 INFO Processing ERB templates for nodejs
>December 11 22:55:18 INFO Running install for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:21 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/install --version 0.6\""' ran. rc=0 out=
>December 11 22:55:21 INFO Ran /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/install --version 0.6 for 52a9339cd49bdabe67000007/nodejs
>
>December 11 22:55:21 INFO Creating gear repo for 52a9339cd49bdabe67000007/nodejs from ``
>December 11 22:55:21 INFO Using '/var/lib/openshift/52a9339cd49bdabe67000007/nodejs/usr/template' to populate git repository for 52a9339cd49bdabe67000007
>December 11 22:55:21 INFO Shell command '/bin/cp -ad /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/usr/template /var/lib/openshift/52a9339cd49bdabe67000007/git' ran. rc=0 out=
>December 11 22:55:22 INFO Shell command '\
>set -xe;
>git init;
>git config user.email "builder@example.com";
>git config user.name "Template builder";
>git config core.logAllRefUpdates true;
>git add -f .;
>git commit -a -m "Creating template";
>' ran. rc=0 out=Initialized empty Git repository in /var/lib/openshift/52a9339cd49bdabe67000007/git/template/.git/
>[master (root-commit) e24d015] Creating template
> 18 files changed, 547 insertions(+)
> create mode 100644 .openshift/action_hooks/README.md
> create mode 100644 .openshift/cron/README.cron
> create mode 100644 .openshift/cron/daily/.gitignore
> create mode 100644 .openshift/cron/hourly/.gitignore
> create mode 100644 .openshift/cron/minutely/.gitignore
> create mode 100644 .openshift/cron/monthly/.gitignore
> create mode 100644 .openshift/cron/weekly/README
> create mode 100644 .openshift/cron/weekly/chrono.dat
> create mode 100755 .openshift/cron/weekly/chronograph
> create mode 100644 .openshift/cron/weekly/jobs.allow
> create mode 100644 .openshift/cron/weekly/jobs.deny
> create mode 100644 .openshift/markers/.gitkeep
> create mode 100644 README.md
> create mode 100644 deplist.txt
> create mode 100644 index.html
> create mode 100644 node_modules/.gitkeep
> create mode 100644 package.json
> create mode 100755 server.js
>
>December 11 22:55:22 INFO Shell command '\
>set -xe;
>git clone --bare --no-hardlinks template mynodejs06.git;
>GIT_DIR=./mynodejs06.git git config core.logAllRefUpdates true;
>GIT_DIR=./mynodejs06.git git repack;
>' ran. rc=0 out=Cloning into bare repository 'mynodejs06.git'...
>done.
>
>December 11 22:55:22 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"
>set -xe;
>shopt -s dotglob;
>if [ "$(find objects -type f 2>/dev/null | wc -l)" -eq "0" ]; then
>  exit 0;
>fi
>git archive --format=tar master | (cd /var/lib/openshift/52a9339cd49bdabe67000007/app-root/runtime/repo && tar --warning=no-timestamp -xf -);
>\""' ran. rc=0 out=
>December 11 22:55:22 INFO Connecting frontend mapping for 52a9339cd49bdabe67000007/nodejs: [] => [127.1.244.1:8080] with options: {"websocket"=>true, "protocols"=>["http", "ws"]}
>December 11 22:55:22 INFO Shell command '/usr/sbin/httxt2dbm -f DB -i /etc/httpd/conf.d/openshift/nodes.txt -o /etc/httpd/conf.d/openshift/nodes.db-20131211-1074-ue6um6/new.db' ran. rc=0 out=
>December 11 22:55:23 INFO Connecting frontend mapping for 52a9339cd49bdabe67000007/nodejs: [/health] => [127.1.244.1:8080] with options: {"health"=>true, "protocols"=>["http", "ws"]}
>December 11 22:55:23 INFO Shell command '/usr/sbin/httxt2dbm -f DB -i /etc/httpd/conf.d/openshift/nodes.txt -o /etc/httpd/conf.d/openshift/nodes.db-20131211-1074-b98ye2/new.db' ran. rc=0 out=
>December 11 22:55:23 INFO configure output: 
>December 11 22:55:23 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): 
>     Filesystem  blocks   quota   limit   grace   files   quota   limit   grace
>     /dev/xvde2     604       0 1048576             165       0   80000        
>
>December 11 22:55:23 INFO Shell command 'restorecon /var/lib/openshift/52a9339cd49bdabe67000007//.ssh/authorized_keys' ran. rc=0 out=
>December 11 22:55:23 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): 
>     Filesystem  blocks   quota   limit   grace   files   quota   limit   grace
>     /dev/xvde2     604       0 1048576             165       0   80000        
>
>December 11 22:55:24 INFO Shell command 'restorecon /var/lib/openshift/52a9339cd49bdabe67000007//.ssh/authorized_keys' ran. rc=0 out=
>December 11 22:55:24 INFO stdin() file() URL()
>December 11 22:55:24 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/rsync -av --delete /var/lib/openshift/52a9339cd49bdabe67000007/app-root/runtime/repo/ /var/lib/openshift/52a9339cd49bdabe67000007/app-deployments/2013-12-11_22-55-12.243/repo/\""' ran. rc=0 out=sending incremental file list
>./
>README.md
>deplist.txt
>index.html
>package.json
>server.js
>.openshift/
>.openshift/action_hooks/
>.openshift/action_hooks/README.md
>.openshift/cron/
>.openshift/cron/README.cron
>.openshift/cron/daily/
>.openshift/cron/daily/.gitignore
>.openshift/cron/hourly/
>.openshift/cron/hourly/.gitignore
>.openshift/cron/minutely/
>.openshift/cron/minutely/.gitignore
>.openshift/cron/monthly/
>.openshift/cron/monthly/.gitignore
>.openshift/cron/weekly/
>.openshift/cron/weekly/README
>.openshift/cron/weekly/chrono.dat
>.openshift/cron/weekly/chronograph
>.openshift/cron/weekly/jobs.allow
>.openshift/cron/weekly/jobs.deny
>.openshift/markers/
>.openshift/markers/.gitkeep
>node_modules/
>node_modules/.gitkeep
>
>sent 49765 bytes  received 397 bytes  100324.00 bytes/sec
>total size is 48327  speedup is 0.96
>
>December 11 22:55:25 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/rsync -av --delete /var/lib/openshift/52a9339cd49bdabe67000007/app-root/runtime/dependencies/ /var/lib/openshift/52a9339cd49bdabe67000007/app-deployments/2013-12-11_22-55-12.243/dependencies/\""' ran. rc=0 out=sending incremental file list
>./
>.npm/
>nodejs/
>nodejs/node_modules/
>nodejs/node_modules/async -> /usr/lib/node_modules/async
>nodejs/node_modules/connect -> /usr/lib/node_modules/connect
>nodejs/node_modules/express -> /usr/lib/node_modules/express
>nodejs/node_modules/formidable -> /usr/lib/node_modules/formidable
>nodejs/node_modules/generic-pool -> /usr/lib/node_modules/generic-pool
>nodejs/node_modules/hashish -> /usr/lib/node_modules/hashish
>nodejs/node_modules/mime -> /usr/lib/node_modules/mime
>nodejs/node_modules/mkdirp -> /usr/lib/node_modules/mkdirp
>nodejs/node_modules/mongodb -> /usr/lib/node_modules/mongodb
>nodejs/node_modules/mysql -> /usr/lib/node_modules/mysql
>nodejs/node_modules/node-static -> /usr/lib/node_modules/node-static
>nodejs/node_modules/pg -> /usr/lib/node_modules/pg
>nodejs/node_modules/qs -> /usr/lib/node_modules/qs
>nodejs/node_modules/traverse -> /usr/lib/node_modules/traverse
>nodejs/node_modules/.bin/
>nodejs/node_modules/.bin/express -> ../express/bin/express
>
>sent 861 bytes  received 76 bytes  1874.00 bytes/sec
>total size is 423  speedup is 0.45
>
>December 11 22:55:25 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"/usr/bin/rsync -av --delete /var/lib/openshift/52a9339cd49bdabe67000007/app-root/runtime/build-dependencies/ /var/lib/openshift/52a9339cd49bdabe67000007/app-deployments/2013-12-11_22-55-12.243/build-dependencies/\""' ran. rc=0 out=sending incremental file list
>
>sent 79 bytes  received 12 bytes  182.00 bytes/sec
>total size is 0  speedup is 0.00
>
>December 11 22:55:25 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"tar -c --exclude metadata.json . | tar -xO | sha1sum | cut -f 1 -d ' '\""' ran. rc=0 out=b787a82b8e61a6e03628dac276fd5d3bdf8f2438
>
>December 11 22:55:26 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"
>set -xe;
>git rev-parse --short master
>\""' ran. rc=0 out=e24d015
>
>December 11 22:55:26 INFO Shell command 'find objects -type f 2>/dev/null | wc -l' ran. rc=0 out=24
>
>December 11 22:55:26 INFO 52a9339cd49bdabe67000007 start against 'nodejs'
>December 11 22:55:35 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"set -e; /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/control start \""' ran. rc=1 out=Starting NodeJS cartridge
>
>December 11 22:55:35 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): 
>     Filesystem  blocks   quota   limit   grace   files   quota   limit   grace
>     /dev/xvde2     772       0 1048576             220       0   80000        
>
>December 11 22:55:36 INFO Deleting private endpoints for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:36 INFO Deleted private endpoints for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:36 INFO 52a9339cd49bdabe67000007 stop against 'nodejs'
>December 11 22:55:38 INFO Shell command '/sbin/runuser -s /bin/sh 52a9339cd49bdabe67000007 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1000' /bin/sh -c \"set -e; /var/lib/openshift/52a9339cd49bdabe67000007/nodejs/bin/control stop \""' ran. rc=0 out=Stopping NodeJS cartridge
>
>December 11 22:55:38 INFO Disconnecting frontend mapping for 52a9339cd49bdabe67000007/nodejs: ["", "/health"]
>December 11 22:55:38 INFO Shell command '/usr/sbin/httxt2dbm -f DB -i /etc/httpd/conf.d/openshift/nodes.txt -o /etc/httpd/conf.d/openshift/nodes.db-20131211-1074-1alkuul/new.db' ran. rc=0 out=
>December 11 22:55:38 INFO Deleting cartridge directory for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:38 INFO Deleted cartridge directory for 52a9339cd49bdabe67000007/nodejs
>December 11 22:55:38 INFO Shell command 'quota --always-resolve -w 52a9339cd49bdabe67000007' ran. rc=0 out=Disk quotas for user 52a9339cd49bdabe67000007 (uid 1000): 
>     Filesystem  blocks   quota   limit   grace   files   quota   limit   grace
>     /dev/xvde2     684       0 1048576             194       0   80000        
>
>December 11 22:55:41 INFO V2 destroy
>December 11 22:55:41 INFO Shell command '/usr/bin/pkill -9 -u 1000' ran. rc=1 out=
>December 11 22:55:41 INFO Shell command '/usr/bin/pgrep -u 1000' ran. rc=1 out=
>December 11 22:55:41 INFO Shell command 'ip link show dev eth0' ran. rc=0 out=2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc htb state UP qlen 1000
>    link/ether 12:31:39:25:20:0e brd ff:ff:ff:ff:ff:ff
>
>December 11 22:55:41 INFO Shell command 'cat /tmp/tc-batch20131211-1074-vpiey | tc -force -batch' ran. rc=0 out=
>December 11 22:55:41 INFO Shell command 'rm -f /var/lib/openshift/.last_access/mynodejs06 > /dev/null' ran. rc=0 out=
>December 11 22:55:41 INFO Shell command '/usr/bin/pkill -9 -u 1000' ran. rc=1 out=
>December 11 22:55:41 INFO Shell command '/usr/bin/pgrep -u 1000' ran. rc=1 out=
>December 11 22:55:41 INFO Shell command '/usr/bin/ipcs -c -m 2> /dev/null' ran. rc=0 out=
>------ Shared Memory Segment Creators/Owners --------
>shmid      perms      cuid       cgid       uid        gid       
>
>
>December 11 22:55:41 INFO Shell command '/usr/bin/ipcs -c -q 2> /dev/null' ran. rc=0 out=
>------ Message Queues: Creators/Owners --------
>msqid      perms      cuid       cgid       uid        gid       
>
>
>December 11 22:55:41 INFO Shell command '/usr/bin/ipcs -c -s 2> /dev/null' ran. rc=0 out=
>------ Semaphore Arrays Creators/Owners --------
>semid      perms      cuid       cgid       uid        gid       
>0          600        root       root       root       root      
>32769      600        root       root       root       root      
>65538      600        root       root       apache     apache    
>98307      600        root       root       apache     apache    
>131076     600        root       root       apache     apache    
>163845     600        root       root       apache     apache    
>196614     600        root       root       apache     apache    
>229383     600        root       root       libra_passenger libra_user
>262152     600        root       root       libra_passenger libra_user
>
>
>December 11 22:55:41 INFO Shell command 'oo-iptables-port-proxy removeproxy 38031 38032 38033 38034 38035' ran. rc=0 out=
>December 11 22:55:41 INFO Shell command 'ip -o -4 route get 54.196.44.111' ran. rc=0 out=54.196.44.111 via 10.73.30.1 dev eth0  src 10.73.30.252 \    cache  mtu 1500 advmss 1460 hoplimit 64
>
>December 11 22:55:42 INFO Shell command '/sbin/service openshift-sni-proxy condreload' ran. rc=0 out=Reloading haproxy15: 
>
>December 11 22:55:42 INFO Shell command 'userdel --remove -f "52a9339cd49bdabe67000007"' ran. rc=0 out=
>December 11 22:55:42 INFO Shell command 'setquota --always-resolve -u 52a9339cd49bdabe67000007 0 0 0 0 -a /var' ran. rc=1 out=

Actions: View

Attachments on bug 1040780: 835620 | 835621 | 835622