• Global community
    • Language:
      • Deutsch
      • English
      • Español
      • Français
      • Português
  • 日本語コミュニティ
    Dedicated community for Japanese speakers
  • 한국 커뮤니티
    Dedicated community for Korean speakers
Exit
0

CF11 IIS JSON POST request hangs indefinitely but cfml runs

New Here ,
Sep 11, 2014 Sep 11, 2014

Copy link to clipboard

Copied

Issue Description

Simply put when we make a request to any .cfm page with content-type of application/json and json in the request body the cfml will run (tested with cflog) but the browser/testing tool will indefinitely hang. If you leave the request body empty though the request will work normally.

Setup

Windows Server 2008R2 - IIS 7.5

Coldfusion 11 (still no patches!)

Postman/Fiddler for testing

Debugging

So I know that the request makes it to coldfusion by using cflog.

I then put the isapi_redirect connector into debug mode to see if anything useful appeared in the logs (will add below) and when the request gets through to coldfusion it looks like the html for the page is returned, but for some reason it looks like its looking up the index.cfm and index.html (which is odd) and there is also a difference the the last few lines of the two requests - i dont really know enough at this level to make heads or tails of it.

On the IIS side of things if you look at the worker processes for the connection pool all POST application/json requests are just queued up and for ever getting longer - which cant be good. Also in the windows event viewer under WAS there are some errors about 'pools exceeding time limits' with codes 5013 and 5138 which seem a bit generic and may just be IIS finally deciding that said requests now need to be killed.

We have replicated the issue on three clones of the same install and two other separate installs, tried updating the connector to 1.2.4 and had a go at the BonCode connector on riaforge to no joy.

ISAPI_Redirect connector log

<!--- BAD REQUEST BELOW --->

[Wed Sep 10 15:22:32.545 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2184): Filter started

[Wed Sep 10 15:22:32.545 2014] [2912:1016] [debug] map_uri_to_worker_ext::jk_uri_worker_map.c (1131): Attempting to map URI '/10.10.10.37/index.cfm' from 30 maps

[Wed Sep 10 15:22:32.545 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flashservices/gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfform-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cffileservlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfformgateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFileServlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFormGateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.561 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/rest/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.hbmxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfswf=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.mxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFML=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFC=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.swc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFM=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.577 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfr=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.sws=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.jsp=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] find_match::jk_uri_worker_map.c (958): Found a wildchar match '/*.cfm=cfusion'

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2266): check if [/index.cfm] points to the web-inf directory

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2283): [/index.cfm] is a servlet url - should redirect to cfusion

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2321): fowarding escaped URI [/index.cfm]

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2394): forwarding to : /jakarta/isapi_redirect.dll

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2396): forward URI   : TOMCATURI000000006A6B0000:/index.cfm

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2399): forward query : TOMCATQUERY000000006A6B0000:screwyRequest

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2401): forward worker: TOMCATWORKER000000006A6B0000:cfusion

[Wed Sep 10 15:22:32.592 2014] [2912:1016] [debug] handle_notify_event::jk_isapi_plugin.c (2403): worker index  : TOMCATWORKERIDX000000006A6B0000:28

[Wed Sep 10 15:22:32.639 2014] [2912:1016] [debug] wc_maintain::jk_worker.c (338): Maintaining worker cfusion

[Wed Sep 10 15:22:32.639 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3516): Reading extension header HTTP_TOMCATWORKER000000006A6B0000: cfusion

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3517): Reading extension header HTTP_TOMCATWORKERIDX000000006A6B0000: 28

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3518): Reading extension header HTTP_TOMCATURI000000006A6B0000: /index.cfm

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3519): Reading extension header HTTP_TOMCATQUERY000000006A6B0000: screwyRequest

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3702): Applying service extensions

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Cache-Control : no-cache

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Connection : keep-alive

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Content-Length : 129

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Content-Type : application/json

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept : */*

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept-Encoding : gzip,deflate

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept-Language : en-GB,en-US;q=0.8,en;q=0.6

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Cookie : JSESSIONID=F723FD3DEB37888D2015BE10B01868C7.cfusion

[Wed Sep 10 15:22:32.655 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Host : 10.10.10.37

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header User-Agent : Mozilla/5.0 (Windows NT 6.1; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/37.0.2062.103 Safari/537.36

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Origin : chrome-extension://fdmmgilgnpjigdojojpjoooidkmcomcm

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header DNT : 1

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3973): Service protocol=HTTP/1.1 method=POST host=10.10.10.11 addr=10.10.10.11 name=10.10.10.37 port=80 auth= user= uri=/index.cfm

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] init_ws_service::jk_isapi_plugin.c (3985): Service request headers=12 attributes=0 chunked=no content-length=129 available=129

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] wc_get_worker_for_name::jk_worker.c (115): found a worker cfusion

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] HttpExtensionProc::jk_isapi_plugin.c (2582): got a worker for name cfusion

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] ajp_get_endpoint::jk_ajp_common.c (3287): acquired connection pool slot=2 after 0 retries

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] ajp_marshal_into_msgb::jk_ajp_common.c (668): ajp marshaling done

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] ajp_service::jk_ajp_common.c (2569): processing cfusion with 2 retries

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] ajp_send_request::jk_ajp_common.c (1673): (cfusion) all endpoints are disconnected.

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] jk_open_socket::jk_connect.c (485): socket TCP_NODELAY set to On

[Wed Sep 10 15:22:32.670 2014] [2912:1016] [debug] jk_open_socket::jk_connect.c (609): trying to connect socket 748 to 127.0.0.1:8014

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] jk_open_socket::jk_connect.c (635): socket 748 [127.0.0.1:49430 -> 127.0.0.1:8014] connected

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=619 max=65536

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 02 67 02 04 00 08 48 54 54 50 2F 31 2E 31  - .4.g....HTTP/1.1

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    00 00 0A 2F 69 6E 64 65 78 2E 63 66 6D 00 00 0B  - .../index.cfm...

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    31 30 2E 31 30 2E 31 30 2E 31 31 00 00 0B 31 30  - 10.10.10.11...10

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0030    2E 31 30 2E 31 30 2E 31 31 00 00 0B 31 30 2E 31  - .10.10.11...10.1

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0040    30 2E 31 30 2E 33 37 00 00 50 00 00 0C 00 0D 43  - 0.10.37..P.....C

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0050    61 63 68 65 2D 43 6F 6E 74 72 6F 6C 00 00 08 6E  - ache-Control...n

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0060    6F 2D 63 61 63 68 65 00 A0 06 00 0A 6B 65 65 70  - o-cache.....keep

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0070    2D 61 6C 69 76 65 00 A0 08 00 03 31 32 39 00 A0  - -alive.....129..

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0080    07 00 10 61 70 70 6C 69 63 61 74 69 6F 6E 2F 6A  - ...application/j

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0090    73 6F 6E 00 A0 01 00 03 2A 2F 2A 00 00 0F 41 63  - son.....*/*...Ac

