Created
September 1, 2017 18:13
-
-
Save ywkaras/239e7843d9313df00a478233dc0160d5 to your computer and use it in GitHub Desktop.
traffic_manager privilege elevation failure caused by traffic_ctl config set
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
[E. Mgmt] log ==> [TrafficManager] using root directory '/home/wkaras/TS2/tests/_sandbox/forwarded/ts2' | |
[Sep 1 18:10:07.445] Server {0x2b2a378667a0} DEBUG: <DNS.cc:1763 (ink_dns_init)> (dns) ink_dns_init: called with init_called = 0 | |
[Sep 1 18:10:07.452] Server {0x2b2a378667a0} DEBUG: <DNS.cc:283 (dns_init)> (dns) localhost=beliesimplies.corp.ne1.yahoo.com | |
[Sep 1 18:10:07.452] Server {0x2b2a378667a0} DEBUG: <DNS.cc:284 (dns_init)> (dns) Round-robin nameservers = 1 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:540 (startEvent)> (dns) DNSHandler::startEvent: on thread 0 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:483 (open_con)> (dns) open_con: opening connection 98.138.236.9:53 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNSConnection.cc:150 (connect)> (dns) random port = 0.0.0.0:31273 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:513 (open_con)> (dns) opening connection 98.138.236.9:53 SUCCEEDED for 0 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:563 (startEvent)> (dns_pas) opened connection to 98.138.236.9:53, n_con = 1 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:483 (open_con)> (dns) open_con: opening connection 98.138.236.8:53 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNSConnection.cc:150 (connect)> (dns) random port = 0.0.0.0:22572 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:513 (open_con)> (dns) opening connection 98.138.236.8:53 SUCCEEDED for 1 | |
[Sep 1 18:10:07.462] Server {0x2b2a3c90c700} DEBUG: <DNS.cc:563 (startEvent)> (dns_pas) opened connection to 98.138.236.8:53, n_con = 2 | |
[Sep 1 18:10:07.509] Server {0x2b2a3ca0e700} DEBUG: <ProtocolProbeSessionAccept.cc:139 (mainEvent)> (http) probe needs data, read.. | |
[Sep 1 18:10:07.510] Server {0x2b2a3ca0e700} DEBUG: <HttpSessionAccept.cc:58 (accept)> (http_seq) [HttpSessionAccept:mainEvent 0x2aaadc018d00] accepted connection from 127.0.0.1:58926 transport type = 1 | |
[Sep 1 18:10:07.511] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:200 (new_connection)> (http_cs) [0] session born, netvc 0x2aaadc018d00 | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <ProxyClientTransaction.cc:52 (new_transaction)> (http_txn) [0] Starting transaction 1 using sm [0] | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2513 (main_handler)> (http) [0] [HttpSM::main_handler, VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:544 (state_read_client_request_header)> (http) [0] [&HttpSM::state_read_client_request_header, VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:691 (state_read_client_request_header)> (http) [0] done parsing client request header | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1012 (ModifyRequest)> (http_trans) [0] START HttpTransact::ModifyRequest | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1101 (ModifyRequest)> (http_trans) [0] END HttpTransact::ModifyRequest | |
[Sep 1 18:10:07.521] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1102 (ModifyRequest)> (http_trans) [0] Checking if transaction wants to upgrade | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1110 (ModifyRequest)> (http_trans) Next action SM_ACTION_API_READ_REQUEST_HDR; HttpTransact::StartRemapRequest | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_UNDEFINED -> SM_ACTION_API_READ_REQUEST_HDR | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:619 (StartRemapRequest)> (http_trans) [0] START HttpTransact::StartRemapRequest | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:659 (StartRemapRequest)> (http_trans) [0] Before Remapping: | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) HTTP_HEADER 0x2aaad803e888: [T: 3, L: 48, OBJFLAGS: 0] | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HTTP.cc:570 (http_hdr_describe)> (http) [TYPE: REQ, V: 10001, URL: 0x2aaad803eb08, METHOD: "GET", METHOD_LEN: 3, FIELDS: 0x2aaad803e8b8] | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) URL 0x2aaad803eb08: [T: 2, L: 112, OBJFLAGS: 0] | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1622 (url_describe)> (http) [URLTYPE: 1, SWKSIDX: 99, | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1624 (url_describe)> (http) SCHEME: "http", SCHEME_LEN: 4, | |
[Sep 1 18:10:07.522] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1625 (url_describe)> (http) USER: "", USER_LEN: 0, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1627 (url_describe)> (http) PASSWORD: "", PASSWORD_LEN: 0, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1628 (url_describe)> (http) HOST: "www.no-oride.com", HOST_LEN: 16, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1630 (url_describe)> (http) PORT: "", PORT_LEN: 0, PORT_NUM: 0 | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1631 (url_describe)> (http) PATH: "", PATH_LEN: 0, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1633 (url_describe)> (http) PARAMS: "", PARAMS_LEN: 0, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1635 (url_describe)> (http) QUERY: "", QUERY_LEN: 0, | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1637 (url_describe)> (http) FRAGMENT: "", FRAGMENT_LEN: 0] | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) MIME_HEADER 0x2aaad803e8b8: [T: 4, L: 592, OBJFLAGS: 0] | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2681 (mime_hdr_describe)> (http) | |
[PBITS: 0x0008010001000001, SLACC: 0xFFFFFFF2FFFFFFFF3FFFFFFFFFF1FFFF, HEADBLK: 0x2aaad803e8f8, TAILBLK: 0x2aaad803e8f8] | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2686 (mime_hdr_describe)> (http) [CBITS: 0x00000000, T_MAXAGE: 0, T_SMAXAGE: 0, T_MAXSTALE: 0, T_MINFRESH: 0, PNO$: 0] | |
[Sep 1 18:10:07.523] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) FIELD_BLOCK 0x2aaad803e8f8: [T: 5, L: 528, OBJFLAGS: 0] | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2702 (mime_field_block_describe)> (http) [FREETOP: 4, NEXTBLK: (nil)] | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 0 (0x2aaad803e908), LIVE | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Host", N_LEN: 4, N_IDX: 30, | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "www.no-oride.com", V_LEN: 16, | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 24, F: 1] | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 1 (0x2aaad803e928), LIVE | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "User-Agent", N_LEN: 10, N_IDX: 64, | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "curl/7.47.1", V_LEN: 11, | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 25, F: 1] | |
[Sep 1 18:10:07.524] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 2 (0x2aaad803e948), LIVE | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Accept", N_LEN: 6, N_IDX: 4, | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "*/*", V_LEN: 3, | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 13, F: 1] | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 3 (0x2aaad803e968), LIVE | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Proxy-Connection", N_LEN: 16, N_IDX: 50, | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "Keep-Alive", V_LEN: 10, | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 30, F: 1] | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:669 (StartRemapRequest)> (http_trans) [0] END HttpTransact::StartRemapRequest | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:670 (StartRemapRequest)> (http_trans) Next action SM_ACTION_API_PRE_REMAP; HttpTransact::PerformRemap | |
[Sep 1 18:10:07.525] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_API_READ_REQUEST_HDR -> SM_ACTION_API_PRE_REMAP | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:676 (PerformRemap)> (http_trans) [0] Inside PerformRemap | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:677 (PerformRemap)> (http_trans) Next action SM_ACTION_REMAP_REQUEST; HttpTransact::EndRemapRequest | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_API_PRE_REMAP -> SM_ACTION_REMAP_REQUEST | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:3947 (do_remap_request)> (http_seq) [HttpSM::do_remap_request] Remapping request | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:683 (EndRemapRequest)> (http_trans) [0] START HttpTransact::EndRemapRequest | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:689 (EndRemapRequest)> (http_trans) [0] EndRemapRequest host is 127.0.0.1 | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:827 (EndRemapRequest)> (http_trans) [0] After Remapping: | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) HTTP_HEADER 0x2aaad803e888: [T: 3, L: 48, OBJFLAGS: 0] | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HTTP.cc:570 (http_hdr_describe)> (http) [TYPE: REQ, V: 10001, URL: 0x2aaad803eb08, METHOD: "GET", METHOD_LEN: 3, FIELDS: 0x2aaad803e8b8] | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) URL 0x2aaad803eb08: [T: 2, L: 112, OBJFLAGS: 0] | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1622 (url_describe)> (http) [URLTYPE: 1, SWKSIDX: 99, | |
[Sep 1 18:10:07.526] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1624 (url_describe)> (http) SCHEME: "http", SCHEME_LEN: 4, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1625 (url_describe)> (http) USER: "", USER_LEN: 0, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1627 (url_describe)> (http) PASSWORD: "", PASSWORD_LEN: 0, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1628 (url_describe)> (http) HOST: "127.0.0.1", HOST_LEN: 9, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1630 (url_describe)> (http) PORT: "61999", PORT_LEN: 5, PORT_NUM: 61999 | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1631 (url_describe)> (http) PATH: "", PATH_LEN: 0, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1633 (url_describe)> (http) PARAMS: "", PARAMS_LEN: 0, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1635 (url_describe)> (http) QUERY: "", QUERY_LEN: 0, | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1637 (url_describe)> (http) FRAGMENT: "", FRAGMENT_LEN: 0] | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) MIME_HEADER 0x2aaad803e8b8: [T: 4, L: 592, OBJFLAGS: 0] | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2681 (mime_hdr_describe)> (http) | |
[PBITS: 0x0008010001000001, SLACC: 0xFFFFFFF2FFFFFFFF3FFFFFFFFFF1FFFF, HEADBLK: 0x2aaad803e8f8, TAILBLK: 0x2aaad803e8f8] | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2686 (mime_hdr_describe)> (http) [CBITS: 0x00000000, T_MAXAGE: 0, T_SMAXAGE: 0, T_MAXSTALE: 0, T_MINFRESH: 0, PNO$: 0] | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) FIELD_BLOCK 0x2aaad803e8f8: [T: 5, L: 528, OBJFLAGS: 0] | |
[Sep 1 18:10:07.527] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2702 (mime_field_block_describe)> (http) [FREETOP: 4, NEXTBLK: (nil)] | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 0 (0x2aaad803e908), LIVE | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Host", N_LEN: 4, N_IDX: 30, | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "www.no-oride.com", V_LEN: 16, | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 24, F: 1] | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 1 (0x2aaad803e928), LIVE | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "User-Agent", N_LEN: 10, N_IDX: 64, | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "curl/7.47.1", V_LEN: 11, | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 25, F: 1] | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 2 (0x2aaad803e948), LIVE | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Accept", N_LEN: 6, N_IDX: 4, | |
[Sep 1 18:10:07.528] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "*/*", V_LEN: 3, | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 13, F: 1] | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 3 (0x2aaad803e968), LIVE | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Proxy-Connection", N_LEN: 16, N_IDX: 50, | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "Keep-Alive", V_LEN: 10, | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 30, F: 1] | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:846 (EndRemapRequest)> (http_trans) [0] END HttpTransact::EndRemapRequest | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:852 (EndRemapRequest)> (http_trans) Next action SM_ACTION_API_POST_REMAP; HttpTransact::HandleRequest | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_REMAP_REQUEST -> SM_ACTION_API_POST_REMAP | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1147 (HandleRequest)> (http_trans) [0] START HttpTransact::HandleRequest | |
[Sep 1 18:10:07.529] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:5135 (check_request_validity)> (http_trans) [0] [init_stat_vars_from_req] set req cont length to 0 | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:6190 (is_request_valid)> (http_trans) [0] [is_request_valid] no request header errors | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1168 (HandleRequest)> (http_seq) [0] [HttpTransact::HandleRequest] request valid. | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) HTTP_HEADER 0x2aaad803e888: [T: 3, L: 48, OBJFLAGS: 0] | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <HTTP.cc:570 (http_hdr_describe)> (http) [TYPE: REQ, V: 10001, URL: 0x2aaad803eb08, METHOD: "GET", METHOD_LEN: 3, FIELDS: 0x2aaad803e8b8] | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) URL 0x2aaad803eb08: [T: 2, L: 112, OBJFLAGS: 0] | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1622 (url_describe)> (http) [URLTYPE: 1, SWKSIDX: 99, | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1624 (url_describe)> (http) SCHEME: "http", SCHEME_LEN: 4, | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1625 (url_describe)> (http) USER: "", USER_LEN: 0, | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1627 (url_describe)> (http) PASSWORD: "", PASSWORD_LEN: 0, | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1628 (url_describe)> (http) HOST: "127.0.0.1", HOST_LEN: 9, | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1630 (url_describe)> (http) PORT: "61999", PORT_LEN: 5, PORT_NUM: 61999 | |
[Sep 1 18:10:07.530] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1631 (url_describe)> (http) PATH: "", PATH_LEN: 0, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1633 (url_describe)> (http) PARAMS: "", PARAMS_LEN: 0, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1635 (url_describe)> (http) QUERY: "", QUERY_LEN: 0, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <URL.cc:1637 (url_describe)> (http) FRAGMENT: "", FRAGMENT_LEN: 0] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) MIME_HEADER 0x2aaad803e8b8: [T: 4, L: 592, OBJFLAGS: 0] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2681 (mime_hdr_describe)> (http) | |
[PBITS: 0x0008010001000001, SLACC: 0xFFFFFFF2FFFFFFFF3FFFFFFFFFF1FFFF, HEADBLK: 0x2aaad803e8f8, TAILBLK: 0x2aaad803e8f8] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2686 (mime_hdr_describe)> (http) [CBITS: 0x00000000, T_MAXAGE: 0, T_SMAXAGE: 0, T_MAXSTALE: 0, T_MINFRESH: 0, PNO$: 0] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <HdrHeap.cc:56 (obj_describe)> (http) FIELD_BLOCK 0x2aaad803e8f8: [T: 5, L: 528, OBJFLAGS: 0] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2702 (mime_field_block_describe)> (http) [FREETOP: 4, NEXTBLK: (nil)] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 0 (0x2aaad803e908), LIVE | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Host", N_LEN: 4, N_IDX: 30, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "www.no-oride.com", V_LEN: 16, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 24, F: 1] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 1 (0x2aaad803e928), LIVE | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "User-Agent", N_LEN: 10, N_IDX: 64, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "curl/7.47.1", V_LEN: 11, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 25, F: 1] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 2 (0x2aaad803e948), LIVE | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Accept", N_LEN: 6, N_IDX: 4, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "*/*", V_LEN: 3, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 13, F: 1] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2706 (mime_field_block_describe)> (http) SLOT # 3 (0x2aaad803e968), LIVE | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2715 (mime_field_block_describe)> (http) [N: "Proxy-Connection", N_LEN: 16, N_IDX: 50, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2716 (mime_field_block_describe)> (http) V: "Keep-Alive", V_LEN: 10, | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2718 (mime_field_block_describe)> (http) NEXTDUP: (nil), RAW: 1, RAWLEN: 30, F: 1] | |
[Sep 1 18:10:07.531] Server {0x2b2a3ca0e700} DEBUG: <MIME.cc:2721 (mime_field_block_describe)> (http) | |
+++++++++ Incoming Request +++++++++ | |
-- State Machine Id: 0 | |
GET http://127.0.0.1:61999/ HTTP/1.1 | |
Host: www.no-oride.com | |
User-Agent: curl/7.47.1 | |
Accept: */* | |
Proxy-Connection: Keep-Alive | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1324 (HandleRequest)> (http_trans) Next action SM_ACTION_DNS_LOOKUP; OSDNSLookup | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_API_POST_REMAP -> SM_ACTION_DNS_LOOKUP | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7198 (set_next_state)> (dns) [HttpTransact::HandleRequest] Skipping DNS lookup for 127.0.0.1 because it's loopback | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1582 (OSDNSLookup)> (http_trans) [0] [HttpTransact::OSDNSLookup] This was attempt 0 | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1644 (OSDNSLookup)> (http_seq) [0] [HttpTransact::OSDNSLookup] DNS Lookup successful | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1683 (OSDNSLookup)> (http_trans) [0] [OSDNSLookup] DNS lookup for O.S. successful IP: 127.0.0.1 | |
[Sep 1 18:10:07.532] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1790 (HandleRequestAuthorized)> (http_trans) Next action SM_ACTION_API_OS_DNS; HttpTransact::DecideCacheLookup | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_DNS_LOOKUP -> SM_ACTION_API_OS_DNS | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1902 (DecideCacheLookup)> (http_trans) [0] [DecideCacheLookup] Will NOT do cache lookup. | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1903 (DecideCacheLookup)> (http_seq) [0] [DecideCacheLookup] Will NOT do cache lookup | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1922 (DecideCacheLookup)> (http_trans) Next action SM_ACTION_API_CACHE_LOOKUP_COMPLETE; LookupSkipOpenServer | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_API_OS_DNS -> SM_ACTION_API_CACHE_LOOKUP_COMPLETE | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:5054 (add_client_ip_to_outgoing_request)> (http_trans) [0] client_ip_set = 0 | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:5067 (add_client_ip_to_outgoing_request)> (http_trans) [0] [add_client_ip_to_outgoing_request] Appended connecting client's (127.0.0.1) to the X-Forwards header | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:1183 (add_forwarded_field_to_request)> (http_trans) [add_forwarded_field_to_outgoing_request] Forwarded header (by=_43415f22-f62c-4ffe-85f3-41cefb5fa02b) added | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:7616 (build_request)> (http_trans) [0] [build_request] removing host name from url | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:7653 (build_request)> (http_trans) [0] [build_request] request_sent_time: 1504289407 | |
+++++++++ Proxy's Request +++++++++ | |
-- State Machine Id: 0 | |
GET / HTTP/1.1 | |
Host: www.no-oride.com | |
User-Agent: curl/7.47.1 | |
Accept: */* | |
X-Forwarded-For: 127.0.0.1 | |
Forwarded: by=_43415f22-f62c-4ffe-85f3-41cefb5fa02b | |
Via: http/1.1 Poxy_Proxy[43415f22-f62c-4ffe-85f3-41cefb5fa02b] (ApacheTrafficServer/8.0.0) | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:1955 (LookupSkipOpenServer)> (http_trans) Next action next; HttpTransact::HandleResponse | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_API_CACHE_LOOKUP_COMPLETE -> SM_ACTION_ORIGIN_SERVER_OPEN | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:4627 (do_http_server_open)> (http_track) entered inside do_http_server_open ][ipv4] | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:4654 (do_http_server_open)> (http) [0] open connection to 127.0.0.1: 127.0.0.1:61999 | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:4666 (do_http_server_open)> (http_seq) [HttpSM::do_http_server_open] Sending request to server | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSessionManager.cc:319 (acquire_session)> (http_ss) [acquire session] thread pool search failed | |
[Sep 1 18:10:07.533] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:4987 (do_http_server_open)> (http) calling netProcessor.connect_re | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2513 (main_handler)> (http) [0] [HttpSM::main_handler, NET_EVENT_OPEN] | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:1666 (state_http_server_open)> (http_track) entered inside state_http_server_open | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:1667 (state_http_server_open)> (http) [0] [&HttpSM::state_http_server_open, NET_EVENT_OPEN] | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpServerSession.cc:93 (new_connection)> (http_ss) [0] session born, netvc 0x2aaadc018a00 | |
+++++++++ Proxy's Request after hooks +++++++++ | |
-- State Machine Id: 0 | |
GET / HTTP/1.1 | |
Host: www.no-oride.com | |
User-Agent: curl/7.47.1 | |
Accept: */* | |
X-Forwarded-For: 127.0.0.1 | |
Forwarded: by=_43415f22-f62c-4ffe-85f3-41cefb5fa02b | |
Via: http/1.1 Poxy_Proxy[43415f22-f62c-4ffe-85f3-41cefb5fa02b] (ApacheTrafficServer/8.0.0) | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2513 (main_handler)> (http) [0] [HttpSM::main_handler, VC_EVENT_WRITE_COMPLETE] | |
[Sep 1 18:10:07.534] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:1933 (state_send_server_request_header)> (http) [0] [&HttpSM::state_send_server_request_header, VC_EVENT_WRITE_COMPLETE] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2513 (main_handler)> (http) [0] [HttpSM::main_handler, VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:1761 (state_read_server_response_header)> (http) [0] [&HttpSM::state_read_server_response_header, VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:1877 (state_read_server_response_header)> (http_seq) Done parsing server response header | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1728 (deallocate_redirect_postdata_buffers)> (http_redirect) [HttpTunnel::deallocate_postdata_copy_buffers] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3155 (HandleResponse)> (http_trans) [0] [HttpTransact::HandleResponse] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3156 (HandleResponse)> (http_seq) [0] [HttpTransact::HandleResponse] Response received | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3163 (HandleResponse)> (http_trans) [0] [HandleResponse] response_received_time: 1504289407 | |
+++++++++ Incoming O.S. Response +++++++++ | |
-- State Machine Id: 0 | |
HTTP/1.1 200 OK | |
Connection: close | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:6348 (is_response_valid)> (http_trans) [0] [is_response_valid] No errors in response | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3181 (HandleResponse)> (http_seq) [0] [HttpTransact::HandleResponse] Response valid | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3474 (handle_response_from_server)> (http_trans) [0] [handle_response_from_server] (hrfs) | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3486 (handle_response_from_server)> (http_trans) [0] [hrfs] connection alive | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3757 (handle_forward_server_connection_open)> (http_trans) [0] [handle_forward_server_connection_open] (hfsco) | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3758 (handle_forward_server_connection_open)> (http_seq) [0] [HttpTransact::handle_server_connection_open] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:4164 (do_hostdb_update_if_necessary)> (http) server info = 127.0.0.1:61999 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:3864 (handle_forward_server_connection_open)> (http_trans) [0] [hfsco] cache action: CACHE_DO_NO_ACTION | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:4427 (handle_no_cache_operation_on_forward_server_response)> (http_trans) [0] [handle_no_cache_operation_on_forward_server_response] (hncoofsr) | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:4428 (handle_no_cache_operation_on_forward_server_response)> (http_seq) [0] [handle_no_cache_operation_on_forward_server_response] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:4435 (handle_no_cache_operation_on_forward_server_response)> (http_trans) [0] [hncoofsr] server sent back 200 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransact.cc:4442 (handle_no_cache_operation_on_forward_server_response)> (http_trans) [0] [hncoofsr] next action will be OS_READ_CACHE_NOOP | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:438 (calculate_document_age)> (http_age) [calculate_document_age] age_value: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:439 (calculate_document_age)> (http_age) [calculate_document_age] date_value: 1504289407 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:440 (calculate_document_age)> (http_age) [calculate_document_age] response_time: 1504289407 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:441 (calculate_document_age)> (http_age) [calculate_document_age] now: 1504289407 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:442 (calculate_document_age)> (http_age) [calculate_document_age] now (fixed): 1504289407 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:443 (calculate_document_age)> (http_age) [calculate_document_age] apparent_age: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:444 (calculate_document_age)> (http_age) [calculate_document_age] corrected_received_age: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:445 (calculate_document_age)> (http_age) [calculate_document_age] response_delay: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:446 (calculate_document_age)> (http_age) [calculate_document_age] corrected_initial_age: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:447 (calculate_document_age)> (http_age) [calculate_document_age] resident_time: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:448 (calculate_document_age)> (http_age) [calculate_document_age] current_age: 0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:638 (generate_and_set_squid_codes)> (http_trans) [Squid code generation] Hit/Miss: 1, Log: 3, Hier: 2 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTransactHeaders.cc:1207 (add_server_header_to_response)> (http_trans) Adding Server: ATS/8.0.0 | |
+++++++++ Base Header for Building Response +++++++++ | |
-- State Machine Id: 0 | |
HTTP/1.1 200 OK | |
Connection: close | |
Date: Fri, 01 Sep 2017 18:10:07 GMT | |
+++++++++ Proxy's Response 2 +++++++++ | |
-- State Machine Id: 0 | |
HTTP/1.1 200 OK | |
Date: Fri, 01 Sep 2017 18:10:07 GMT | |
Age: 0 | |
Transfer-Encoding: chunked | |
Proxy-Connection: keep-alive | |
Server: ATS/8.0.0 | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7115 (call_transact_and_set_next_state)> (http) [0] State Transition: SM_ACTION_ORIGIN_SERVER_OPEN -> SM_ACTION_SERVER_READ | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:7626 (do_redirect)> (http_redirect) [HttpSM::do_redirect] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1728 (deallocate_redirect_postdata_buffers)> (http_redirect) [HttpTunnel::deallocate_postdata_copy_buffers] | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:6478 (setup_server_transfer)> (http) Setup Server Transfer | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:669 (add_producer)> (http_tunnel) [0] adding producer 'http server' | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:724 (add_consumer)> (http_tunnel) [0] adding consumer 'user agent' | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:5692 (perform_cache_write_action)> (http) [0] perform_cache_write_action CACHE_DO_NO_ACTION | |
[Sep 1 18:10:07.537] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:771 (tunnel_run)> (http_tunnel) tunnel_run started, p_arg is provided | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:230 (do_io_write)> (http_cs) tcp_init_cwnd_set 0 | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:249 (set_tcp_init_cwnd)> (http_cs) desired TCP congestion window is 0 | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1150 (producer_handler)> (http_tunnel) [0] producer_handler [http server VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1055 (producer_handler_dechunked)> (http_tunnel) [0] producer_handler_dechunked [http server VC_EVENT_READ_READY] | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1190 (producer_handler)> (http_redirect) [HttpTunnel::producer_handler] enable_redirection: [1 0 0] event: 100 | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1150 (producer_handler)> (http_tunnel) [0] producer_handler [http server VC_EVENT_EOS] | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1055 (producer_handler_dechunked)> (http_tunnel) [0] producer_handler_dechunked [http server VC_EVENT_EOS] | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1190 (producer_handler)> (http_redirect) [HttpTunnel::producer_handler] enable_redirection: [1 0 0] event: 104 | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2844 (tunnel_handler_server)> (http) [0] [&HttpSM::tunnel_handler_server, VC_EVENT_EOS] | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2901 (tunnel_handler_server)> (http) [0] [HttpSM::tunnel_handler_server] finishing HTTP tunnel | |
[Sep 1 18:10:07.538] Server {0x2b2a3ca0e700} DEBUG: <HttpServerSession.cc:125 (do_io_close)> (http_ss) [0] session closing, netvc 0x2aaadc018a00 | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1349 (consumer_handler)> (http_tunnel) [0] consumer_handler [user agent VC_EVENT_WRITE_COMPLETE] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:3108 (tunnel_handler_ua)> (http) [0] [&HttpSM::tunnel_handler_ua, VC_EVENT_WRITE_COMPLETE] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <ProxyClientTransaction.cc:67 (release)> (http_txn) [0] session released by sm [0] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:230 (do_io_write)> (http_cs) tcp_init_cwnd_set 1 | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:470 (release)> (http_cs) [0] initiating io for next header | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2513 (main_handler)> (http) [0] [HttpSM::main_handler, HTTP_TUNNEL_EVENT_DONE] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:2784 (tunnel_handler)> (http) [0] [&HttpSM::tunnel_handler, HTTP_TUNNEL_EVENT_DONE] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1728 (deallocate_redirect_postdata_buffers)> (http_redirect) [HttpTunnel::deallocate_postdata_copy_buffers] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpTunnel.cc:1728 (deallocate_redirect_postdata_buffers)> (http_redirect) [HttpTunnel::deallocate_postdata_copy_buffers] | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:6830 (kill_this)> (http_seq) [HttpSM::update_stats] Logging transaction | |
[Sep 1 18:10:07.539] Server {0x2b2a3ca0e700} DEBUG: <HttpSM.cc:6857 (kill_this)> (http) [0] deallocating sm | |
[Sep 1 18:10:07.540] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:416 (state_keep_alive)> (http_cs) [0] [&Http1ClientSession::state_keep_alive, VC_EVENT_EOS] | |
[Sep 1 18:10:07.540] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:317 (do_io_close)> (http_cs) [0] session closed | |
[Sep 1 18:10:07.540] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:94 (destroy)> (http_cs) [0] session destroy | |
[Sep 1 18:10:07.540] Server {0x2b2a3ca0e700} DEBUG: <Http1ClientSession.cc:230 (do_io_write)> (http_cs) tcp_init_cwnd_set 1 | |
Fatal: exiting on shutdown message | |
Fatal: failed to acquire privileged capabilities: Operation not permitted |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment