Mailinglist Archive: opensuse-buildservice (90 mails)

< Previous Next >
Re: [opensuse-buildservice] Cant access package after updating on external instance

On 03.02.2017 10:35, Adrian Schröter wrote:
On Freitag, 3. Februar 2017, 10:09:14 CET wrote Mathias Radtke:
Hi

we use a local and the official opensuse.org instance of the OBS
Our local instance has a mirror of the external instance, this is done
via a _link file.

About two hours ago I uploaded a new source on the follwoing project
https://build.opensuse.org/package/show/home:uibmz:opsi:opsi40-experimental/opsi-linux-bootimage
This should automatically be downloaded on our local instance.

However i cannot access the package in the repository. All other
packages are available and accessible.
I also cannot check out the repository via osc as it fails on the
opsi-linux.bootimage package

Server returned an error: HTTP Error 502: Proxy Error

Request:
https://obs.uib.local/source/home:uibmz:opsi:opsi40-experimental/opsi-linux-bootimage?linkrev=base&rev=latest
Headers:
x-request-id: 39fefc27-bd8d-404e-ab36-3d30476a2596
x-xss-protection: 1; mode=block
x-content-type-options: nosniff
x-powered-by: Phusion Passenger 5.0.22
connection: close
x-opensuse-runtimes: {"view":null,"db":5.62134,"backend":0,"xml":0}
content-length: 626
server: Apache
x-runtime: 0.028243
x-opensuse-apiversion: 2.7.3
cache-control: no-transform
date: Fri, 03 Feb 2017 08:56:49 GMT
x-frame-options: SAMEORIGIN
content-type: text/html; charset=iso-8859-1

In the Monitor of the repository I can see that the package is blocked
due to a download in progress.
Usually the download of the files doesnt need that long
the download of binary packages and in general the status reporting is
independend of the source handling.

However, your proxy points to some issue that you may not can reach the
other server. Check you production.log (maybe enable debug) to get at
least a backtrace. And try to find out between which servers is the problem
actually.

I was able to branch your package in our test instance via remote link btw,
so it can not be a general code problem. Maybe a proxy setup problem on your
side.

https://build-test.opensuse.org/package/show/home:adrianSuSE/WEG
Hi
I checked the production.log
It always gets timeoouts without any more specific info
Here's a traceback
I attached a production.log for insights.

In addition /var/log/apache2/error_log provides something like this. I cannot access the webUZI at all now.

[Fri Feb 03 09:53:29.656034 2017] [mpm_prefork:notice] [pid 7895] AH00163: Apache/2.4.16 (Linux/SUSE) OpenSSL/1.0.1k-fips Phusion_Passenger/5.0.22 configured -- resuming normal operations
[Fri Feb 03 09:53:29.656197 2017] [core:notice] [pid 7895] AH00094: Command line: '/usr/sbin/httpd-prefork -f /etc/apache2/httpd.conf -D SYSCONFIG -D SSL -C PidFile /var/run/httpd.pid -C Include /etc/apache2 /sysconfig.d/ -D SYSTEMD -D FOREGROUND'
/usr/lib64/passenger/5.0.22//helper-scripts/prespawn:140:in `connect': SSL_connect returned=1 errno=0 state=SSLv2/v3 read server hello A: unknown protocol (OpenSSL::SSL::SSLError)
from /usr/lib64/passenger/5.0.22//helper-scripts/prespawn:140:in `connect'
from /usr/lib64/passenger/5.0.22//helper-scripts/prespawn:89:in `socket'
from /usr/lib64/passenger/5.0.22//helper-scripts/prespawn:108:in `head_request'
from /usr/lib64/passenger/5.0.22//helper-scripts/prespawn:171:in `<main>'
App 8004 stdout:
App 8004 stderr: WARNING: Nokogiri was built against LibXML version 2.9.1, but has dynamically loaded 2.9.4
App 8004 stderr: /usr/lib64/passenger/5.0.22/bin/passenger-config:33:in `require'
App 8004 stderr: :
App 8004 stderr: cannot load such file -- phusion_passenger
App 8004 stderr: (
App 8004 stderr: LoadError
App 8004 stderr: )
App 8004 stderr: from /usr/lib64/passenger/5.0.22/bin/passenger-config:33:in `<main>'
App 8022 stdout:
App 8030 stdout:
[Fri Feb 03 09:54:33.705816 2017] [mpm_prefork:notice] [pid 7895] AH00170: caught SIGWINCH, shutting down gracefully





Is there any way to fix this issue instead of waiting and hoping it
would fix by itself?
PS: the obvious reboot didnt help at all

Cheers




--
Mathias Radtke


---
http://uib.de/de/support-schulung/schulung/

---
uib gmbh
Bonifaziusplatz 1B
55118 Mainz

Tel. 06131 / 27561-16 <phone:061312756116>
Fax 06131 / 27561-22 <phone:061312756122>

E-Mail: m.radtke@xxxxxx
Internet: www.uib.de

Geschäftsführer: dr. detlef oertel & erol ueluekmen
Handelsregister: Amtsgericht Mainz HRB 6942

[45aea769-f648-4ede-bdcd-fc9204b4d6cf] [1578:2722.01] --> caught timeout,
closing HTTP
[45aea769-f648-4ede-bdcd-fc9204b4d6cf] [1578:2722.01] Completed 408 Request
Timeout in 600315ms (ActiveRecord: 12.1ms | Backend: 0.0ms | XML: 0.0ms)
[45aea769-f648-4ede-bdcd-fc9204b4d6cf] [1578:2722.03]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:174:in `find'
lib/activexml/node.rb:125:in `find_priv'
lib/activexml/node.rb:139:in `find'
app/controllers/webui/project_controller.rb:609:in `monitor'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[44f7d37d-b4fa-4065-8bf3-73bb22a34989] [5937:120.91] --> caught timeout,
closing HTTP
[44f7d37d-b4fa-4065-8bf3-73bb22a34989] [5937:120.92] Completed 408 Request
Timeout in 120367ms (ActiveRecord: 13.1ms | Backend: 0.0ms | XML: 0.0ms)
[44f7d37d-b4fa-4065-8bf3-73bb22a34989] [5937:120.94]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:229:in `direct_http'
app/models/worker_status.rb:4:in `hidden'
app/controllers/webui/main_controller.rb:28:in `block in index'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:105:in `block in fetch'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `block in
instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:166:in
`instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:104:in `fetch'
app/controllers/webui/main_controller.rb:27:in `index'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[c652565c-7a08-4e20-a3a9-e6307cd716f5] [1578:2736.32] Started GET "/" for
192.168.2.16 at 2017-02-03 09:35:03 +0000
[c652565c-7a08-4e20-a3a9-e6307cd716f5] [1578:2736.34] Processing by
Webui::MainController#index as HTML
[1684:2734.16] --> caught timeout, closing HTTP
[1546:2759.44] 2017-02-03T09:35:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job Event::NotifyBackends#send_not_in_queue (id=1337488) RUNNING
[1546:2759.45] 2017-02-03T09:35:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job Event::NotifyBackends#send_not_in_queue (id=1337488) COMPLETED
after 0.0114
[1546:2759.46] 2017-02-03T09:35:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337489) RUNNING
[1546:2759.49] 2017-02-03T09:35:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337489) COMPLETED after 0.0329
[1546:2759.49] 2017-02-03T09:35:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] 2 jobs processed at 32.0270 j/s, 0 failed
[542d920f-208c-4939-959a-306d6d2cc82f] [2520:2531.81] Started GET
"/source/home:uibmz:opsi:opsi41-experimental" for 192.168.16.1 at 2017-02-03
09:36:43 +0000
[542d920f-208c-4939-959a-306d6d2cc82f] [2520:2531.82] Processing by
SourceController#show_project as XML
[542d920f-208c-4939-959a-306d6d2cc82f] [2520:2531.82] Parameters:
{"project"=>"home:uibmz:opsi:opsi41-experimental"}
[542d920f-208c-4939-959a-306d6d2cc82f] [2520:2531.84] Rendered
status.xml.builder (1.2ms)
[542d920f-208c-4939-959a-306d6d2cc82f] [2520:2531.84] Completed 401
Unauthorized in 15ms (Views: 3.5ms | ActiveRecord: 1.1ms | Backend: 0.0ms |
XML: 0.0ms)
[2252f7a9-6e55-494c-9e03-29fa45688a25] [2520:2531.89] Started GET
"/source/home:uibmz:opsi:opsi41-experimental" for 192.168.16.1 at 2017-02-03
09:36:43 +0000
[2252f7a9-6e55-494c-9e03-29fa45688a25] [2520:2531.89] Processing by
SourceController#show_project as XML
[2252f7a9-6e55-494c-9e03-29fa45688a25] [2520:2531.89] Parameters:
{"project"=>"home:uibmz:opsi:opsi41-experimental"}
[2252f7a9-6e55-494c-9e03-29fa45688a25] [2520:2531.93] Completed 200 OK in 40ms
(Views: 0.2ms | ActiveRecord: 9.0ms | Backend: 0.0ms | XML: 0.0ms)
[93d27a5c-e7a7-4731-a682-0054df84e607] [2520:2531.98] Started GET
"/source/home:uibmz:opsi:opsi41-experimental/opsi-linux-bootimages?rev=latest"
for 192.168.16.1 at 2017-02-03 09:36:43 +0000
[93d27a5c-e7a7-4731-a682-0054df84e607] [2520:2531.99] Processing by
SourceController#show_package as XML
[93d27a5c-e7a7-4731-a682-0054df84e607] [2520:2531.99] Parameters:
{"rev"=>"latest", "project"=>"home:uibmz:opsi:opsi41-experimental",
"package"=>"opsi-linux-bootimages"}
[93d27a5c-e7a7-4731-a682-0054df84e607] [2520:2532.00] Rendered
status.xml.builder (1.0ms)
[93d27a5c-e7a7-4731-a682-0054df84e607] [2520:2532.00] Completed 401
Unauthorized in 10ms (Views: 2.0ms | ActiveRecord: 1.1ms | Backend: 0.0ms |
XML: 0.0ms)
[1df26251-5f2a-4ecf-9e45-b544fa8e15dc] [2520:2532.05] Started GET
"/source/home:uibmz:opsi:opsi41-experimental/opsi-linux-bootimages?rev=latest"
for 192.168.16.1 at 2017-02-03 09:36:43 +0000
[1df26251-5f2a-4ecf-9e45-b544fa8e15dc] [2520:2532.06] Processing by
SourceController#show_package as XML
[1df26251-5f2a-4ecf-9e45-b544fa8e15dc] [2520:2532.06] Parameters:
{"rev"=>"latest", "project"=>"home:uibmz:opsi:opsi41-experimental",
"package"=>"opsi-linux-bootimages"}
[1df26251-5f2a-4ecf-9e45-b544fa8e15dc] [2520:2532.08] Completed 200 OK in 22ms
(ActiveRecord: 7.2ms | Backend: 0.0ms | XML: 0.0ms)
[c652565c-7a08-4e20-a3a9-e6307cd716f5] [1578:2856.43] --> caught timeout,
closing HTTP
[c652565c-7a08-4e20-a3a9-e6307cd716f5] [1578:2856.43] Completed 408 Request
Timeout in 120095ms (ActiveRecord: 3.2ms | Backend: 0.0ms | XML: 0.0ms)
[c652565c-7a08-4e20-a3a9-e6307cd716f5] [1578:2856.45]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:229:in `direct_http'
app/models/worker_status.rb:4:in `hidden'
app/controllers/webui/main_controller.rb:28:in `block in index'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:105:in `block in fetch'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `block in
instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:166:in
`instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:104:in `fetch'
app/controllers/webui/main_controller.rb:27:in `index'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[801bfe20-8a87-42e2-a61f-78e8401a3915] [1578:2857.73] Started GET "/" for
192.168.2.16 at 2017-02-03 09:37:04 +0000
[801bfe20-8a87-42e2-a61f-78e8401a3915] [1578:2857.74] Processing by
Webui::MainController#index as HTML
[1684:2855.16] --> caught timeout, closing HTTP
[1532:2879.85] 2017-02-03T09:37:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337490) RUNNING
[1532:2879.86] 2017-02-03T09:37:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337490) COMPLETED
after 0.0087
[1532:2879.86] 2017-02-03T09:37:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] 1 jobs processed at 39.0441 j/s, 0 failed
[1546:2879.57] 2017-02-03T09:37:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337491) RUNNING
[1546:2879.58] 2017-02-03T09:37:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337491) COMPLETED after 0.0164
[1546:2879.59] 2017-02-03T09:37:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] 1 jobs processed at 35.1593 j/s, 0 failed
[801bfe20-8a87-42e2-a61f-78e8401a3915] [1578:2977.88] --> caught timeout,
closing HTTP
[801bfe20-8a87-42e2-a61f-78e8401a3915] [1578:2977.88] Completed 408 Request
Timeout in 120136ms (ActiveRecord: 1.7ms | Backend: 0.0ms | XML: 0.0ms)
[801bfe20-8a87-42e2-a61f-78e8401a3915] [1578:2977.89]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:229:in `direct_http'
app/models/worker_status.rb:4:in `hidden'
app/controllers/webui/main_controller.rb:28:in `block in index'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:105:in `block in fetch'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `block in
instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:166:in
`instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:359:in `instrument'
dalli (2.7.4) lib/active_support/cache/dalli_store.rb:104:in `fetch'
app/controllers/webui/main_controller.rb:27:in `index'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[1684:2976.16] --> caught timeout, closing HTTP
[1532:2999.94] 2017-02-03T09:39:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337492) RUNNING
[1546:2999.66] 2017-02-03T09:39:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337493) RUNNING
[1532:2999.96] 2017-02-03T09:39:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337492) COMPLETED
after 0.0197
[1532:2999.96] 2017-02-03T09:39:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] 1 jobs processed at 25.9103 j/s, 0 failed
[1546:2999.68] 2017-02-03T09:39:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] Job SendEventEmails#perform (id=1337493) COMPLETED after 0.0227
[1546:2999.68] 2017-02-03T09:39:12+0000: [Worker(delayed_job.2 host:obs
pid:1546)] 1 jobs processed at 24.4479 j/s, 0 failed
[85a4e231-796f-4741-b7ab-7dac3a2ae90e] [1568:2999.38] --> caught timeout,
closing HTTP
[85a4e231-796f-4741-b7ab-7dac3a2ae90e] [1568:2999.38] Completed 408 Request
Timeout in 600182ms (ActiveRecord: 9.4ms | Backend: 0.0ms | XML: 0.0ms)
[85a4e231-796f-4741-b7ab-7dac3a2ae90e] [1568:2999.40]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:174:in `find'
lib/activexml/node.rb:125:in `find_priv'
lib/activexml/node.rb:139:in `find'
app/controllers/webui/project_controller.rb:609:in `monitor'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[8733c4a5-202d-49e0-af70-773029689e60] [2001:2895.74] --> caught timeout,
closing HTTP
[8733c4a5-202d-49e0-af70-773029689e60] [2001:2895.74] Completed 408 Request
Timeout in 600235ms (ActiveRecord: 4.2ms | Backend: 0.0ms | XML: 0.0ms)
[8733c4a5-202d-49e0-af70-773029689e60] [2001:2895.75]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:174:in `find'
lib/activexml/node.rb:125:in `find_priv'
lib/activexml/node.rb:139:in `find'
lib/activexml/node.rb:143:in `find_hashed'
app/controllers/webui/package_controller.rb:1088:in `load_buildresults'
app/controllers/webui/package_controller.rb:61:in `show'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[7227d828-c375-4ee7-aebd-dd526eaed7c2] [2045:2900.67] --> caught timeout,
closing HTTP
[7227d828-c375-4ee7-aebd-dd526eaed7c2] [2045:2900.67] Completed 408 Request
Timeout in 600292ms (ActiveRecord: 13.2ms | Backend: 0.0ms | XML: 0.0ms)
[7227d828-c375-4ee7-aebd-dd526eaed7c2] [2045:2900.69]
Timeout::Error (Timeout::Error):
lib/activexml/transport.rb:365:in `rescue in http_do'
lib/activexml/transport.rb:389:in `http_do'
lib/activexml/transport.rb:174:in `find'
lib/activexml/node.rb:125:in `find_priv'
lib/activexml/node.rb:139:in `find'
app/controllers/webui/project_controller.rb:609:in `monitor'
actionpack (4.2.7.1) lib/action_controller/metal/implicit_render.rb:4:in
`send_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:198:in `process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rendering.rb:10:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:20:in `block in
process_action'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:117:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:555:in `block (2
levels) in compile'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:505:in `call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:92:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_process_action_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/abstract_controller/callbacks.rb:19:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/rescue.rb:29:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:32:in
`block in process_action'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in `block in
instrument'
activesupport (4.2.7.1)
lib/active_support/notifications/instrumenter.rb:20:in `instrument'
activesupport (4.2.7.1) lib/active_support/notifications.rb:164:in
`instrument'
actionpack (4.2.7.1) lib/action_controller/metal/instrumentation.rb:30:in
`process_action'
actionpack (4.2.7.1) lib/action_controller/metal/params_wrapper.rb:250:in
`process_action'
activerecord (4.2.7.1) lib/active_record/railties/controller_runtime.rb:18:in
`process_action'
actionpack (4.2.7.1) lib/abstract_controller/base.rb:137:in `process'
actionview (4.2.7.1) lib/action_view/rendering.rb:30:in `process'
actionpack (4.2.7.1) lib/action_controller/metal.rb:196:in `dispatch'
actionpack (4.2.7.1) lib/action_controller/metal/rack_delegation.rb:13:in
`dispatch'
actionpack (4.2.7.1) lib/action_controller/metal.rb:237:in `block in action'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:43:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/mapper.rb:49:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:43:in `block in
serve'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `each'
actionpack (4.2.7.1) lib/action_dispatch/journey/router.rb:30:in `serve'
actionpack (4.2.7.1) lib/action_dispatch/routing/route_set.rb:817:in `call'
config/initializers/wrap_parameters.rb:38:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/rack.rb:27:in `call'
rack (1.6.4) lib/rack/deflater.rb:35:in `call'
rack (1.6.4) lib/rack/etag.rb:24:in `call'
rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
rack (1.6.4) lib/rack/head.rb:13:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/flash.rb:260:in `call'
rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/cookies.rb:560:in `call'
activerecord (4.2.7.1) lib/active_record/query_cache.rb:36:in `call'
activerecord (4.2.7.1)
lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:29:in `block
in call'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:88:in
`__run_callbacks__'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:778:in
`_run_call_callbacks'
activesupport (4.2.7.1) lib/active_support/callbacks.rb:81:in `run_callbacks'
actionpack (4.2.7.1) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/debug_exceptions.rb:17:in
`call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/show_exceptions.rb:30:in
`call'
railties (4.2.7.1) lib/rails/rack/logger.rb:38:in `call_app'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `block in call'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `block in
tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:26:in `tagged'
activesupport (4.2.7.1) lib/active_support/tagged_logging.rb:68:in `tagged'
railties (4.2.7.1) lib/rails/rack/logger.rb:20:in `call'
actionpack (4.2.7.1) lib/action_dispatch/middleware/request_id.rb:21:in `call'
rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
rack (1.6.4) lib/rack/runtime.rb:18:in `call'
activesupport (4.2.7.1)
lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
rack (1.6.4) lib/rack/lock.rb:17:in `call'
rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
hoptoad_notifier (2.4.11) lib/hoptoad_notifier/user_informer.rb:12:in `call'
railties (4.2.7.1) lib/rails/engine.rb:518:in `call'
railties (4.2.7.1) lib/rails/application.rb:165:in `call'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `public_send'
railties (4.2.7.1) lib/rails/railtie.rb:194:in `method_missing'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/rack/thread_handler_extension.rb:97:in
`process_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:152:in
`accept_and_process_next_request'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler/thread_handler.rb:113:in
`main_loop'
passenger (5.0.22)
src/ruby_supportlib/phusion_passenger/request_handler.rb:416:in `block (3
levels) in start_threads'
passenger (5.0.22) src/ruby_supportlib/phusion_passenger/utils.rb:113:in
`block in create_thread_and_abort_on_exception'


[1684:3097.16] --> caught timeout, closing HTTP
[1539:3119.88] 2017-02-03T09:41:12+0000: [Worker(delayed_job.1 host:obs
pid:1539)] Job StatusHistoryRescaler#rescale (id=1337494) RUNNING
[1532:3120.04] 2017-02-03T09:41:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337495) RUNNING
[1532:3120.05] 2017-02-03T09:41:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job Event::NotifyBackends#send_not_in_queue (id=1337495) COMPLETED
after 0.0083
[1532:3120.05] 2017-02-03T09:41:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job SendEventEmails#perform (id=1337496) RUNNING
[1532:3120.07] 2017-02-03T09:41:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] Job SendEventEmails#perform (id=1337496) COMPLETED after 0.0159
[1532:3120.07] 2017-02-03T09:41:12+0000: [Worker(delayed_job.0 host:obs
pid:1532)] 2 jobs processed at 44.0800 j/s, 0 failed
[1539:3126.45] 2017-02-03T09:41:19+0000: [Worker(delayed_job.1 host:obs
pid:1539)] Job StatusHistoryRescaler#rescale (id=1337494) COMPLETED after 6.5695
[1539:3126.45] 2017-02-03T09:41:19+0000: [Worker(delayed_job.1 host:obs
pid:1539)] 1 jobs processed at 0.1519 j/s, 0 failed
< Previous Next >