[rt-users] Problem with TransactionBatch scrip
David Stipp
dstipp at uiuc.edu
Mon May 21 17:55:32 EDT 2007
Hello all,
I'm having a problem with a scrip running in the TransactionBatch stage.
Setting the scene:
RT 3.6.3, Oracle, Apache2, Perl 5.8.8
One queue required a custom field to be populated with information
extracted from an e-mail message on a ticket creation. The initial
notification to the AdminCcs needed to have the information from the CF
in the message. To make this work, I set $UseTransactionBatch, and
modified the scrip 'On Create, Notify AdminCcs' to execute in the
Transaction Batch stage.
On e-mail from unprivileged users to the queue, everything works. User
gets their notification back, CF is populated, and AdminCcs get their
notification with the CF.
Switch to another Queue: Same configuration, except it doesn't have the
CF or the scrip to extract and populate that CF.
If an unprivileged sends e-mail to this queue, they get their
notification, but the AdminCcs do not.
If a privileged user sends e-mail to this queue, they get their
notification AND the AdminCcs get their notification.
It was suggested on IRC by Ruslan that I try RT 3.6.4rc1, since it
addressed some TransactionBatch issues. This, however, did not help.
He then asked me to send mail here. :-)
Attached are some logs, broken apart by case. Let me know if there's
any more information I can provide!
Thanks in advance,
David
--
David Stipp <dstipp at uiuc.edu>
-------------- next part --------------
********************************************************************************
********************************************************************************
Problem Queue: SBIT
********************************************************************************
Unprivileged user sending e-mail
[Mon May 21 18:53:39 2007] [debug]: RT::Date used date::parse to make 1970-01-01 21600 (/services/rt/rt3/lib/RT/Date.pm:211)
[Mon May 21 18:55:40 2007] [debug]: Converting 'us-ascii' to 'utf-8' for text/plain - test from admin@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/I18N.pm:223)
[Mon May 21 18:55:40 2007] [debug]: About to think about scrips for transaction #18785 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:40 2007] [debug]: About to think about scrips for transaction #18786 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:40 2007] [debug]: About to think about scrips for transaction #18787 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:40 2007] [debug]: About to think about scrips for transaction #18788 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:40 2007] [debug]: About to think about scrips for transaction #18789 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:40 2007] [debug]: About to prepare scrips for transaction #18789 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:169)
[Mon May 21 18:55:40 2007] [debug]: Found 3 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Mon May 21 18:55:40 2007] [debug]: About to commit scrips for transaction #18789 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:178)
[Mon May 21 18:55:40 2007] [info]: <rt-3.6.3-14794-1179773740-285.533-30-0@< XX HOSTNAME REMOVED XX >> #533/18789 - Scrip 30 100-OnCreateAutoreplyToRequestors (/services/rt/rt3/lib/RT/Action/SendEmail.pm:243)
[Mon May 21 18:55:41 2007] [info]: <rt-3.6.3-14794-1179773740-285.533-30-0@< XX HOSTNAME REMOVED XX >> sent To: admin@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/Action/SendEmail.pm:274)
[Mon May 21 18:55:41 2007] [debug]: About to think about scrips for transaction #18790 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:55:41 2007] [info]: Ticket 533 created in queue 'SBIT' by admin@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/Ticket_Overlay.pm:754)
[Mon May 21 18:55:41 2007] [debug]: Found 0 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
********************************************************************************
Privileged user sending e-mail
[Mon May 21 18:47:06 2007] [debug]: Converting 'ISO-8859-1' to 'utf-8' for text/plain - testing the queue thingie (/services/rt/rt3/lib/RT/I18N.pm:223)
[Mon May 21 18:47:06 2007] [debug]: About to think about scrips for transaction #18766 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:06 2007] [debug]: About to think about scrips for transaction #18767 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:06 2007] [debug]: About to think about scrips for transaction #18768 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:06 2007] [debug]: About to think about scrips for transaction #18769 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:07 2007] [debug]: About to think about scrips for transaction #18770 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:07 2007] [debug]: About to prepare scrips for transaction #18770 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:169)
[Mon May 21 18:47:07 2007] [debug]: Found 3 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Mon May 21 18:47:07 2007] [debug]: About to commit scrips for transaction #18770 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:178)
[Mon May 21 18:47:07 2007] [info]: <rt-3.6.3-14797-1179773227-856.530-30-0@< XX HOSTNAME REMOVED XX >> #530/18770 - Scrip 30 100-OnCreateAutoreplyToRequestors (/services/rt/rt3/lib/RT/Action/SendEmail.pm:243)
[Mon May 21 18:47:07 2007] [info]: <rt-3.6.3-14797-1179773227-856.530-30-0@< XX HOSTNAME REMOVED XX >> sent To: < XX E-MAIL ADDRESS REMOVED XX > (/services/rt/rt3/lib/RT/Action/SendEmail.pm:274)
[Mon May 21 18:47:07 2007] [debug]: About to think about scrips for transaction #18771 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Mon May 21 18:47:07 2007] [info]: Ticket 530 created in queue 'SBIT' by boydbria (/services/rt/rt3/lib/RT/Ticket_Overlay.pm:754)
[Mon May 21 18:47:07 2007] [debug]: Found 1 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Mon May 21 18:47:08 2007] [info]: <rt-3.6.3-14797-1179773228-522.530-4-0@< XX HOSTNAME REMOVED XX >> #530/18770 - Scrip 4 075-OnCreateNotifyAdminCcs (/services/rt/rt3/lib/RT/Action/SendEmail.pm:243)
[Mon May 21 18:47:08 2007] [info]: <rt-3.6.3-14797-1179773228-522.530-4-0@< XX HOSTNAME REMOVED XX >> sent Bcc: < XX E-MAIL ADDRESS REMOVED XX > (/services/rt/rt3/lib/RT/Action/SendEmail.pm:274)
[Mon May 21 18:47:08 2007] [debug]: About to think about scrips for transaction #18772 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
********************************************************************************
********************************************************************************
Working Queue: SMGp
********************************************************************************
Unprivileged user sending e-mail
[Fri May 18 15:50:43 2007] [debug]: Guessed encoding: ascii (/services/rt/rt3/lib/RT/I18N.pm:399)
[Fri May 18 15:50:43 2007] [debug]: Guessed encoding: ascii (/services/rt/rt3/lib/RT/I18N.pm:399)
[Fri May 18 15:50:43 2007] [debug]: Converting 'ascii' to 'utf-8' for text/plain - Message from Swatch on < XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/I18N.pm:223)
[Fri May 18 15:50:43 2007] [debug]: CreateFromExternalUserInfo: entered with args: mail root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:55)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Entered with:
key = mail
value = root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:198)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Attempting TLS LDAP lookup (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:210)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: First search filter 'mail=root@< XX HOSTNAME REMOVED XX >' (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:269)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Search produced 0 results (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:281)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Leaving LDAP examination with:
Name =
EmailAddress =
RealName =
Found = 0 (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:302)
[Fri May 18 15:50:43 2007] [debug]: CreateFromExternalUserInfo: params hash: RealName Name EmailAddress (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:58)
[Fri May 18 15:50:43 2007] [info]: CreateFromExternalUserInfo: failed to find user with args: mail root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:60)
[Fri May 18 15:50:43 2007] [debug]: CreateFromExternalUserInfo: entered with args: cn root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:55)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Entered with:
key = cn
value = root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:198)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Attempting TLS LDAP lookup (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:210)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: First search filter 'cn=root@< XX HOSTNAME REMOVED XX >' (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:269)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Search produced 0 results (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:281)
[Fri May 18 15:50:43 2007] [debug]: LookupExternalUserInfo: Leaving LDAP examination with:
Name =
EmailAddress =
RealName =
Found = 0 (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:302)
[Fri May 18 15:50:43 2007] [debug]: CreateFromExternalUserInfo: params hash: RealName Name EmailAddress (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:58)
[Fri May 18 15:50:43 2007] [info]: CreateFromExternalUserInfo: failed to find user with args: cn root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/CurrentUser_Local.pm:60)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18562 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18563 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18564 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18565 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18566 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18567 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18568 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to prepare scrips for transaction #18568 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:169)
[Fri May 18 15:50:44 2007] [debug]: Found 4 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Fri May 18 15:50:44 2007] [debug]: About to commit scrips for transaction #18568 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:178)
[Fri May 18 15:50:44 2007] [debug]: load cf Hostname (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:38)
[Fri May 18 15:50:44 2007] [debug]: load cf done: 1 Found Object (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:44)
[Fri May 18 15:50:44 2007] [debug]: look for cf in Header RT-Hostname (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:56)
[Fri May 18 15:50:44 2007] [debug]: matched value: < XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:61)
[Fri May 18 15:50:44 2007] [debug]: found value for cf: < XX HOSTNAME REMOVED XX > (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:79)
[Fri May 18 15:50:44 2007] [debug]: About to think about scrips for transaction #18569 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:44 2007] [debug]: About to prepare scrips for transaction #18569 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:169)
[Fri May 18 15:50:44 2007] [debug]: Found 2 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Fri May 18 15:50:44 2007] [debug]: About to commit scrips for transaction #18569 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:178)
[Fri May 18 15:50:45 2007] [info]: CustomFieldValue (Hostname,< XX HOSTNAME REMOVED XX >) added: 1 Hostname < XX HOSTNAME REMOVED XX > added (/services/rt/rt3/local/lib/RT/Action/ExtractCustomFieldValues.pm:82)
[Fri May 18 15:50:45 2007] [info]: <rt-3.6.3-13449-1179503444-1808.521-25-0@< XX HOSTNAME REMOVED XX >> #521/18568 - Scrip 25 100-OnCreateAutoreplyToRequestors (/services/rt/rt3/lib/RT/Action/SendEmail.pm:243)
[Fri May 18 15:50:45 2007] [info]: <rt-3.6.3-13449-1179503444-1808.521-25-0@< XX HOSTNAME REMOVED XX >> sent To: root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/Action/SendEmail.pm:274)
[Fri May 18 15:50:45 2007] [debug]: About to think about scrips for transaction #18570 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
[Fri May 18 15:50:45 2007] [info]: Ticket 521 created in queue 'SMG-p' by root@< XX HOSTNAME REMOVED XX > (/services/rt/rt3/lib/RT/Ticket_Overlay.pm:754)
[Fri May 18 15:50:45 2007] [debug]: Found 1 scrips (/services/rt/rt3/lib/RT/Scrips_Overlay.pm:363)
[Fri May 18 15:50:45 2007] [info]: <rt-3.6.3-13449-1179503445-1029.521-4-0@< XX HOSTNAME REMOVED XX >> #521/18568 - Scrip 4 075-OnCreateNotifyAdminCcs (/services/rt/rt3/lib/RT/Action/SendEmail.pm:243)
[Fri May 18 15:50:46 2007] [info]: <rt-3.6.3-13449-1179503445-1029.521-4-0@< XX HOSTNAME REMOVED XX >> sent Bcc: < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX >, < XX E-MAIL ADDRESS REMOVED XX > (/services/rt/rt3/lib/RT/Action/SendEmail.pm:274)
[Fri May 18 15:50:46 2007] [debug]: About to think about scrips for transaction #18571 (/services/rt/rt3/lib/RT/Transaction_Overlay.pm:165)
More information about the rt-users
mailing list