Luca Rea created TS-3214:
----------------------------
Summary: rewuest in not forwarded to parent
Key: TS-3214
URL: https://issues.apache.org/jira/browse/TS-3214
Project: Traffic Server
Issue Type: Bug
Components: Core
Reporter: Luca Rea
Hi,
I've added the directive "CONFIG
proxy.config.http.cache.cache_urls_that_look_dynamic INT 0" because of TS-3212
but now some rules of parent.config don't work anymore:
destination:
{code}
opmanager.tomatowin.local resolved as 172.20.5.250
{code}
the rule below worked fine
{code}
url_regex="^http://opmanager.tomatowin.local"; port="8080"
parent="192.168.242.250:8080"
{code}
now it returns errors:
{code}
172.17.0.153 - - [26/Nov/2014:10:00:04 +0100] "GET
http://opmanager.tomatowin.local/overview.do?selectedTab=Home&fromLogin=true
HTTP/1.1" 502 0 000 0 0 0 2090 0 2090 0 0 DIRECT FIN INTR ERR_CONNECT_FAIL
172.17.0.153 - - [26/Nov/2014:10:00:04 +0100] "GET
http://opmanager.tomatowin.local/overview.do?selectedTab=Home&fromLogin=true
HTTP/1.1" 502 247 000 0 0 0 2090 209 2090 0 6 DIRECT FIN INTR ERR_CONNECT_FAIL
{code}
debug:
{code}
+++++++++ Incoming Request +++++++++
-- State Machine Id: 1
GET
http://opmanager.tomatowin.local/overview.do?selectedTab=Home&fromLogin=true
HTTP/1.1
Host: opmanager.tomatowin.local
User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:33.0) Gecko/20100101
Firefox/33.0
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
Accept-Language: it-IT,it;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip
Referer: http://opmanager/LoginPage.do
Cookie: testcookie=; am_username=; am_check=;
defaultSnapshotDetailsTab=DeviceDetails; defaultSnapshotMNITabs=monitorsList;
MNIAtabs=monitorsList; SelectedMonitor=Performance; defaultReportDetails=true;
encryptPassForAutomaticSignin=C70z
38bn081C7; userNameForAutomaticSignin=admlrea;
domainNameForAutomaticSignin=TOMATOWIN; isADAuth=true;
signInAutomatically=true;
monitordnd=%5B%7Bbay%3A%27DRAG_APPEND_1%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_1%27%2Cstate%3A%27on%27%2Ccontent
%3A%27show%27%7D%2C%7Btab%3A%27DRAG_9%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_2%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_7%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_11%27%2Cstat
e%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_3%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_3%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_4%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%
3A%27DRAG_13%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_4%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_6%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_12%27%2Cstate%3A%27on%27%2Ccontent%3A
%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_5%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_8%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_10%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%5D;
allResourceTable_sortdi
r=down; defaultIntfSnapshotDetailsTab=IntfNotes; flashversionInstalled=15.0.0;
JSESSIONID=AD1C5525F00C724FF561D205CA54D4FE;
OPUTILSTICKET=e8ed98176f600c28ce7ec4fdd489ef53;
NPMTICKET=345ddb60eba824cd3dac253197a73e90
Connection: keep-alive
Cache-Control: max-age=0
[Nov 26 10:02:27.216] Server {0x2ac9a1e0c700} DEBUG: (http_trans) Next action
SM_ACTION_DNS_LOOKUP; OSDNSLookup
[Nov 26 10:02:27.216] Server {0x2ac9a1e0c700} DEBUG: (http) [1] State
Transition: SM_ACTION_API_POST_REMAP -> SM_ACTION_DNS_LOOKUP
[Nov 26 10:02:27.216] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[HttpSM::do_hostdb_lookup] Doing DNS Lookup
[Nov 26 10:02:27.236] Server {0x2ac9a1e0c700} DEBUG: (dns) received query
opmanager.tomatowin.local type = 1, timeout = 0
[Nov 26 10:02:27.236] Server {0x2ac9a0c6ff00} DEBUG: (dns) enqueing query
opmanager.tomatowin.local
[Nov 26 10:02:27.236] Server {0x2ac9a0c6ff00} DEBUG: (dns) adding first to
collapsing queue
[Nov 26 10:02:27.236] Server {0x2ac9a0c6ff00} DEBUG: (dns) send query (qtype=1)
for opmanager.tomatowin.local to fd 49
[Nov 26 10:02:27.236] Server {0x2ac9a0c6ff00} DEBUG: (dns) sent qname =
opmanager.tomatowin.local, id = 947, nameserver = 0
[Nov 26 10:02:27.236] Server {0x2ac9a0c6ff00} DEBUG: (dns) sent_one:
failover_number for resolver 0 is 1
[Nov 26 10:02:27.237] Server {0x2ac9a0c6ff00} DEBUG: (dns) received packet size
= 506
[Nov 26 10:02:27.237] Server {0x2ac9a0c6ff00} DEBUG: (dns) round-robin:
nameserver 0 DNS response code = 0
[Nov 26 10:02:27.237] Server {0x2ac9a0c6ff00} DEBUG: (dns) received A name =
opmanager.tomatowin.local
[Nov 26 10:02:27.237] Server {0x2ac9a0c6ff00} DEBUG: (dns) received A =
172.20.5.250
[Nov 26 10:02:27.237] Server {0x2ac9a0c6ff00} DEBUG: (dns) SUCCESS result for
opmanager.tomatowin.local = 172.20.5.250 retry 0
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (dns) called back
continuation for opmanager.tomatowin.local
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[HttpSM::main_handler, EVENT_HOST_DB_LOOKUP]
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[&HttpSM::state_hostdb_lookup, EVENT_HOST_DB_LOOKUP]
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[ink_cluster_time] local: 1416992547, highest_delta: 0, cluster: 1416992547
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[HttpTransact::OSDNSLookup] This was attempt 1
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[HttpTransact::OSDNSLookup] DNS Lookup successful
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) [OSDNSLookup]
DNS lookup for O.S. successful IP: 172.20.5.250
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) Next action
SM_ACTION_API_OS_DNS; HttpTransact::DecideCacheLookup
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1] State
Transition: SM_ACTION_DNS_LOOKUP -> SM_ACTION_API_OS_DNS
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[DecideCacheLookup] Will NOT do cache lookup.
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[DecideCacheLookup] Will NOT do cache lookup
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) Next action
SM_ACTION_API_CACHE_LOOKUP_COMPLETE; LookupSkipOpenServer
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1] State
Transition: SM_ACTION_API_OS_DNS -> SM_ACTION_API_CACHE_LOOKUP_COMPLETE
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) request not
cacheable, so bypass parent
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) client_ip_set
= 0
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) inserted
request header 'Client-ip: 172.17.0.153'
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[add_client_ip_to_outgoing_request] Appended connecting client's (172.17.0.153)
to the X-Forwards header
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[build_request] removing host name from url
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[ink_cluster_time] local: 1416992547, highest_delta: 0, cluster: 1416992547
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[build_request] request_sent_time: 1416992547
+++++++++ Proxy's Request +++++++++
-- State Machine Id: 1
GET /overview.do?selectedTab=Home&fromLogin=true HTTP/1.1
Host: opmanager.tomatowin.local
User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:33.0) Gecko/20100101
Firefox/33.0
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
Accept-Language: it-IT,it;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip
Referer: http://opmanager/LoginPage.do
Cookie: testcookie=; am_username=; am_check=;
defaultSnapshotDetailsTab=DeviceDetails; defaultSnapshotMNITabs=monitorsList;
MNIAtabs=monitorsList; SelectedMonitor=Performance; defaultReportDetails=true;
encryptPassForAutomaticSignin=C70z38bn081C7;
userNameForAutomaticSignin=admlrea; domainNameForAutomaticSignin=TOMATOWIN;
isADAuth=true; signInAutomatically=true;
monitordnd=%5B%7Bbay%3A%27DRAG_APPEND_1%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_1%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_9%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_2%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_7%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_11%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_3%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_3%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_4%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_13%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_4%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_6%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_12%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_5%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_8%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_10%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%5D;
allResourceTable_sortdir=down; defaultIntfSnapshotDetailsTab=IntfNotes;
flashversionInstalled=15.0.0; JSESSIONID=AD1C5525F00C724FF561D205CA54D4FE;
OPUTILSTICKET=e8ed98176f600c28ce7ec4fdd489ef53;
NPMTICKET=345ddb60eba824cd3dac253197a73e90
Cache-Control: max-age=0
Client-ip: 172.17.0.153
X-Forwarded-For: 172.17.0.153
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) Next action
next; HttpTransact::HandleResponse
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1] State
Transition: SM_ACTION_API_CACHE_LOOKUP_COMPLETE -> SM_ACTION_ORIGIN_SERVER_OPEN
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_track) entered
inside do_http_server_open ][IPv4]
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1] open connection
to opmanager.tomatowin.local: 172.20.5.250:80
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[HttpSM::do_http_server_open] Sending request to server
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) calling
netProcessor.connect_re
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[HttpSM::main_handler, NET_EVENT_OPEN]
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_track) entered
inside state_http_server_open
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[&HttpSM::state_http_server_open, NET_EVENT_OPEN]
[Nov 26 10:02:27.237] Server {0x2ac9a1e0c700} DEBUG: (http_ss) [1] session
born, netvc 0x2ac9c00158b0
+++++++++ Proxy's Request after hooks +++++++++
-- State Machine Id: 1
GET /overview.do?selectedTab=Home&fromLogin=true HTTP/1.1
Host: opmanager.tomatowin.local
User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:33.0) Gecko/20100101
Firefox/33.0
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
Accept-Language: it-IT,it;q=0.8,en-US;q=0.5,en;q=0.3
Accept-Encoding: gzip
Referer: http://opmanager/LoginPage.do
Cookie: testcookie=; am_username=; am_check=;
defaultSnapshotDetailsTab=DeviceDetails; defaultSnapshotMNITabs=monitorsList;
MNIAtabs=monitorsList; SelectedMonitor=Performance; defaultReportDetails=true;
encryptPassForAutomaticSignin=C70z38bn081C7;
userNameForAutomaticSignin=admlrea; domainNameForAutomaticSignin=TOMATOWIN;
isADAuth=true; signInAutomatically=true;
monitordnd=%5B%7Bbay%3A%27DRAG_APPEND_1%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_1%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_9%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_2%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_7%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_11%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_3%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_3%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_4%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_13%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_4%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_6%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_12%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%2C%7Bbay%3A%27DRAG_APPEND_5%27%2Cchildren%3A%5B%7Btab%3A%27DRAG_8%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%2C%7Btab%3A%27DRAG_10%27%2Cstate%3A%27on%27%2Ccontent%3A%27show%27%7D%5D%7D%5D;
allResourceTable_sortdir=down; defaultIntfSnapshotDetailsTab=IntfNotes;
flashversionInstalled=15.0.0; JSESSIONID=AD1C5525F00C724FF561D205CA54D4FE;
OPUTILSTICKET=e8ed98176f600c28ce7ec4fdd489ef53;
NPMTICKET=345ddb60eba824cd3dac253197a73e90
Cache-Control: max-age=0
Client-ip: 172.17.0.153
X-Forwarded-For: 172.17.0.153
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[HttpSM::main_handler, VC_EVENT_ERROR]
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[&HttpSM::state_send_server_request_header, VC_EVENT_ERROR]
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http) [1]
[&HttpSM::handle_server_setup_error, VC_EVENT_ERROR]
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_ss) [1] session
closing, netvc 0x2ac9c00158b0
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[HttpTransact::HandleResponse]
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[HttpTransact::HandleResponse] Response received
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[ink_cluster_time] local: 1416992548, highest_delta: 0, cluster: 1416992548
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[HandleResponse] response_received_time: 1416992548
+++++++++ Incoming O.S. Response +++++++++
-- State Machine Id: 1
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_seq)
[HttpTransact::HandleResponse] Response not valid
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[handle_response_from_server] (hrfs)
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans) [1] failed to
connect [5] to 172.20.5.250
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[retry_server_connection_not_open] attempts now: 2, max: 6
[Nov 26 10:02:28.237] Server {0x2ac9a1e0c700} DEBUG: (http_trans)
[handle_response_from_server] Error. Retrying...
{code}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
