Bug #45568 Proxy credentials error is not shown in Open Support Issues section
Submitted: 17 Jun 2009 19:47 Modified: 7 Jul 2009 21:06
Reporter: Bill Weber Email Updates:
Status: Won't fix Impact on me:
None 
Category:MySQL Enterprise Monitor: Web Severity:S3 (Non-critical)
Version:2.1.0.1062 OS:Any
Assigned to: Josh Sled CPU Architecture:Any

[17 Jun 2009 19:47] Bill Weber
Description:
If using HTTP Proxy to get What's New and Open Support Issues and the Proxy Username or Proxy Password are incorrect, the correct bad credentials error is shown on the Product Release Announcements section but the Open Support Issues section still shows the generic "There is a problem..." error (see screenshot).

How to repeat:
- setup HTTP Proxy with incorrect credentials
- go to What's New tab and click "configure what's new" link
- click on "Force check now" for both Announcements and Support issues
- click save
- after a bit, refresh What's New tab
| should see the same errors as in screenshot

logs with Network set to Debug:

-----using correct password "test"-----

2009-06-17 12:29:37,330 DEBUG [em-worker-pool-thread-5:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] proxyUri: http://net-dev2.mysql.com:808
2009-06-17 12:29:37,330 DEBUG [em-worker-pool-thread-5:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] setting proxy <http://net-dev2.mysql.com:808> net-dev2.mysql.com:808 creds alien8:test
2009-06-17 12:29:37,331  INFO [http-18080-1:com.mysql.timing.accessLog.action] /UpdateHttpProxySettings.action 9 ms
2009-06-17 12:29:37,332 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] proxyUri: http://net-dev2.mysql.com:808
2009-06-17 12:29:37,332 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] setting proxy <http://net-dev2.mysql.com:808> net-dev2.mysql.com:808 creds alien8:test
2009-06-17 12:29:37,371 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] trying request for [https://support.mysql.com/rest/issue]
2009-06-17 12:29:37,426 DEBUG [em-worker-pool-thread-5:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] trying request for [http://enterprise.mysql.com/feed/monitor.xml]
2009-06-17 12:29:37,583  INFO [http-18080-3:com.mysql.timing.accessLog.action] /GlobalSettings.action 247 ms
2009-06-17 12:29:38,014 DEBUG [em-worker-pool-thread-5:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] we should be done true with status 304
2009-06-17 12:29:38,491 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] credentials request support.mysql.com:443 isProxy? false
2009-06-17 12:29:38,493 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.MemCredentialsProvider] password auth requested for support.mysql.com/10.128.23.11 [realm MySQL Support Systems] host support.mysql.com, dynamic: 2 static: 0
2009-06-17 12:29:38,493 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.MemCredentialsProvider] matched with: [null (.+[.])?mysql[.]com null test_enterprise_platinum@mysql.com cf531572288dbee6d925c2a5954ef1f7]
2009-06-17 12:29:39,508 DEBUG [em-worker-pool-thread-6:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] we should be done true with status 200
2009-06-17 12:29:42,951  INFO [http-18080-4:com.mysql.timing.accessLog.action] /WhatsNew.action 86 ms
2009-06-17 12:29:46,135  INFO [http-18080-1:com.mysql.timing.accessLog.action] /WhatsNew.action 57 ms

-----using correct password "foo"-----

2009-06-17 12:29:51,917  INFO [http-18080-4:com.mysql.timing.accessLog.action] /GlobalSettings.action 165 ms
2009-06-17 12:30:02,611  INFO [http-18080-1:com.mysql.timing.accessLog.action] /UpdateHttpProxySettings.action 22 ms
2009-06-17 12:30:02,611 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] proxyUri: http://net-dev2.mysql.com:808
2009-06-17 12:30:02,612 DEBUG [em-worker-pool-thread-2:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] Last message repeated 2 times
2009-06-17 12:30:02,612 DEBUG [em-worker-pool-thread-2:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] setting proxy <http://net-dev2.mysql.com:808> net-dev2.mysql.com:808 creds alien8:foo
2009-06-17 12:30:02,696 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] trying request for [http://enterprise.mysql.com/feed/monitor.xml]
2009-06-17 12:30:02,714 DEBUG [em-worker-pool-thread-2:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] trying request for [https://support.mysql.com/rest/issue]
2009-06-17 12:30:02,778  INFO [http-18080-3:com.mysql.timing.accessLog.action] /GlobalSettings.action 159 ms
2009-06-17 12:30:02,843 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] Last message repeated 2 times
2009-06-17 12:30:02,843 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.JerseyApacheHttp] credentials request net-dev2.mysql.com:808 isProxy? true
2009-06-17 12:30:02,844 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.MemCredentialsProvider] password auth requested for net-dev2.mysql.com/10.100.113.13 [realm CCProxy Authorization] host net-dev2.mysql.com, dynamic: 2 static: 0
2009-06-17 12:30:02,844 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.MemCredentialsProvider] matched with: [null (.+[.])?mysql[.]com null test_enterprise_platinum@mysql.com cf531572288dbee6d925c2a5954ef1f7]
2009-06-17 12:30:02,844 DEBUG [em-worker-pool-thread-2:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] jersey exception for [https://support.mysql.com/rest/issue]
com.sun.jersey.api.client.ClientHandlerException: java.io.IOException: Stream closed
	at com.sun.jersey.api.client.ClientResponse.getEntity(ClientResponse.java:269)
	at com.sun.jersey.api.client.ClientResponse.getEntity(ClientResponse.java:220)
	at com.mysql.etools.util.net.JerseyHttp$RequestResponse.<init>(JerseyHttp.java:210)
	at com.mysql.etools.util.net.JerseyHttp.doGet(JerseyHttp.java:476)
	at com.mysql.etools.util.net.JerseyHttp.get(JerseyHttp.java:288)
	at com.mysql.etools.util.net.AbstractHttpPoller.innerPoll(AbstractHttpPoller.java:236)
	at com.mysql.etools.util.net.AbstractHttpPoller.poll(AbstractHttpPoller.java:199)
	at com.mysql.etools.util.net.AbstractHttpPoller.forcePoll(AbstractHttpPoller.java:162)
	at com.mysql.etools.util.net.AbstractHttpPoller$2.run(AbstractHttpPoller.java:168)
	at com.mysql.etools.util.LogServiceTaskDecorator$LoggingRunnable.run(LogServiceTaskDecorator.java:69)
	at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.util.concurrent.FutureTask$Sync.innerRun(Unknown Source)
	at java.util.concurrent.FutureTask.run(Unknown Source)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.lang.Thread.run(Unknown Source)
Caused by: java.io.IOException: Stream closed
	at java.io.BufferedInputStream.getBufIfOpen(Unknown Source)
	at java.io.BufferedInputStream.read(Unknown Source)
	at java.io.FilterInputStream.read(Unknown Source)
	at org.apache.commons.httpclient.AutoCloseInputStream.read(AutoCloseInputStream.java:108)
	at java.io.FilterInputStream.read(Unknown Source)
	at java.io.FilterInputStream.read(Unknown Source)
	at com.sun.jersey.core.provider.AbstractMessageReaderWriterProvider.writeTo(AbstractMessageReaderWriterProvider.java:72)
	at com.sun.jersey.core.impl.provider.entity.ByteArrayProvider.readFrom(ByteArrayProvider.java:76)
	at com.sun.jersey.core.impl.provider.entity.ByteArrayProvider.readFrom(ByteArrayProvider.java:58)
	at com.sun.jersey.api.client.ClientResponse.getEntity(ClientResponse.java:259)
	... 17 more
2009-06-17 12:30:02,893 DEBUG [em-worker-pool-thread-4:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] we should be done true with status 407
2009-06-17 12:30:06,521  INFO [http-18080-4:com.mysql.timing.accessLog.action] /WhatsNew.action 57 ms
[18 Jun 2009 16:31] Enterprise Tools JIRA Robot
Bill Weber writes: 
verified by marcos
[7 Jul 2009 21:06] Enterprise Tools JIRA Robot
Josh Sled writes: 
The error messages are correct for the underlying network activity.  Looking more closely at the debug-level log output, specifically:

2009-06-17 12:30:02,844 DEBUG [em-worker-pool-thread-2:com.mysql.net.com.mysql.etools.util.net.JerseyHttp] jersey exception for [https://support.mysql.com/rest/issue]
com.sun.jersey.api.client.ClientHandlerException: java.io.IOException: Stream closed

This error occurs before any proxy-related auth credentials are checked, and is interpreted as a generic/catch-all network connectivity error, resulting in the message shown.  Presumably, if this error hadn't occurred, then the proxy-related error would have, and the related error message would have been surfaced.

See EM-3411, as well, though I'm not sure how it would be interpret this set of data any better, if/when it comes into being.