[Wed Sep 10 15:22:32.686 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00a0    63 65 70 74 2D 45 6E 63 6F 64 69 6E 67 00 00 0C  - cept-Encoding...

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00b0    67 7A 69 70 2C 64 65 66 6C 61 74 65 00 00 0F 41  - gzip,deflate...A

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00c0    63 63 65 70 74 2D 4C 61 6E 67 75 61 67 65 00 00  - ccept-Language..

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00d0    1A 65 6E 2D 47 42 2C 65 6E 2D 55 53 3B 71 3D 30  - .en-GB,en-US;q=0

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00e0    2E 38 2C 65 6E 3B 71 3D 30 2E 36 00 A0 09 00 33  - .8,en;q=0.6....3

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00f0    4A 53 45 53 53 49 4F 4E 49 44 3D 46 37 32 33 46  - JSESSIONID=F723F

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0100    44 33 44 45 42 33 37 38 38 38 44 32 30 31 35 42  - D3DEB37888D2015B

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0110    45 31 30 42 30 31 38 36 38 43 37 2E 63 66 75 73  - E10B01868C7.cfus

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0120    69 6F 6E 00 A0 0B 00 0B 31 30 2E 31 30 2E 31 30  - ion.....10.10.10

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0130    2E 33 37 00 A0 0E 00 72 4D 6F 7A 69 6C 6C 61 2F  - .37....rMozilla/

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0140    35 2E 30 20 28 57 69 6E 64 6F 77 73 20 4E 54 20  - 5.0.(Windows.NT.

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0150    36 2E 31 3B 20 57 69 6E 36 34 3B 20 78 36 34 29  - 6.1;.Win64;.x64)

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0160    20 41 70 70 6C 65 57 65 62 4B 69 74 2F 35 33 37  - .AppleWebKit/537

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0170    2E 33 36 20 28 4B 48 54 4D 4C 2C 20 6C 69 6B 65  - .36.(KHTML,.like

[Wed Sep 10 15:22:32.702 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0180    20 47 65 63 6B 6F 29 20 43 68 72 6F 6D 65 2F 33  - .Gecko).Chrome/3

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0190    37 2E 30 2E 32 30 36 32 2E 31 30 33 20 53 61 66  - 7.0.2062.103.Saf

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01a0    61 72 69 2F 35 33 37 2E 33 36 00 00 06 4F 72 69  - ari/537.36...Ori

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01b0    67 69 6E 00 00 33 63 68 72 6F 6D 65 2D 65 78 74  - gin..3chrome-ext

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01c0    65 6E 73 69 6F 6E 3A 2F 2F 66 64 6D 6D 67 69 6C  - ension://fdmmgil

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01d0    67 6E 70 6A 69 67 64 6F 6A 6F 6A 70 6A 6F 6F 6F  - gnpjigdojojpjooo

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01e0    69 64 6B 6D 63 6F 6D 63 6D 00 00 03 44 4E 54 00  - idkmcomcm...DNT.

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01f0    00 01 31 00 03 00 00 00 04 00 00 00 0E 00 11 4D  - ..1............M

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0200    69 63 72 6F 73 6F 66 74 2D 49 49 53 2F 37 2E 35  - icrosoft-IIS/7.5

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0210    00 0F 00 07 43 47 49 2F 31 2E 31 00 10 00 00 00  - ....CGI/1.1.....

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0220    11 00 00 00 05 00 0D 73 63 72 65 77 79 52 65 71  - .......screwyReq

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0230    75 65 73 74 00 0A 00 0F 41 4A 50 5F 52 45 4D 4F  - uest....AJP_REMO

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0240    54 45 5F 50 4F 52 54 00 00 05 31 31 38 37 32 00  - TE_PORT...11872.

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0250    0A 00 10 4A 4B 5F 4C 42 5F 41 43 54 49 56 41 54  - ...JK_LB_ACTIVAT

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0260    49 4F 4E 00 00 03 41 43 54 00 FF 00 00 00 00 00  - ION...ACT.......

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_send_request::jk_ajp_common.c (1733): (cfusion) request body to send 129 - request body to resend 0

[Wed Sep 10 15:22:32.717 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=14 max=65536

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    0F 00 0A 2F 69 6E 64 65 78 2E 63 66 6D 00 00 00  - .../index.cfm...

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_process_callback::jk_ajp_common.c (1934): Getting real path

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] getRealPath::jk_isapi_plugin.c (4032): getRealPath(/index.cfm) = C:\inetpub\wwwroot\index.cfm

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=33 max=34

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 00 1D 1C 43 3A 5C 69 6E 65 74 70 75 62 5C  - .4...C:\inetpub\

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    77 77 77 72 6F 6F 74 5C 69 6E 64 65 78 2E 63 66  - wwwroot\index.cf

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    6D 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - m...............

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=14 max=65536

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    0F 00 0A 2F 69 6E 64 65 78 2E 68 74 6D 00 00 00  - .../index.htm...

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_process_callback::jk_ajp_common.c (1934): Getting real path

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] getRealPath::jk_isapi_plugin.c (4032): getRealPath(/index.htm) = C:\inetpub\wwwroot\index.htm

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=33 max=34

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 00 1D 1C 43 3A 5C 69 6E 65 74 70 75 62 5C  - .4...C:\inetpub\

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    77 77 77 72 6F 6F 74 5C 69 6E 64 65 78 2E 68 74  - wwwroot\index.ht

[Wed Sep 10 15:22:32.733 2014] [2912:1016] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    6D 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - m...............

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=165 max=65536

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    04 00 C8 00 02 4F 4B 00 00 04 00 0D 43 61 63 68  - .....OK.....Cach

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0010    65 2D 43 6F 6E 74 72 6F 6C 00 00 2E 6E 6F 2D 63  - e-Control...no-c

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0020    61 63 68 65 2C 20 6E 6F 2D 73 74 6F 72 65 2C 20  - ache,.no-store,.

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0030    6D 75 73 74 2D 72 65 76 61 6C 69 64 61 74 65 2C  - must-revalidate,

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0040    20 6D 61 78 2D 61 67 65 3D 30 00 00 06 50 72 61  - .max-age=0...Pra

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0050    67 6D 61 00 00 08 6E 6F 2D 63 61 63 68 65 00 00  - gma...no-cache..

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0060    07 45 78 70 69 72 65 73 00 00 1D 54 68 75 2C 20  - .Expires...Thu,.

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0070    30 31 20 4A 61 6E 20 31 39 37 30 20 30 30 3A 30  - 01.Jan.1970.00:0

[Wed Sep 10 15:22:32.748 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0080    30 3A 30 30 20 47 4D 54 00 A0 01 00 17 74 65 78  - 0:00.GMT.....tex

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0090    74 2F 68 74 6D 6C 3B 63 68 61 72 73 65 74 3D 55  - t/html;charset=U

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00a0    54 46 2D 38 00 00 00 00 00 00 00 00 00 00 00 00  - TF-8............

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (723): status = 200

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (730): Number of headers is = 4

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[0] [Cache-Control] = [no-cache, no-store, must-revalidate, max-age=0]

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[1] [Pragma] = [no-cache]

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[2] [Expires] = [Thu, 01 Jan 1970 00:00:00 GMT]

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[3] [Content-Type] = [text/html;charset=UTF-8]

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] start_response::jk_isapi_plugin.c (1128): Starting response for URI '/index.cfm' (protocol HTTP/1.1)

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] start_response::jk_isapi_plugin.c (1237): Not using Keep-Alive

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] start_response::jk_isapi_plugin.c (1272): headers String 'Cache-Control: no-cache, no-store, must-revalidate, max-age=0

Pragma: no-cache

Expires: Thu, 01 Jan 1970 00:00:00 GMT

Content-Type: text/html;charset=UTF-8

'

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=7958 max=65536

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    03 1F 12 3C 70 3E 68 65 6C 6C 6F 3C 2F 70 3E 0D  - ...<p>hello</p>.

[Wed Sep 10 15:22:32.764 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0010    0A 0D 0A 3C 73 74 79 6C 65 3E 0D 0A 0D 0A 0A 09  - ...<style>......

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0020    74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 77 64 64  - table.cfdump_wdd

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0030    78 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - x,..table.cfdump

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0040    5F 78 6D 6C 2C 0A 09 74 61 62 6C 65 2E 63 66 64  - _xml,..table.cfd

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0050    75 6D 70 5F 73 74 72 75 63 74 2C 0A 09 74 61 62  - ump_struct,..tab

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0060    6C 65 2E 63 66 64 75 6D 70 5F 76 61 72 75 6E 64  - le.cfdump_varund

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0070    65 66 69 6E 65 64 2C 0A 09 74 61 62 6C 65 2E 63  - efined,..table.c

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0080    66 64 75 6D 70 5F 61 72 72 61 79 2C 0A 09 74 61  - fdump_array,..ta

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0090    62 6C 65 2E 63 66 64 75 6D 70 5F 71 75 65 72 79  - ble.cfdump_query

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00a0    2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F  - ,..table.cfdump_

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00b0    63 66 63 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75  - cfc,..table.cfdu

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00c0    6D 70 5F 6F 62 6A 65 63 74 2C 0A 09 74 61 62 6C  - mp_object,..tabl

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00d0    65 2E 63 66 64 75 6D 70 5F 62 69 6E 61 72 79 2C  - e.cfdump_binary,

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00e0    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00f0    64 66 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D  - df,..table.cfdum

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0100    70 5F 75 64 66 62 6F 64 79 2C 0A 09 74 61 62 6C  - p_udfbody,..tabl

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0110    65 2E 63 66 64 75 6D 70 5F 75 64 66 61 72 67 75  - e.cfdump_udfargu

[Wed Sep 10 15:22:32.780 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0120    6D 65 6E 74 73 20 7B 0A 09 09 66 6F 6E 74 2D 73  - ments.{...font-s

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0130    69 7A 65 3A 20 78 78 2D 73 6D 61 6C 6C 3B 0A 09  - ize:.xx-small;..

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0140    09 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 20 76 65  - .font-family:.ve

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0150    72 64 61 6E 61 2C 20 61 72 69 61 6C 2C 20 68 65  - rdana,.arial,.he

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0160    6C 76 65 74 69 63 61 2C 20 73 61 6E 73 2D 73 65  - lvetica,.sans-se

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0170    72 69 66 3B 0A 09 09 63 65 6C 6C 2D 73 70 61 63  - rif;...cell-spac

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0180    69 6E 67 3A 20 32 70 78 3B 0A 09 7D 0A 0A 09 74  - ing:.2px;..}...t

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0190    61 62 6C 65 2E 63 66 64 75 6D 70 5F 77 64 64 78  - able.cfdump_wddx

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01a0    20 74 68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75  - .th,..table.cfdu

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01b0    6D 70 5F 78 6D 6C 20 74 68 2C 0A 09 74 61 62 6C  - mp_xml.th,..tabl

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01c0    65 2E 63 66 64 75 6D 70 5F 73 74 72 75 63 74 20  - e.cfdump_struct.

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01d0    74 68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D  - th,..table.cfdum

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01e0    70 5F 76 61 72 75 6E 64 65 66 69 6E 65 64 20 74  - p_varundefined.t

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01f0    68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - h,..table.cfdump

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0200    5F 61 72 72 61 79 20 74 68 2C 0A 09 74 61 62 6C  - _array.th,..tabl

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0210    65 2E 63 66 64 75 6D 70 5F 71 75 65 72 79 20 74  - e.cfdump_query.t

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0220    68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - h,..table.cfdump

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0230    5F 63 66 63 20 74 68 2C 0A 09 74 61 62 6C 65 2E  - _cfc.th,..table.

[Wed Sep 10 15:22:32.795 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0240    63 66 64 75 6D 70 5F 6F 62 6A 65 63 74 20 74 68  - cfdump_object.th

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0250    2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F  - ,..table.cfdump_

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0260    62 69 6E 61 72 79 20 74 68 2C 0A 09 74 61 62 6C  - binary.th,..tabl

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0270    65 2E 63 66 64 75 6D 70 5F 75 64 66 20 74 68 2C  - e.cfdump_udf.th,

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0280    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0290    64 66 62 6F 64 79 20 74 68 2C 0A 09 74 61 62 6C  - dfbody.th,..tabl

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02a0    65 2E 63 66 64 75 6D 70 5F 75 64 66 61 72 67 75  - e.cfdump_udfargu

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02b0    6D 65 6E 74 73 20 74 68 20 7B 0A 09 09 74 65 78  - ments.th.{...tex

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02c0    74 2D 61 6C 69 67 6E 3A 20 6C 65 66 74 3B 0A 09  - t-align:.left;..

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02d0    09 63 6F 6C 6F 72 3A 20 77 68 69 74 65 3B 0A 09  - .color:.white;..

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02e0    09 70 61 64 64 69 6E 67 3A 20 35 70 78 3B 0A 09  - .padding:.5px;..

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02f0    7D 0A 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - }...table.cfdump

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0300    5F 77 64 64 78 20 74 64 2C 0A 09 74 61 62 6C 65  - _wddx.td,..table

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0310    2E 63 66 64 75 6D 70 5F 78 6D 6C 20 74 64 2C 0A  - .cfdump_xml.td,.

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0320    09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 73 74  - .table.cfdump_st

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0330    72 75 63 74 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - ruct.td,..table.

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0340    63 66 64 75 6D 70 5F 76 61 72 75 6E 64 65 66 69  - cfdump_varundefi

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0350    6E 65 64 20 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - ned..td,..table.

[Wed Sep 10 15:22:32.811 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0360    63 66 64 75 6D 70 5F 61 72 72 61 79 20 74 64 2C  - cfdump_array.td,

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0370    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 71  - ..table.cfdump_q

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0380    75 65 72 79 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - uery.td,..table.

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0390    63 66 64 75 6D 70 5F 63 66 63 20 74 64 2C 0A 09  - cfdump_cfc.td,..

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03a0    74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 6F 62 6A  - table.cfdump_obj

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03b0    65 63 74 20 74 64 2C 0A 09 74 61 62 6C 65 2E 63  - ect.td,..table.c

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03c0    66 64 75 6D 70 5F 62 69 6E 61 72 79 20 74 64 2C  - fdump_binary.td,

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03d0    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03e0    64 66 20 74 64 2C 0A 09 74 61 62 6C 65 2E 63 66  - df.td,..table.cf

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03f0    64 75 6D 70 5F 75 64 66 62 6F 64 79 20 74 64 2C  - dump_udfbody.td,

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] isapi_write_client::jk_isapi_plugin.c (1391): Writing 7954 bytes of data to client

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] isapi_write_client::jk_isapi_plugin.c (1392): IIS7 flush enabled 0

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] isapi_write_client::jk_isapi_plugin.c (1393): writeclient write_length value 7954

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] isapi_write_client::jk_isapi_plugin.c (1413): Wrote 7954 bytes of data successfully

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=4 max=65536

[Wed Sep 10 15:22:32.827 2014] [2912:1016] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    03 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - ................

<!--- GOOD REQUEST BELOW --->

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] handle_notify_event::jk_isapi_plugin.c (2184): Filter started

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] uri_worker_map_update::jk_uri_worker_map.c (1265): File C:\ColdFusion11\config\wsconfig\1\uriworkermap.properties is not modified

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] map_uri_to_worker_ext::jk_uri_worker_map.c (1131): Attempting to map URI '/10.10.10.37/' from 30 maps

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flashservices/gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfform-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cffileservlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfformgateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.064 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFileServlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.080 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.080 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFormGateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.080 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.080 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/rest/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.hbmxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.126 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfswf=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.mxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFML=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFC=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.swc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFM=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfr=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.142 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.sws=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.jsp=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.as=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flashservices/gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfform-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cffileservlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfformgateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFileServlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFormGateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.158 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/rest/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.hbmxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfswf=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.mxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFML=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFC=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.swc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFM=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfr=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.sws=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.173 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.jsp=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.as=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] handle_notify_event::jk_isapi_plugin.c (2409): [/] is not a servlet url

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] wc_maintain::jk_worker.c (338): Maintaining worker cfusion

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3516): Reading extension header HTTP_TOMCATWORKER000000006A6B0000: (null)

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3517): Reading extension header HTTP_TOMCATWORKERIDX000000006A6B0000: -1

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3518): Reading extension header HTTP_TOMCATURI000000006A6B0000: (null)

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3519): Reading extension header HTTP_TOMCATQUERY000000006A6B0000: (null)

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3524): No URI header value provided. Defaulting to old behaviour

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3588): query_string value:

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] map_uri_to_worker_ext::jk_uri_worker_map.c (1131): Attempting to map URI '/index.cfm' from 30 maps

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flashservices/gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfform-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cffileservlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/cfformgateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFileServlet/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex-internal/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.189 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/CFFormGateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/rest/*=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/flex2gateway=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.hbmxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfswf=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.mxml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFML=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfml=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFC=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.swc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.CFM=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.205 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfr=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.Cfc=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.sws=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.jsp=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (945): Attempting to map context URI '/*.cfm=cfusion' source 'uriworkermap'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] find_match::jk_uri_worker_map.c (958): Found a wildchar match '/*.cfm=cfusion'

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3702): Applying service extensions

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Cache-Control : no-cache

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Connection : keep-alive

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Pragma : no-cache

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Content-Length : 0

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept : text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept-Encoding : gzip, deflate

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Accept-Language : en-gb,en;q=0.5

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header Host : 10.10.10.37

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header User-Agent : Mozilla/5.0 (Windows NT 6.1; WOW64; rv:31.0) Gecko/20100101 Firefox/31.0

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3944): Forwarding request header DNT : 1

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3973): Service protocol=HTTP/1.1 method=GET host=10.10.10.11 addr=10.10.10.11 name=10.10.10.37 port=80 auth= user= uri=/index.cfm

[Wed Sep 10 15:42:22.220 2014] [2912:2664] [debug] init_ws_service::jk_isapi_plugin.c (3985): Service request headers=10 attributes=0 chunked=no content-length=0 available=0

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] wc_get_worker_for_name::jk_worker.c (115): found a worker cfusion

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] HttpExtensionProc::jk_isapi_plugin.c (2582): got a worker for name cfusion

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_get_endpoint::jk_ajp_common.c (3287): acquired connection pool slot=3 after 0 retries

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_marshal_into_msgb::jk_ajp_common.c (668): ajp marshaling done

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_service::jk_ajp_common.c (2569): processing cfusion with 2 retries

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_send_request::jk_ajp_common.c (1673): (cfusion) all endpoints are disconnected.

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] jk_open_socket::jk_connect.c (485): socket TCP_NODELAY set to On

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] jk_open_socket::jk_connect.c (609): trying to connect socket 772 to 127.0.0.1:8014

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] jk_open_socket::jk_connect.c (635): socket 772 [127.0.0.1:49436 -> 127.0.0.1:8014] connected

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=494 max=65536

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 01 EA 02 02 00 08 48 54 54 50 2F 31 2E 31  - .4......HTTP/1.1

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    00 00 0A 2F 69 6E 64 65 78 2E 63 66 6D 00 00 0B  - .../index.cfm...

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    31 30 2E 31 30 2E 31 30 2E 31 31 00 00 0B 31 30  - 10.10.10.11...10

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0030    2E 31 30 2E 31 30 2E 31 31 00 00 0B 31 30 2E 31  - .10.10.11...10.1

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0040    30 2E 31 30 2E 33 37 00 00 50 00 00 0A 00 0D 43  - 0.10.37..P.....C

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0050    61 63 68 65 2D 43 6F 6E 74 72 6F 6C 00 00 08 6E  - ache-Control...n

[Wed Sep 10 15:42:22.236 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0060    6F 2D 63 61 63 68 65 00 A0 06 00 0A 6B 65 65 70  - o-cache.....keep

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0070    2D 61 6C 69 76 65 00 A0 0C 00 08 6E 6F 2D 63 61  - -alive.....no-ca

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0080    63 68 65 00 A0 08 00 01 30 00 A0 01 00 3F 74 65  - che.....0....?te

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0090    78 74 2F 68 74 6D 6C 2C 61 70 70 6C 69 63 61 74  - xt/html,applicat

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00a0    69 6F 6E 2F 78 68 74 6D 6C 2B 78 6D 6C 2C 61 70  - ion/xhtml+xml,ap

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00b0    70 6C 69 63 61 74 69 6F 6E 2F 78 6D 6C 3B 71 3D  - plication/xml;q=

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00c0    30 2E 39 2C 2A 2F 2A 3B 71 3D 30 2E 38 00 00 0F  - 0.9,*/*;q=0.8...

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00d0    41 63 63 65 70 74 2D 45 6E 63 6F 64 69 6E 67 00  - Accept-Encoding.

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00e0    00 0D 67 7A 69 70 2C 20 64 65 66 6C 61 74 65 00  - ..gzip,.deflate.

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 00f0    00 0F 41 63 63 65 70 74 2D 4C 61 6E 67 75 61 67  - ..Accept-Languag

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0100    65 00 00 0E 65 6E 2D 67 62 2C 65 6E 3B 71 3D 30  - e...en-gb,en;q=0

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0110    2E 35 00 A0 0B 00 0B 31 30 2E 31 30 2E 31 30 2E  - .5.....10.10.10.

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0120    33 37 00 A0 0E 00 48 4D 6F 7A 69 6C 6C 61 2F 35  - 37....HMozilla/5

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0130    2E 30 20 28 57 69 6E 64 6F 77 73 20 4E 54 20 36  - .0.(Windows.NT.6

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0140    2E 31 3B 20 57 4F 57 36 34 3B 20 72 76 3A 33 31  - .1;.WOW64;.rv:31

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0150    2E 30 29 20 47 65 63 6B 6F 2F 32 30 31 30 30 31  - .0).Gecko/201001

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0160    30 31 20 46 69 72 65 66 6F 78 2F 33 31 2E 30 00  - 01.Firefox/31.0.

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0170    00 03 44 4E 54 00 00 01 31 00 03 00 00 00 04 00  - ..DNT...1.......

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0180    00 00 0E 00 11 4D 69 63 72 6F 73 6F 66 74 2D 49  - .....Microsoft-I

