Created
July 11, 2017 04:25
-
-
Save imechemi/adfa410bc34bcf764a09e8aaf8fdbdfe to your computer and use it in GitHub Desktop.
This is the actual error log with PassengerLogLevel 7 and during incident time.
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
[ 2017-07-09 08:55:01.1282 6743/7fb4a7f34700 Uti/ScopeGuard.h:113 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:01.1284 6743/7fb4a7f34700 App/Poo/AnalyticsCollection.cpp:71 ]: Analytics collection done; next analytics collection in 4.872 sec | |
[ 2017-07-09 08:55:02.0688 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:02.0690 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.0690 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2041] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.0690 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2041 | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2041] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2041] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2041] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.0691 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.0692 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2041] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:02.0693 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2041] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.0693 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2041] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.0693 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2041] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:02.0694 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2041] New request received: #1 | |
[ 2017-07-09 08:55:02.0694 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.0695 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2041] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:02.0695 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2041] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.0695 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2041] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.0698 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.0699 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.0700 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.0700 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0700 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2582 | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.0701 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2041] Ending request | |
[ 2017-07-09 08:55:02.0702 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2041] Ending request | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.0703 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2041] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2041] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2041] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2041] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2041] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2041] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2041] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2041] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2041] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2041] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2041] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2041] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.0704 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2041] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2041] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2041] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2041] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.0705 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2041] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2041] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2041] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2041] Client sent EOF | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2041] Client sent EOF | |
[ 2017-07-09 08:55:02.0706 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2041] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2041] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2041] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2041] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2041] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.0707 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2041] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2041] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2041] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2041] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2041] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2041] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.0708 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2041] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.0709 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2041] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.0709 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2041] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.0709 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2041] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.0709 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2041] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.0709 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2041] Client object destroyed; not added to freelist because it's full (0) | |
[ 2017-07-09 08:55:02.0764 6751/7f5ab40b0700 age/Ust/LoggingServer.h:753 ]: Flushing all sinks | |
[ 2017-07-09 08:55:02.1010 6779/7f65892e27e0 apa/Hooks.cpp:275 ]: File descriptor opened: 10 | |
[ 2017-07-09 08:55:02.1012 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: 66 | |
[ 2017-07-09 08:55:02.1012 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:135 ]: Accepted client file descriptor: 66 | |
[ 2017-07-09 08:55:02.1012 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: -1 | |
[ 2017-07-09 08:55:02.1012 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: -1 | |
[ 2017-07-09 08:55:02.1013 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:163 ]: Feeding client to server thread 3: file descriptor 66 | |
[ 2017-07-09 08:55:02.1014 6743/7fb4a5375700 age/Cor/Req/TurboCaching.h:242 ]: Clearing turbocache | |
[ 2017-07-09 08:55:02.1015 6743/7fb4a5375700 Ser/Server.h:352 ]: [ServerThr.4] Checking out client object from freelist (128 -> 127) | |
[ 2017-07-09 08:55:02.1015 6743/7fb4a5375700 Ser/Server.h:352 ]: [ServerThr.4] Checking out client object from freelist (128 -> 127) | |
[ 2017-07-09 08:55:02.1015 6743/7fb4a5375700 Ser/Server.h:575 ]: [Client 4-4816] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.1015 6743/7fb4a5375700 Ser/Server.h:575 ]: [Client 4-4816] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.1016 6743/7fb4a5375700 Ser/Server.h:726 ]: File descriptor purpose: 66: Server ServerThr.4, client 4-4816 | |
[ 2017-07-09 08:55:02.1016 6743/7fb4a5375700 Ser/Server.h:730 ]: [ServerThr.4] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.1017 6743/7fb4a5375700 Ser/HttpServer.h:668 ]: [Client 4-4816] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.1017 6743/7fb4a5375700 Ser/HttpServer.h:235 ]: [Client 4-4816] Refcount increased; it is now 3 | |
ased; it is now 3 | |
[ 2017-07-09 08:55:02.1018 6743/7fb4a5375700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xb5de10] Deinitialize | |
[ 2017-07-09 08:55:02.1018 6743/7fb4a5375700 Ser/HttpServer.h:119 ]: [ServerThr.4] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.1018 6743/7fb4a5375700 Ser/Server.h:452 ]: [Client 4-4816] Processing 464 bytes of client data | |
[ 2017-07-09 08:55:02.1019 6743/7fb4a5375700 Ser/HttpServer.h:676 ]: [Client 4-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.1019 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1019 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1019 6743/7fb4a5375700 Ser/HttpServer.h:256 ]: [Client 4-4816] Parsing 464 bytes of HTTP header: "HEAD /client-solution-configuration-service/meta/availability HTTP/1.1\r\nX-Forwarded-Proto: https\r\nConnection: close\r\n!~: kbdnBq92lKPPhbOsZhFlmKsr\r\n!~DOCUMENT_ROOT: /opt/healtheintent/applications/client_solution_configuration_service/public\r\n!~SCRIPT_NAME: /client-solution-configuration-service\r\n!~REMOTE_ADDR: 10.190.115.27\r\n!~REMOTE_PORT: 53316\r\n!~PASSENGER_APP_GROUP_NAME: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_" | |
[ 2017-07-09 08:55:02.1020 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1021 6743/7fb4a5375700 Ser/Server.h:479 ]: [Client 4-4816] 464 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1021 6743/7fb4a5375700 Ser/Server.h:528 ]: [Client 4-4816] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1021 6743/7fb4a5375700 Ser/FdSourceChannel.h:54 ]: [Client 4-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1022 6743/7fb4a5375700 Ser/Server.h:452 ]: [Client 4-4816] Processing 265 bytes of client data | |
[ 2017-07-09 08:55:02.1022 6743/7fb4a5375700 Ser/HttpServer.h:676 ]: [Client 4-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.1023 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1023 6743/7fb4a5375700 Ser/HttpServer.h:256 ]: [Client 4-4816] Parsing 265 bytes of HTTP header: "ROOT: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_TYPE: rack\r\n!~PASSENGER_RUBY: /usr/local/ruby/2.2.3/bin/ruby\r\n!~PASSENGER_MIN_PROCESSES: 18\r\n!~PASSENGER_MAX_REQUESTS: 30\r\n!~PASSENGER_SPAWN_METHOD: smart\r\n!~FLAGS: CDB\r\n\r\n" | |
[ 2017-07-09 08:55:02.1023 6743/7fb4a5375700 Ser/HttpServer.h:267 ]: [Client 4-4816] New request received: #4816 | |
[ 2017-07-09 08:55:02.1024 6743/7fb4a5375700 age/Cor/Req/InitRequest.cpp:59 ]: [Client 4-4816] Initiating request | |
[ 2017-07-09 08:55:02.1024 6743/7fb4a5375700 age/Cor/Req/InitRequest.cpp:124 ]: [Client 4-4816] Dechunk flag detected | |
[ 2017-07-09 08:55:02.1024 6743/7fb4a5375700 age/Cor/Req/InitRequest.cpp:127 ]: [Client 4-4816] Request body buffering enabled | |
[ 2017-07-09 08:55:02.1024 6743/7fb4a5375700 age/Cor/Req/InitRequest.cpp:133 ]: [Client 4-4816] Stripping 100 Continue header | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:36 ]: [Client 4-4816] Checking out session: appRoot=/opt/healtheintent/applications/client_solution_configuration_service | |
[ 2017-07-09 08:55:02.1024 6743/7fb4a5375700 age/Cor/Req/InitRequest.cpp:133 ]: [Client 4-4816] Stripping 100 Continue header | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:36 ]: [Client 4-4816] Checking out session: appRoot=/opt/healtheintent/applications/client_solution_configuration_service | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:50 ]: [Client 4-4816] Request refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:50 ]: [Client 4-4816] Request refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 App/Poo/Miscellaneous.cpp:42 ]: asyncGet(appGroupName=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1025 6743/7fb4a5375700 App/Poo/Miscellaneous.cpp:42 ]: asyncGet(appGroupName=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1026 6743/7fb4a5375700 App/Poo/Miscellaneous.cpp:48 ]: Found existing Group | |
[ 2017-07-09 08:55:02.1026 6743/7fb4a5375700 App/Gro/SessionManagement.cpp:329 ]: Session checked out from process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1027 6743/7fb4a5375700 App/Poo/Miscellaneous.cpp:53 ]: asyncGet() finished | |
[ 2017-07-09 08:55:02.1027 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:114 ]: [Client 4-4816] Session checked out: pid=7603, gupid=17d5ebd-NxAAcIkqYu | |
[ 2017-07-09 08:55:02.1027 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:114 ]: [Client 4-4816] Session checked out: pid=7603, gupid=17d5ebd-NxAAcIkqYu | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 App/Socket.h:167 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking out connection from connection pool (1 -> 0 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 App/Socket.h:167 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking out connection from connection pool (1 -> 0 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:182 ]: [Client 4-4816] Session initiated: fd=81 | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:34 ]: [Client 4-4816] Sending headers to application with session protocol | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:124 ]: [Client 4-4816] Header data: "\000\000\001\250REQUEST_URI\000/client-solution-configuration-service/meta/availability\000PATH_INFO\000/client-solution-configuration-service/meta/availability\000SCRIPT_NAME\000\000QUERY_STRING\000\000REQUEST_METHOD\000HEAD\000SERVER_NAME\000localhost\000SERVER_PORT\00080\000SERVER_SOFTWARE\000Apache/2.2.15 (Unix) Phusion_Passenger/5.0.18\000SERVER_PROTOCOL\000HTTP/1.1\000REMOTE_ADDR\00010.190.115.27\000REMOTE_PORT\00053316\000PASSENGER_CONNECT_PASSWORD\000W42m1JWqR42WXZSN\000HTTP_X_FORWARDED_PROTO\000https\000" | |
[ 2017-07-09 08:55:02.1029 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:846 ]: [Client 4-4816] No body to send to application | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:75 ]: [Client 4-4816] Request refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/Server.h:479 ]: [Client 4-4816] 265 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/FdSourceChannel.h:54 ]: [Client 4-4816] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:34 ]: [Client 4-4816] Sending headers to application with session protocol | |
[ 2017-07-09 08:55:02.1028 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:124 ]: [Client 4-4816] Header data: "\000\000\001\250REQUEST_URI\000/client-solution-configuration-service/meta/availability\000PATH_INFO\000/client-solution-configuration-service/meta/availability\000SCRIPT_NAME\000\000QUERY_STRING\000\000REQUEST_METHOD\000HEAD\000SERVER_NAME\000localhost\000SERVER_PORT\00080\000SERVER_SOFTWARE\000Apache/2.2.15 (Unix) Phusion_Passenger/5.0.18\000SERVER_PROTOCOL\000HTTP/1.1\000REMOTE_ADDR\00010.190.115.27\000REMOTE_PORT\00053316\000PASSENGER_CONNECT_PASSWORD\000W42m1JWqR42WXZSN\000HTTP_X_FORWARDED_PROTO\000https\000" | |
[ 2017-07-09 08:55:02.1029 6743/7fb4a5375700 age/Cor/Req/SendRequest.cpp:846 ]: [Client 4-4816] No body to send to application | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 age/Cor/Req/CheckoutSession.cpp:75 ]: [Client 4-4816] Request refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/HttpServer.h:679 ]: [Client 4-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/Server.h:479 ]: [Client 4-4816] 265 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1030 6743/7fb4a5375700 Ser/FdSourceChannel.h:54 ]: [Client 4-4816] Refcount decreased; it is now 2 | |
App 6794 stderr: [ 2017-07-09 08:55:02.1033 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:139 ]: Accepted new request on socket main socket | |
[ 2017-07-09 08:55:02.1118 6743/7fb4a5375700 Ser/FdSourceChannel.h:54 ]: [Client 4-4816] Request refcount increased; it is now 2 | |
App 6794 stderr: [ 2017-07-09 08:55:02.1118 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:404 ]: Keep-aliving connection. | |
[ 2017-07-09 08:55:02.1119 6743/7fb4a5375700 age/Cor/Req/ForwardResponse.cpp:43 ]: [Client 4-4816] Event: onAppSourceData | |
[ 2017-07-09 08:55:02.1120 6743/7fb4a5375700 age/Cor/Req/ForwardResponse.cpp:54 ]: [Client 4-4816] Processing 157 bytes of application data: "HTTP/1.1 404 Whatever\r\nContent-Type: text/html; charset=utf-8\r\nContent-Length: 0\r\nX-Request-Id: 3860a442-f72e-419d-80b0-fb86465aef2e\r\nX-Runtime: 0.007981\r\n\r\n" | |
[ 2017-07-09 08:55:02.1120 6743/7fb4a72fb700 age/Cor/Req/TurboCaching.h:242 ]: Clearing turbocache | |
App 6794 stderr: [ 2017-07-09 08:55:02.1120 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:169 ]: Request done. | |
[ 2017-07-09 08:55:02.1121 6743/7fb4a5375700 age/Cor/Req/ForwardResponse.cpp:66 ]: [Client 4-4816] Application response headers received | |
[ 2017-07-09 08:55:02.1121 6743/7fb4a5375700 age/Cor/Req/ForwardResponse.cpp:800 ]: [Client 4-4816] Sending response headers using writev() | |
[ 2017-07-09 08:55:02.1121 6743/7fb4a5375700 age/Cor/Req/ForwardResponse.cpp:861 ]: [Client 4-4816] Sending response headers: "HTTP/1.1 404 Not Found\r\nStatus: 404 Not Found\r\nContent-Length: 0\r\nX-Runtime: 0.007981\r\nContent-Type: text/html; charset=utf-8\r\nX-Request-Id: 3860a442-f72e-419d-80b0-fb86465aef2e\r\nDate: Sun, 09 Jul 2017 13:55:02 GMT\r\nConnection: close\r\nX-Powered-By: Phusion Passenger 5.0.18\r\n\r\n" | |
[ 2017-07-09 08:55:02.1122 6743/7fb4a5375700 App/Socket.h:196 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking in connection into connection pool (0 -> 1 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.1123 6743/7fb4a5375700 App/Gro/SessionManagement.cpp:149 ]: Session closed for process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
olution_configuration_service) | |
[ 2017-07-09 08:55:02.1123 6743/7fb4a5375700 Ser/HttpServer.h:1060 ]: [Client 4-4816] Ending request | |
[ 2017-07-09 08:55:02.1124 6743/7fb4a5375700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb478006d10] Deinitialize | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xb5de10] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xb5de10] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:484 ]: [FBC 0xb5de10] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:484 ]: [FBC 0xb5de10] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:552 ]: [FBC 0xb5de10] Reader: reading next | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:552 ]: [FBC 0xb5de10] Reader: reading next | |
[ 2017-07-09 08:55:02.1125 6743/7fb4a5375700 Ser/FileBufferedChannel.h:564 ]: [FBC 0xb5de10] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.1126 6743/7fb4a5375700 Ser/FileBufferedChannel.h:580 ]: [FBC 0xb5de10] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.1126 6743/7fb4a5375700 Ser/FileBufferedChannel.h:537 ]: [FBC 0xb5de10] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.1127 6743/7fb4a5375700 Ser/HttpServer.h:219 ]: [Client 4-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1127 6743/7fb4a5375700 Ser/HttpServer.h:219 ]: [Client 4-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1127 6743/7fb4a5375700 Ser/HttpServer.h:224 ]: [Client 4-4816] Not keeping alive connection, disconnecting client | |
[ 2017-07-09 08:55:02.1127 6743/7fb4a5375700 Ser/Server.h:896 ]: [Client 4-4816] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.1127 6743/7fb4a5375700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xb5de10] Deinitialize | |
[ 2017-07-09 08:55:02.1128 6743/7fb4a5375700 Ser/Server.h:906 ]: [Client 4-4816] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.1128 6743/7fb4a5375700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/Server.h:917 ]: [Client 4-4816] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/FdSourceChannel.h:54 ]: [Client 4-4816] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/HttpServer.h:146 ]: [Client 4-4816] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/HttpServer.h:146 ]: [Client 4-4816] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/HttpServer.h:154 ]: [Client 4-4816] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.1129 6743/7fb4a5375700 Ser/HttpServer.h:161 ]: [Client 4-4816] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1129 6779/7f65892e27e0 FileDescriptor.h:83 ]: File descriptor closed: 10 | |
[ 2017-07-09 08:55:02.1130 6743/7fb4a5375700 Ser/Server.h:378 ]: [Client 4-4816] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1129 6779/7f65892e27e0 FileDescriptor.h:83 ]: File descriptor closed: 10 | |
[ 2017-07-09 08:55:02.1130 6743/7fb4a5375700 Ser/Server.h:378 ]: [Client 4-4816] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1130 6743/7fb4a5375700 Ser/Server.h:384 ]: [Client 4-4816] Client object added to freelist (127 -> 128) | |
[ 2017-07-09 08:55:02.1257 6792/7f65892e27e0 apa/Hooks.cpp:275 ]: File descriptor opened: 10 | |
[ 2017-07-09 08:55:02.1260 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: 66 | |
[ 2017-07-09 08:55:02.1262 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:135 ]: Accepted client file descriptor: 66 | |
[ 2017-07-09 08:55:02.1263 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: -1 | |
[ 2017-07-09 08:55:02.1263 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:163 ]: Feeding client to server thread 4: file descriptor 66 | |
[ 2017-07-09 08:55:02.1263 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: -1 | |
[ 2017-07-09 08:55:02.1263 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:163 ]: Feeding client to server thread 4: file descriptor 66 | |
[ 2017-07-09 08:55:02.1264 6743/7fb477fff700 age/Cor/Req/TurboCaching.h:242 ]: Clearing turbocache | |
[ 2017-07-09 08:55:02.1265 6743/7fb477fff700 Ser/Server.h:352 ]: [ServerThr.5] Checking out client object from freelist (128 -> 127) | |
[ 2017-07-09 08:55:02.1265 6743/7fb477fff700 Ser/Server.h:575 ]: [Client 5-4816] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.1266 6743/7fb477fff700 Ser/Server.h:726 ]: File descriptor purpose: 66: Server ServerThr.5, client 5-4816 | |
[ 2017-07-09 08:55:02.1266 6743/7fb477fff700 Ser/Server.h:730 ]: [ServerThr.5] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.1266 6743/7fb477fff700 Ser/Server.h:730 ]: [ServerThr.5] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.1267 6743/7fb477fff700 Ser/HttpServer.h:668 ]: [Client 5-4816] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.1267 6743/7fb477fff700 Ser/HttpServer.h:235 ]: [Client 5-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1267 6743/7fb477fff700 Ser/HttpServer.h:235 ]: [Client 5-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1267 6743/7fb477fff700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xb81610] Deinitialize | |
6743/7fb477fff700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xb81610] Deinitialize | |
[ 2017-07-09 08:55:02.1268 6743/7fb477fff700 Ser/HttpServer.h:119 ]: [ServerThr.5] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.1268 6743/7fb477fff700 Ser/HttpServer.h:119 ]: [ServerThr.5] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.1268 6743/7fb477fff700 Ser/Server.h:452 ]: [Client 5-4816] Processing 464 bytes of client data | |
[ 2017-07-09 08:55:02.1269 6743/7fb477fff700 Ser/HttpServer.h:676 ]: [Client 5-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.1269 6743/7fb477fff700 Ser/HttpServer.h:679 ]: [Client 5-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1269 6743/7fb477fff700 Ser/HttpServer.h:256 ]: [Client 5-4816] Parsing 464 bytes of HTTP header: "HEAD /client-solution-configuration-service/meta/availability HTTP/1.1\r\nX-Forwarded-Proto: https\r\nConnection: close\r\n!~: kbdnBq92lKPPhbOsZhFlmKsr\r\n!~DOCUMENT_ROOT: /opt/healtheintent/applications/client_solution_configuration_service/public\r\n!~SCRIPT_NAME: /client-solution-configuration-service\r\n!~REMOTE_ADDR: 10.190.115.28\r\n!~REMOTE_PORT: 50852\r\n!~PASSENGER_APP_GROUP_NAME: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_" | |
[ 2017-07-09 08:55:02.1270 6743/7fb477fff700 Ser/HttpServer.h:679 ]: [Client 5-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1271 6743/7fb477fff700 Ser/Server.h:479 ]: [Client 5-4816] 464 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1271 6743/7fb477fff700 Ser/Server.h:479 ]: [Client 5-4816] 464 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1271 6743/7fb477fff700 Ser/Server.h:528 ]: [Client 5-4816] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1271 6743/7fb477fff700 Ser/FdSourceChannel.h:54 ]: [Client 5-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1272 6743/7fb477fff700 Ser/Server.h:452 ]: [Client 5-4816] Processing 265 bytes of client data | |
[ 2017-07-09 08:55:02.1272 6743/7fb477fff700 Ser/HttpServer.h:676 ]: [Client 5-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.1273 6743/7fb477fff700 Ser/HttpServer.h:679 ]: [Client 5-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1273 6743/7fb477fff700 Ser/HttpServer.h:256 ]: [Client 5-4816] Parsing 265 bytes of HTTP header: "ROOT: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_TYPE: rack\r\n!~PASSENGER_RUBY: /usr/local/ruby/2.2.3/bin/ruby\r\n!~PASSENGER_MIN_PROCESSES: 18\r\n!~PASSENGER_MAX_REQUESTS: 30\r\n!~PASSENGER_SPAWN_METHOD: smart\r\n!~FLAGS: CDB\r\n\r\n" | |
[ 2017-07-09 08:55:02.1274 6743/7fb477fff700 Ser/HttpServer.h:267 ]: [Client 5-4816] New request received: #4816 | |
[ 2017-07-09 08:55:02.1274 6743/7fb477fff700 age/Cor/Req/InitRequest.cpp:59 ]: [Client 5-4816] Initiating request | |
[ 2017-07-09 08:55:02.1274 6743/7fb477fff700 age/Cor/Req/InitRequest.cpp:124 ]: [Client 5-4816] Dechunk flag detected | |
[ 2017-07-09 08:55:02.1274 6743/7fb477fff700 age/Cor/Req/InitRequest.cpp:127 ]: [Client 5-4816] Request body buffering enabled | |
[ 2017-07-09 08:55:02.1274 6743/7fb477fff700 age/Cor/Req/InitRequest.cpp:133 ]: [Client 5-4816] Stripping 100 Continue header | |
[ 2017-07-09 08:55:02.1275 6743/7fb477fff700 age/Cor/Req/CheckoutSession.cpp:36 ]: [Client 5-4816] Checking out session: appRoot=/opt/healtheintent/applications/client_solution_configuration_service | |
[ 2017-07-09 08:55:02.1275 6743/7fb477fff700 age/Cor/Req/CheckoutSession.cpp:50 ]: [Client 5-4816] Request refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.1275 6743/7fb477fff700 App/Poo/Miscellaneous.cpp:42 ]: asyncGet(appGroupName=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1275 6743/7fb477fff700 App/Poo/Miscellaneous.cpp:48 ]: Found existing Group | |
[ 2017-07-09 08:55:02.1276 6743/7fb477fff700 App/Gro/SessionManagement.cpp:329 ]: Session checked out from process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1276 6743/7fb477fff700 App/Poo/Miscellaneous.cpp:53 ]: asyncGet() finished | |
[ 2017-07-09 08:55:02.1276 6743/7fb477fff700 age/Cor/Req/CheckoutSession.cpp:114 ]: [Client 5-4816] Session checked out: pid=7603, gupid=17d5ebd-NxAAcIkqYu | |
[ 2017-07-09 08:55:02.1276 6743/7fb477fff700 App/Socket.h:167 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking out connection from connection pool (1 -> 0 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.1277 6743/7fb477fff700 age/Cor/Req/CheckoutSession.cpp:182 ]: [Client 5-4816] Session initiated: fd=81 | |
[ 2017-07-09 08:55:02.1277 6743/7fb477fff700 age/Cor/Req/SendRequest.cpp:34 ]: [Client 5-4816] Sending headers to application with session protocol | |
[ 2017-07-09 08:55:02.1277 6743/7fb477fff700 age/Cor/Req/SendRequest.cpp:124 ]: [Client 5-4816] Header data: "\000\000\001\250REQUEST_URI\000/client-solution-configuration-service/meta/availability\000PATH_INFO\000/meta/availability\000SCRIPT_NAME\000/client-solution-configuration-service\000QUERY_STRING\000\000REQUEST_METHOD\000HEAD\000SERVER_NAME\000localhost\000SERVER_PORT\00080\000SERVER_SOFTWARE\000Apache/2.2.15 (Unix) Phusion_Passenger/5.0.18\000SERVER_PROTOCOL\000HTTP/1.1\000REMOTE_ADDR\00010.190.115.28\000REMOTE_PORT\00050852\000PASSENGER_CONNECT_PASSWORD\000W42m1JWqR42WXZSN\000HTTP_X_FORWARDED_PROTO\000https\000" | |
[ 2017-07-09 08:55:02.1278 6743/7fb477fff700 age/Cor/Req/SendRequest.cpp:846 ]: [Client 5-4816] No body to send to application | |
[ 2017-07-09 08:55:02.1279 6743/7fb477fff700 age/Cor/Req/CheckoutSession.cpp:75 ]: [Client 5-4816] Request refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.1279 6743/7fb477fff700 Ser/HttpServer.h:679 ]: [Client 5-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1279 6743/7fb477fff700 Ser/Server.h:479 ]: [Client 5-4816] 265 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.1279 6743/7fb477fff700 Ser/FdSourceChannel.h:54 ]: [Client 5-4816] Refcount decreased; it is now 2 | |
App 6794 stderr: [ 2017-07-09 08:55:02.1281 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:139 ]: Accepted new request on socket main socket | |
[ 2017-07-09 08:55:02.1332 6743/7fb477fff700 Ser/FdSourceChannel.h:54 ]: [Client 5-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.1333 6743/7fb477fff700 age/Cor/Req/ForwardResponse.cpp:43 ]: [Client 5-4816] Event: onAppSourceData | |
[ 2017-07-09 08:55:02.1333 6743/7fb477fff700 age/Cor/Req/ForwardResponse.cpp:54 ]: [Client 5-4816] Processing 340 bytes of application data: "HTTP/1.1 200 Whatever\r\nX-Frame-Options: SAMEORIGIN\r\nX-XSS-Protection: 1; mode=block\r\nX-Content-Type-Options: nosniff\r\nCache-Control: no-cache, no-store, max-age=0, must-revalidate\r\nPragma: no-cache\r\nExpires: -1\r\nContent-Type: text/html\r\nX-Request-Id: a2caeb24-5fe5-406e-a2b9-7c0e9932d66a\r\nX-Runtime: 0.004394\r\nTransfer-Encoding: chunked\r\n\r\n" | |
[ 2017-07-09 08:55:02.1334 6743/7fb477fff700 age/Cor/Req/ForwardResponse.cpp:66 ]: [Client 5-4816] Application response headers received | |
[ 2017-07-09 08:55:02.1334 6743/7fb477fff700 age/Cor/Req/ForwardResponse.cpp:800 ]: [Client 5-4816] Sending response headers using writev() | |
[ 2017-07-09 08:55:02.1334 6743/7fb477fff700 age/Cor/Req/ForwardResponse.cpp:861 ]: [Client 5-4816] Sending response headers: "HTTP/1.1 200 OK\r\nStatus: 200 OK\r\nX-Request-Id: a2caeb24-5fe5-406e-a2b9-7c0e9932d66a\r\nCache-Control: no-cache, no-store, max-age=0, must-revalidate\r\nTransfer-Encoding: chunked\r\nX-Runtime: 0.004394\r\nX-Frame-Options: SAMEORIGIN\r\nX-XSS-Protection: 1; mode=block\r\nX-Content-Type-Options: nosniff\r\nPragma: no-cache\r\nContent-Type: text/html\r\nExpires: -1\r\nDate: Sun, 09 Jul 2017 13:55:02 GMT\r\nConnection: close\r\nX-Powered-By: Phusion Passenger 5.0.18\r\n\r\n" | |
[ 2017-07-09 08:55:02.1335 6743/7fb477fff700 App/Socket.h:196 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking in connection into connection pool (0 -> 1 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.1335 6743/7fb477fff700 App/Gro/SessionManagement.cpp:149 ]: Session closed for process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.1336 6743/7fb477fff700 Ser/HttpServer.h:1060 ]: [Client 5-4816] Ending request | |
[ 2017-07-09 08:55:02.1336 6743/7fb477fff700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb468007120] Deinitialize | |
App 6794 stderr: [ 2017-07-09 08:55:02.1335 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:404 ]: Keep-aliving connection. | |
[ 2017-07-09 08:55:02.1336 6743/7fb477fff700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xb81610] Feeding 0 bytes | |
App 6794 stderr: [ 2017-07-09 08:55:02.1335 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:404 ]: Keep-aliving connection. | |
[ 2017-07-09 08:55:02.1336 6743/7fb477fff700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xb81610] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.1337 6743/7fb477fff700 Ser/FileBufferedChannel.h:484 ]: [FBC 0xb81610] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.1337 6743/7fb477fff700 Ser/FileBufferedChannel.h:552 ]: [FBC 0xb81610] Reader: reading next | |
[ 2017-07-09 08:55:02.1337 6743/7fb477fff700 Ser/FileBufferedChannel.h:564 ]: [FBC 0xb81610] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.1338 6743/7fb477fff700 Ser/FileBufferedChannel.h:580 ]: [FBC 0xb81610] Reader: EOF fed. Transitioning to RS_TERMINATED | |
App 6794 stderr: [ 2017-07-09 08:55:02.1336 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:169 ]: Request done. | |
[ 2017-07-09 08:55:02.1338 6743/7fb477fff700 Ser/FileBufferedChannel.h:537 ]: [FBC 0xb81610] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.1338 6743/7fb477fff700 Ser/HttpServer.h:219 ]: [Client 5-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1339 6743/7fb477fff700 Ser/HttpServer.h:224 ]: [Client 5-4816] Not keeping alive connection, disconnecting client | |
[ 2017-07-09 08:55:02.1339 6743/7fb477fff700 Ser/HttpServer.h:224 ]: [Client 5-4816] Not keeping alive connection, disconnecting client | |
[ 2017-07-09 08:55:02.1339 6743/7fb477fff700 Ser/Server.h:896 ]: [Client 5-4816] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.1339 6743/7fb477fff700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xb81610] Deinitialize | |
[ 2017-07-09 08:55:02.1340 6743/7fb477fff700 Ser/Server.h:906 ]: [Client 5-4816] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.1340 6743/7fb477fff700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/Server.h:917 ]: [Client 5-4816] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/FdSourceChannel.h:54 ]: [Client 5-4816] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1341 6792/7f65892e27e0 FileDescriptor.h:83 ]: File descriptor closed: 10 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/HttpServer.h:146 ]: [Client 5-4816] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/HttpServer.h:154 ]: [Client 5-4816] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/HttpServer.h:161 ]: [Client 5-4816] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/Server.h:378 ]: [Client 5-4816] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/Server.h:384 ]: [Client 5-4816] Client object added to freelist (127 -> 128) | |
[ 2017-07-09 08:55:02.1340 6743/7fb477fff700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/Server.h:917 ]: [Client 5-4816] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/FdSourceChannel.h:54 ]: [Client 5-4816] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1341 6792/7f65892e27e0 FileDescriptor.h:83 ]: File descriptor closed: 10 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/HttpServer.h:146 ]: [Client 5-4816] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1341 6743/7fb477fff700 Ser/HttpServer.h:154 ]: [Client 5-4816] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/HttpServer.h:161 ]: [Client 5-4816] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/Server.h:378 ]: [Client 5-4816] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.1342 6743/7fb477fff700 Ser/Server.h:384 ]: [Client 5-4816] Client object added to freelist (127 -> 128) | |
[ 2017-07-09 08:55:02.2574 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2042] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2042] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2042 | |
[ 2017-07-09 08:55:02.2576 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2042 | |
[ 2017-07-09 08:55:02.2577 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.2577 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2042] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.2577 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2042] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.2577 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.2578 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.2578 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2042] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:02.2578 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2042] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.2579 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2042] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.2579 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2042] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.2579 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2042] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:02.2579 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2042] New request received: #1 | |
[ 2017-07-09 08:55:02.2580 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.2580 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2042] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:02.2581 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2042] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.2581 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2042] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.2584 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:02.2584 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.2584 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2584 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2585 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2582 | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.2586 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.2587 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.2587 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2587 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.2587 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.2587 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2042] Ending request | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.2588 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2042] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2042] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.2589 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2042] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2042] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2042] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2042] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.2590 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2042] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.2591 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2042] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.2591 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2042] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.2591 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2042] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.2591 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2042] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.2591 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2042] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.2592 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2042] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.2592 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2042] Client sent EOF | |
[ 2017-07-09 08:55:02.2592 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2042] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.2592 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2042] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.2592 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2042] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.2593 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2042] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.2593 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.2593 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2042] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.2593 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.2593 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.2594 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2042] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.2594 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2042] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.2594 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2042] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.2594 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2042] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.2594 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2042] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.2595 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2042] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.2595 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2042] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.2595 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2042] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.2596 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2042] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.2596 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2042] Client object destroyed; not added to freelist because it's full (0) | |
[ 2017-07-09 08:55:02.4833 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:02.4834 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.4834 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2043] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.4835 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2043 | |
[ 2017-07-09 08:55:02.4835 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.4835 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2043] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2043] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.4836 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2043] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:02.4837 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2043] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.4837 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2043] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.4837 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2043] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:02.4838 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2043] New request received: #1 | |
[ 2017-07-09 08:55:02.4838 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.4838 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2043] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:02.4839 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2043] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.4839 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2043] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.4839 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2043] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.4843 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:02.4844 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.4844 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4844 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.4845 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2582 | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
ompleted: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.4846 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.4847 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4847 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.4847 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.4847 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2043] Ending request | |
[ 2017-07-09 08:55:02.4847 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.4848 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2043] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2043] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2043] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2043] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.4849 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2043] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2043] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2043] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2043] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2043] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2043] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2043] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.4850 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2043] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.4856 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2043] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.4857 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2043] Client sent EOF | |
[ 2017-07-09 08:55:02.4857 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2043] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.4857 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2043] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.4857 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2043] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.4858 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2043] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.4858 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.4858 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2043] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.4858 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.4859 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2043] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.4859 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2043] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.4859 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2043] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.4859 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2043] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.4860 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2043] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.4860 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2043] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.4860 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2043] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.4860 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2043] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.4860 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2043] Client object destroyed; not added to freelist because it's full (0) | |
[ 2017-07-09 08:55:02.6907 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:02.6908 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.6908 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.6909 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2044] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.6909 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2044 | |
[ 2017-07-09 08:55:02.6910 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.6910 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2044] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.6910 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2044] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.6910 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2044] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.6910 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.6911 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.6911 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.6911 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2044] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:02.6912 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2044] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.6912 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2044] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.6912 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2044] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:02.6913 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2044] New request received: #1 | |
[ 2017-07-09 08:55:02.6913 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.6913 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.6913 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2044] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:02.6914 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2044] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.6914 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2044] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.6917 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:02.6917 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.6917 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.6917 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.6917 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.6918 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.6918 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.6919 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.6919 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.6919 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.6919 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2582 | |
[ 2017-07-09 08:55:02.6919 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.6921 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.6921 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.6921 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.6922 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.6922 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.6922 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.6922 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2044] Ending request | |
[ 2017-07-09 08:55:02.6922 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.6923 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.6923 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.6923 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.6923 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.6924 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.6924 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2044] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.6924 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2044] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.6924 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2044] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.6925 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.6925 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.6925 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2044] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.6925 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2044] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.6925 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2044] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.6926 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2044] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.6926 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2044] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.6926 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2044] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.6926 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2044] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.6927 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2044] Client sent EOF | |
[ 2017-07-09 08:55:02.6927 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2044] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.6927 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2044] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.6927 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2044] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.6928 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2044] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.6928 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.6928 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2044] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.6928 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.6929 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2044] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.6929 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2044] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.6929 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2044] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.6929 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2044] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.6929 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2044] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.6930 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2044] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.6930 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2044] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.6930 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2044] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.6930 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2044] Client object destroyed; not added to freelist because it's full (0) | |
[ 2017-07-09 08:55:02.9215 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:02.9217 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:02.9217 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2045] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.9218 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2045 | |
[ 2017-07-09 08:55:02.9218 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.9219 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2045] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.9219 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2045] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9219 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.9219 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.9220 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2045] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:02.9220 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2045] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.9220 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2045] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.9220 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2045] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:02.9221 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2045] New request received: #1 | |
[ 2017-07-09 08:55:02.9221 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2045] New request received: #1 | |
[ 2017-07-09 08:55:02.9221 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.9221 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:02.9222 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2045] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:02.9222 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2045] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.9222 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2045] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:02.9223 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2045] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.9223 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2045] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:02.9225 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:02.9226 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.9227 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:02.9227 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9227 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2582 bytes | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2582 | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9228 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2582 bytes | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:02.9229 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2045] Ending request | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:02.9230 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2045] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2045] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2045] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:02.9231 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2045] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2045] Request refcount decreased; it is now 0 | |
r.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2045] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2045] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2045] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2045] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2045] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2045] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2045] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9232 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2045] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2045] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2045] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.9233 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2045] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9239 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2045] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9240 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2045] Client sent EOF | |
[ 2017-07-09 08:55:02.9240 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2045] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.9240 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2045] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.9240 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2045] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.9240 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2045] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9241 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:02.9241 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2045] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.9241 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.9241 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2045] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9242 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2045] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.9242 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2045] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9242 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2045] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.9242 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2045] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9243 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2045] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.9243 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2045] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.9243 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2045] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9244 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2045] Client object destroyed; not added to freelist because it's full (0) | |
[ 2017-07-09 08:55:02.9568 6781/7f65892e27e0 apa/Hooks.cpp:275 ]: File descriptor opened: 10 | |
[ 2017-07-09 08:55:02.9570 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: 66 | |
[ 2017-07-09 08:55:02.9571 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:135 ]: Accepted client file descriptor: 66 | |
[ 2017-07-09 08:55:02.9571 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:193 ]: File descriptor opened: -1 | |
[ 2017-07-09 08:55:02.9572 6743/7fb4761fc700 Ser/AcceptLoadBalancer.h:163 ]: Feeding client to server thread 5: file descriptor 66 | |
[ 2017-07-09 08:55:02.9574 6743/7fb4775fe700 age/Cor/Req/TurboCaching.h:242 ]: Clearing turbocache | |
[ 2017-07-09 08:55:02.9575 6743/7fb4775fe700 Ser/Server.h:352 ]: [ServerThr.6] Checking out client object from freelist (128 -> 127) | |
[ 2017-07-09 08:55:02.9576 6743/7fb4775fe700 Ser/Server.h:575 ]: [Client 6-4816] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.9576 6743/7fb4775fe700 Ser/Server.h:575 ]: [Client 6-4816] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:02.9576 6743/7fb4775fe700 Ser/Server.h:726 ]: File descriptor purpose: 66: Server ServerThr.6, client 6-4816 | |
[ 2017-07-09 08:55:02.9577 6743/7fb4775fe700 Ser/Server.h:730 ]: [ServerThr.6] 1 new client(s) accepted; there are now 1 active client(s) | |
ed; there are now 1 active client(s) | |
[ 2017-07-09 08:55:02.9577 6743/7fb4775fe700 Ser/HttpServer.h:668 ]: [Client 6-4816] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.9577 6743/7fb4775fe700 Ser/HttpServer.h:668 ]: [Client 6-4816] Event: onClientAccepted | |
[ 2017-07-09 08:55:02.9577 6743/7fb4775fe700 Ser/HttpServer.h:235 ]: [Client 6-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9577 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xba5280] Deinitialize | |
[ 2017-07-09 08:55:02.9578 6743/7fb4775fe700 Ser/HttpServer.h:119 ]: [ServerThr.6] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:02.9578 6743/7fb4775fe700 Ser/Server.h:452 ]: [Client 6-4816] Processing 464 bytes of client data | |
[ 2017-07-09 08:55:02.9579 6743/7fb4775fe700 Ser/HttpServer.h:676 ]: [Client 6-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.9579 6743/7fb4775fe700 Ser/HttpServer.h:679 ]: [Client 6-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.9579 6743/7fb4775fe700 Ser/HttpServer.h:256 ]: [Client 6-4816] Parsing 464 bytes of HTTP header: "HEAD /client-solution-configuration-service/meta/availability HTTP/1.1\r\nX-Forwarded-Proto: https\r\nConnection: close\r\n!~: kbdnBq92lKPPhbOsZhFlmKsr\r\n!~DOCUMENT_ROOT: /opt/healtheintent/applications/client_solution_configuration_service/public\r\n!~SCRIPT_NAME: /client-solution-configuration-service\r\n!~REMOTE_ADDR: 10.190.133.44\r\n!~REMOTE_PORT: 34592\r\n!~PASSENGER_APP_GROUP_NAME: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_" | |
[ 2017-07-09 08:55:02.9580 6743/7fb4775fe700 Ser/HttpServer.h:679 ]: [Client 6-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9580 6743/7fb4775fe700 Ser/Server.h:479 ]: [Client 6-4816] 464 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.9580 6743/7fb4775fe700 Ser/Server.h:528 ]: [Client 6-4816] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9580 6743/7fb4775fe700 Ser/Server.h:528 ]: [Client 6-4816] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9581 6743/7fb4775fe700 Ser/FdSourceChannel.h:54 ]: [Client 6-4816] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9581 6743/7fb4775fe700 Ser/Server.h:452 ]: [Client 6-4816] Processing 265 bytes of client data | |
[ 2017-07-09 08:55:02.9582 6743/7fb4775fe700 Ser/HttpServer.h:676 ]: [Client 6-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.9581 6743/7fb4775fe700 Ser/Server.h:452 ]: [Client 6-4816] Processing 265 bytes of client data | |
[ 2017-07-09 08:55:02.9582 6743/7fb4775fe700 Ser/HttpServer.h:676 ]: [Client 6-4816] Event: onClientDataReceived | |
[ 2017-07-09 08:55:02.9582 6743/7fb4775fe700 Ser/HttpServer.h:679 ]: [Client 6-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.9582 6743/7fb4775fe700 Ser/HttpServer.h:256 ]: [Client 6-4816] Parsing 265 bytes of HTTP header: "ROOT: /opt/healtheintent/applications/client_solution_configuration_service\r\n!~PASSENGER_APP_TYPE: rack\r\n!~PASSENGER_RUBY: /usr/local/ruby/2.2.3/bin/ruby\r\n!~PASSENGER_MIN_PROCESSES: 18\r\n!~PASSENGER_MAX_REQUESTS: 30\r\n!~PASSENGER_SPAWN_METHOD: smart\r\n!~FLAGS: CDB\r\n\r\n" | |
[ 2017-07-09 08:55:02.9582 6743/7fb4775fe700 Ser/HttpServer.h:267 ]: [Client 6-4816] New request received: #4816 | |
[ 2017-07-09 08:55:02.9583 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:59 ]: [Client 6-4816] Initiating request | |
[ 2017-07-09 08:55:02.9583 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:124 ]: [Client 6-4816] Dechunk flag detected | |
[ 2017-07-09 08:55:02.9583 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:124 ]: [Client 6-4816] Dechunk flag detected | |
[ 2017-07-09 08:55:02.9583 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:127 ]: [Client 6-4816] Request body buffering enabled | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:133 ]: [Client 6-4816] Stripping 100 Continue header | |
[ 2017-07-09 08:55:02.9583 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:127 ]: [Client 6-4816] Request body buffering enabled | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 age/Cor/Req/InitRequest.cpp:133 ]: [Client 6-4816] Stripping 100 Continue header | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:36 ]: [Client 6-4816] Checking out session: appRoot=/opt/healtheintent/applications/client_solution_configuration_service | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:50 ]: [Client 6-4816] Request refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:50 ]: [Client 6-4816] Request refcount increased; it is now 3 | |
[ 2017-07-09 08:55:02.9584 6743/7fb4775fe700 App/Poo/Miscellaneous.cpp:42 ]: asyncGet(appGroupName=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.9585 6743/7fb4775fe700 App/Poo/Miscellaneous.cpp:48 ]: Found existing Group | |
[ 2017-07-09 08:55:02.9585 6743/7fb4775fe700 App/Gro/SessionManagement.cpp:329 ]: Session checked out from process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.9586 6743/7fb4775fe700 App/Poo/Miscellaneous.cpp:53 ]: asyncGet() finished | |
[ 2017-07-09 08:55:02.9586 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:114 ]: [Client 6-4816] Session checked out: pid=7603, gupid=17d5ebd-NxAAcIkqYu | |
[ 2017-07-09 08:55:02.9586 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:114 ]: [Client 6-4816] Session checked out: pid=7603, gupid=17d5ebd-NxAAcIkqYu | |
[ 2017-07-09 08:55:02.9586 6743/7fb4775fe700 App/Socket.h:167 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking out connection from connection pool (1 -> 0 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.9586 6743/7fb4775fe700 App/Socket.h:167 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking out connection from connection pool (1 -> 0 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.9587 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:182 ]: [Client 6-4816] Session initiated: fd=81 | |
[ 2017-07-09 08:55:02.9587 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:182 ]: [Client 6-4816] Session initiated: fd=81 | |
[ 2017-07-09 08:55:02.9587 6743/7fb4775fe700 age/Cor/Req/SendRequest.cpp:34 ]: [Client 6-4816] Sending headers to application with session protocol | |
[ 2017-07-09 08:55:02.9587 6743/7fb4775fe700 age/Cor/Req/SendRequest.cpp:34 ]: [Client 6-4816] Sending headers to application with session protocol | |
[ 2017-07-09 08:55:02.9588 6743/7fb4775fe700 age/Cor/Req/SendRequest.cpp:124 ]: [Client 6-4816] Header data: "\000\000\001\250REQUEST_URI\000/client-solution-configuration-service/meta/availability\000PATH_INFO\000/meta/availability\000SCRIPT_NAME\000/client-solution-configuration-service\000QUERY_STRING\000\000REQUEST_METHOD\000HEAD\000SERVER_NAME\000localhost\000SERVER_PORT\00080\000SERVER_SOFTWARE\000Apache/2.2.15 (Unix) Phusion_Passenger/5.0.18\000SERVER_PROTOCOL\000HTTP/1.1\000REMOTE_ADDR\00010.190.133.44\000REMOTE_PORT\00034592\000PASSENGER_CONNECT_PASSWORD\000W42m1JWqR42WXZSN\000HTTP_X_FORWARDED_PROTO\000https\000" | |
[ 2017-07-09 08:55:02.9589 6743/7fb4775fe700 age/Cor/Req/SendRequest.cpp:846 ]: [Client 6-4816] No body to send to application | |
[ 2017-07-09 08:55:02.9589 6743/7fb4775fe700 age/Cor/Req/CheckoutSession.cpp:75 ]: [Client 6-4816] Request refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:02.9589 6743/7fb4775fe700 Ser/HttpServer.h:679 ]: [Client 6-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9589 6743/7fb4775fe700 Ser/Server.h:479 ]: [Client 6-4816] 265 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:02.9589 6743/7fb4775fe700 Ser/FdSourceChannel.h:54 ]: [Client 6-4816] Refcount decreased; it is now 2 | |
App 6794 stderr: [ 2017-07-09 08:55:02.9591 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:139 ]: Accepted new request on socket main socket | |
[ 2017-07-09 08:55:02.9641 6743/7fb4775fe700 Ser/FdSourceChannel.h:54 ]: [Client 6-4816] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:02.9642 6743/7fb4775fe700 age/Cor/Req/ForwardResponse.cpp:43 ]: [Client 6-4816] Event: onAppSourceData | |
[ 2017-07-09 08:55:02.9643 6743/7fb4775fe700 age/Cor/Req/ForwardResponse.cpp:54 ]: [Client 6-4816] Processing 340 bytes of application data: "HTTP/1.1 200 Whatever\r\nX-Frame-Options: SAMEORIGIN\r\nX-XSS-Protection: 1; mode=block\r\nX-Content-Type-Options: nosniff\r\nCache-Control: no-cache, no-store, max-age=0, must-revalidate\r\nPragma: no-cache\r\nExpires: -1\r\nContent-Type: text/html\r\nX-Request-Id: 07e0be07-112d-4e5e-af7f-3ce624c6463f\r\nX-Runtime: 0.004471\r\nTransfer-Encoding: chunked\r\n\r\n" | |
[ 2017-07-09 08:55:02.9644 6743/7fb4775fe700 age/Cor/Req/ForwardResponse.cpp:66 ]: [Client 6-4816] Application response headers received | |
[ 2017-07-09 08:55:02.9644 6743/7fb4775fe700 age/Cor/Req/ForwardResponse.cpp:800 ]: [Client 6-4816] Sending response headers using writev() | |
App 6794 stderr: [ 2017-07-09 08:55:02.9643 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:404 ]: Keep-aliving connection. | |
[ 2017-07-09 08:55:02.9645 6743/7fb4775fe700 age/Cor/Req/ForwardResponse.cpp:861 ]: [Client 6-4816] Sending response headers: "HTTP/1.1 200 OK\r\nStatus: 200 OK\r\nX-Request-Id: 07e0be07-112d-4e5e-af7f-3ce624c6463f\r\nCache-Control: no-cache, no-store, max-age=0, must-revalidate\r\nTransfer-Encoding: chunked\r\nX-Runtime: 0.004471\r\nX-Frame-Options: SAMEORIGIN\r\nX-XSS-Protection: 1; mode=block\r\nX-Content-Type-Options: nosniff\r\nPragma: no-cache\r\nContent-Type: text/html\r\nExpires: -1\r\nDate: Sun, 09 Jul 2017 13:55:02 GMT\r\nConnection: close\r\nX-Powered-By: Phusion Passenger 5.0.18\r\n\r\n" | |
[ 2017-07-09 08:55:02.9645 6743/7fb4775fe700 App/Socket.h:196 ]: Socket unix:/tmp/passenger.Z5XpabV/apps.s/ruby.L7uHlSo5VlaHjyjRPPqMa0MtAv3snwTcNf19eWbQXsfu36byEtNJtxftwvdP1aD: checking in connection into connection pool (0 -> 1 items). Current total number of connections: 1 | |
[ 2017-07-09 08:55:02.9646 6743/7fb4775fe700 App/Gro/SessionManagement.cpp:149 ]: Session closed for process (pid=7603, group=/opt/healtheintent/applications/client_solution_configuration_service) | |
[ 2017-07-09 08:55:02.9646 6743/7fb4775fe700 Ser/HttpServer.h:1060 ]: [Client 6-4816] Ending request | |
[ 2017-07-09 08:55:02.9646 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb46c000e70] Deinitialize | |
[ 2017-07-09 08:55:02.9646 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb46c000e70] Deinitialize | |
App 6794 stderr: [ 2017-07-09 08:55:02.9646 7603/0x007f2016eceea0(Worker 1) request_handler/thread_handler.rb:169 ]: Request done. | |
[ 2017-07-09 08:55:02.9647 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xba5280] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.9647 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0xba5280] Feeding 0 bytes | |
[ 2017-07-09 08:55:02.9647 6743/7fb4775fe700 Ser/FileBufferedChannel.h:484 ]: [FBC 0xba5280] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:02.9647 6743/7fb4775fe700 Ser/FileBufferedChannel.h:552 ]: [FBC 0xba5280] Reader: reading next | |
[ 2017-07-09 08:55:02.9647 6743/7fb4775fe700 Ser/FileBufferedChannel.h:552 ]: [FBC 0xba5280] Reader: reading next | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/FileBufferedChannel.h:564 ]: [FBC 0xba5280] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/FileBufferedChannel.h:564 ]: [FBC 0xba5280] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/FileBufferedChannel.h:580 ]: [FBC 0xba5280] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/FileBufferedChannel.h:537 ]: [FBC 0xba5280] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/FileBufferedChannel.h:537 ]: [FBC 0xba5280] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/HttpServer.h:219 ]: [Client 6-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9648 6743/7fb4775fe700 Ser/HttpServer.h:219 ]: [Client 6-4816] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9649 6743/7fb4775fe700 Ser/HttpServer.h:224 ]: [Client 6-4816] Not keeping alive connection, disconnecting client | |
[ 2017-07-09 08:55:02.9649 6743/7fb4775fe700 Ser/Server.h:896 ]: [Client 6-4816] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:02.9649 6743/7fb4775fe700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0xba5280] Deinitialize | |
[ 2017-07-09 08:55:02.9649 6743/7fb4775fe700 Ser/Server.h:906 ]: [Client 6-4816] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.9649 6743/7fb4775fe700 Ser/Server.h:906 ]: [Client 6-4816] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:02.9650 6743/7fb4775fe700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:02.9650 6743/7fb4775fe700 Ser/Server.h:917 ]: [Client 6-4816] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:02.9650 6743/7fb4775fe700 Ser/FdSourceChannel.h:54 ]: [Client 6-4816] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.9651 6743/7fb4775fe700 Ser/HttpServer.h:146 ]: [Client 6-4816] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9651 6781/7f65892e27e0 FileDescriptor.h:83 ]: File descriptor closed: 10 | |
[ 2017-07-09 08:55:02.9651 6743/7fb4775fe700 Ser/HttpServer.h:154 ]: [Client 6-4816] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:02.9651 6743/7fb4775fe700 Ser/HttpServer.h:161 ]: [Client 6-4816] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:02.9651 6743/7fb4775fe700 Ser/Server.h:378 ]: [Client 6-4816] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:02.9651 6743/7fb4775fe700 Ser/Server.h:384 ]: [Client 6-4816] Client object added to freelist (127 -> 128) | |
[ 2017-07-09 08:55:03.6009 6743/7fb476bfd700 Ser/Server.h:241 ]: [ApiServer] New clients can be accepted on a server socket | |
[ 2017-07-09 08:55:03.6010 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:03.6010 6743/7fb476bfd700 Ser/Server.h:363 ]: [ApiServer] Creating new client object | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2046] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/Server.h:575 ]: [Client A2046] Client associated with file descriptor: 66 | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2046 | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/Server.h:261 ]: File descriptor purpose: 66: Server ApiServer, client A2046 | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/Server.h:267 ]: [ApiServer] 1 new client(s) accepted; there are now 1 active client(s) | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2046] Event: onClientAccepted | |
[ 2017-07-09 08:55:03.6011 6743/7fb476bfd700 Ser/HttpServer.h:668 ]: [Client A2046] Event: onClientAccepted | |
[ 2017-07-09 08:55:03.6012 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2046] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:03.6012 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:03.6012 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:03.6012 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (2 -> 1) | |
[ 2017-07-09 08:55:03.6013 6743/7fb476bfd700 Ser/Server.h:452 ]: [Client A2046] Processing 206 bytes of client data | |
[ 2017-07-09 08:55:03.6013 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2046] Event: onClientDataReceived | |
[ 2017-07-09 08:55:03.6013 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2046] Event: onClientDataReceived | |
[ 2017-07-09 08:55:03.6014 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2046] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:03.6014 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2046] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:03.6014 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2046] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:03.6014 6743/7fb476bfd700 Ser/HttpServer.h:256 ]: [Client A2046] Parsing 206 bytes of HTTP header: "GET /pool.txt?colorize=false&verbose= HTTP/1.1\r\nAccept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3\r\nAccept: */*\r\nUser-Agent: Ruby\r\nAuthorization: Basic cm9fYWRtaW46UHB1S21SQTBrTVBZUmxrZFFMZFdoZWpX\r\n\r\n" | |
[ 2017-07-09 08:55:03.6014 6743/7fb476bfd700 Ser/HttpServer.h:267 ]: [Client A2046] New request received: #1 | |
[ 2017-07-09 08:55:03.6015 6743/7fb476bfd700 age/Cor/ApiServer.h:517 ]: API request: GET /pool.txt?colorize=false&verbose= | |
[ 2017-07-09 08:55:03.6015 6743/7fb476bfd700 age/ApiServerUtils.h:252 ]: [Client A2046] Authenticated with UID: 0 | |
[ 2017-07-09 08:55:03.6015 6743/7fb476bfd700 age/ApiServerUtils.h:277 ]: [Client A2046] HTTP basic authentication supplied: ro_admin | |
[ 2017-07-09 08:55:03.6016 6743/7fb476bfd700 age/ApiServerUtils.h:291 ]: [Client A2046] Authenticated with administrator account: ro_admin | |
[ 2017-07-09 08:55:03.6018 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 146 bytes | |
[ 2017-07-09 08:55:03.6018 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 146 | |
[ 2017-07-09 08:55:03.6018 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:03.6018 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 146 bytes | |
[ 2017-07-09 08:55:03.6019 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:03.6019 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 146 bytes | |
[ 2017-07-09 08:55:03.6019 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 2586 bytes | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 2586 | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:03.6020 6743/7fb476bfd700 Ser/FileBufferedChannel.h:584 ]: [FBC 0x7fb464000a00] Reader: found buffer, 2586 bytes | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/FileBufferedChannel.h:491 ]: [FBC 0x7fb464000a00] popBuffer() completed: nbuffers = 0, bytesBuffered = 0 | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/FileBufferedChannel.h:592 ]: [FBC 0x7fb464000a00] Reader: feeding buffer, 2586 bytes | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/FileBufferedChannel.h:559 ]: [FBC 0x7fb464000a00] Reader: no more buffers. Transitioning to RS_INACTIVE | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:03.6021 6743/7fb476bfd700 Ser/HttpServer.h:1060 ]: [Client A2046] Ending request | |
[ 2017-07-09 08:55:03.6022 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1405 ]: [FBC 0x7fb464000a00] Feeding 0 bytes | |
[ 2017-07-09 08:55:03.6022 6743/7fb476bfd700 Ser/FileBufferedChannel.h:484 ]: [FBC 0x7fb464000a00] pushBuffer() completed: nbuffers = 1, bytesBuffered = 0 | |
[ 2017-07-09 08:55:03.6022 6743/7fb476bfd700 Ser/FileBufferedChannel.h:552 ]: [FBC 0x7fb464000a00] Reader: reading next | |
[ 2017-07-09 08:55:03.6022 6743/7fb476bfd700 Ser/FileBufferedChannel.h:564 ]: [FBC 0x7fb464000a00] Reader: EOF encountered. Feeding EOF | |
[ 2017-07-09 08:55:03.6022 6743/7fb476bfd700 Ser/FileBufferedChannel.h:580 ]: [FBC 0x7fb464000a00] Reader: EOF fed. Transitioning to RS_TERMINATED | |
[ 2017-07-09 08:55:03.6023 6743/7fb476bfd700 Ser/FileBufferedChannel.h:537 ]: [FBC 0x7fb464000a00] Calling dataFlushedCallback | |
[ 2017-07-09 08:55:03.6023 6743/7fb476bfd700 Ser/HttpServer.h:219 ]: [Client A2046] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:03.6023 6743/7fb476bfd700 Ser/HttpServer.h:221 ]: [Client A2046] Keeping alive connection, handling next request | |
[ 2017-07-09 08:55:03.6023 6743/7fb476bfd700 Ser/HttpServer.h:235 ]: [Client A2046] Refcount increased; it is now 4 | |
[ 2017-07-09 08:55:03.6023 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:03.6024 6743/7fb476bfd700 Ser/HttpServer.h:119 ]: [ApiServer] Checking out request object from freelist (1 -> 0) | |
[ 2017-07-09 08:55:03.6024 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2046] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:03.6024 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2046] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:03.6024 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2046] Request object added to freelist (0 -> 1) | |
[ 2017-07-09 08:55:03.6025 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2046] Refcount decreased; it is now 3 | |
[ 2017-07-09 08:55:03.6025 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2046] 206 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:03.6025 6743/7fb476bfd700 Ser/Server.h:528 ]: [Client A2046] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:03.6025 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2046] Refcount increased; it is now 3 | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/Server.h:454 ]: [Client A2046] Client sent EOF | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/HttpServer.h:676 ]: [Client A2046] Event: onClientDataReceived | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2046] Request refcount increased; it is now 2 | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/Server.h:896 ]: [Client A2046] Disconnecting; there are now 0 active clients | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/HttpServer.h:725 ]: [Client A2046] Request refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:03.6026 6743/7fb476bfd700 Ser/FileBufferedChannel.h:1449 ]: [FBC 0x7fb464000a00] Deinitialize | |
[ 2017-07-09 08:55:03.6027 6743/7fb476bfd700 Ser/Server.h:906 ]: [Client A2046] Closing client file descriptor: 66 | |
[ 2017-07-09 08:55:03.6027 6743/7fb476bfd700 Ser/Server.h:909 ]: File descriptor closed: 66 | |
[ 2017-07-09 08:55:03.6027 6743/7fb476bfd700 Ser/Server.h:917 ]: [Client A2046] Refcount decreased; it is now 2 | |
[ 2017-07-09 08:55:03.6027 6743/7fb476bfd700 Ser/HttpServer.h:679 ]: [Client A2046] Request refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:03.6027 6743/7fb476bfd700 Ser/HttpServer.h:146 ]: [Client A2046] Request object reached a reference count of 0 | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/HttpServer.h:154 ]: [Client A2046] Request object added to freelist (1 -> 2) | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/HttpServer.h:161 ]: [Client A2046] Refcount decreased; it is now 1 | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/Server.h:479 ]: [Client A2046] 0 bytes of client data consumed in this callback | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/FdSourceChannel.h:54 ]: [Client A2046] Refcount decreased; it is now 0 | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/Server.h:378 ]: [Client A2046] Client object reached a reference count of 0 | |
[ 2017-07-09 08:55:03.6028 6743/7fb476bfd700 Ser/Server.h:387 ]: [Client A2046] Client object destroyed; not added to freelist because it's full (0) |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment