Bug 692204 - several errors in connector.log while attempting to build templates
Summary: several errors in connector.log while attempting to build templates
Keywords:
Status: CLOSED CURRENTRELEASE
Alias: None
Product: CloudForms Cloud Engine
Classification: Retired
Component: aeolus-conductor
Version: 0.3.1
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: rc
Assignee: Jason Guiditta
QA Contact: wes hayutin
URL:
Whiteboard:
Depends On:
Blocks: ce-beta
TreeView+ depends on / blocked
 
Reported: 2011-03-30 17:06 UTC by wes hayutin
Modified: 2012-01-26 12:19 UTC (History)
2 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed:
Embargoed:


Attachments (Terms of Use)

Description wes hayutin 2011-03-30 17:06:27 UTC
[root@dhcp231-29 log]# rpm -qa | grep aeolus
aeolus-conductor-0.0.3-0.fc14.20110330133246git37c7457.x86_64
aeolus-configure-2.0.0-5.fc14.2011033093316gitecf8f95.noarch
aeolus-conductor-daemons-0.0.3-0.fc14.20110330133246git37c7457.x86_64
aeolus-conductor-doc-0.0.3-0.fc14.20110330133246git37c7457.x86_64




> Thin web server (v1.2.5 codename This Is Not A Web Server)
>> Maximum connections set to 1024
>> Listening on 0.0.0.0:2003, CTRL+C to stop
D, [2011-03-30T12:16:21.120229 #4500] DEBUG -- : build method called with {"template"=>"http://localhost:9090/templates/ffdba400-5ae8-11e0-83fb-001e4fac24ec", "target"=>"ec2"}
D, [2011-03-30T12:16:24.223997 #4500] DEBUG -- : GOT AN EVENT:  redhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5, old_statusNEWeventSTATUSnew_statusBUILDINGaddr_object_namebuild_adaptor:image:b1689f2a-af39-428a-a7a2-fa12259ac169_agent_nameredhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5 at 1301501784222568438
E, [2011-03-30T12:16:24.307575 #4500] ERROR -- : Error Received: #<Qmf2::Data:0x7f8ee199c948 @impl=#<Cqmf2::Data:0x7f8ee199c998>, @schema=nil>
D, [2011-03-30T12:16:24.307860 #4500] DEBUG -- : ====== Type of event: STATUS
D, [2011-03-30T12:16:24.308842 #4500] DEBUG -- : calling handle status in base handler
D, [2011-03-30T12:16:24.309314 #4500] DEBUG -- : Data: #<FactoryRestHandler::EventData:0x7f8ee199a7b0 @value="building", @event="STATUS", @uuid="b1689f2a-af39-428a-a7a2-fa12259ac169", @obj="image">
D, [2011-03-30T12:16:24.331232 #4500] DEBUG -- : Return code is: 404
D, [2011-03-30T12:16:24.331373 #4500] DEBUG -- : Return body is:  
D, [2011-03-30T12:17:22.071806 #4500] DEBUG -- : GOT AN EVENT:  redhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5, percent_complete10eventPERCENTAGEaddr_object_namebuild_adaptor:image:b1689f2a-af39-428a-a7a2-fa12259ac169_agent_nameredhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5 at 1301501842070061430
D, [2011-03-30T12:17:22.080237 #4500] DEBUG -- : ====== Type of event: PERCENTAGE
D, [2011-03-30T12:17:22.080647 #4500] DEBUG -- : GOT AN EVENT:  redhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5, old_statusBUILDINGeventSTATUSnew_statusFAILEDaddr_object_namebuild_adaptor:image:b1689f2a-af39-428a-a7a2-fa12259ac169_agent_nameredhat.com:imagefactory:7cc0ed88-bdda-4959-b783-d8968ab4c6e5 at 1301501842078000654
D, [2011-03-30T12:17:22.080806 #4500] DEBUG -- : ====== Type of event: STATUS
D, [2011-03-30T12:17:22.080917 #4500] DEBUG -- : calling handle status in base handler
D, [2011-03-30T12:17:22.081154 #4500] DEBUG -- : Data: #<FactoryRestHandler::EventData:0x7f8ee1994338 @value="failed", @event="STATUS", @uuid="b1689f2a-af39-428a-a7a2-fa12259ac169", @obj="image">
D, [2011-03-30T12:17:22.093075 #4500] DEBUG -- : Return code is: 404
D, [2011-03-30T12:17:22.093488 #4500] DEBUG -- : Return body is:  
>> Stopping ...
127.0.0.1 - - [30/Mar/2011 12:50:21] "POST /build HTTP/1.1" 500 - 3.0025
127.0.0.1 - - [30/Mar/2011 12:53:04] "POST /build HTTP/1.1" 500 - 4.0025
2011-03-30 12:53:55 warning Connection [45635 localhost:5672] closed
2011-03-30 12:53:55 warning Connection [58004 localhost:5672] closed
2011-03-30 12:53:55 warning Connect failed: Connection refused
2011-03-30 12:53:55 warning Connection  closed
2011-03-30 12:53:55 warning Connect failed: Connection refused
2011-03-30 12:53:55 warning Connection  closed
2011-03-30 12:53:58 warning Connect failed: Connection refused
2011-03-30 12:53:58 warning Connection  closed
2011-03-30 12:53:58 warning Connect failed: Connection refused
2011-03-30 12:53:58 warning Connection  closed
2011-03-30 12:53:58 warning Connect failed: Connection refused
2011-03-30 12:53:58 warning Connection  closed
2011-03-30 12:54:04 warning Connect failed: Connection refused
2011-03-30 12:54:04 warning Connection  closed
2011-03-30 12:54:04 warning Connect failed: Connection refused
2011-03-30 12:54:04 warning Connection  closed
2011-03-30 12:54:04 warning Connect failed: Connection refused
2011-03-30 12:54:04 warning Connection  closed
2011-03-30 12:54:16 warning Connect failed: Connection refused
2011-03-30 12:54:16 warning Connection  closed
2011-03-30 12:54:16 warning Connect failed: Connection refused
2011-03-30 12:54:16 warning Connection  closed
2011-03-30 12:54:16 warning Connect failed: Connection refused
2011-03-30 12:54:16 warning Connection  closed
2011-03-30 12:54:40 warning Connect failed: Connection refused
2011-03-30 12:54:40 warning Connection  closed
2011-03-30 12:54:40 warning Connect failed: Connection refused
2011-03-30 12:54:40 warning Connection  closed
2011-03-30 12:54:40 warning Connect failed: Connection refused
2011-03-30 12:54:40 warning Connection  closed
2011-03-30 12:55:28 warning Connection [58099 localhost:5672] closed
D, [2011-03-30T12:49:04.493360 #7461] DEBUG -- : GOT AN AGENT:  apache.org:qpidd:60d82d95-8dd7-4c0a-b29d-ac80804c965f at Wed Mar 30 16:49:04 UTC 2011
D, [2011-03-30T12:49:04.503278 #7461] DEBUG -- : AGENT GONE:  apache.org:qpidd:60d82d95-8dd7-4c0a-b29d-ac80804c965f at Wed Mar 30 16:49:04 UTC 2011, because filter
>> Thin web server (v1.2.5 codename This Is Not A Web Server)
>> Maximum connections set to 1024
>> Listening on 0.0.0.0:2003, CTRL+C to stop
D, [2011-03-30T12:50:18.724440 #7461] DEBUG -- : build method called with {"template"=>"http://localhost:9090/templates/b9915ad0-5aed-11e0-8fc4-001e4fac24ec", "target"=>"ec2"}
D, [2011-03-30T12:50:19.725113 #7461] DEBUG -- : Encountered error in build_image: undefined method `query' for nil:NilClass
E, [2011-03-30T12:50:20.725530 #7461] ERROR -- : Error Received: #<NoMethodError: undefined method `query' for nil:NilClass>
D, [2011-03-30T12:53:00.905559 #7461] DEBUG -- : build method called with {"template"=>"http://localhost:9090/templates/24085328-5aee-11e0-8fc4-001e4fac24ec", "target"=>"ec2"}
D, [2011-03-30T12:53:01.906174 #7461] DEBUG -- : Encountered error in build_image: undefined method `query' for nil:NilClass
E, [2011-03-30T12:53:03.906816 #7461] ERROR -- : Error Received: #<NoMethodError: undefined method `query' for nil:NilClass>
>> Stopping ...
[root@dhcp231-29 log]# cat /var/log/aeolus-conductor/aeolus-connector.log 



recreate:
1. install
2. create provider account for ec2-us-east-1
3. create template
4. attempt build

5. aeolus-cleanup/configure
steps 2-4
6. aeolus-clean/configure
steps 2-4

Comment 1 wes hayutin 2011-04-01 14:47:24 UTC
recreated in:

[root@ibm-x3550m3-01 ~]# rpm -qa | grep aeolus
aeolus-conductor-0.0.3-0.fc14.20110401092645git4cd715c.x86_64
aeolus-conductor-doc-0.0.3-0.fc14.20110401092645git4cd715c.x86_64
aeolus-configure-2.0.0-5.fc14.2011040152712gitcd696c2.noarch
aeolus-conductor-daemons-0.0.3-0.fc14.20110401092645git4cd715c.x86_64


~
127.0.0.1 - - [01/Apr/2011 10:29:32] "POST /build HTTP/1.1" 500 - 3.0023
2011-04-01 10:33:21 warning Connection [37388 localhost:5672] closed
>> Thin web server (v1.2.5 codename This Is Not A Web Server)
>> Maximum connections set to 1024
>> Listening on 0.0.0.0:2003, CTRL+C to stop
D, [2011-04-01T10:29:29.018889 #32524] DEBUG -- : build method called with {"template"=>"http://localhost:9090/templates/65feb32e-5c6c-11e0-943b-00215ec821a8", "target"=>"ec2"}
D, [2011-04-01T10:29:30.019635 #32524] DEBUG -- : Encountered error in build_image: undefined method `query' for nil:NilClass
E, [2011-04-01T10:29:31.020184 #32524] ERROR -- : Error Received: #<NoMethodError: undefined method `query' for nil:NilClass>
D, [2011-04-01T10:31:45.605594 #32524] DEBUG -- : GOT AN AGENT:  redhat.com:imagefactory:de10b670-a53a-402b-ae26-9728df7841d5 at Fri Apr 01 14:31:45 UTC 2011
D, [2011-04-01T10:31:46.610953 #32524] DEBUG -- : AGENT SCHEMA UPDATED:  imagefactory
>> Stopping ...
[  OK  ]^M127.0.0.1 - - [01/Apr/2011 10:42:00] "POST /build HTTP/1.1" 500 - 6.0031
(END)

Comment 2 wes hayutin 2011-06-23 22:02:36 UTC
[root@ibm-x3950m2-01 noarch]# cat /var/log/aeolus-connector.log | grep -i undefined method 
grep: method: No such file or directory
[root@ibm-x3950m2-01 noarch]# cat /var/log/aeolus-connector.log | grep -i "undefined method" 
[root@ibm-x3950m2-01 noarch]# cat /var/log/aeolus-connector.log | grep -i "nill" 
[root@ibm-x3950m2-01 noarch]# cat /var/log/aeolus-connector.log | grep -i complete
D, [2011-06-23T13:56:58.581322 #10459] DEBUG -- : GOT AN EVENT:  redhat.com:imagefactory:848fa44e-3eaf-4821-be1e-a351c2ddf8c1, percent_complete100eventPERCENTAGEaddr_object_namebuild_adaptor:build_image:8809de31-c008-457b-8578-f743948eac2c_agent_nameredhat.com:imagefactory:848fa44e-3eaf-4821-be1e-a351c2ddf8c1 at 1308851818579773033
D, [2011-06-23T13:56:58.591694 #10459] DEBUG -- : GOT AN EVENT:  redhat.com:imagefactory:848fa44e-3eaf-4821-be1e-a351c2ddf8c1, old_statusNEWeventSTATUSnew_statusCOMPLETEDaddr_object_namebuild_adaptor:build_image:8809de31-c008-457b-8578-f743948eac2c_agent_nameredhat.com:imagefactory:848fa44e-3eaf-4821-be1e-a351c2ddf8c1 at 1308851818585917097
D, [2011-06-23T13:56:58.632069 #10459] DEBUG -- : Data: #<FactoryRestHand



[root@ibm-x3950m2-01 noarch]# rpm -qa | grep aeolus
aeolus-conductor-0.3.0-0.el6.20110623205403git551632a.noarch
aeolus-configure-2.0.1-0.el6.20110622123902gitdf4ae05.noarch
aeolus-conductor-doc-0.3.0-0.el6.20110623205403git551632a.noarch
aeolus-all-0.3.0-0.el6.20110623205403git551632a.noarch
rubygem-aeolus-cli-0.0.1-1.el6.20110623205403git551632a.noarch
aeolus-conductor-daemons-0.3.0-0.el6.20110623205403git551632a.noarch
aeolus-conductor-devel-0.3.0-0.el6.20110623205403git551632a.noarch

Comment 3 wes hayutin 2011-08-01 20:01:26 UTC
release pending...

Comment 4 wes hayutin 2011-08-01 20:01:43 UTC
release pending...

Comment 5 wes hayutin 2011-08-01 20:01:57 UTC
release pending.. 2

Comment 7 wes hayutin 2011-12-08 14:03:24 UTC
closing out old bugs

Comment 8 wes hayutin 2011-12-08 14:15:10 UTC
perm close


Note You need to log in before you can comment on or make changes to this bug.