Last active
September 2, 2015 04:33
-
-
Save ipoddar-ibm/0ccf62ff921e964aebc1 to your computer and use it in GitHub Desktop.
uaa startup errors on internal deployment of cloud foundry
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| ubuntu@dance:~$ bosh vms | |
| [WARNING] Loading the cli took 38.9 seconds, consider cleaning your gem environment | |
| Acting as user 'admin' on 'my-bosh' | |
| Deployment `cf' | |
| Director task 53 | |
| Task 53 done | |
| +----------------------+----------+---------------+-----------+ | |
| | Job/index | State | Resource Pool | IPs | | |
| +----------------------+----------+---------------+-----------+ | |
| | api/0 | running | medium | 10.0.1.62 | | |
| | dea-runner/0 | running | large | 10.0.1.58 | | |
| | haproxy-gorouter/0 | running | small | 10.0.1.57 | | |
| | hm9000/0 | running | small | 10.0.1.64 | | |
| | loggregator/0 | running | medium | 10.0.1.63 | | |
| | login/0 | running | small | 10.0.1.61 | | |
| | nats-etcd-postgres/0 | running | large | 10.0.1.56 | | |
| | nfs/0 | running | small | 10.0.1.60 | | |
| | uaa/0 | starting | small | 10.0.1.59 | | |
| +----------------------+----------+---------------+-----------+ | |
| VMs total: 9 | |
| Note that the uaa VM state is showing as starting, not running. | |
| I ssh'ed into the VM and ran monit status and got this: | |
| ubuntu@dance:~$ bosh ssh uaa/0 | |
| [WARNING] Loading the cli took 38.5 seconds, consider cleaning your gem environment | |
| Acting as user 'admin' on deployment 'cf' on 'my-bosh' | |
| Enter password (use it to sudo on remote host): ******** | |
| Target deployment is `cf' | |
| Setting up ssh artifacts | |
| Director task 56 | |
| Task 56 done | |
| Starting interactive shell on job uaa/0 | |
| The authenticity of host '10.0.1.59 (10.0.1.59)' can't be established. | |
| ECDSA key fingerprint is e1:5c:c3:83:61:6d:ac:1f:69:d0:79:af:0b:a9:be:82. | |
| Are you sure you want to continue connecting (yes/no)? yes | |
| Warning: Permanently added '10.0.1.59' (ECDSA) to the list of known hosts. | |
| Ubuntu 14.04.3 LTS | |
| Welcome to Ubuntu 14.04.3 LTS (GNU/Linux 3.16.0-46-generic ppc64le) | |
| * Documentation: https://help.ubuntu.com/ | |
| The programs included with the Ubuntu system are free software; | |
| the exact distribution terms for each program are described in the | |
| individual files in /usr/share/doc/*/copyright. | |
| Ubuntu comes with ABSOLUTELY NO WARRANTY, to the extent permitted by | |
| applicable law. | |
| To run a command as administrator (user "root"), use "sudo <command>". | |
| See "man sudo_root" for details. | |
| bosh_ndu4u75ue@d0162079-8750-4758-80b3-4de169e98e6a:~$ su | |
| Password: | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/bosh_ssh/bosh_ndu4u75ue# cd /var/vcap/packages/ | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/packages# ls | |
| common metron_agent ruby-2.1.4 uaa | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/packages# monit status | |
| The Monit daemon 5.2.4 uptime: 4d 10h 0m | |
| Process 'uaa' | |
| status Connection failed | |
| monitoring status monitored | |
| pid 0 | |
| parent pid 0 | |
| uptime 0m | |
| children 0 | |
| memory kilobytes 0 | |
| memory kilobytes total 0 | |
| memory percent 0.0% | |
| memory percent total 0.0% | |
| cpu percent 0.0% | |
| cpu percent total 0.0% | |
| port response time 0.000s to localhost:8080/healthz [HTTP via TCP] | |
| data collected Tue Sep 1 01:55:35 2015 | |
| Process 'uaa_cf-registrar' | |
| status initializing | |
| monitoring status initializing | |
| data collected Tue Sep 1 01:55:35 2015 | |
| Process 'metron_agent' | |
| status running | |
| monitoring status monitored | |
| pid 2140 | |
| parent pid 1 | |
| uptime 4d 10h 0m | |
| children 2 | |
| memory kilobytes 30976 | |
| memory kilobytes total 30976 | |
| memory percent 1.4% | |
| memory percent total 1.4% | |
| cpu percent 0.0% | |
| cpu percent total 0.0% | |
| data collected Tue Sep 1 01:55:35 2015 | |
| System 'system_d0162079-8750-4758-80b3-4de169e98e6a' | |
| status running | |
| monitoring status monitored | |
| load average [0.12] [0.08] [0.06] | |
| cpu 3.7%us 1.6%sy 0.3%wa | |
| memory usage 243392 kB [11.7%] | |
| swap usage 0 kB [0.0%] | |
| data collected Tue Sep 1 01:55:35 2015 | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/packages# | |
| [2015-08-27 22:31:18+0000] + echo '------------ STARTING uaa_ctl at Thu Aug 27 22:31:18 UTC 2015 --------------' | |
| [2015-08-27 22:31:18+0000] ------------ STARTING uaa_ctl at Thu Aug 27 22:31:18 UTC 2015 -------------- | |
| [2015-08-27 22:31:18+0000] + pidfile=/var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:18+0000] + name=UAA | |
| [2015-08-27 22:31:18+0000] + '[' -f /var/vcap/sys/run/uaa/uaa.pid ']' | |
| [2015-08-27 22:31:18+0000] ++ head -1 /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:18+0000] + pid=7435 | |
| [2015-08-27 22:31:18+0000] + '[' -n 7435 ']' | |
| [2015-08-27 22:31:18+0000] + '[' -e /proc/7435 ']' | |
| [2015-08-27 22:31:18+0000] + echo 'Removing stale pidfile...' | |
| [2015-08-27 22:31:18+0000] + rm /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:18+0000] + mkdir -p /var/vcap/sys/run/uaa | |
| [2015-08-27 22:31:18+0000] + mkdir -p /var/vcap/sys/log/uaa | |
| [2015-08-27 22:31:18+0000] + chown vcap:vcap /var/vcap/sys/run/uaa | |
| [2015-08-27 22:31:18+0000] + chown -R vcap:vcap /var/vcap/sys/log/uaa | |
| [2015-08-27 22:31:18+0000] + echo 7850 | |
| [2015-08-27 22:31:18+0000] + chown vcap:vcap /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:18+0000] + username=11515-14963-24898-24684 | |
| [2015-08-27 22:31:18+0000] + password=26264-4853-19805-8841 | |
| [2015-08-27 22:31:18+0000] + sed -i s/_random_username_replaced_by_a_script_/11515-14963-24898-24684/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-08-27 22:31:18+0000] + sed -i s/_random_password_replaced_by_a_script_/26264-4853-19805-8841/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-08-27 22:31:18+0000] + rm -rf /var/vcap/data/uaa | |
| [2015-08-27 22:31:18+0000] + mkdir -p /var/vcap/data/uaa | |
| [2015-08-27 22:31:18+0000] + cp -a /var/vcap/packages/uaa/tomcat /var/vcap/data/uaa | |
| [2015-08-27 22:31:18+0000] + cp -a /var/vcap/jobs/uaa/config/tomcat/logging.properties /var/vcap/jobs/uaa/config/tomcat/server.xml /var/vcap/data/uaa/tomcat/conf/ | |
| [2015-08-27 22:31:18+0000] + export CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-08-27 22:31:18+0000] + CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-08-27 22:31:18+0000] + export 'JAVA_OPTS=-DPID=7850 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-08-27 22:31:18+0000] + JAVA_OPTS='-DPID=7850 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-08-27 22:31:18+0000] + export 'CATALINA_OPTS=-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-08-27 22:31:18+0000] + CATALINA_OPTS='-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-08-27 22:31:18+0000] + apt-get update | |
| [2015-08-27 22:31:31+0000] + case in | |
| [2015-08-27 22:31:31+0000] + kill_and_wait /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:31+0000] + pidfile=/var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:31+0000] + timeout=25 | |
| [2015-08-27 22:31:31+0000] + force=1 | |
| [2015-08-27 22:31:31+0000] + wait_pidfile /var/vcap/sys/run/uaa/uaa.pid 1 25 1 | |
| [2015-08-27 22:31:31+0000] + pidfile=/var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:31+0000] + try_kill=1 | |
| [2015-08-27 22:31:31+0000] + timeout=25 | |
| [2015-08-27 22:31:31+0000] + force=1 | |
| [2015-08-27 22:31:31+0000] + countdown=250 | |
| [2015-08-27 22:31:31+0000] + '[' -f /var/vcap/sys/run/uaa/uaa.pid ']' | |
| [2015-08-27 22:31:31+0000] ++ head -1 /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:31+0000] + pid=7850 | |
| [2015-08-27 22:31:31+0000] + '[' -z 7850 ']' | |
| [2015-08-27 22:31:31+0000] + '[' -e /proc/7850 ']' | |
| [2015-08-27 22:31:31+0000] + '[' 1 = 1 ']' | |
| [2015-08-27 22:31:31+0000] + echo 'Killing /var/vcap/sys/run/uaa/uaa.pid: 7850 ' | |
| [2015-08-27 22:31:31+0000] + kill 7850 | |
| [2015-08-27 22:31:31+0000] + '[' -e /proc/7850 ']' | |
| [2015-08-27 22:31:31+0000] + '[' -e /proc/7850 ']' | |
| [2015-08-27 22:31:31+0000] + echo Stopped | |
| [2015-08-27 22:31:31+0000] + rm -f /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-08-27 22:31:32+0000] + case in | |
| [2015-08-27 22:31:32+0000] + pid_guard /var/vcap/sys/run/uaa/uaa.pid UAA | |
| [2015-08-27 22:31:32+0000] + tee /dev/stderr | |
| [2015-08-27 22:31:32+0000] ++ basename /var/vcap/jobs/uaa/bin/uaa_ctl | |
| [2015-08-27 22:31:32+0000] ++ date | |
| CF_TRACE after fixing DNS server in uaa VM | |
| ubuntu@dance:~$ export CF_TRACE=true | |
| ubuntu@dance:~$ cf login -u admin -p admin | |
| VERSION: | |
| BUILT_FROM_SOURCE | |
| API endpoint: https://api.10.0.1.57.xip.io | |
| REQUEST: [2015-09-02T04:14:14Z] | |
| GET /v2/info HTTP/1.1 | |
| Host: api.10.0.1.57.xip.io | |
| Accept: application/json | |
| Content-Type: application/json | |
| User-Agent: go-cli BUILT_FROM_SOURCE / linux | |
| RESPONSE: [2015-09-02T04:14:14Z] | |
| HTTP/1.1 200 OK | |
| Content-Length: 384 | |
| Content-Type: application/json;charset=utf-8 | |
| Date: Wed, 02 Sep 2015 04:14:10 GMT | |
| Server: nginx | |
| X-Cf-Requestid: 37608bd0-cac5-42d3-6c6a-931c94cd6a24 | |
| X-Content-Type-Options: nosniff | |
| X-Vcap-Request-Id: dc8a1ebf-67aa-4df2-50d9-15686613ada0::f06018d3-04a8-41cf-91ff-5d1cb141f50e | |
| {"name":"vcap","build":"2222","support":"http://support.cloudfoundry.com","version":2,"description":"Cloud Foundry sponsored by Pivotal","authorization_endpoint":"http://login.10.0.1.57.xip.io","token_endpoint":"https://uaa.10.0.1.57.xip.io","min_cli_version":null,"min_recommended_cli_version":null,"api_version":"2.25.0","logging_endpoint":"wss://loggregator.10.0.1.57.xip.io:4443"} | |
| REQUEST: [2015-09-02T04:14:14Z] | |
| GET /login HTTP/1.1 | |
| Host: login.10.0.1.57.xip.io | |
| Accept: application/json | |
| Content-Type: application/json | |
| User-Agent: go-cli BUILT_FROM_SOURCE / linux | |
| RESPONSE: [2015-09-02T04:14:14Z] | |
| HTTP/1.1 200 OK | |
| Content-Length: 162 | |
| Cache-Control: no-cache, no-store, max-age=0 | |
| Content-Language: en-US | |
| Content-Type: application/json;charset=UTF-8 | |
| Date: Wed, 02 Sep 2015 04:14:15 GMT | |
| Expires: Thu, 01 Jan 1970 00:00:00 GMT | |
| Pragma: no-cache | |
| Server: Apache-Coyote/1.1 | |
| X-Cf-Requestid: 3926ba12-712b-4541-52d3-4fa4874916ec | |
| {"timestamp":"2014-12-05T23:59:46+0000","app":{"version":"1.11"},"commit_id":"9156eed","prompts":{"username":["text","Email"],"password":["password","Password"]}} | |
| Authenticating... | |
| REQUEST: [2015-09-02T04:14:14Z] | |
| POST /oauth/token HTTP/1.1 | |
| Host: login.10.0.1.57.xip.io | |
| Accept: application/json | |
| Authorization: [PRIVATE DATA HIDDEN] | |
| Content-Type: application/x-www-form-urlencoded | |
| User-Agent: go-cli BUILT_FROM_SOURCE / linux | |
| grant_type=password&password=[PRIVATE DATA HIDDEN]&scope=&username=admin | |
| RESPONSE: [2015-09-02T04:14:46Z] | |
| HTTP/1.1 500 Internal Server Error | |
| Content-Length: 128 | |
| Cache-Control: no-cache, no-store, max-age=0 | |
| Content-Language: en-US | |
| Content-Type: application/json;charset=UTF-8 | |
| Date: Wed, 02 Sep 2015 04:14:41 GMT | |
| Expires: Thu, 01 Jan 1970 00:00:00 GMT | |
| Pragma: no-cache | |
| Server: Apache-Coyote/1.1 | |
| X-Cf-Requestid: 736b376b-2ad2-41d8-4703-922ca4a970cd | |
| {"passwd":"( \"https://console.\" domain \"/password_resets/new\" )","register":"( \"https://console.\" domain \"/register\" )"} | |
| Server error, status code: 500, error code: , message: | |
| Password> | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log# tail -100 uaa_ctl.log | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/main ppc64el Packages | |
| [2015-09-02 04:08:16+0000] Hit http://archive.ubuntu.com trusty-backports/restricted Sources | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/restricted ppc64el Packages | |
| [2015-09-02 04:08:16+0000] Hit http://archive.ubuntu.com trusty-backports/universe Sources | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/universe ppc64el Packages | |
| [2015-09-02 04:08:16+0000] Hit http://archive.ubuntu.com trusty-backports/multiverse Sources | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/multiverse ppc64el Packages | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/main Translation-en | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/multiverse Translation-en | |
| [2015-09-02 04:08:16+0000] Hit http://ports.ubuntu.com trusty/restricted Translation-en | |
| [2015-09-02 04:08:17+0000] Hit http://ports.ubuntu.com trusty/universe Translation-en | |
| [2015-09-02 04:08:17+0000] Get:11 http://ports.ubuntu.com trusty-updates/main ppc64el Packages [501 kB] | |
| [2015-09-02 04:08:17+0000] Get:12 http://ports.ubuntu.com trusty-updates/restricted ppc64el Packages [28 B] | |
| [2015-09-02 04:08:18+0000] Get:13 http://ports.ubuntu.com trusty-updates/universe ppc64el Packages [285 kB] | |
| [2015-09-02 04:08:18+0000] Get:14 http://ports.ubuntu.com trusty-updates/multiverse ppc64el Packages [5674 B] | |
| [2015-09-02 04:08:18+0000] Get:15 http://ports.ubuntu.com trusty-updates/main Translation-en [294 kB] | |
| [2015-09-02 04:08:19+0000] Hit http://ports.ubuntu.com trusty-updates/multiverse Translation-en | |
| [2015-09-02 04:08:19+0000] Hit http://ports.ubuntu.com trusty-updates/restricted Translation-en | |
| [2015-09-02 04:08:19+0000] Get:16 http://ports.ubuntu.com trusty-updates/universe Translation-en [164 kB] | |
| [2015-09-02 04:08:19+0000] Hit http://ports.ubuntu.com trusty-backports/main ppc64el Packages | |
| [2015-09-02 04:08:19+0000] Hit http://ports.ubuntu.com trusty-backports/restricted ppc64el Packages | |
| [2015-09-02 04:08:19+0000] Hit http://ports.ubuntu.com trusty-backports/universe ppc64el Packages | |
| [2015-09-02 04:08:20+0000] Hit http://ports.ubuntu.com trusty-backports/multiverse ppc64el Packages | |
| [2015-09-02 04:08:20+0000] Hit http://ports.ubuntu.com trusty-backports/main Translation-en | |
| [2015-09-02 04:08:20+0000] Hit http://ports.ubuntu.com trusty-backports/multiverse Translation-en | |
| [2015-09-02 04:08:20+0000] Hit http://ports.ubuntu.com trusty-backports/restricted Translation-en | |
| [2015-09-02 04:08:20+0000] Hit http://ports.ubuntu.com trusty-backports/universe Translation-en | |
| [2015-09-02 04:08:20+0000] Get:17 http://ports.ubuntu.com trusty-security/main Sources [93.0 kB] | |
| [2015-09-02 04:08:21+0000] Get:18 http://ports.ubuntu.com trusty-security/restricted Sources [2061 B] | |
| [2015-09-02 04:08:21+0000] Get:19 http://ports.ubuntu.com trusty-security/universe Sources [29.9 kB] | |
| [2015-09-02 04:08:21+0000] Get:20 http://ports.ubuntu.com trusty-security/multiverse Sources [2330 B] | |
| [2015-09-02 04:08:21+0000] Get:21 http://ports.ubuntu.com trusty-security/main ppc64el Packages [280 kB] | |
| [2015-09-02 04:08:22+0000] Get:22 http://ports.ubuntu.com trusty-security/restricted ppc64el Packages [28 B] | |
| [2015-09-02 04:08:22+0000] Get:23 http://ports.ubuntu.com trusty-security/universe ppc64el Packages [104 kB] | |
| [2015-09-02 04:08:22+0000] Get:24 http://ports.ubuntu.com trusty-security/multiverse ppc64el Packages [1669 B] | |
| [2015-09-02 04:08:22+0000] Get:25 http://ports.ubuntu.com trusty-security/main Translation-en [183 kB] | |
| [2015-09-02 04:08:22+0000] Hit http://ports.ubuntu.com trusty-security/multiverse Translation-en | |
| [2015-09-02 04:08:23+0000] Hit http://ports.ubuntu.com trusty-security/restricted Translation-en | |
| [2015-09-02 04:08:23+0000] Get:26 http://ports.ubuntu.com trusty-security/universe Translation-en [66.9 kB] | |
| [2015-09-02 04:08:23+0000] Fetched 2582 kB in 8s (295 kB/s) | |
| [2015-09-02 04:08:25+0000] Reading package lists... | |
| [2015-09-02 04:08:25+0000] Reading package lists... | |
| [2015-09-02 04:08:25+0000] Building dependency tree... | |
| [2015-09-02 04:08:25+0000] Reading state information... | |
| [2015-09-02 04:08:26+0000] The following extra packages will be installed: | |
| [2015-09-02 04:08:26+0000] libnspr4 libnspr4-dev libnss3 libnss3-nssdb | |
| [2015-09-02 04:08:26+0000] The following NEW packages will be installed: | |
| [2015-09-02 04:08:26+0000] libnspr4 libnspr4-dev libnss3 libnss3-dev libnss3-nssdb | |
| [2015-09-02 04:08:26+0000] 0 upgraded, 5 newly installed, 0 to remove and 1 not upgraded. | |
| [2015-09-02 04:08:26+0000] Need to get 1629 kB of archives. | |
| [2015-09-02 04:08:26+0000] After this operation, 7288 kB of additional disk space will be used. | |
| [2015-09-02 04:08:26+0000] Get:1 http://ports.ubuntu.com/ubuntu-ports/ trusty-updates/main libnspr4 ppc64el 2:4.10.7-0ubuntu0.14.04.1 [100 kB] | |
| [2015-09-02 04:08:26+0000] Get:2 http://ports.ubuntu.com/ubuntu-ports/ trusty-updates/main libnss3-nssdb all 2:3.19.2-0ubuntu0.14.04.1 [10.6 kB] | |
| [2015-09-02 04:08:26+0000] Get:3 http://ports.ubuntu.com/ubuntu-ports/ trusty-updates/main libnss3 ppc64el 2:3.19.2-0ubuntu0.14.04.1 [1098 kB] | |
| [2015-09-02 04:08:27+0000] Get:4 http://ports.ubuntu.com/ubuntu-ports/ trusty-updates/main libnspr4-dev ppc64el 2:4.10.7-0ubuntu0.14.04.1 [207 kB] | |
| [2015-09-02 04:08:27+0000] Get:5 http://ports.ubuntu.com/ubuntu-ports/ trusty-updates/main libnss3-dev ppc64el 2:3.19.2-0ubuntu0.14.04.1 [213 kB] | |
| [2015-09-02 04:08:28+0000] Fetched 1629 kB in 1s (904 kB/s) | |
| [2015-09-02 04:08:28+0000] Selecting previously unselected package libnspr4:ppc64el. | |
| [2015-09-02 04:08:28+0000] (Reading database ... 51222 files and directories currently installed.) | |
| [2015-09-02 04:08:28+0000] Preparing to unpack .../libnspr4_2%3a4.10.7-0ubuntu0.14.04.1_ppc64el.deb ... | |
| [2015-09-02 04:08:28+0000] Unpacking libnspr4:ppc64el (2:4.10.7-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:28+0000] Selecting previously unselected package libnss3-nssdb. | |
| [2015-09-02 04:08:28+0000] Preparing to unpack .../libnss3-nssdb_2%3a3.19.2-0ubuntu0.14.04.1_all.deb ... | |
| [2015-09-02 04:08:28+0000] Unpacking libnss3-nssdb (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:28+0000] Selecting previously unselected package libnss3:ppc64el. | |
| [2015-09-02 04:08:28+0000] Preparing to unpack .../libnss3_2%3a3.19.2-0ubuntu0.14.04.1_ppc64el.deb ... | |
| [2015-09-02 04:08:28+0000] Unpacking libnss3:ppc64el (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:29+0000] Selecting previously unselected package libnspr4-dev. | |
| [2015-09-02 04:08:29+0000] Preparing to unpack .../libnspr4-dev_2%3a4.10.7-0ubuntu0.14.04.1_ppc64el.deb ... | |
| [2015-09-02 04:08:29+0000] Unpacking libnspr4-dev (2:4.10.7-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:29+0000] Selecting previously unselected package libnss3-dev:ppc64el. | |
| [2015-09-02 04:08:29+0000] Preparing to unpack .../libnss3-dev_2%3a3.19.2-0ubuntu0.14.04.1_ppc64el.deb ... | |
| [2015-09-02 04:08:29+0000] Unpacking libnss3-dev:ppc64el (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:30+0000] Setting up libnspr4:ppc64el (2:4.10.7-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:30+0000] Setting up libnspr4-dev (2:4.10.7-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:30+0000] Setting up libnss3-nssdb (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:30+0000] Setting up libnss3:ppc64el (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:31+0000] Setting up libnss3-dev:ppc64el (2:3.19.2-0ubuntu0.14.04.1) ... | |
| [2015-09-02 04:08:31+0000] Processing triggers for libc-bin (2.19-0ubuntu6.6) ... | |
| [2015-09-02 04:08:40+0000] [2015-09-02 04:08:40.613] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... INFO --- DispatcherServlet: FrameworkServlet 'spring': initialization started | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.009] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- YamlProcessor: Merging document (no matchers set){oauth={user={authorities=[openid, scim.me, cloud_controller.read, cloud_controller.write, cloud_controller_service_permissions.read, password.write, scim.userids, uaa.user, approvals.me, oauth.approvals]}}} | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.013] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- YamlProcessor: Loaded 1 document from YAML resource: class path resource [uaa.yml] | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.106] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- YamlProcessor: Merging document (no matchers set){name=uaa, database={url=jdbc:postgresql://10.0.1.56:5524/uaadb, username=uaaadmin, password=#, maxactive=100, maxidle=10, removeabandoned=false, logabandoned=true, abandonedtimeout=300}, spring_profiles=postgresql, logging={config=/var/vcap/jobs/uaa/config/log4j.properties}, jwt={token={signing-key=#, verification-key=-----BEGIN PUBLIC KEY----- | |
| [2015-09-02 04:08:41+0000] MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDHFr+KICms+tuT1OXJwhCUmR2d | |
| [2015-09-02 04:08:41+0000] KVy7psa8xzElSyzqx7oJyfJ1JZyOzToj9T5SfTIq396agbHJWVfYphNahvZ/7uMX | |
| [2015-09-02 04:08:41+0000] qHxf+ZH9BL1gk9Y6kCnbM5R60gfwjyW1/dQPjOzn9N394zd2FJoFHwdq9Qs0wBug | |
| [2015-09-02 04:08:41+0000] spULZVNRxq7veq/fzwIDAQAB | |
| [2015-09-02 04:08:41+0000] -----END PUBLIC KEY----- | |
| [2015-09-02 04:08:41+0000] }}, authentication={policy={lockoutAfterFailures=5, countFailuresWithinSeconds=3600, lockoutPeriodSeconds=300}}, issuer.uri=https://uaa.10.0.1.57.xip.io, oauth={client={autoapprove=[cf, login, developer_console, support-signon]}, clients={app-direct={secret=#}, cc-service-dashboards={authorities=clients.read,clients.write,clients.admin, authorized-grant-types=client_credentials, scope=cloud_controller.write,openid,cloud_controller.read,cloud_controller_service_permissions.read, secret=#}, cf={access-token-validity=7200, authorities=uaa.none, authorized-grant-types=password,implicit,refresh_token, override=true, refresh-token-validity=1209600, scope=cloud_controller.read,cloud_controller.write,openid,password.write,cloud_controller.admin,scim.read,scim.write,scim.userids,doppler.firehose}, cloud_controller_username_lookup={authorities=scim.userids, authorized-grant-types=client_credentials, secret=#}, developer_console={secret=#}, doppler={authorities=uaa.resource, override=true, secret=#}, gorouter={authorities=clients.read,clients.write,clients.admin,route.admin,route.advertise, authorized-grant-types=authorization_code,lient_credentials,refresh_token, scope=openid,cloud_controller_service_permissions.read,oauth.approvals,doppler.firehose, secret=#}, login={authorities=oauth.login,scim.write,clients.read,notifications.write,critical_notifications.write,emails.write,scim.userids,password.write, authorized-grant-types=authorization_code,client_credentials,refresh_token, override=true, redirect-uri=https://uaa.10.0.1.57.xip.io, scope=openid,oauth.approvals,doppler.firehose, secret=#}, notifications={authorities=cloud_controller.admin,scim.read, authorized-grant-types=client_credentials, secret=#}, admin={authorized-grant-types=client_credentials, authorities=clients.read,clients.write,clients.secret,uaa.admin,scim.read,scim.write,password.write, id=admin, secret=#}, cloud_controller={authorized-grant-types=client_credentials, authorities=scim.read,scim.write,password.write, id=cloud_controller, secret=#, access-token-validity=604800}}, user={authorities=[openid, scim.me, cloud_controller.read, cloud_controller.write, cloud_controller_service_permissions.read, password.write, uaa.user, approvals.me, oauth.approvals, notification_preferences.read, notification_preferences.write]}, openid={fallbackToAuthcode=true}}, scim={userids_enabled=true, user.override=true, users=[services|admin|scim.write,scim.read,openid,cloud_controller.admin, admin|admin|scim.write,scim.read,openid,cloud_controller.admin,clients.read,clients.write,password.write,uaa.admin,clients.secret,doppler.firehose]}, zones={internal={hostnames=[uaa.service.consul]}}} | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.112] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- YamlProcessor: Loaded 1 document from YAML resource: URL [file:/var/vcap/jobs/uaa/config/uaa.yml] | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.247] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- NestedMapPropertySource: PropertySource [servletConfigYaml] contains 'spring_profiles' | |
| [2015-09-02 04:08:41+0000] [2015-09-02 04:08:41.262] cloudfoundry-identity-uaa - 20284 [localhost-startStop-1] .... DEBUG --- NestedMapPropertySource: PropertySource [servletConfigYaml] contains 'logging.config' | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.054] varz/varz - 20284 [localhost-startStop-1] .... DEBUG --- DelegatingFilterProxy: Initializing filter 'varzSecurityFilterChain' | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.105] varz/varz - 20284 [localhost-startStop-1] .... DEBUG --- DelegatingFilterProxy: Filter 'varzSecurityFilterChain' configured successfully | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.156] varz/varz - 20284 [localhost-startStop-1] .... DEBUG --- DispatcherServlet: Initializing servlet 'varz' | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.197] varz/varz - 20284 [localhost-startStop-1] .... INFO --- DispatcherServlet: FrameworkServlet 'varz': initialization started | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.197] varz/varz - 20284 [localhost-startStop-1] .... DEBUG --- DispatcherServlet: Servlet with name 'varz' will try to create custom WebApplicationContext context of class 'org.springframework.web.context.support.XmlWebApplicationContext', using parent context [null] | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.300] varz/varz - 20284 [localhost-startStop-1] .... INFO --- YamlProcessor: Loading from YAML: URL [file:/var/vcap/jobs/uaa/config/varz.yml] | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.349] varz/varz - 20284 [localhost-startStop-1] .... DEBUG --- YamlProcessor: Merging document (no matchers set){pid=/var/vcap/sys/run/uaa.pid, varz={username=291-15472-1660-22679, password=#, type=uaa}, logging={config=/var/vcap/jobs/uaa/config/varz.log4j.properties}} | |
| [2015-09-02 04:09:06+0000] [2015-09-02 04:09:06.350] varz/varz - 20284 [localhost-startStop-1] .... INFO --- YamlProcessor: Loaded 1 document from YAML resource: URL [file:/var/vcap/jobs/uaa/config/varz.yml] | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log# tail -100 uaa_ctl.err.log | |
| [2015-09-02 02:12:10+0000] | |
| [2015-09-02 02:12:10+0000] W: Failed to fetch http://archive.ubuntu.com/ubuntu/dists/trusty-updates/Release.gpg Could not resolve 'archive.ubuntu.com' | |
| [2015-09-02 02:12:10+0000] | |
| [2015-09-02 02:12:10+0000] W: Failed to fetch http://archive.ubuntu.com/ubuntu/dists/trusty-backports/Release.gpg Could not resolve 'archive.ubuntu.com' | |
| [2015-09-02 02:12:10+0000] | |
| [2015-09-02 02:12:10+0000] W: Some index files failed to download. They have been ignored, or old ones used instead. | |
| [2015-09-02 02:12:41+0000] + case in | |
| [2015-09-02 02:12:41+0000] + pid_guard /var/vcap/sys/run/uaa/uaa.pid UAA | |
| [2015-09-02 02:12:41+0000] + tee /dev/stderr | |
| [2015-09-02 02:12:41+0000] ++ basename /var/vcap/jobs/uaa/bin/uaa_ctl | |
| [2015-09-02 02:12:41+0000] ++ date | |
| [2015-09-02 02:12:41+0000] + echo '------------ STARTING uaa_ctl at Wed Sep 2 02:12:41 UTC 2015 --------------' | |
| [2015-09-02 02:12:41+0000] ------------ STARTING uaa_ctl at Wed Sep 2 02:12:41 UTC 2015 -------------- | |
| [2015-09-02 02:12:41+0000] + pidfile=/var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 02:12:41+0000] + name=UAA | |
| [2015-09-02 02:12:41+0000] + '[' -f /var/vcap/sys/run/uaa/uaa.pid ']' | |
| [2015-09-02 02:12:41+0000] ++ head -1 /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 02:12:41+0000] + pid=19173 | |
| [2015-09-02 02:12:41+0000] + '[' -n 19173 ']' | |
| [2015-09-02 02:12:41+0000] + '[' -e /proc/19173 ']' | |
| [2015-09-02 02:12:41+0000] + echo 'Removing stale pidfile...' | |
| [2015-09-02 02:12:41+0000] + rm /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 02:12:41+0000] + mkdir -p /var/vcap/sys/run/uaa | |
| [2015-09-02 02:12:41+0000] + mkdir -p /var/vcap/sys/log/uaa | |
| [2015-09-02 02:12:41+0000] + chown vcap:vcap /var/vcap/sys/run/uaa | |
| [2015-09-02 02:12:41+0000] + chown -R vcap:vcap /var/vcap/sys/log/uaa | |
| [2015-09-02 02:12:41+0000] + echo 19588 | |
| [2015-09-02 02:12:41+0000] + chown vcap:vcap /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 02:12:41+0000] + username=10612-344-23852-3483 | |
| [2015-09-02 02:12:41+0000] + password=24987-2387-26410-7109 | |
| [2015-09-02 02:12:41+0000] + sed -i s/_random_username_replaced_by_a_script_/10612-344-23852-3483/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-09-02 02:12:41+0000] + sed -i s/_random_password_replaced_by_a_script_/24987-2387-26410-7109/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-09-02 02:12:41+0000] + rm -rf /var/vcap/data/uaa | |
| [2015-09-02 02:12:41+0000] + mkdir -p /var/vcap/data/uaa | |
| [2015-09-02 02:12:41+0000] + cp -a /var/vcap/packages/uaa/tomcat /var/vcap/data/uaa | |
| [2015-09-02 02:12:41+0000] + cp -a /var/vcap/jobs/uaa/config/tomcat/logging.properties /var/vcap/jobs/uaa/config/tomcat/server.xml /var/vcap/data/uaa/tomcat/conf/ | |
| [2015-09-02 02:12:41+0000] + export CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-09-02 02:12:41+0000] + CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-09-02 02:12:41+0000] + export 'JAVA_OPTS=-DPID=19588 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-09-02 02:12:41+0000] + JAVA_OPTS='-DPID=19588 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-09-02 02:12:41+0000] + export 'CATALINA_OPTS=-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-09-02 02:12:41+0000] + CATALINA_OPTS='-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-09-02 02:12:41+0000] + export JAVA_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 02:12:41+0000] + JAVA_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 02:12:41+0000] + export JRE_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 02:12:41+0000] + JRE_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 02:12:41+0000] + cd /var/vcap/data/uaa | |
| [2015-09-02 02:12:41+0000] + chown -R vcap:vcap /var/vcap/data/uaa | |
| [2015-09-02 02:12:41+0000] + exec chpst -u vcap:vcap tomcat/bin/catalina.sh run | |
| [2015-09-02 02:12:44+0000] Warning: default mime table not found: /var/vcap/data/packages/uaa/7843f879849c3b9a4ed33ca4519a9a0ef19a48a1.1-81dd440f1ec54053c42284140ca24cd18d62b777/jdk/jre/lib/content-types.properties | |
| [2015-09-02 02:13:15+0000] log4j:ERROR Could not find value for key log4j.appender.SYSLOG | |
| [2015-09-02 02:13:15+0000] log4j:ERROR Could not instantiate appender named SYSLOG. | |
| [2015-09-02 04:08:14+0000] + case in | |
| [2015-09-02 04:08:14+0000] + pid_guard /var/vcap/sys/run/uaa/uaa.pid UAA | |
| [2015-09-02 04:08:14+0000] + tee /dev/stderr | |
| [2015-09-02 04:08:14+0000] ++ basename /var/vcap/jobs/uaa/bin/uaa_ctl | |
| [2015-09-02 04:08:14+0000] ++ date | |
| [2015-09-02 04:08:14+0000] + echo '------------ STARTING uaa_ctl at Wed Sep 2 04:08:14 UTC 2015 --------------' | |
| [2015-09-02 04:08:14+0000] ------------ STARTING uaa_ctl at Wed Sep 2 04:08:14 UTC 2015 -------------- | |
| [2015-09-02 04:08:14+0000] + pidfile=/var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 04:08:14+0000] + name=UAA | |
| [2015-09-02 04:08:14+0000] + '[' -f /var/vcap/sys/run/uaa/uaa.pid ']' | |
| [2015-09-02 04:08:14+0000] ++ head -1 /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 04:08:14+0000] + pid=19588 | |
| [2015-09-02 04:08:14+0000] + '[' -n 19588 ']' | |
| [2015-09-02 04:08:14+0000] + '[' -e /proc/19588 ']' | |
| [2015-09-02 04:08:14+0000] + echo 'Removing stale pidfile...' | |
| [2015-09-02 04:08:14+0000] + rm /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 04:08:14+0000] + mkdir -p /var/vcap/sys/run/uaa | |
| [2015-09-02 04:08:14+0000] + mkdir -p /var/vcap/sys/log/uaa | |
| [2015-09-02 04:08:14+0000] + chown vcap:vcap /var/vcap/sys/run/uaa | |
| [2015-09-02 04:08:14+0000] + chown -R vcap:vcap /var/vcap/sys/log/uaa | |
| [2015-09-02 04:08:14+0000] + echo 20284 | |
| [2015-09-02 04:08:14+0000] + chown vcap:vcap /var/vcap/sys/run/uaa/uaa.pid | |
| [2015-09-02 04:08:14+0000] + username=14338-14137-1069-23140 | |
| [2015-09-02 04:08:14+0000] + password=32359-16092-6061-6176 | |
| [2015-09-02 04:08:14+0000] + sed -i s/_random_username_replaced_by_a_script_/14338-14137-1069-23140/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-09-02 04:08:14+0000] + sed -i s/_random_password_replaced_by_a_script_/32359-16092-6061-6176/g /var/vcap/jobs/uaa/config/varz.yml | |
| [2015-09-02 04:08:14+0000] + rm -rf /var/vcap/data/uaa | |
| [2015-09-02 04:08:14+0000] + mkdir -p /var/vcap/data/uaa | |
| [2015-09-02 04:08:14+0000] + cp -a /var/vcap/packages/uaa/tomcat /var/vcap/data/uaa | |
| [2015-09-02 04:08:14+0000] + cp -a /var/vcap/jobs/uaa/config/tomcat/logging.properties /var/vcap/jobs/uaa/config/tomcat/server.xml /var/vcap/data/uaa/tomcat/conf/ | |
| [2015-09-02 04:08:14+0000] + export CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-09-02 04:08:14+0000] + CLOUD_FOUNDRY_CONFIG_PATH=/var/vcap/jobs/uaa/config | |
| [2015-09-02 04:08:14+0000] + export 'JAVA_OPTS=-DPID=20284 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-09-02 04:08:14+0000] + JAVA_OPTS='-DPID=20284 -Dsun.net.inetaddr.ttl=60 -Dnetworkaddress.cache.ttl=60 -Dpassword-policy.required-score=0 ' | |
| [2015-09-02 04:08:14+0000] + export 'CATALINA_OPTS=-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-09-02 04:08:14+0000] + CATALINA_OPTS='-Xmx768m -XX:MaxPermSize=256m' | |
| [2015-09-02 04:08:14+0000] + apt-get update | |
| [2015-09-02 04:08:25+0000] + apt-get install -y libnss3-dev | |
| [2015-09-02 04:08:32+0000] + export JAVA_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 04:08:32+0000] + JAVA_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 04:08:32+0000] + export JRE_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 04:08:32+0000] + JRE_HOME=/var/vcap/packages/uaa/jdk | |
| [2015-09-02 04:08:32+0000] + cd /var/vcap/data/uaa | |
| [2015-09-02 04:08:32+0000] + chown -R vcap:vcap /var/vcap/data/uaa | |
| [2015-09-02 04:08:32+0000] + exec chpst -u vcap:vcap tomcat/bin/catalina.sh run | |
| [2015-09-02 04:08:33+0000] Warning: default mime table not found: /var/vcap/data/packages/uaa/7843f879849c3b9a4ed33ca4519a9a0ef19a48a1.1-81dd440f1ec54053c42284140ca24cd18d62b777/jdk/jre/lib/content-types.properties | |
| [2015-09-02 04:09:06+0000] log4j:ERROR Could not find value for key log4j.appender.SYSLOG | |
| [2015-09-02 04:09:06+0000] log4j:ERROR Could not instantiate appender named SYSLOG. | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log# | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# tail -100 uaa.log | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:22:50.316] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:22:50.317] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:22:50.317] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:22:50.317] uaa - 20284 [http-bio-8080-exec-5] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:22:58.878] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:22:58.879] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:22:58.880] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:22:58.881] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:22:58.881] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:22:58.881] uaa - 20284 [http-bio-8080-exec-1] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:23:08.886] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:23:08.887] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:23:08.887] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:23:08.887] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:23:08.888] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:23:08.888] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:23:08.888] uaa - 20284 [http-bio-8080-exec-7] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:23:18.894] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:23:18.894] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:23:18.894] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:23:18.894] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:23:18.894] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:23:18.895] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:23:18.895] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:23:18.895] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:23:18.895] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:23:18.895] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:23:18.896] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:23:18.896] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:23:18.896] uaa - 20284 [http-bio-8080-exec-9] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:23:20.304] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcTemplate: Executing prepared SQL query | |
| [2015-09-02 04:23:20.305] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcTemplate: Executing prepared SQL statement [select client_id, client_secret, resource_ids, scope, authorized_grant_types, web_server_redirect_uri, authorities, access_token_validity, refresh_token_validity, additional_information, autoapprove from oauth_client_details order by client_id] | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:23:20.330] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:23:20.331] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:23:20.331] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:23:20.331] uaa - 20284 [http-bio-8080-exec-10] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:23:20.333] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcScimUserProvisioning: Filtering groups with SQL: sql: id IS NOT NULL ORDER BY created ASC, params: {} | |
| [2015-09-02 04:23:20.333] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcScimUserProvisioning: complete sql: select id,version,created,lastModified,username,email,givenName,familyName,active,phoneNumber,verified,origin,external_id from users where id IS NOT NULL ORDER BY created ASC, params: {} | |
| [2015-09-02 04:23:20.333] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcTemplate: Executing prepared SQL query | |
| [2015-09-02 04:23:20.333] uaa - 20284 [http-bio-8080-exec-4] .... DEBUG --- JdbcTemplate: Executing prepared SQL statement [select count(*) from users where id is not null ] | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:23:28.902] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:23:28.903] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:23:28.903] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:23:28.903] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:23:28.903] uaa - 20284 [http-bio-8080-exec-3] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/resources/**' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/favicon.ico' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/info' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/password/**' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- AntPathRequestMatcher: Checking match of request : '/healthz'; against '/healthz/**' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- FilterChainProxy: /healthz at position 1 of 1 in additional filter chain; firing Filter: 'UaaLoggingFilter' | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- SecurityFilterChainPostProcessor$UaaLoggingFilter: Filter chain 'org.springframework.security.web.DefaultSecurityFilterChain#4' processing request GET /healthz | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- FilterChainProxy: /healthz reached end of additional filter chain; proceeding with original chain | |
| [2015-09-02 04:23:38.911] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- DispatcherServlet: DispatcherServlet with name 'spring' processing GET request for [/healthz] | |
| [2015-09-02 04:23:38.912] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- DispatcherServlet: Last-Modified value for [/healthz] is: -1 | |
| [2015-09-02 04:23:38.913] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- RequestResponseBodyMethodProcessor: Written [ok | |
| ] as "text/plain;charset=ISO-8859-1" using [org.springframework.http.converter.StringHttpMessageConverter@20a38b8] | |
| [2015-09-02 04:23:38.913] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- DispatcherServlet: Null ModelAndView returned to DispatcherServlet with name 'spring': assuming HandlerAdapter completed request handling | |
| [2015-09-02 04:23:38.913] uaa - 20284 [http-bio-8080-exec-6] .... DEBUG --- DispatcherServlet: Successfully completed request | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# tail -100 catalina.2015-09-02.log | |
| Sep 02, 2015 2:12:42 AM org.apache.catalina.core.AprLifecycleListener init | |
| INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /usr/java/packages/lib/ppc64:/usr/lib/powerpc64le-linux-gnu/jni:/lib/powerpc64le-linux-gnu:/usr/lib/powerpc64le-linux-gnu:/usr/lib/jni:/lib:/usr/lib | |
| Sep 02, 2015 2:12:42 AM org.apache.catalina.startup.SetAllPropertiesRule begin | |
| WARNING: [SetAllPropertiesRule]{Server/Service/Connector} Setting property 'class' to 'org.apache.coyote.http11.Http11NioProtocol' did not find a matching property. | |
| Sep 02, 2015 2:12:43 AM org.apache.coyote.AbstractProtocol init | |
| INFO: Initializing ProtocolHandler ["http-bio-8080"] | |
| Sep 02, 2015 2:12:43 AM org.apache.catalina.startup.Catalina load | |
| INFO: Initialization processed in 1241 ms | |
| Sep 02, 2015 2:12:43 AM org.apache.catalina.core.StandardService startInternal | |
| INFO: Starting service Catalina | |
| Sep 02, 2015 2:12:43 AM org.apache.catalina.core.StandardEngine startInternal | |
| INFO: Starting Servlet Engine: Apache Tomcat/7.0.55 | |
| Sep 02, 2015 2:12:43 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deploying web application archive /var/vcap/data/uaa/tomcat/webapps/ROOT.war | |
| Sep 02, 2015 2:12:50 AM org.apache.catalina.util.SessionIdGenerator createSecureRandom | |
| INFO: Creation of SecureRandom instance for session ID generation using [SHA1PRNG] took [5,016] milliseconds. | |
| Sep 02, 2015 2:13:13 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deployment of web application archive /var/vcap/data/uaa/tomcat/webapps/ROOT.war has finished in 30,349 ms | |
| Sep 02, 2015 2:13:13 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deploying web application archive /var/vcap/data/uaa/tomcat/webapps/varz.war | |
| Sep 02, 2015 2:13:17 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deployment of web application archive /var/vcap/data/uaa/tomcat/webapps/varz.war has finished in 3,726 ms | |
| Sep 02, 2015 2:13:17 AM org.apache.coyote.AbstractProtocol start | |
| INFO: Starting ProtocolHandler ["http-bio-8080"] | |
| Sep 02, 2015 2:13:17 AM org.apache.catalina.startup.Catalina start | |
| INFO: Server startup in 34214 ms | |
| Sep 02, 2015 4:08:32 AM org.apache.catalina.core.AprLifecycleListener init | |
| INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /usr/java/packages/lib/ppc64:/usr/lib/powerpc64le-linux-gnu/jni:/lib/powerpc64le-linux-gnu:/usr/lib/powerpc64le-linux-gnu:/usr/lib/jni:/lib:/usr/lib | |
| Sep 02, 2015 4:08:32 AM org.apache.catalina.startup.SetAllPropertiesRule begin | |
| WARNING: [SetAllPropertiesRule]{Server/Service/Connector} Setting property 'class' to 'org.apache.coyote.http11.Http11NioProtocol' did not find a matching property. | |
| Sep 02, 2015 4:08:33 AM org.apache.coyote.AbstractProtocol init | |
| INFO: Initializing ProtocolHandler ["http-bio-8080"] | |
| Sep 02, 2015 4:08:33 AM org.apache.catalina.startup.Catalina load | |
| INFO: Initialization processed in 870 ms | |
| Sep 02, 2015 4:08:33 AM org.apache.catalina.core.StandardService startInternal | |
| INFO: Starting service Catalina | |
| Sep 02, 2015 4:08:33 AM org.apache.catalina.core.StandardEngine startInternal | |
| INFO: Starting Servlet Engine: Apache Tomcat/7.0.55 | |
| Sep 02, 2015 4:08:33 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deploying web application archive /var/vcap/data/uaa/tomcat/webapps/ROOT.war | |
| Sep 02, 2015 4:08:39 AM org.apache.catalina.util.SessionIdGenerator createSecureRandom | |
| INFO: Creation of SecureRandom instance for session ID generation using [SHA1PRNG] took [5,016] milliseconds. | |
| Sep 02, 2015 4:09:03 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deployment of web application archive /var/vcap/data/uaa/tomcat/webapps/ROOT.war has finished in 30,436 ms | |
| Sep 02, 2015 4:09:03 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deploying web application archive /var/vcap/data/uaa/tomcat/webapps/varz.war | |
| Sep 02, 2015 4:09:07 AM org.apache.catalina.startup.HostConfig deployWAR | |
| INFO: Deployment of web application archive /var/vcap/data/uaa/tomcat/webapps/varz.war has finished in 4,271 ms | |
| Sep 02, 2015 4:09:07 AM org.apache.coyote.AbstractProtocol start | |
| INFO: Starting ProtocolHandler ["http-bio-8080"] | |
| Sep 02, 2015 4:09:07 AM org.apache.catalina.startup.Catalina start | |
| INFO: Server startup in 34764 ms | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# tail -100 varz.log | |
| [2015-09-02 02:13:15.846] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- XmlWebApplicationContext: Refreshing WebApplicationContext for namespace 'varz-servlet': startup date [Wed Sep 02 02:13:15 GMT 2015]; root of context hierarchy | |
| [2015-09-02 02:13:15.882] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- XmlBeanDefinitionReader: Loading XML bean definitions from ServletContext resource [/WEB-INF/varz-servlet.xml] | |
| [2015-09-02 02:13:15.923] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- XmlBeanDefinitionReader: Loading XML bean definitions from ServletContext resource [/WEB-INF/env-context.xml] | |
| [2015-09-02 02:13:15.952] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- SpringSecurityCoreVersion: You are running with Spring Security Core 3.1.2.RELEASE | |
| [2015-09-02 02:13:15.953] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- SecurityNamespaceHandler: Spring Security 'config' module version is 3.1.2.RELEASE | |
| [2015-09-02 02:13:16.016] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- HttpSecurityBeanDefinitionParser: Checking sorted filter chain: [Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, Root bean: class [org.springframework.security.web.authentication.www.BasicAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1200, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1900, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 2000] | |
| [2015-09-02 02:13:16.843] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- YamlProcessor: Loading from YAML: class path resource [varz.yml] | |
| [2015-09-02 02:13:16.843] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- YamlProcessor: Loaded 0 document from YAML resource: class path resource [varz.yml] | |
| [2015-09-02 02:13:16.920] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- DefaultListableBeanFactory: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@2a46d769: defining beans [applicationProperties,org.springframework.context.support.PropertySourcesPlaceholderConfigurer#0,mbeanServer,org.springframework.security.filterChains,org.springframework.security.filterChainProxy,org.springframework.security.web.DefaultSecurityFilterChain#0,org.springframework.security.web.PortMapperImpl#0,org.springframework.security.web.PortResolverImpl#0,org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.web.savedrequest.NullRequestCache#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.userDetailsServiceFactory,org.springframework.security.web.DefaultSecurityFilterChain#1,securityContextRepository,org.springframework.security.provisioning.InMemoryUserDetailsManager#0,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,authenticationDetailsSource,accessDeniedHandler,authenticationEntryPoint,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping#0,org.springframework.format.support.FormattingConversionServiceFactoryBean#0,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter#0,org.springframework.web.servlet.handler.MappedInterceptor#0,org.springframework.web.servlet.mvc.method.annotation.ExceptionHandlerExceptionResolver#0,org.springframework.web.servlet.mvc.annotation.ResponseStatusExceptionResolver#0,org.springframework.web.servlet.mvc.support.DefaultHandlerExceptionResolver#0,org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping,org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter,org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping#1,varzEndpoint]; root of factory hierarchy | |
| [2015-09-02 02:13:16.970] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- DefaultSecurityFilterChain: Creating filter chain: Ant [pattern='/info/**'], [] | |
| [2015-09-02 02:13:17.195] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- DefaultSecurityFilterChain: Creating filter chain: org.springframework.security.web.util.AnyRequestMatcher@1, [org.springframework.security.web.context.SecurityContextPersistenceFilter@28a80210, org.springframework.security.web.authentication.www.BasicAuthenticationFilter@2e1f7d4a, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@155a9cee, org.springframework.security.web.access.ExceptionTranslationFilter@6ff4d835, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@339eb8ff] | |
| [2015-09-02 02:13:17.300] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/{domain}],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getDomain(java.lang.String,java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.300] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/domains],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Set<java.lang.String> org.cloudfoundry.identity.varz.VarzEndpoint.getMBeanDomains() throws java.io.IOException | |
| [2015-09-02 02:13:17.300] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getVarz(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.301] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/env],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getEnv() throws java.lang.Exception | |
| [2015-09-02 02:13:17.301] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/info],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getInfo(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.509] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/{domain}],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getDomain(java.lang.String,java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.510] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/domains],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Set<java.lang.String> org.cloudfoundry.identity.varz.VarzEndpoint.getMBeanDomains() throws java.io.IOException | |
| [2015-09-02 02:13:17.510] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getVarz(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.510] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/env],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getEnv() throws java.lang.Exception | |
| [2015-09-02 02:13:17.515] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/info],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getInfo(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 02:13:17.528] uaa/varz - 19588 [localhost-startStop-1] .... INFO --- DispatcherServlet: FrameworkServlet 'varz': initialization completed in 1847 ms | |
| [2015-09-02 04:09:06.354] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- XmlWebApplicationContext: Refreshing WebApplicationContext for namespace 'varz-servlet': startup date [Wed Sep 02 04:09:06 GMT 2015]; root of context hierarchy | |
| [2015-09-02 04:09:06.387] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- XmlBeanDefinitionReader: Loading XML bean definitions from ServletContext resource [/WEB-INF/varz-servlet.xml] | |
| [2015-09-02 04:09:06.435] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- XmlBeanDefinitionReader: Loading XML bean definitions from ServletContext resource [/WEB-INF/env-context.xml] | |
| [2015-09-02 04:09:06.495] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- SpringSecurityCoreVersion: You are running with Spring Security Core 3.1.2.RELEASE | |
| [2015-09-02 04:09:06.495] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- SecurityNamespaceHandler: Spring Security 'config' module version is 3.1.2.RELEASE | |
| [2015-09-02 04:09:06.563] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- HttpSecurityBeanDefinitionParser: Checking sorted filter chain: [Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, Root bean: class [org.springframework.security.web.authentication.www.BasicAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1200, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1900, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 2000] | |
| [2015-09-02 04:09:06.679] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- YamlProcessor: Loading from YAML: class path resource [varz.yml] | |
| [2015-09-02 04:09:06.684] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- YamlProcessor: Loaded 0 document from YAML resource: class path resource [varz.yml] | |
| [2015-09-02 04:09:06.747] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- DefaultListableBeanFactory: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4b41ceef: defining beans [applicationProperties,org.springframework.context.support.PropertySourcesPlaceholderConfigurer#0,mbeanServer,org.springframework.security.filterChains,org.springframework.security.filterChainProxy,org.springframework.security.web.DefaultSecurityFilterChain#0,org.springframework.security.web.PortMapperImpl#0,org.springframework.security.web.PortResolverImpl#0,org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.web.savedrequest.NullRequestCache#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.userDetailsServiceFactory,org.springframework.security.web.DefaultSecurityFilterChain#1,securityContextRepository,org.springframework.security.provisioning.InMemoryUserDetailsManager#0,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,authenticationDetailsSource,accessDeniedHandler,authenticationEntryPoint,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping#0,org.springframework.format.support.FormattingConversionServiceFactoryBean#0,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter#0,org.springframework.web.servlet.handler.MappedInterceptor#0,org.springframework.web.servlet.mvc.method.annotation.ExceptionHandlerExceptionResolver#0,org.springframework.web.servlet.mvc.annotation.ResponseStatusExceptionResolver#0,org.springframework.web.servlet.mvc.support.DefaultHandlerExceptionResolver#0,org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping,org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter,org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter,org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping#1,varzEndpoint]; root of factory hierarchy | |
| [2015-09-02 04:09:06.796] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- DefaultSecurityFilterChain: Creating filter chain: Ant [pattern='/info/**'], [] | |
| [2015-09-02 04:09:07.027] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- DefaultSecurityFilterChain: Creating filter chain: org.springframework.security.web.util.AnyRequestMatcher@1, [org.springframework.security.web.context.SecurityContextPersistenceFilter@4d6e11f3, org.springframework.security.web.authentication.www.BasicAuthenticationFilter@755c903b, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@10014daf, org.springframework.security.web.access.ExceptionTranslationFilter@4593245e, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@3f38bb01] | |
| [2015-09-02 04:09:07.173] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/{domain}],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getDomain(java.lang.String,java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.173] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/domains],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Set<java.lang.String> org.cloudfoundry.identity.varz.VarzEndpoint.getMBeanDomains() throws java.io.IOException | |
| [2015-09-02 04:09:07.174] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/env],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getEnv() throws java.lang.Exception | |
| [2015-09-02 04:09:07.174] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getVarz(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.174] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/info],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getInfo(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.959] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/{domain}],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getDomain(java.lang.String,java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.963] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/domains],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Set<java.lang.String> org.cloudfoundry.identity.varz.VarzEndpoint.getMBeanDomains() throws java.io.IOException | |
| [2015-09-02 04:09:07.963] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/env],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getEnv() throws java.lang.Exception | |
| [2015-09-02 04:09:07.964] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getVarz(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.964] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- RequestMappingHandlerMapping: Mapped "{[/info],methods=[],params=[],headers=[],consumes=[],produces=[],custom=[]}" onto public java.util.Map<java.lang.String, ?> org.cloudfoundry.identity.varz.VarzEndpoint.getInfo(java.lang.String) throws java.lang.Exception | |
| [2015-09-02 04:09:07.981] uaa/varz - 20284 [localhost-startStop-1] .... INFO --- DispatcherServlet: FrameworkServlet 'varz': initialization completed in 1784 ms | |
| root@d0162079-8750-4758-80b3-4de169e98e6a:/var/vcap/sys/log/uaa# | |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment