ERROR: 503 - Service Unavailable in both 2.5M1 & M2 during scan

  • Platform information:

  • Raspberry Pi 3 b+

  • Openhabian

  • openjdk version “1.8.0_212”

  • OpenJDK Runtime Environment (Zulu8.38.0.163-CA-linux_aarch32hf) (build 1.8.0_212-b163)

  • OpenJDK Client VM (Zulu8.38.0.163-CA-linux_aarch32hf) (build 25.212-b163, mixed mode, Evaluation)

  • Openhab 2.5M2

After updating to either snapshot most things seem to run fine, but I am unable to start any type of discovery scan. If I go to the inbox via. PaperUI and select a type, it’ll show “ERROR: 503 - Service Unavailable” in the corner. I’ve already attempted the usual workaround of clearing the cache, but no change. If I downgrade to 2.4 it works fine again.

Everything aside from Rules and a single item to handle WoL is configured in PaperUI.

I believe this is the result of the attempt to initiate a discovery scan


2019-09-04 14:30:29.148 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=//192.168.1.226:8080/rest/discovery,age=4} onContentComplete
2019-09-04 14:30:29.151 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=//192.168.1.226:8080/rest/discovery,age=6} onRequestComplete
2019-09-04 14:30:29.154 [DEBUG] [org.eclipse.jetty.server.HttpInput  ] - HttpInputOverHTTP@1dcd5dd[c=0,q=0,[0]=null,s=STREAM] addContent EOF
2019-09-04 14:30:29.158 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=20/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=END,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=//192.168.1.226:8080/rest/discovery,age=13} parsed true HttpParser{s=END,0 of -1}
2019-09-04 14:30:29.162 [DEBUG] [.eclipse.jetty.server.HttpConnection] - releaseRequestBuffer HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=24/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=END,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=//192.168.1.226:8080/rest/discovery,age=17}
2019-09-04 14:30:29.164 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=//192.168.1.226:8080/rest/discovery,age=20} handle //192.168.1.226:8080/rest/discovery
2019-09-04 14:30:29.167 [DEBUG] [clipse.jetty.server.HttpChannelState] - handling HttpChannelState@17af584{s=IDLE a=NOT_ASYNC i=true r=IDLE w=false}
2019-09-04 14:30:29.169 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=DISPATCHED,uri=//192.168.1.226:8080/rest/discovery,age=25} action DISPATCH
2019-09-04 14:30:29.172 [DEBUG] [org.eclipse.jetty.server.Server     ] - REQUEST GET /rest/discovery on HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=DISPATCHED,uri=//192.168.1.226:8080/rest/discovery,age=28}
2019-09-04 14:30:29.175 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/discovery @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [20], contextID=default]}
2019-09-04 14:30:29.177 [DEBUG] [.jetty.server.handler.ContextHandler] - context=||/rest/discovery @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=com.eclipsesource.jaxrs.publisher_5.3.1.201602281253 [20], contextID=default]}
2019-09-04 14:30:29.180 [DEBUG] [org.eclipse.jetty.server.session    ] - SessionHandler.doScope
2019-09-04 14:30:29.183 [DEBUG] [org.eclipse.jetty.server.session    ] - sessionHandler=org.eclipse.jetty.server.session.SessionHandler17807041==dftMaxIdleSec=600 session=null
2019-09-04 14:30:29.191 [DEBUG] [se.jetty.server.handler.ErrorHandler] - No Error Page mapping for request(GET /rest/discovery) (using default)
2019-09-04 14:30:29.196 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - sendResponse info=null content=DirectByteBuffer@15d9113[p=0,l=351,c=32768,r=351]={<<<<html>\n<head>\n<me.../body>\n</html>\n>>>dBridgeTypeUIDs":...ridge":false},{} complete=true committing=true callback=Blocker@713307{null}
2019-09-04 14:30:29.200 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - COMMIT for /rest/discovery on HttpChannelOverHttp@e62311{r=19,c=true,c=false/false,a=DISPATCHED,uri=//192.168.1.226:8080/rest/discovery,age=55}
503 Service Unavailable HTTP/1.1
Cache-Control: must-revalidate,no-cache,no-store
Content-Type: text/html;charset=iso-8859-1


2019-09-04 14:30:29.204 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1dca0ef[PROCESSING][i=HTTP/1.1{s=503,h=2,cl=-1},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@189929f] generate: NEED_HEADER (null,[p=0,l=351,c=32768,r=351],true)@START
2019-09-04 14:30:29.208 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1dca0ef[PROCESSING][i=HTTP/1.1{s=503,h=2,cl=-1},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@189929f] generate: FLUSH ([p=0,l=184,c=8192,r=184],[p=0,l=351,c=32768,r=351],true)@COMPLETING
2019-09-04 14:30:29.213 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@1dca0ef[PROCESSING][i=HTTP/1.1{s=503,h=2,cl=-1},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@189929f] generate: DONE ([p=184,l=184,c=8192,r=0],[p=351,l=351,c=32768,r=0],true)@END
2019-09-04 14:30:29.217 [DEBUG] [org.eclipse.jetty.server.session    ] - FinalSession=null, old_session_handler=null, this=org.eclipse.jetty.server.session.SessionHandler17807041==dftMaxIdleSec=600, calling complete=true
2019-09-04 14:30:29.220 [DEBUG] [org.eclipse.jetty.server.session    ] - Complete called with session null
2019-09-04 14:30:29.223 [DEBUG] [org.eclipse.jetty.server.Server     ] - handled=true async=false committed=true on HttpChannelOverHttp@e62311{r=19,c=true,c=false/true,a=DISPATCHED,uri=//192.168.1.226:8080/rest/discovery,age=78}
2019-09-04 14:30:29.225 [DEBUG] [clipse.jetty.server.HttpChannelState] - unhandle HttpChannelState@17af584{s=DISPATCHED a=NOT_ASYNC i=true r=IDLE w=false}
2019-09-04 14:30:29.228 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=true,c=false/true,a=COMPLETING,uri=//192.168.1.226:8080/rest/discovery,age=84} action COMPLETE
2019-09-04 14:30:29.232 [DEBUG] [clipse.jetty.server.HttpChannelState] - onComplete HttpChannelState@17af584{s=COMPLETING a=NOT_ASYNC i=false r=IDLE w=false}
2019-09-04 14:30:29.234 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - COMPLETE for /rest/discovery written=351
2019-09-04 14:30:29.237 [DEBUG] [clipse.jetty.server.HttpChannelState] - recycle HttpChannelState@17af584{s=COMPLETED a=NOT_ASYNC i=false r=IDLE w=false}
2019-09-04 14:30:29.240 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0} handle exit, result COMPLETE
2019-09-04 14:30:29.244 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=31/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=START,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0} filled 0 HeapByteBuffer@ac74fc[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 503 Serv...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
2019-09-04 14:30:29.247 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=34/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=START,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0} parse HeapByteBuffer@ac74fc[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 503 Serv...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} {}
2019-09-04 14:30:29.251 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=38/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=START,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0} parsed false HttpParser{s=START,0 of -1}
2019-09-04 14:30:29.255 [DEBUG] [.eclipse.jetty.server.HttpConnection] - releaseRequestBuffer HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=-,flush=-,to=42/30000}{io=0/0,kio=0,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=START,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0}
2019-09-04 14:30:29.259 [DEBUG] [.eclipse.jetty.server.HttpConnection] - HttpConnection@1ce90fd::SocketChannelEndPoint@63b8f6{/192.168.1.100:50660<->/192.168.1.226:8080,OPEN,fill=FI,flush=-,to=1/30000}{io=1/1,kio=1,kro=1}->HttpConnection@1ce90fd[p=HttpParser{s=START,0 of -1},g=HttpGenerator@6257c7{s=START}]=>HttpChannelOverHttp@e62311{r=19,c=false,c=false/false,a=IDLE,uri=null,age=0} onFillable exit HttpChannelState@17af584{s=IDLE a=NOT_ASYNC i=true r=IDLE w=false} null
2019-09-04 14:30:29.586 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - sendResponse info=null content=DirectByteBuffer@10588bf[p=0,l=147,c=32768,r=147]={<<<event: message\nda...mStateEvent"}\n\n>>>\\",\\"oldType\\":\\"...ridge":false},{} complete=false committing=false callback=Blocker@139b115{null}
2019-09-04 14:30:29.589 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ce07fe[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@532880] generate: FLUSH (null,[p=0,l=147,c=32768,r=147],false)@COMMITTED
2019-09-04 14:30:29.590 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@ce07fe[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@532880] generate: DONE (null,[p=147,l=147,c=32768,r=0],false)@COMMITTED

Should add that uninstalling a binding yields the same results, even installing a new binding I’ve never used before, also gives me the 503 error.