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 <[EMAIL PROTECTED]>
********************************************************************************
********************************************************************************
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)
_______________________________________________
http://lists.bestpractical.com/cgi-bin/mailman/listinfo/rt-users
Community help: http://wiki.bestpractical.com
Commercial support: [EMAIL PROTECTED]
Discover RT's hidden secrets with RT Essentials from O'Reilly Media.
Buy a copy at http://rtbook.bestpractical.com