[Wed Sep 10 15:42:22.251 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0190    49 53 2F 37 2E 35 00 0F 00 07 43 47 49 2F 31 2E  - IS/7.5....CGI/1.

[Wed Sep 10 15:42:22.267 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01a0    31 00 10 00 0A 2F 69 6E 64 65 78 2E 63 66 6D 00  - 1..../index.cfm.

[Wed Sep 10 15:42:22.267 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01b0    11 00 00 00 05 00 00 00 0A 00 0F 41 4A 50 5F 52  - ...........AJP_R

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01c0    45 4D 4F 54 45 5F 50 4F 52 54 00 00 05 31 32 33  - EMOTE_PORT...123

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01d0    38 33 00 0A 00 10 4A 4B 5F 4C 42 5F 41 43 54 49  - 83....JK_LB_ACTI

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 01e0    56 41 54 49 4F 4E 00 00 03 41 43 54 00 FF 00 00  - VATION...ACT....

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_send_request::jk_ajp_common.c (1733): (cfusion) request body to send 0 - request body to resend 0

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=14 max=65536

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    0F 00 0A 2F 69 6E 64 65 78 2E 63 66 6D 00 00 00  - .../index.cfm...

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_process_callback::jk_ajp_common.c (1934): Getting real path

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] getRealPath::jk_isapi_plugin.c (4032): getRealPath(/index.cfm) = C:\inetpub\wwwroot\index.cfm

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=33 max=34

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 00 1D 1C 43 3A 5C 69 6E 65 74 70 75 62 5C  - .4...C:\inetpub\

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    77 77 77 72 6F 6F 74 5C 69 6E 64 65 78 2E 63 66  - wwwroot\index.cf

[Wed Sep 10 15:42:22.283 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    6D 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - m...............

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=14 max=65536

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    0F 00 0A 2F 69 6E 64 65 78 2E 68 74 6D 00 00 00  - .../index.htm...

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_process_callback::jk_ajp_common.c (1934): Getting real path

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] getRealPath::jk_isapi_plugin.c (4032): getRealPath(/index.htm) = C:\inetpub\wwwroot\index.htm

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): sending to ajp13 pos=4 len=33 max=34

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0000    12 34 00 1D 1C 43 3A 5C 69 6E 65 74 70 75 62 5C  - .4...C:\inetpub\

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0010    77 77 77 72 6F 6F 74 5C 69 6E 64 65 78 2E 68 74  - wwwroot\index.ht

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_send_message::jk_ajp_common.c (1233): 0020    6D 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - m...............

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=239 max=65536

[Wed Sep 10 15:42:22.298 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    04 00 C8 00 02 4F 4B 00 00 05 A0 07 00 45 4A 53  - .....OK......EJS

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0010    45 53 53 49 4F 4E 49 44 3D 38 33 41 34 37 46 38  - ESSIONID=83A47F8

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0020    35 38 43 41 41 39 45 35 45 31 38 46 41 44 46 33  - 58CAA9E5E18FADF3

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0030    38 31 43 31 36 46 43 35 44 2E 63 66 75 73 69 6F  - 81C16FC5D.cfusio

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0040    6E 3B 20 50 61 74 68 3D 2F 3B 20 48 74 74 70 4F  - n;.Path=/;.HttpO

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0050    6E 6C 79 00 00 0D 43 61 63 68 65 2D 43 6F 6E 74  - nly...Cache-Cont

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0060    72 6F 6C 00 00 2E 6E 6F 2D 63 61 63 68 65 2C 20  - rol...no-cache,.

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0070    6E 6F 2D 73 74 6F 72 65 2C 20 6D 75 73 74 2D 72  - no-store,.must-r

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0080    65 76 61 6C 69 64 61 74 65 2C 20 6D 61 78 2D 61  - evalidate,.max-a

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0090    67 65 3D 30 00 00 06 50 72 61 67 6D 61 00 00 08  - ge=0...Pragma...

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00a0    6E 6F 2D 63 61 63 68 65 00 00 07 45 78 70 69 72  - no-cache...Expir

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00b0    65 73 00 00 1D 54 68 75 2C 20 30 31 20 4A 61 6E  - es...Thu,.01.Jan

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00c0    20 31 39 37 30 20 30 30 3A 30 30 3A 30 30 20 47  - .1970.00:00:00.G

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00d0    4D 54 00 A0 01 00 17 74 65 78 74 2F 68 74 6D 6C  - MT.....text/html

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00e0    3B 63 68 61 72 73 65 74 3D 55 54 46 2D 38 00 00  - ;charset=UTF-8..

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (723): status = 200

[Wed Sep 10 15:42:22.314 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (730): Number of headers is = 5

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[0] [Set-Cookie] = [JSESSIONID=83A47F858CAA9E5E18FADF381C16FC5D.cfusion; Path=/; HttpOnly]

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[1] [Cache-Control] = [no-cache, no-store, must-revalidate, max-age=0]

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[2] [Pragma] = [no-cache]

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[3] [Expires] = [Thu, 01 Jan 1970 00:00:00 GMT]

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_unmarshal_response::jk_ajp_common.c (786): Header[4] [Content-Type] = [text/html;charset=UTF-8]

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] start_response::jk_isapi_plugin.c (1128): Starting response for URI '/index.cfm' (protocol HTTP/1.1)

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] start_response::jk_isapi_plugin.c (1237): Not using Keep-Alive

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] start_response::jk_isapi_plugin.c (1272): headers String 'Set-Cookie: JSESSIONID=83A47F858CAA9E5E18FADF381C16FC5D.cfusion; Path=/; HttpOnly

Cache-Control: no-cache, no-store, must-revalidate, max-age=0

Pragma: no-cache

Expires: Thu, 01 Jan 1970 00:00:00 GMT

Content-Type: text/html;charset=UTF-8

'

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=7958 max=65536

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    03 1F 12 3C 70 3E 68 65 6C 6C 6F 3C 2F 70 3E 0D  - ...<p>hello</p>.

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0010    0A 0D 0A 3C 73 74 79 6C 65 3E 0D 0A 0D 0A 0A 09  - ...<style>......

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0020    74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 77 64 64  - table.cfdump_wdd

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0030    78 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - x,..table.cfdump

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0040    5F 78 6D 6C 2C 0A 09 74 61 62 6C 65 2E 63 66 64  - _xml,..table.cfd

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0050    75 6D 70 5F 73 74 72 75 63 74 2C 0A 09 74 61 62  - ump_struct,..tab

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0060    6C 65 2E 63 66 64 75 6D 70 5F 76 61 72 75 6E 64  - le.cfdump_varund

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0070    65 66 69 6E 65 64 2C 0A 09 74 61 62 6C 65 2E 63  - efined,..table.c

[Wed Sep 10 15:42:22.330 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0080    66 64 75 6D 70 5F 61 72 72 61 79 2C 0A 09 74 61  - fdump_array,..ta

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0090    62 6C 65 2E 63 66 64 75 6D 70 5F 71 75 65 72 79  - ble.cfdump_query

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00a0    2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F  - ,..table.cfdump_

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00b0    63 66 63 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75  - cfc,..table.cfdu

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00c0    6D 70 5F 6F 62 6A 65 63 74 2C 0A 09 74 61 62 6C  - mp_object,..tabl

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00d0    65 2E 63 66 64 75 6D 70 5F 62 69 6E 61 72 79 2C  - e.cfdump_binary,

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00e0    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 00f0    64 66 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D  - df,..table.cfdum

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0100    70 5F 75 64 66 62 6F 64 79 2C 0A 09 74 61 62 6C  - p_udfbody,..tabl

[Wed Sep 10 15:42:22.392 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0110    65 2E 63 66 64 75 6D 70 5F 75 64 66 61 72 67 75  - e.cfdump_udfargu

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0120    6D 65 6E 74 73 20 7B 0A 09 09 66 6F 6E 74 2D 73  - ments.{...font-s

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0130    69 7A 65 3A 20 78 78 2D 73 6D 61 6C 6C 3B 0A 09  - ize:.xx-small;..

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0140    09 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 20 76 65  - .font-family:.ve

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0150    72 64 61 6E 61 2C 20 61 72 69 61 6C 2C 20 68 65  - rdana,.arial,.he

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0160    6C 76 65 74 69 63 61 2C 20 73 61 6E 73 2D 73 65  - lvetica,.sans-se

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0170    72 69 66 3B 0A 09 09 63 65 6C 6C 2D 73 70 61 63  - rif;...cell-spac

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0180    69 6E 67 3A 20 32 70 78 3B 0A 09 7D 0A 0A 09 74  - ing:.2px;..}...t

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0190    61 62 6C 65 2E 63 66 64 75 6D 70 5F 77 64 64 78  - able.cfdump_wddx

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01a0    20 74 68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75  - .th,..table.cfdu

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01b0    6D 70 5F 78 6D 6C 20 74 68 2C 0A 09 74 61 62 6C  - mp_xml.th,..tabl

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01c0    65 2E 63 66 64 75 6D 70 5F 73 74 72 75 63 74 20  - e.cfdump_struct.

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01d0    74 68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D  - th,..table.cfdum

[Wed Sep 10 15:42:22.408 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01e0    70 5F 76 61 72 75 6E 64 65 66 69 6E 65 64 20 74  - p_varundefined.t

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 01f0    68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - h,..table.cfdump

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0200    5F 61 72 72 61 79 20 74 68 2C 0A 09 74 61 62 6C  - _array.th,..tabl

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0210    65 2E 63 66 64 75 6D 70 5F 71 75 65 72 79 20 74  - e.cfdump_query.t

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0220    68 2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - h,..table.cfdump

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0230    5F 63 66 63 20 74 68 2C 0A 09 74 61 62 6C 65 2E  - _cfc.th,..table.

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0240    63 66 64 75 6D 70 5F 6F 62 6A 65 63 74 20 74 68  - cfdump_object.th

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0250    2C 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F  - ,..table.cfdump_

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0260    62 69 6E 61 72 79 20 74 68 2C 0A 09 74 61 62 6C  - binary.th,..tabl

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0270    65 2E 63 66 64 75 6D 70 5F 75 64 66 20 74 68 2C  - e.cfdump_udf.th,

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0280    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0290    64 66 62 6F 64 79 20 74 68 2C 0A 09 74 61 62 6C  - dfbody.th,..tabl

[Wed Sep 10 15:42:22.423 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02a0    65 2E 63 66 64 75 6D 70 5F 75 64 66 61 72 67 75  - e.cfdump_udfargu

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02b0    6D 65 6E 74 73 20 74 68 20 7B 0A 09 09 74 65 78  - ments.th.{...tex

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02c0    74 2D 61 6C 69 67 6E 3A 20 6C 65 66 74 3B 0A 09  - t-align:.left;..

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02d0    09 63 6F 6C 6F 72 3A 20 77 68 69 74 65 3B 0A 09  - .color:.white;..

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02e0    09 70 61 64 64 69 6E 67 3A 20 35 70 78 3B 0A 09  - .padding:.5px;..

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 02f0    7D 0A 0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70  - }...table.cfdump

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0300    5F 77 64 64 78 20 74 64 2C 0A 09 74 61 62 6C 65  - _wddx.td,..table

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0310    2E 63 66 64 75 6D 70 5F 78 6D 6C 20 74 64 2C 0A  - .cfdump_xml.td,.

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0320    09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 73 74  - .table.cfdump_st

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0330    72 75 63 74 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - ruct.td,..table.

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0340    63 66 64 75 6D 70 5F 76 61 72 75 6E 64 65 66 69  - cfdump_varundefi

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0350    6E 65 64 20 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - ned..td,..table.

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0360    63 66 64 75 6D 70 5F 61 72 72 61 79 20 74 64 2C  - cfdump_array.td,

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0370    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 71  - ..table.cfdump_q

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0380    75 65 72 79 20 74 64 2C 0A 09 74 61 62 6C 65 2E  - uery.td,..table.

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0390    63 66 64 75 6D 70 5F 63 66 63 20 74 64 2C 0A 09  - cfdump_cfc.td,..

[Wed Sep 10 15:42:22.439 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03a0    74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 6F 62 6A  - table.cfdump_obj

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03b0    65 63 74 20 74 64 2C 0A 09 74 61 62 6C 65 2E 63  - ect.td,..table.c

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03c0    66 64 75 6D 70 5F 62 69 6E 61 72 79 20 74 64 2C  - fdump_binary.td,

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03d0    0A 09 74 61 62 6C 65 2E 63 66 64 75 6D 70 5F 75  - ..table.cfdump_u

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03e0    64 66 20 74 64 2C 0A 09 74 61 62 6C 65 2E 63 66  - df.td,..table.cf

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 03f0    64 75 6D 70 5F 75 64 66 62 6F 64 79 20 74 64 2C  - dump_udfbody.td,

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] isapi_write_client::jk_isapi_plugin.c (1391): Writing 7954 bytes of data to client

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] isapi_write_client::jk_isapi_plugin.c (1392): IIS7 flush enabled 0

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] isapi_write_client::jk_isapi_plugin.c (1393): writeclient write_length value 7954

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] isapi_write_client::jk_isapi_plugin.c (1413): Wrote 7954 bytes of data successfully

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=4 max=65536

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    03 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - ................

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): received from ajp13 pos=0 len=2 max=65536

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_connection_tcp_get_message::jk_ajp_common.c (1428): 0000    05 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00  - ................

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [info] ajp_process_callback::jk_ajp_common.c (2101): current reuse count is 2 of max reuse connection 250 and total endpoint count 250

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] ajp_process_callback::jk_ajp_common.c (2105): AJP13 protocol: Reuse is OK, and current reuse count is 2

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] iis_done::jk_isapi_plugin.c (1700): Finally done with writing.

[Wed Sep 10 15:42:22.455 2014] [2912:2664] [debug] HttpExtensionProc::jk_isapi_plugin.c (2602): service() returned OK

[Wed Sep 10 15:42:22.470 2014] [2912:2664] [debug] ajp_reset_endpoint::jk_ajp_common.c (828): (cfusion) resetting endpoint with socket 772

[Wed Sep 10 15:42:22.470 2014] [2912:2664] [debug] ajp_done::jk_ajp_common.c (3218): recycling connection pool for worker cfusion and socket 772

Views

1.2K

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Community Expert ,
Sep 12, 2014 Sep 12, 2014

Copy link to clipboard

Copied

chopki wrote:

Issue Description

Simply put .. we make a request to any .cfm page with content-type of application/json and json in the request body

That might just be the problem. Coldfusion may be ignorant of the file-extension that corresponds to the content-type application/json. Why don't you use a content-type of text/html or text/plain, or else a content-disposition header that specifies the file-extension as .json?

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
New Here ,
Sep 12, 2014 Sep 12, 2014

Copy link to clipboard

Copied

TBH its all slightly over my head as to what bit of the server software does what but surely that's IIS's job and if its got to Coldfusion then that couldn't be the issue as its already decided that its a .cfm and sent the request to coldfusion and coldfusion has sent some data back?

The real world issue that prompted this was a callback from a payment provider and I am sure they are not going to change their API just for me, plus this is a really simple thing that shouldn't be an issue - rock on CF9 for just bloody working.

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Community Expert ,
Sep 12, 2014 Sep 12, 2014

Copy link to clipboard

Copied

Chris_Hopkins wrote:

TBH its all slightly over my head as to what bit of the server software does what but surely that's IIS's job and if its got to Coldfusion then that couldn't be the issue as its already decided that its a .cfm and sent the request to coldfusion and coldfusion has sent some data back?

That is what I think too: the web server sends the CFM to Coldfusion, which runs it and sends the result back to the web server, all as expected. The web server then has to decide whether to send the result to the browser or delegate some other application to process it.

I suspect this is where something goes wrong. I wonder whether the result which Coldfusion sends the web server confuses it.

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
New Here ,
Sep 12, 2014 Sep 12, 2014

Copy link to clipboard

Copied

If you had any ideas on how to debug that interaction it would be very helpful as i dont really know how to dig into IIS any further

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Community Expert ,
Sep 14, 2014 Sep 14, 2014

Copy link to clipboard

Copied

I may not be on IIS, but I am willing to help. You said, "for some reason it looks like its looking up the index.cfm and index.html (which is odd)". This raises 2 questions, which may be related. Firstly, why do you find it odd? Secondly, what is the URL of the CFM page of the request?

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Community Expert ,
Sep 14, 2014 Sep 14, 2014

Copy link to clipboard

Copied

You say it works in Coldfusion 9. Could you please tell us more about the comparable environment in which you use Coldfusion 9? Particularly, the web server and browser / testing tool.

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Community Expert ,
Sep 14, 2014 Sep 14, 2014

Copy link to clipboard

Copied

Two more points stand out from the log:

1) The description of the bad request contains "header Content-Type : application/json" and "header User-Agent : Mozilla/5.0 (Windows NT 6.1; Win64; x64)". The compatibility with Internet Explorer might be an issue.

To test, I ran the following code, as the file testing123.cfm.

<cfheader name="Content-Disposition" value="inline">

<cfcontent type="application/json">

<cfquery name="myQuery" datasource="myDSN">

select id, qty

from myTbl

</cfquery>

<cfoutput>#serializeJson(myQuery)#</cfoutput>

It outputs a JSON. However, while Chrome and Firefox display the content of the page, which is the intention, Internet Explorer insists on offering the file for download as testing123.json. This might be a hint. Is it possible for you to specify the header 'Content-Type : text/plain' or 'Content-Type : text/html' in the test browser / tool?

2) The logs contain the text "table.cfdump_wddx,table.cfdump_xml,table.cfdump_struct, etc.", which looks eerily like like the page output associated with a known bug. The bug was in Coldfusion 9 and occurs when cfdump is used with a file-path as output and format set.... Given that you use version 9, does this ring any bells? I should hurry to add that that bug was later fixed. (I have tested Coldfusion 11's cfdump quite a bit to confirm).

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
New Here ,
Sep 14, 2014 Sep 14, 2014

Copy link to clipboard

Copied

LATEST

I may not be on IIS, but I am willing to help. You said, "for some reason it looks like its looking up the index.cfm and index.html (which is odd)". This raises 2 questions, which may be related. Firstly, why do you find it odd? Secondly, what is the URL of the CFM page of the request?

The URL i was calling would be index.cfm ( i think it shows this in the log "uri=/index.cfm"). It is odd that it returns both the html for index.cfm and index.htm as it knows which file i have called and should not need to lookup both (it does not behave this way for the second request). In reference to this i did make sure that index.cfm was the only default document in IIS just in case it got confused somehow.

BKBK wrote:

You say it works in Coldfusion 9. Could you please tell us more about the comparable environment in which you use Coldfusion 9? Particularly, the web server and browser / testing tool.

This has worked in all CF9 environments we have had, but the one i had to hand was win7 + IIS7.5. To test this i have been using the google chrome postman extension, Teleric fiddler and i also wrote a quick script to make 100% sure the tools were not borked. The script is here Bug#3822607 - HTTP Post of JSON does not return a response with IIS webserver (submitted by another member of the team).

BKBK wrote:

Two more points stand out from the log:

1) The description of the bad request contains "header Content-Type : application/json" and "header User-Agent : Mozilla/5.0 (Windows NT 6.1; Win64; x64)". The compatibility with Internet Explorer might be an issue.

To test, I ran the following code, as the file testing123.cfm.

<cfheader name="Content-Disposition" value="inline">

<cfcontent type="application/json">

<cfquery name="myQuery" datasource="myDSN">

select id, qty

from myTbl

</cfquery>

<cfoutput>#serializeJson(myQuery)#</cfoutput>

It outputs a JSON. However, while Chrome and Firefox display the content of the page, which is the intention, Internet Explorer insists on offering the file for download as testing123.json. This might be a hint. Is it possible for you to specify the header 'Content-Type : text/plain' or 'Content-Type : text/html' in the test browser / tool?

2) The logs contain the text "table.cfdump_wddx,table.cfdump_xml,table.cfdump_struct, etc.", which looks eerily like like the page output associated with a known bug. The bug was in Coldfusion 9 and occurs when cfdump is used with a file-path as output and format set.... Given that you use version 9, does this ring any bells? I should hurry to add that that bug was later fixed. (I have tested Coldfusion 11's cfdump quite a bit to confirm).

1) I have only tried in chrome TBH as i am pretty certain the issue lies within or beyond IIS as the request never really makes it back to the browser and when using the CF script the browser should never be involved, BUT it is a straw to clutch so i will definitely try every browser i can find tomorrow to make sure.

2) This is not something i have ever encountered before, but certainly worth looking into. I had presumed that was all just part of the cf debug output cruft you get normally but i should probably try and render the output and see what i get - might give a clue.

ALSO

Some more information about the bug that makes it even odder:

  • If you post application/json content type without anything in the body of the request it works fine
  • If you post anything - even just {} or a single key pair it breaks
  • If you post to a html / asp / php with the same body that breaks the CF it works fine

Votes

Translate

Translate

Report

Report
Community guidelines
Be kind and respectful, give credit to the original source of content, and search for duplicates before posting. Learn more
community guidelines
Resources
Documentation