[Dspace-tech] Submission form saves only unique contributors

22 views

Skip to first unread message

Jonathan Freesbay

unread,

Aug 26, 2015, 10:34:24 AM8/26/15

to DSpac...@lists.sourceforge.net

Hi,

Tomcat version: 6.0.35.0

Dspace version: 3.1

I would like to save movie data in dublin core. I use:

-dc.contributor.director

-dc.contributor.writer

When the director and writer are the same, the submission wizard just saves one of them.

I can later add the value back using the editor, so it's not a core dublin core limitation.

Can I disable this behaviour in the submission wizard?

Otherwise, I must use dc.director and dc.writer,

Regards,

Ying Jin

unread,

Aug 26, 2015, 10:34:26 AM8/26/15

to dspace-tech@lists.sourceforge.net Tech

BTW, I am using xmlui and did turn on the configurable submission and
ran the update for that.

Thanks,
Ying

On Feb 28, 2013, at 2:09 PM, Ying Jin wrote:

> Hi All,
>
> We are trying to upgrade from DSpace 1.7.2 to 3.0 and checked out
> the DSpace 3.0 branch from github. I followed the upgrading steps
> for DSpace 1.7 to 1.8 and then 1.8 to 3.0 (run upgrade script).
> However, when I tried to use the submission process to complete a
> submit, the system will hang there and give me Internal Server Error
> (timeout) and the dspace log have following errors -
>
> ERROR org.dspace.core.I18nUtil @ No language specified for EPerson 18
> .....
> ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid
> version (expected 2, but 1) or the data in not in 'javabin' format
>
> When I turn on the debugger, it shows the system is trying to query
> some of the communities and subcommunities which seem totally
> unrelated to the collection I am trying to submit to. Does anyone
> have a clue why this is happening? What I am trying to submit is a
> small pdf file and won't take long for 1.7.2 to complete.
>
> Thanks in advance for any help,
> Ying @ Rice Univeristy
>

helix84

unread,

Aug 26, 2015, 10:34:28 AM8/26/15

to Jonathan Freesbay, DSpac...@lists.sourceforge.net

Hi Jonathan,

it would be best to file this as a bug into our Jira:

https://jira.duraspace.org/browse/DS

Otherwise it may be easily overlooked or forgotten here in the lists.

Regards,
~~helix84

Compulsory reading: DSpace Mailing List Etiquette
https://wiki.duraspace.org/display/DSPACE/Mailing+List+Etiquette

Ying Jin

unread,

Aug 26, 2015, 10:34:31 AM8/26/15

to dspace-tech@lists.sourceforge.net Tech

Ying Jin

unread,

Aug 26, 2015, 10:34:33 AM8/26/15

to Bram Luyten, Dspace Tech

Hi Bram,

Thanks for the reply. I read your jira report and i noticed the same
solr version problem with oai in 3.3 and others in 3.5. I am not sure
if my solr error is related to that. I tried to change the version
number in pom.xml and that doesn't help. Also, the version under solr
server and xmlui are the same. I suppose it should not be the version
issue in my case? But I can't really explain why I got the version
error...

Also, the solr error appears when I submit something, or run
stats-util, filter-media... I have not tried oai yet but would like to
test it tomorrow and see if it will get me the same error. I can post
you some detail logs tomorrow too.

Thanks,
Ying

Quoting Bram Luyten <br...@mire.be>:

> Hi Ying,
>
> just an off-list reply here because I'm still in the dark concerning the
> issue you're experiencing.
>
> Could you post some more extensive log files?
>
> Furthermore, when you're starting up DSpace, do you see strange things in
> your logs concerning SOLR/Lucene versions?
>
> Trying to figure out whether your problem is related to what I was seeing
> here:
> https://jira.duraspace.org/browse/DS-1489
>
> Bram
>
> --
> [image: logo]
> *Bram Luyten* *@mire*
> *2888 Loker Avenue East, Suite 315, Carlsbad, CA. 92010*
> *Esperantolaan 4, Heverlee 3001, Belgium*
>
> <http://www.atmire.com/>www.atmire.com<http://atmire.com/website/?q=services&utm_source=emailfooter&utm_medium=email&utm_campaign=braml>

>> ------------------------------------------------------------------------------
>> Everyone hates slow websites. So do we.
>> Make your web apps faster with AppDynamics
>> Download AppDynamics Lite for free today:
>> http://p.sf.net/sfu/appdyn_d2d_feb
>> _______________________________________________
>> DSpace-tech mailing list
>> DSpac...@lists.sourceforge.net
>> https://lists.sourceforge.net/lists/listinfo/dspace-tech
>> List Etiquette:
>> https://wiki.duraspace.org/display/DSPACE/Mailing+List+Etiquette
>>
>

Ying Jin
Application Programmer
Center for Digital Scholarship
Email ying...@rice.edu
Phone 713-348-8082

Ying Jin

unread,

Aug 26, 2015, 10:34:36 AM8/26/15

to Bram Luyten, dspace-tech@lists.sourceforge.net Tech

Hi Bram,

Here is my dspace log with rootCategory and logger.org.dspace in DEBUG mode. The log is from the moment I clicked on the submit button until I got the internal server error. I also attached the Cocoon log which has the PageNotFound error below.

Thanks,

Ying

===========================================

Dspace Log

===========================================

2013-03-01 09:38:22,778 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:38:22,782 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from eperson where eperson_id = ? " with parameters: 18

2013-03-01 09:38:22,782 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:22,782 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:22,783 DEBUG org.dspace.authenticate.IPAuthentication @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:authenticated:special_groups=

2013-03-01 09:38:22,783 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/2946

2013-03-01 09:38:22,783 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: 47

2013-03-01 09:38:22,784 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_collection:collection_id=47

2013-03-01 09:38:22,784 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 66795

2013-03-01 09:38:22,784 DEBUG org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_bitstream:bitstream_id=66795

2013-03-01 09:38:22,784 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: -1

2013-03-01 09:38:22,784 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_bitstream_format:not_found,bitstream_format_id=-1

2013-03-01 09:38:22,784 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where short_description = ? " with parameters: Unknown

2013-03-01 09:38:22,784 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_bitstream:bitstream_format_id=1

2013-03-01 09:38:22,784 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 1

2013-03-01 09:38:22,785 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 77

2013-03-01 09:38:22,785 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,47

2013-03-01 09:38:22,785 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/2946 to collection 47

2013-03-01 09:38:22,789 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:38:22,791 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/1/handle/1911/2946/submit/43071a8c52041f8a4413121919574c7f61676e2a.continue

2013-03-01 09:38:22,794 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/2/handle/1911/2946/submit/43071a8c52041f8a4413121919574c7f61676e2a.continue

2013-03-01 09:38:22,797 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 47

2013-03-01 09:38:22,797 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,2

2013-03-01 09:38:22,798 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 105

2013-03-01 09:38:22,798 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 2

2013-03-01 09:38:22,798 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:22,798 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:22,799 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/3/handle/1911/2946/submit/43071a8c52041f8a4413121919574c7f61676e2a.continue

2013-03-01 09:38:22,803 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from workspaceitem where workspace_item_id = ? " with parameters: 63299

2013-03-01 09:38:22,803 DEBUG org.dspace.content.WorkspaceItem @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_workspace_item:workspace_item_id=63299

2013-03-01 09:38:22,803 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 63325

2013-03-01 09:38:22,803 DEBUG org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:ip_addr=168.7.27.136:find_item:item_id=63325

2013-03-01 09:38:22,803 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,63325

2013-03-01 09:38:22,804 DEBUG org.dspace.app.util.SubmissionInfo @ Loading Submission Config information

2013-03-01 09:38:22,804 DEBUG org.dspace.app.util.SubmissionInfo @ Found Submission Config in session cache!

2013-03-01 09:38:22,804 DEBUG org.dspace.app.util.SubmissionInfo @ Loading Progress Bar Info

2013-03-01 09:38:22,804 DEBUG org.dspace.app.util.SubmissionInfo @ Found Progress Bar Info in cache: 7 pages to display in progress bar

2013-03-01 09:38:22,805 INFO org.dspace.submit.step.LicenseStep @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:accept_license:workspace_item_id63299

2013-03-01 09:38:22,805 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, item2bundle WHERE item2bundle.bundle_id=bundle.bundle_id AND item2bundle.item_id= ? " with parameters: 63325

2013-03-01 09:38:22,805 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 120359

2013-03-01 09:38:22,806 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 2

2013-03-01 09:38:22,806 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream_format:bitstream_format_id=2

2013-03-01 09:38:22,806 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 2

2013-03-01 09:38:22,806 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 120347

2013-03-01 09:38:22,807 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 3

2013-03-01 09:38:22,807 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream_format:bitstream_format_id=3

2013-03-01 09:38:22,807 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 3

2013-03-01 09:38:22,807 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:22,807 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:22,807 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection_id FROM collection WHERE template_item_id = ?" with parameters: 63325

2013-03-01 09:38:22,808 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:22,808 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:22,808 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:remove_bundle:item_id=63325,bundle_id=120359

2013-03-01 09:38:22,808 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM item2bundle WHERE item_id= ? AND bundle_id= ? " with parameters: 63325,120359

2013-03-01 09:38:22,822 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM item2bundle WHERE bundle_id= ? " with parameters: 120359

2013-03-01 09:38:22,823 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:22,965 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:22,967 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:22,968 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:22,969 INFO org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:delete_bundle:bundle_id=120359

2013-03-01 09:38:22,969 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 120359

2013-03-01 09:38:22,970 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:22,970 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:22,971 INFO org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:remove_bitstream:bundle_id=120359,bitstream_id=213470

2013-03-01 09:38:22,971 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 120359

2013-03-01 09:38:22,971 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM bundle2bitstream WHERE bundle_id= ? AND bitstream_id= ? " with parameters: 120359,213470

2013-03-01 09:38:22,989 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM bundle2bitstream WHERE bitstream_id= ? " with parameters: 213470

2013-03-01 09:38:22,990 INFO org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:delete_bitstream:bitstream_id=213470

2013-03-01 09:38:22,990 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 0,213470

2013-03-01 09:38:22,990 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update bundle set primary_bitstream_id = Null where primary_bitstream_id = ? " with parameters: 213470

2013-03-01 09:38:23,025 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update Bundle set primary_bitstream_id=null where primary_bitstream_id = ? " with parameters: 213470

2013-03-01 09:38:23,026 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update Bitstream set deleted = '1' where bitstream_id = ? " with parameters: 213470

2013-03-01 09:38:23,026 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 1,120359

2013-03-01 09:38:23,027 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "delete from bundle where bundle_id = ? " with parameters: 120359

2013-03-01 09:38:23,028 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,029 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,029 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection_id FROM collection WHERE template_item_id = ?" with parameters: 63325

2013-03-01 09:38:23,029 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,029 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,030 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO bundle ( primary_bitstream_id,name,bundle_id) VALUES ( ?,?,getnextid('bundle')) RETURNING bundle_id"

2013-03-01 09:38:23,051 INFO org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:create_bundle:bundle_id=120364

2013-03-01 09:38:23,052 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 120364

2013-03-01 09:38:23,052 INFO org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_bundle:bundle_id=120364

2013-03-01 09:38:23,052 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update bundle set primary_bitstream_id = ?, name = ? where bundle_id = ?"

2013-03-01 09:38:23,053 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,053 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,053 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection_id FROM collection WHERE template_item_id = ?" with parameters: 63325

2013-03-01 09:38:23,054 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,054 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,054 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:add_bundle:item_id=63325,bundle_id=120364

2013-03-01 09:38:23,054 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 2,63325

2013-03-01 09:38:23,055 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,056 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,057 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,057 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,058 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,058 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,059 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,060 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,077 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO item2bundle ( id,item_id,bundle_id) VALUES ( getnextid('item2bundle'),?,?) RETURNING id"

2013-03-01 09:38:23,116 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 120364

2013-03-01 09:38:23,117 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,117 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,117 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,118 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,119 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO bitstream ( size_bytes,bitstream_format_id,checksum,deleted,sequence_id,checksum_algorithm,bitstream_id,source,description,name,internal_id,store_number,user_format_description) VALUES ( ?,?,?,?,?,?,getnextid('bitstream'),?,?,?,?,?,?) RETURNING bitstream_id"

2013-03-01 09:38:23,149 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Local filename for 100365268392261427659755012455239782235 is /server/data/dspace/assetstore/10/03/65/100365268392261427659755012455239782235

2013-03-01 09:38:23,191 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update bitstream set size_bytes = ?, bitstream_format_id = ?, checksum = ?, deleted = ?, sequence_id = ?, checksum_algorithm = ?, source = ?, description = ?, name = ?, internal_id = ?, store_number = ?, user_format_description = ? where bitstream_id = ?"

2013-03-01 09:38:23,192 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Stored bitstream 213475 in file /server/data/dspace/assetstore/10/03/65/100365268392261427659755012455239782235

2013-03-01 09:38:23,192 INFO org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:create_bitstream:bitstream_id=213475

2013-03-01 09:38:23,192 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 213475

2013-03-01 09:38:23,193 DEBUG org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream:bitstream_id=213475

2013-03-01 09:38:23,193 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: -1

2013-03-01 09:38:23,193 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream_format:not_found,bitstream_format_id=-1

2013-03-01 09:38:23,193 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where short_description = ? " with parameters: Unknown

2013-03-01 09:38:23,193 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream:bitstream_format_id=1

2013-03-01 09:38:23,193 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where short_description = ? " with parameters: Unknown

2013-03-01 09:38:23,193 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream:bitstream_format_id=1

2013-03-01 09:38:23,194 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 120364

2013-03-01 09:38:23,194 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,195 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,195 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,195 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,195 INFO org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:add_bitstream:bundle_id=120364,bitstream_id=213475

2013-03-01 09:38:23,195 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 1,120364

2013-03-01 09:38:23,196 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,197 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,197 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,198 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,198 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,199 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,199 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,200 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,201 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT MAX(bitstream_order) as max_value FROM bundle2bitstream WHERE bundle_id=?" with parameters: 120364

2013-03-01 09:38:23,252 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO bundle2bitstream ( id,bitstream_id,bundle_id,bitstream_order) VALUES ( getnextid('bundle2bitstream'),?,?,?) RETURNING id"

2013-03-01 09:38:23,289 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,289 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,289 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection_id FROM collection WHERE template_item_id = ?" with parameters: 63325

2013-03-01 09:38:23,289 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,289 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,290 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:add_bundle:item_id=63325,bundle_id=120364

2013-03-01 09:38:23,290 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where short_description = ? " with parameters: License

2013-03-01 09:38:23,290 DEBUG org.dspace.content.BitstreamFormat @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream:bitstream_format_id=2

2013-03-01 09:38:23,290 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,290 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,290 INFO org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_bitstream:bitstream_id=213475

2013-03-01 09:38:23,291 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update bitstream set bitstream_format_id = ?, source = ?, name = ? where bitstream_id = ?"

2013-03-01 09:38:23,293 DEBUG org.dspace.event.BasicDispatcher @ Processing queue of 17 events.

2013-03-01 09:38:23,294 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,294 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=4, result=false

2013-03-01 09:38:23,294 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=4, result=true

2013-03-01 09:38:23,294 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=REMOVE, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120359, TimeStamp=1362152302822, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,294 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bundle where bundle_id = ? " with parameters: 120359

2013-03-01 09:38:23,295 DEBUG org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bundle:not_found,bundle_id=120359

2013-03-01 09:38:23,295 WARN org.dspace.search.SearchConsumer @ REMOVE event, could not get object for BUNDLE id=120359, perhaps it has been deleted.

2013-03-01 09:38:23,295 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=4, result=true

2013-03-01 09:38:23,295 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=REMOVE, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120359, TimeStamp=1362152302822, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,295 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=REMOVE, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120359, TimeStamp=1362152302822, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,295 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=4, result=false

2013-03-01 09:38:23,295 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,295 DEBUG org.dspace.event.Event @ Filtering event: eventType=32, subjectType=2, result=false

2013-03-01 09:38:23,296 DEBUG org.dspace.event.Event @ Filtering event: eventType=32, subjectType=2, result=true

2013-03-01 09:38:23,296 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=DELETE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152302969, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,296 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bundle where bundle_id = ? " with parameters: 120359

2013-03-01 09:38:23,296 DEBUG org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bundle:not_found,bundle_id=120359

2013-03-01 09:38:23,296 DEBUG org.dspace.event.Event @ Filtering event: eventType=32, subjectType=2, result=true

2013-03-01 09:38:23,296 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=DELETE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152302969, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,296 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=DELETE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152302969, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,296 DEBUG org.dspace.browse.BrowseConsumer @ consume() ignoring event: org.dspace.event.Event(eventType=DELETE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152302969, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,296 DEBUG org.dspace.event.Event @ Filtering event: eventType=32, subjectType=2, result=false

2013-03-01 09:38:23,296 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,296 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=2, result=false

2013-03-01 09:38:23,296 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=2, result=true

2013-03-01 09:38:23,296 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=REMOVE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=BITSTREAM, ObjectID=213470, TimeStamp=1362152302971, dispatcher=1544803905, detail="2", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,296 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bundle where bundle_id = ? " with parameters: 120359

2013-03-01 09:38:23,297 DEBUG org.dspace.content.Bundle @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bundle:not_found,bundle_id=120359

2013-03-01 09:38:23,297 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 213470

2013-03-01 09:38:23,297 DEBUG org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_bitstream:bitstream_id=213470

2013-03-01 09:38:23,297 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=2, result=true

2013-03-01 09:38:23,297 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=REMOVE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=BITSTREAM, ObjectID=213470, TimeStamp=1362152302971, dispatcher=1544803905, detail="2", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,297 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=REMOVE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=BITSTREAM, ObjectID=213470, TimeStamp=1362152302971, dispatcher=1544803905, detail="2", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,297 DEBUG org.dspace.browse.BrowseConsumer @ consume() ignoring event: org.dspace.event.Event(eventType=REMOVE, SubjectType=BUNDLE, SubjectID=120359, ObjectType=BITSTREAM, ObjectID=213470, TimeStamp=1362152302971, dispatcher=1544803905, detail="2", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,297 DEBUG org.dspace.event.Event @ Filtering event: eventType=16, subjectType=2, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=32, subjectType=1, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=1, subjectType=2, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=1, subjectType=2, result=true

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=CREATE, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303051, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=1, subjectType=2, result=true

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=CREATE, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303051, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=CREATE, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303051, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.browse.BrowseConsumer @ consume() ignoring event: org.dspace.event.Event(eventType=CREATE, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303051, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=1, subjectType=2, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=2, result=false

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=2, result=true

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=MODIFY_METADATA, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303052, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=2, result=true

2013-03-01 09:38:23,298 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=MODIFY_METADATA, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303052, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=MODIFY_METADATA, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303052, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.browse.BrowseConsumer @ consume() ignoring event: org.dspace.event.Event(eventType=MODIFY_METADATA, SubjectType=BUNDLE, SubjectID=120364, ObjectType=(Unknown), ObjectID=-1, TimeStamp=1362152303052, dispatcher=1544803905, detail=[null], transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,298 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=2, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=2, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=4, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=4, result=true

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=ADD, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120364, TimeStamp=1362152303116, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.search.SearchConsumer @ consume() adding event to update queue: org.dspace.event.Event(eventType=ADD, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120364, TimeStamp=1362152303116, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=4, result=true

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=ADD, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120364, TimeStamp=1362152303116, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=ADD, SubjectType=ITEM, SubjectID=63325, ObjectType=BUNDLE, ObjectID=120364, TimeStamp=1362152303116, dispatcher=1544803905, detail="LICENSE", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=4, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=1, subjectType=1, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=2, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=2, result=true

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "search": org.dspace.event.Event(eventType=ADD, SubjectType=BUNDLE, SubjectID=120364, ObjectType=BITSTREAM, ObjectID=213475, TimeStamp=1362152303195, dispatcher=1544803905, detail="-1", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=2, result=true

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Sending event to "browse": org.dspace.event.Event(eventType=ADD, SubjectType=BUNDLE, SubjectID=120364, ObjectType=BITSTREAM, ObjectID=213475, TimeStamp=1362152303195, dispatcher=1544803905, detail="-1", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.browse.BrowseConsumer @ consume() evaluating event: org.dspace.event.Event(eventType=ADD, SubjectType=BUNDLE, SubjectID=120364, ObjectType=BITSTREAM, ObjectID=213475, TimeStamp=1362152303195, dispatcher=1544803905, detail="-1", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.browse.BrowseConsumer @ consume() ignoring event: org.dspace.event.Event(eventType=ADD, SubjectType=BUNDLE, SubjectID=120364, ObjectType=BITSTREAM, ObjectID=213475, TimeStamp=1362152303195, dispatcher=1544803905, detail="-1", transactionID="TX144510958812601050471801279592715344468")

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=8, subjectType=2, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,299 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,299 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,300 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,300 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,300 DEBUG org.dspace.event.Event @ Filtering event: eventType=2, subjectType=1, result=false

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Iterating over 5 consumers...

2013-03-01 09:38:23,300 DEBUG org.dspace.event.Event @ Filtering event: eventType=4, subjectType=1, result=false

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Calling end for consumer "versioning"

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Calling end for consumer "search"

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Calling end for consumer "browse"

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Calling end for consumer "eperson"

2013-03-01 09:38:23,300 DEBUG org.dspace.event.BasicDispatcher @ Calling end for consumer "harvester"

2013-03-01 09:38:23,304 INFO org.dspace.submit.step.CompleteStep @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:submission_complete:Completed submission with id=63299

2013-03-01 09:38:23,398 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO cwf_workflowitem ( collection_id,multiple_titles,item_id,workflowitem_id,multiple_files,published_before) VALUES ( ?,?,?,getnextid('cwf_workflowitem'),?,?) RETURNING workflowitem_id"

2013-03-01 09:38:23,487 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: -1

2013-03-01 09:38:23,488 DEBUG org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_item:not_found,item_id=-1

2013-03-01 09:38:23,488 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,488 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,489 INFO org.dspace.xmlworkflow.storedcomponents.XmlWorkflowItem @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_workflow_item:workflowitem_id=177

2013-03-01 09:38:23,489 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,489 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,489 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection_id FROM collection WHERE template_item_id = ?" with parameters: 63325

2013-03-01 09:38:23,489 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: -1

2013-03-01 09:38:23,490 DEBUG org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:find_collection:not_found,collection_id=-1

2013-03-01 09:38:23,490 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,490 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM group2groupcache WHERE child_id= ? OR child_id= ? OR child_id= ? OR child_id= ? " with parameters: 0,103,1,105

2013-03-01 09:38:23,490 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_item:item_id=63325

2013-03-01 09:38:23,490 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM epersongroup2eperson WHERE eperson_id= ?" with parameters: 18

2013-03-01 09:38:23,491 INFO org.dspace.content.Bitstream @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_bitstream:bitstream_id=213475

2013-03-01 09:38:23,491 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update bitstream set bitstream_format_id = ?, sequence_id = ?, source = ?, name = ? where bitstream_id = ?"

2013-03-01 09:38:23,491 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update item set last_modified = ? where item_id = ?"

2013-03-01 09:38:23,492 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update cwf_workflowitem set collection_id = ?, multiple_titles = ?, item_id = ?, multiple_files = ?, published_before = ? where workflowitem_id = ?"

2013-03-01 09:38:23,494 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "UPDATE item SET last_modified = ? WHERE item_id= ? " with parameters: 2013-03-01 09:38:23.494,63325

2013-03-01 09:38:23,495 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND eperson_id= ? " with parameters: 2,63325,18

2013-03-01 09:38:23,527 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND eperson_id= ? " with parameters: 1,120347,18

2013-03-01 09:38:23,528 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND eperson_id= ? " with parameters: 1,120364,18

2013-03-01 09:38:23,529 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND eperson_id= ? " with parameters: 0,213475,18

2013-03-01 09:38:23,529 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 2,63325

2013-03-01 09:38:23,530 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,530 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "UPDATE item SET last_modified = ? WHERE item_id= ? " with parameters: 2013-03-01 09:38:23.53,63325

2013-03-01 09:38:23,531 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,532 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "UPDATE item SET last_modified = ? WHERE item_id= ? " with parameters: 2013-03-01 09:38:23.532,63325

2013-03-01 09:38:23,533 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,533 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,534 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,534 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,535 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,536 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,537 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:23,537 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:23,538 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? " with parameters: 2,63325

2013-03-01 09:38:23,557 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_collectionrole WHERE collection_id=47 AND role_id= ? " with parameters: reviewer

2013-03-01 09:38:23,616 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_collectionrole WHERE collection_id=47 AND role_id= ? " with parameters: editor

2013-03-01 09:38:23,637 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_collectionrole WHERE collection_id=47 AND role_id= ? " with parameters: finaleditor

2013-03-01 09:38:23,639 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_workflowitemrole WHERE workflowitem_id= ? " with parameters: 177

2013-03-01 09:38:23,664 INFO org.dspace.xmlworkflow.XmlWorkflowManager @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:archive_item:workflow_item_id=177item_id=63325collection_id=47

2013-03-01 09:38:23,666 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,63325

2013-03-01 09:38:23,666 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from versionitem where item_id = ? " with parameters: 63325

2013-03-01 09:38:23,727 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO handle ( resource_id,handle,resource_type_id,handle_id) VALUES ( ?,?,?,getnextid('handle')) RETURNING handle_id"

2013-03-01 09:38:23,778 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update handle set resource_id = ?, handle = ?, resource_type_id = ? where handle_id = ?"

2013-03-01 09:38:23,779 DEBUG org.dspace.identifier.VersionedHandleIdentifierProvider @ Created new handle for ITEM 1911/64788

2013-03-01 09:38:23,779 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from versionitem where item_id = ? " with parameters: 63325

2013-03-01 09:38:23,780 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,63325

2013-03-01 09:38:23,780 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM MetadataValue WHERE item_id= ? ORDER BY metadata_field_id, place" with parameters: 63325

2013-03-01 09:38:23,781 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_item:item_id=63325

2013-03-01 09:38:23,781 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT mfr.* FROM MetadataFieldRegistry mfr, MetadataSchemaRegistry msr where mfr.metadata_schema_id= msr.metadata_schema_id ORDER BY msr.short_id, mfr.element, mfr.qualifier" with parameters:

2013-03-01 09:38:23,784 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM MetadataValue WHERE item_id= ? ORDER BY metadata_field_id, place" with parameters: 63325

2013-03-01 09:38:23,786 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO metadatavalue ( authority,metadata_field_id,text_lang,text_value,item_id,metadata_value_id,confidence,place) VALUES ( ?,?,?,?,?,getnextid('metadatavalue'),?,?) RETURNING metadata_value_id"

2013-03-01 09:38:23,887 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update item set last_modified = ? where item_id = ?"

2013-03-01 09:38:23,910 INFO org.dspace.content.Collection @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:add_item:collection_id=47,item_id=63325

2013-03-01 09:38:23,928 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO collection2item ( id,collection_id,item_id) VALUES ( getnextid('collection2item'),?,?) RETURNING id"

2013-03-01 09:38:23,976 INFO org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:update_item:item_id=63325

2013-03-01 09:38:23,976 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM MetadataValue WHERE item_id= ? ORDER BY metadata_field_id, place" with parameters: 63325

2013-03-01 09:38:23,977 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO metadatavalue ( authority,metadata_field_id,text_lang,text_value,item_id,metadata_value_id,confidence,place) VALUES ( ?,?,?,?,?,getnextid('metadatavalue'),?,?) RETURNING metadata_value_id"

2013-03-01 09:38:23,989 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO metadatavalue ( authority,metadata_field_id,text_lang,text_value,item_id,metadata_value_id,confidence,place) VALUES ( ?,?,?,?,?,getnextid('metadatavalue'),?,?) RETURNING metadata_value_id"

2013-03-01 09:38:23,992 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO metadatavalue ( authority,metadata_field_id,text_lang,text_value,item_id,metadata_value_id,confidence,place) VALUES ( ?,?,?,?,?,getnextid('metadatavalue'),?,?) RETURNING metadata_value_id"

2013-03-01 09:38:24,001 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update item set last_modified = ?, owning_collection = ?, in_archive = ? where item_id = ?"

2013-03-01 09:38:24,002 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_workflowitemrole WHERE workflowitem_id= ? " with parameters: 177

2013-03-01 09:38:24,002 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_pooltask WHERE workflowitem_id= 177" with parameters:

2013-03-01 09:38:24,025 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM cwf_claimtask WHERE workflowitem_id= 177" with parameters:

2013-03-01 09:38:24,027 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "delete from cwf_workflowitem where workflowitem_id = ? " with parameters: 177

2013-03-01 09:38:24,031 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 3,47,10

2013-03-01 09:38:24,056 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 2,63325,TYPE_SUBMISSION

2013-03-01 09:38:24,057 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 2,63325,TYPE_WORKFLOW

2013-03-01 09:38:24,058 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND epersongroup_id=? AND action_id=? AND policy_id <> ? " with parameters: 2,63325,0,0,165339

2013-03-01 09:38:24,059 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:24,059 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 0

2013-03-01 09:38:24,060 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "UPDATE item SET last_modified = ? WHERE item_id= ? " with parameters: 2013-03-01 09:38:24.06,63325

2013-03-01 09:38:24,061 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:24,088 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "UPDATE item SET last_modified = ? WHERE item_id= ? " with parameters: 2013-03-01 09:38:24.088,63325

2013-03-01 09:38:24,089 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 3,47,9

2013-03-01 09:38:24,090 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 1,120347,TYPE_SUBMISSION

2013-03-01 09:38:24,091 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 1,120347,TYPE_WORKFLOW

2013-03-01 09:38:24,091 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND epersongroup_id=? AND action_id=? AND policy_id <> ? " with parameters: 1,120347,0,0,165340

2013-03-01 09:38:24,092 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:24,092 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:24,093 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 0,213458,TYPE_SUBMISSION

2013-03-01 09:38:24,093 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND epersongroup_id=? AND action_id=? AND policy_id <> ? " with parameters: 0,213458,0,0,165340

2013-03-01 09:38:24,094 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:24,094 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:24,094 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 1,120364,TYPE_SUBMISSION

2013-03-01 09:38:24,095 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 1,120364,TYPE_WORKFLOW

2013-03-01 09:38:24,095 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND epersongroup_id=? AND action_id=? AND policy_id <> ? " with parameters: 1,120364,0,0,165340

2013-03-01 09:38:24,095 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:24,096 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:24,096 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "DELETE FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND rptype=? " with parameters: 0,213475,TYPE_SUBMISSION

2013-03-01 09:38:24,097 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND epersongroup_id=? AND action_id=? AND policy_id <> ? " with parameters: 0,213475,0,0,165340

2013-03-01 09:38:24,097 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "INSERT INTO resourcepolicy ( rpname,action_id,resource_id,end_date,resource_type_id,rpdescription,rptype,start_date,policy_id,eperson_id,epersongroup_id) VALUES ( ?,?,?,?,?,?,?,?,getnextid('resourcepolicy'),?,?) RETURNING policy_id"

2013-03-01 09:38:24,098 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "update resourcepolicy set rpname = ?, action_id = ?, resource_id = ?, end_date = ?, resource_type_id = ?, rpdescription = ?, rptype = ?, start_date = ?, eperson_id = ?, epersongroup_id = ? where policy_id = ?"

2013-03-01 09:38:24,098 DEBUG org.dspace.content.Item @ ying...@rice.edu:session_id=148670CD8CA0C63850AB77C0F44368A9:item_inheritCollectionDefaultPolicies:item_id=63325

2013-03-01 09:38:24,098 ERROR org.dspace.core.I18nUtil @ No language specified for EPerson 18

2013-03-01 09:38:24,129 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,63325

2013-03-01 09:39:06,304 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:39:06,309 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=92CE28A155A901F72CAF105CFAA92A69:authenticated:special_groups=

2013-03-01 09:39:06,309 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/64051

2013-03-01 09:39:06,309 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 64148

2013-03-01 09:39:06,310 DEBUG org.dspace.content.Item @ anonymous:session_id=92CE28A155A901F72CAF105CFAA92A69:ip_addr=72.37.171.140:find_item:item_id=64148

2013-03-01 09:39:06,310 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,64148

2013-03-01 09:39:06,310 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/64051 to item 64148

2013-03-01 09:39:06,310 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, item2bundle WHERE item2bundle.bundle_id=bundle.bundle_id AND item2bundle.item_id= ? " with parameters: 64148

2013-03-01 09:39:06,311 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 111516

2013-03-01 09:39:06,312 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 3

2013-03-01 09:39:06,312 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=92CE28A155A901F72CAF105CFAA92A69:ip_addr=72.37.171.140:find_bitstream_format:bitstream_format_id=3

2013-03-01 09:39:06,312 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 3

2013-03-01 09:39:06,312 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,204127,0

2013-03-01 09:39:06,313 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,204127,0

2013-03-01 09:39:06,313 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 204127

2013-03-01 09:39:06,313 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Local filename for 90805566177301746971183707861512450423 is /server/data/dspace/assetstore/90/80/55/90805566177301746971183707861512450423

2013-03-01 09:39:06,330 INFO org.dspace.usage.LoggerUsageEventListener @ anonymous:session_id=92CE28A155A901F72CAF105CFAA92A69:ip_addr=72.37.171.140:view_bitstream:bitstream_id=204127

2013-03-01 09:39:06,435 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 204127

2013-03-01 09:39:06,436 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 111516

2013-03-01 09:39:06,438 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection.* FROM collection, collection2item WHERE collection2item.collection_id=collection.collection_id AND collection2item.item_id= ? " with parameters: 64148

2013-03-01 09:39:06,439 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,90

2013-03-01 09:39:06,439 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 90

2013-03-01 09:39:06,439 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,2

2013-03-01 09:39:06,440 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 105

2013-03-01 09:39:06,440 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 2

2013-03-01 09:39:06,440 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 204127

2013-03-01 09:39:06,441 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ HttpConnectionManager.getConnection: config = HostConfiguration[host=http://localhost:8080], timeout = 0

2013-03-01 09:39:06,441 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Getting free connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:06,442 DEBUG org.apache.commons.httpclient.HttpConnection @ Connection is stale, closing...

2013-03-01 09:39:06,443 DEBUG org.apache.commons.httpclient.HttpConnection @ Open connection to localhost:8080

2013-03-01 09:39:06,443 DEBUG httpclient.wire.header @ >> "POST /solr/statistics/update?wt=javabin&version=2 HTTP/1.1[\r][\n]"

2013-03-01 09:39:06,444 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Adding Host request header

2013-03-01 09:39:06,444 DEBUG httpclient.wire.header @ >> "User-Agent: Solr[org.apache.solr.client.solrj.impl.CommonsHttpSolrServer] 1.0[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.header @ >> "Host: localhost:8080[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.header @ >> "Transfer-Encoding: chunked[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.header @ >> "Content-Type: application/xml; charset=UTF-8[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.header @ >> "[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.content @ >> "3f5[\r][\n]"

2013-03-01 09:39:06,444 DEBUG httpclient.wire.content @ >> "<add><doc boost="1.0"><field name="ip">72.37.171.140</field><field name="referrer">http://www.google.com/search?q=pipeline+expenditures&hl=en&nfpr=&spell=1&sa=X&ei=dMswUeLfLoqV0QHzvICwDQ&ved=0CBcQvwU</field><field name="dns">149ob.scansafe.net.</field><field name="continent">NA</field><field name="countryCode">US</field><field name="latitude">38.0</field><field name="longitude">-97.0</field><field name="isBot">false</field><field name="userAgent">Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 5.1; .NET CLR 1.1.4322; .NET CLR 2.0.50727; .NET CLR 3.0.04506.648; .NET CLR 3.5.21022; MS-RTC LM 8; .NET CLR 3.0.4506.2152; .NET CLR 3.5.30729; .NET4.0C; .NET4.0E; BRI/2)</field><field name="id">204127</field><field name="type">0</field><field name="owningItem">64148</field><field name="owningColl">90</field><field name="owningComm">2</field><field name="time">2013-03-01T09:39:06.440Z</field><field name="bundleName">ORIGINAL</field><field name="statistics_type">view</field></doc></add>"

2013-03-01 09:39:06,445 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:06,445 DEBUG httpclient.wire.content @ >> "0"

2013-03-01 09:39:06,445 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:06,445 DEBUG org.apache.commons.httpclient.methods.EntityEnclosingMethod @ Request body sent

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "HTTP/1.1 200 OK[\r][\n]"

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "Server: Apache-Coyote/1.1[\r][\n]"

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "Content-Type: application/octet-stream[\r][\n]"

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "Content-Length: 40[\r][\n]"

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "Date: Fri, 01 Mar 2013 15:39:06 GMT[\r][\n]"

2013-03-01 09:39:06,448 DEBUG httpclient.wire.header @ << "[\r][\n]"

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Default charset used: ISO-8859-1

2013-03-01 09:39:06,448 DEBUG httpclient.wire.content @ << "[0x1][0xa1][0xe0].responseHeader[0xa2][0xe0]&status[0x6][0x0][0x0][0x0][0x0][0xe0]%QTimeA"

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Resorting to protocol version default close connection policy

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Should NOT close connection, using HTTP/1.1

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.HttpConnection @ Releasing connection back to connection manager.

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Freeing connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.util.IdleConnectionHandler @ Adding connection at: 1362152346448

2013-03-01 09:39:06,448 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Notifying no-one, there are no waiting threads

2013-03-01 09:39:06,448 ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid version (expected 2, but 1) or the data in not in 'javabin' format

2013-03-01 09:39:11,349 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:39:11,355 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:authenticated:special_groups=

2013-03-01 09:39:11,355 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/3850

2013-03-01 09:39:11,355 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 5792

2013-03-01 09:39:11,356 DEBUG org.dspace.content.Item @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:ip_addr=66.249.74.209:find_item:item_id=5792

2013-03-01 09:39:11,356 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,5792

2013-03-01 09:39:11,372 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/3850 to item 5792

2013-03-01 09:39:11,372 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, item2bundle WHERE item2bundle.bundle_id=bundle.bundle_id AND item2bundle.item_id= ? " with parameters: 5792

2013-03-01 09:39:11,373 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 69180

2013-03-01 09:39:11,381 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 11

2013-03-01 09:39:11,381 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:ip_addr=66.249.74.209:find_bitstream_format:bitstream_format_id=11

2013-03-01 09:39:11,381 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 11

2013-03-01 09:39:11,381 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 10857

2013-03-01 09:39:11,382 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 3

2013-03-01 09:39:11,382 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:ip_addr=66.249.74.209:find_bitstream_format:bitstream_format_id=3

2013-03-01 09:39:11,382 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 3

2013-03-01 09:39:11,382 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 11608

2013-03-01 09:39:11,392 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 5

2013-03-01 09:39:11,392 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:ip_addr=66.249.74.209:find_bitstream_format:bitstream_format_id=5

2013-03-01 09:39:11,392 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 5

2013-03-01 09:39:11,393 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,153162,0

2013-03-01 09:39:11,393 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 153162

2013-03-01 09:39:11,394 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Local filename for 145124999854719217061979751771961869785 is /server/data/dspace/assetstore/14/51/24/145124999854719217061979751771961869785

2013-03-01 09:39:11,419 INFO org.dspace.usage.LoggerUsageEventListener @ anonymous:session_id=71DB1B18981994372DD5E83BF6C83E83:ip_addr=66.249.74.209:view_bitstream:bitstream_id=153162

2013-03-01 09:39:11,421 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 153162

2013-03-01 09:39:11,422 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 69180

2013-03-01 09:39:11,423 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection.* FROM collection, collection2item WHERE collection2item.collection_id=collection.collection_id AND collection2item.item_id= ? " with parameters: 5792

2013-03-01 09:39:11,424 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 85

2013-03-01 09:39:11,424 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,56

2013-03-01 09:39:11,424 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 56

2013-03-01 09:39:11,425 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,2

2013-03-01 09:39:11,425 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 105

2013-03-01 09:39:11,425 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 2

2013-03-01 09:39:11,426 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 153162

2013-03-01 09:39:11,426 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ HttpConnectionManager.getConnection: config = HostConfiguration[host=http://localhost:8080], timeout = 0

2013-03-01 09:39:11,426 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Getting free connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:11,428 DEBUG httpclient.wire.header @ >> "POST /solr/statistics/update?wt=javabin&version=2 HTTP/1.1[\r][\n]"

2013-03-01 09:39:11,428 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Adding Host request header

2013-03-01 09:39:11,428 DEBUG httpclient.wire.header @ >> "User-Agent: Solr[org.apache.solr.client.solrj.impl.CommonsHttpSolrServer] 1.0[\r][\n]"

2013-03-01 09:39:11,428 DEBUG httpclient.wire.header @ >> "Host: localhost:8080[\r][\n]"

2013-03-01 09:39:11,428 DEBUG httpclient.wire.header @ >> "Transfer-Encoding: chunked[\r][\n]"

2013-03-01 09:39:11,428 DEBUG httpclient.wire.header @ >> "Content-Type: application/xml; charset=UTF-8[\r][\n]"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.header @ >> "[\r][\n]"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.content @ >> "2c3[\r][\n]"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.content @ >> "<add><doc boost="1.0"><field name="ip">66.249.74.209</field><field name="dns">crawl-66-249-74-209.googlebot.com.</field><field name="continent">NA</field><field name="countryCode">US</field><field name="city">Mountain View</field><field name="latitude">37.419205</field><field name="longitude">-122.0574</field><field name="isBot">false</field><field name="userAgent">Googlebot-Image/1.0</field><field name="id">153162</field><field name="type">0</field><field name="owningItem">5792</field><field name="owningColl">56</field><field name="owningComm">2</field><field name="time">2013-03-01T09:39:11.426Z</field><field name="bundleName">THUMBNAIL</field><field name="statistics_type">view</field></doc></add>"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.content @ >> "0"

2013-03-01 09:39:11,429 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:11,429 DEBUG org.apache.commons.httpclient.methods.EntityEnclosingMethod @ Request body sent

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "HTTP/1.1 200 OK[\r][\n]"

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "Server: Apache-Coyote/1.1[\r][\n]"

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "Content-Type: application/octet-stream[\r][\n]"

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "Content-Length: 40[\r][\n]"

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "Date: Fri, 01 Mar 2013 15:39:11 GMT[\r][\n]"

2013-03-01 09:39:11,432 DEBUG httpclient.wire.header @ << "[\r][\n]"

2013-03-01 09:39:11,432 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Default charset used: ISO-8859-1

2013-03-01 09:39:11,432 DEBUG httpclient.wire.content @ << "[0x1][0xa1][0xe0].responseHeader[0xa2][0xe0]&status[0x6][0x0][0x0][0x0][0x0][0xe0]%QTimeA"

2013-03-01 09:39:11,432 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Resorting to protocol version default close connection policy

2013-03-01 09:39:11,432 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Should NOT close connection, using HTTP/1.1

2013-03-01 09:39:11,432 DEBUG org.apache.commons.httpclient.HttpConnection @ Releasing connection back to connection manager.

2013-03-01 09:39:11,432 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Freeing connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:11,433 DEBUG org.apache.commons.httpclient.util.IdleConnectionHandler @ Adding connection at: 1362152351433

2013-03-01 09:39:11,433 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Notifying no-one, there are no waiting threads

2013-03-01 09:39:11,433 ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid version (expected 2, but 1) or the data in not in 'javabin' format

2013-03-01 09:39:49,359 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:39:49,364 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=6B43965E13450DBCF04E6B54F33D3DBC:authenticated:special_groups=

2013-03-01 09:39:49,364 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/58318

2013-03-01 09:39:49,365 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 59495

2013-03-01 09:39:49,365 DEBUG org.dspace.content.Item @ anonymous:session_id=6B43965E13450DBCF04E6B54F33D3DBC:ip_addr=66.249.74.209:find_item:item_id=59495

2013-03-01 09:39:49,365 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,59495

2013-03-01 09:39:49,365 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/58318 to item 59495

2013-03-01 09:39:49,365 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, item2bundle WHERE item2bundle.bundle_id=bundle.bundle_id AND item2bundle.item_id= ? " with parameters: 59495

2013-03-01 09:39:49,393 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 104497

2013-03-01 09:39:49,405 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 11

2013-03-01 09:39:49,405 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=6B43965E13450DBCF04E6B54F33D3DBC:ip_addr=66.249.74.209:find_bitstream_format:bitstream_format_id=11

2013-03-01 09:39:49,405 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 11

2013-03-01 09:39:49,405 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 100601

2013-03-01 09:39:49,423 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,193693,0

2013-03-01 09:39:49,451 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,193693,0

2013-03-01 09:39:49,451 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 193693

2013-03-01 09:39:49,451 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Local filename for 31131507138479621530655472187086292074 is /server/data/dspace/assetstore/31/13/15/31131507138479621530655472187086292074

2013-03-01 09:39:49,495 INFO org.dspace.usage.LoggerUsageEventListener @ anonymous:session_id=6B43965E13450DBCF04E6B54F33D3DBC:ip_addr=66.249.74.209:view_bitstream:bitstream_id=193693

2013-03-01 09:39:49,497 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 193693

2013-03-01 09:39:49,497 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 104497

2013-03-01 09:39:49,498 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection.* FROM collection, collection2item WHERE collection2item.collection_id=collection.collection_id AND collection2item.item_id= ? " with parameters: 59495

2013-03-01 09:39:49,499 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,83

2013-03-01 09:39:49,500 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 83

2013-03-01 09:39:49,500 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,30

2013-03-01 09:39:49,500 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 30

2013-03-01 09:39:49,501 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,29

2013-03-01 09:39:49,501 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 29

2013-03-01 09:39:49,502 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 29

2013-03-01 09:39:49,502 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 193693

2013-03-01 09:39:49,503 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ HttpConnectionManager.getConnection: config = HostConfiguration[host=http://localhost:8080], timeout = 0

2013-03-01 09:39:49,503 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Getting free connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:49,503 DEBUG org.apache.commons.httpclient.HttpConnection @ Connection is stale, closing...

2013-03-01 09:39:49,503 DEBUG org.apache.commons.httpclient.HttpConnection @ Open connection to localhost:8080

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "POST /solr/statistics/update?wt=javabin&version=2 HTTP/1.1[\r][\n]"

2013-03-01 09:39:49,504 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Adding Host request header

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "User-Agent: Solr[org.apache.solr.client.solrj.impl.CommonsHttpSolrServer] 1.0[\r][\n]"

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "Host: localhost:8080[\r][\n]"

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "Transfer-Encoding: chunked[\r][\n]"

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "Content-Type: application/xml; charset=UTF-8[\r][\n]"

2013-03-01 09:39:49,504 DEBUG httpclient.wire.header @ >> "[\r][\n]"

2013-03-01 09:39:49,505 DEBUG httpclient.wire.content @ >> "30b[\r][\n]"

2013-03-01 09:39:49,505 DEBUG httpclient.wire.content @ >> "<add><doc boost="1.0"><field name="ip">66.249.74.209</field><field name="dns">crawl-66-249-74-209.googlebot.com.</field><field name="continent">NA</field><field name="countryCode">US</field><field name="city">Mountain View</field><field name="latitude">37.419205</field><field name="longitude">-122.0574</field><field name="isBot">false</field><field name="userAgent">Googlebot-Image/1.0</field><field name="id">193693</field><field name="type">0</field><field name="owningItem">59495</field><field name="owningColl">83</field><field name="owningComm">30</field><field name="owningComm">29</field><field name="owningComm">29</field><field name="time">2013-03-01T09:39:49.502Z</field><field name="bundleName">THUMBNAIL</field><field name="statistics_type">view</field></doc></add>"

2013-03-01 09:39:49,505 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:49,505 DEBUG httpclient.wire.content @ >> "0"

2013-03-01 09:39:49,505 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:39:49,505 DEBUG org.apache.commons.httpclient.methods.EntityEnclosingMethod @ Request body sent

2013-03-01 09:39:49,507 DEBUG httpclient.wire.header @ << "HTTP/1.1 200 OK[\r][\n]"

2013-03-01 09:39:49,508 DEBUG httpclient.wire.header @ << "Server: Apache-Coyote/1.1[\r][\n]"

2013-03-01 09:39:49,508 DEBUG httpclient.wire.header @ << "Content-Type: application/octet-stream[\r][\n]"

2013-03-01 09:39:49,508 DEBUG httpclient.wire.header @ << "Content-Length: 40[\r][\n]"

2013-03-01 09:39:49,508 DEBUG httpclient.wire.header @ << "Date: Fri, 01 Mar 2013 15:39:49 GMT[\r][\n]"

2013-03-01 09:39:49,508 DEBUG httpclient.wire.header @ << "[\r][\n]"

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Default charset used: ISO-8859-1

2013-03-01 09:39:49,508 DEBUG httpclient.wire.content @ << "[0x1][0xa1][0xe0].responseHeader[0xa2][0xe0]&status[0x6][0x0][0x0][0x0][0x0][0xe0]%QTimeB"

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Resorting to protocol version default close connection policy

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Should NOT close connection, using HTTP/1.1

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.HttpConnection @ Releasing connection back to connection manager.

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Freeing connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.util.IdleConnectionHandler @ Adding connection at: 1362152389508

2013-03-01 09:39:49,508 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Notifying no-one, there are no waiting threads

2013-03-01 09:39:49,508 ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid version (expected 2, but 1) or the data in not in 'javabin' format

2013-03-01 09:40:11,805 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:40:11,811 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:authenticated:special_groups=

2013-03-01 09:40:11,811 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/64723

2013-03-01 09:40:11,811 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 64820

2013-03-01 09:40:11,811 DEBUG org.dspace.content.Item @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:ip_addr=206.190.94.226:find_item:item_id=64820

2013-03-01 09:40:11,812 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,64820

2013-03-01 09:40:11,812 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/64723 to item 64820

2013-03-01 09:40:11,812 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, item2bundle WHERE item2bundle.bundle_id=bundle.bundle_id AND item2bundle.item_id= ? " with parameters: 64820

2013-03-01 09:40:11,858 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 118315

2013-03-01 09:40:11,859 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 11

2013-03-01 09:40:11,860 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:ip_addr=206.190.94.226:find_bitstream_format:bitstream_format_id=11

2013-03-01 09:40:11,860 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 11

2013-03-01 09:40:11,860 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 118314

2013-03-01 09:40:11,861 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 5

2013-03-01 09:40:11,861 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:ip_addr=206.190.94.226:find_bitstream_format:bitstream_format_id=5

2013-03-01 09:40:11,861 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 5

2013-03-01 09:40:11,861 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bitstream.*,bundle2bitstream.bitstream_order FROM bitstream, bundle2bitstream WHERE bundle2bitstream.bitstream_id=bitstream.bitstream_id AND bundle2bitstream.bundle_id= ? ORDER BY bitstream_order ASC" with parameters: 112188

2013-03-01 09:40:11,862 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstreamformatregistry where bitstream_format_id = ? " with parameters: 3

2013-03-01 09:40:11,862 DEBUG org.dspace.content.BitstreamFormat @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:ip_addr=206.190.94.226:find_bitstream_format:bitstream_format_id=3

2013-03-01 09:40:11,862 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM fileextension WHERE bitstream_format_id= ? " with parameters: 3

2013-03-01 09:40:11,862 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,204892,0

2013-03-01 09:40:11,863 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 0,204892,0

2013-03-01 09:40:11,863 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from bitstream where bitstream_id = ? " with parameters: 204892

2013-03-01 09:40:11,863 DEBUG org.dspace.storage.bitstore.BitstreamStorageManager @ Local filename for 98151093316198173280765083308152124162 is /server/data/dspace/assetstore/98/15/10/98151093316198173280765083308152124162

2013-03-01 09:40:11,895 INFO org.dspace.usage.LoggerUsageEventListener @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:ip_addr=206.190.94.226:view_bitstream:bitstream_id=204892

2013-03-01 09:40:11,983 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 204892

2013-03-01 09:40:11,984 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT item.* FROM item, item2bundle WHERE item2bundle.item_id=item.item_id AND item2bundle.bundle_id= ? " with parameters: 112188

2013-03-01 09:40:11,985 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection.* FROM collection, collection2item WHERE collection2item.collection_id=collection.collection_id AND collection2item.item_id= ? " with parameters: 64820

2013-03-01 09:40:11,985 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,90

2013-03-01 09:40:11,985 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 90

2013-03-01 09:40:11,986 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,2

2013-03-01 09:40:11,986 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 105

2013-03-01 09:40:11,986 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 2

2013-03-01 09:40:11,987 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT bundle.* FROM bundle, bundle2bitstream WHERE bundle.bundle_id=bundle2bitstream.bundle_id AND bundle2bitstream.bitstream_id= ? " with parameters: 204892

2013-03-01 09:40:11,987 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ HttpConnectionManager.getConnection: config = HostConfiguration[host=http://localhost:8080], timeout = 0

2013-03-01 09:40:11,987 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Getting free connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:40:11,988 DEBUG org.apache.commons.httpclient.HttpConnection @ Connection is stale, closing...

2013-03-01 09:40:11,988 DEBUG org.apache.commons.httpclient.HttpConnection @ Open connection to localhost:8080

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "POST /solr/statistics/update?wt=javabin&version=2 HTTP/1.1[\r][\n]"

2013-03-01 09:40:11,989 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Adding Host request header

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "User-Agent: Solr[org.apache.solr.client.solrj.impl.CommonsHttpSolrServer] 1.0[\r][\n]"

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "Host: localhost:8080[\r][\n]"

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "Transfer-Encoding: chunked[\r][\n]"

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "Content-Type: application/xml; charset=UTF-8[\r][\n]"

2013-03-01 09:40:11,989 DEBUG httpclient.wire.header @ >> "[\r][\n]"

2013-03-01 09:40:11,990 DEBUG httpclient.wire.content @ >> "440[\r][\n]"

2013-03-01 09:40:11,990 DEBUG httpclient.wire.content @ >> "<add><doc boost="1.0"><field name="ip">206.190.94.226</field><field name="referrer">http://www.google.com/url?sa=t&rct=j&q=frederick%20c%20gamst%20contact&source=web&cd=2&ved=0CDUQFjAB&url=http%3A%2F%2Fdspaceland.rice.edu%2Fbitstream%2Fhandle%2F1911%2F64723%2Farticle_RIP661_part2.pdf%3Fsequence%3D1&ei=1sswUe7eHaX9iwL8zoCACg&usg=AFQjCNHM_Tj_MuIsw40qGXlAwq7fxbpYmg</field><field name="dns">mail.hmnlaw.com.</field><field name="continent">NA</field><field name="countryCode">US</field><field name="city">San Luis Obispo</field><field name="latitude">35.282806</field><field name="longitude">-120.6596</field><field name="isBot">false</field><field name="userAgent">Mozilla/5.0 (Windows NT 6.1; WOW64; rv:19.0) Gecko/20100101 Firefox/19.0</field><field name="id">204892</field><field name="type">0</field><field name="owningItem">64820</field><field name="owningColl">90</field><field name="owningComm">2</field><field name="time">2013-03-01T09:40:11.987Z</field><field name="bundleName">ORIGINAL</field><field name="statistics_type">view</field></doc></add>"

2013-03-01 09:40:11,990 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:40:11,990 DEBUG httpclient.wire.content @ >> "0"

2013-03-01 09:40:11,990 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:40:11,990 DEBUG org.apache.commons.httpclient.methods.EntityEnclosingMethod @ Request body sent

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "HTTP/1.1 200 OK[\r][\n]"

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "Server: Apache-Coyote/1.1[\r][\n]"

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "Content-Type: application/octet-stream[\r][\n]"

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "Content-Length: 40[\r][\n]"

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "Date: Fri, 01 Mar 2013 15:40:11 GMT[\r][\n]"

2013-03-01 09:40:11,993 DEBUG httpclient.wire.header @ << "[\r][\n]"

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Default charset used: ISO-8859-1

2013-03-01 09:40:11,993 DEBUG httpclient.wire.content @ << "[0x1][0xa1][0xe0].responseHeader[0xa2][0xe0]&status[0x6][0x0][0x0][0x0][0x0][0xe0]%QTimeB"

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Resorting to protocol version default close connection policy

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Should NOT close connection, using HTTP/1.1

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.HttpConnection @ Releasing connection back to connection manager.

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Freeing connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.util.IdleConnectionHandler @ Adding connection at: 1362152411993

2013-03-01 09:40:11,993 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Notifying no-one, there are no waiting threads

2013-03-01 09:40:11,993 ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid version (expected 2, but 1) or the data in not in 'javabin' format

2013-03-01 09:40:26,210 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:40:26,215 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:40:26,218 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/1/favicon.ico

2013-03-01 09:40:26,221 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=7FEEF44A21D79B7E8EF855915866EC0F:authenticated:special_groups=

2013-03-01 09:40:26,221 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/2/favicon.ico

2013-03-01 09:40:26,224 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/3/favicon.ico

2013-03-01 09:40:26,227 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/4/favicon.ico

2013-03-01 09:40:26,230 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/5/favicon.ico

2013-03-01 09:40:26,234 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/6/favicon.ico

2013-03-01 09:40:26,237 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/7/favicon.ico

2013-03-01 09:40:26,241 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/8/favicon.ico

2013-03-01 09:40:26,245 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/9/favicon.ico

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore hit for PK_G-file-jndi:/localhost/aspects/protodocument.xml

2013-03-01 09:40:26,251 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/9/favicon.ico resolved to cocoon://DRI/9/favicon.ico?pipelinehash=823411183535858997

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/9/favicon.ico?pipelinehash=823411183535858997_T-Navigation--5757817660713989585

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,251 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/8/favicon.ico resolved to cocoon://DRI/8/favicon.ico?pipelinehash=4867438742130903316

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/8/favicon.ico?pipelinehash=4867438742130903316_T-Navigation--5757817660713989585

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,251 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/7/favicon.ico resolved to cocoon://DRI/7/favicon.ico?pipelinehash=-8594204211677975687

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/7/favicon.ico?pipelinehash=-8594204211677975687_T-Navigation--5757817660713989585

2013-03-01 09:40:26,251 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,251 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/6/favicon.ico resolved to cocoon://DRI/6/favicon.ico?pipelinehash=8939853564440891967

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/6/favicon.ico?pipelinehash=8939853564440891967_T-SystemwideAlerts-1_T-Navigation--5367372201529954577

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,252 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/5/favicon.ico resolved to cocoon://DRI/5/favicon.ico?pipelinehash=1787803058489565393

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/5/favicon.ico?pipelinehash=1787803058489565393_T-Navigation-5799876941772906259

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,252 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/4/favicon.ico resolved to cocoon://DRI/4/favicon.ico?pipelinehash=3008577346849953677

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/4/favicon.ico?pipelinehash=3008577346849953677

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,252 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/3/favicon.ico resolved to cocoon://DRI/3/favicon.ico?pipelinehash=-828796593584516762

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/3/favicon.ico?pipelinehash=-828796593584516762

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,252 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/2/favicon.ico resolved to cocoon://DRI/2/favicon.ico?pipelinehash=3612079005655330140

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/2/favicon.ico?pipelinehash=3612079005655330140

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,252 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/1/favicon.ico resolved to cocoon://DRI/1/favicon.ico?pipelinehash=4724225716876016996

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/1/favicon.ico?pipelinehash=4724225716876016996_T-PageNotFound--242969834922413342

2013-03-01 09:40:26,252 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,277 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Using locale 'en_US'

2013-03-01 09:40:26,277 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Default catalogue is messages

2013-03-01 09:40:26,277 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-file-cocoon://DRI/favicon.ico?pipelinehash=-4990666651161627652_T-IncludePageMeta--5534495057400678945_T-IncludePageMeta-7145676799531262490_T-IncludePageMeta-7904007307692048974_T-xslt-jndi:/localhost/themes/Mirage/Mirage.xsl_T-i18n-context://i18n/?en_US__S-xhtml-;doctype-public=-//W3C//DTD XHTML 1.0 Strict//EN;doctype-system=http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd;encoding=UTF-8;indent=yes

2013-03-01 09:40:26,277 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:40:26,292 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:40:26,293 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Using locale 'en_US'

2013-03-01 09:40:26,293 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Default catalogue is messages

2013-03-01 09:40:26,298 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:40:26,298 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:40:26,298 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.general.go_home'

2013-03-01 09:40:26,298 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:40:26,298 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.general.go_home from catalogue null

2013-03-01 09:41:06,404 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:41:06,408 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=27E233E766518A84EE79737568CEF4F3:authenticated:special_groups=

2013-03-01 09:41:06,408 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/4144

2013-03-01 09:41:06,408 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from item where item_id = ? " with parameters: 5959

2013-03-01 09:41:06,409 DEBUG org.dspace.content.Item @ anonymous:session_id=27E233E766518A84EE79737568CEF4F3:ip_addr=66.249.74.48:find_item:item_id=5959

2013-03-01 09:41:06,409 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 2,5959

2013-03-01 09:41:06,409 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/4144 to item 5959

2013-03-01 09:41:06,412 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:41:06,415 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/1/handle/1911/4144

2013-03-01 09:41:06,417 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/2/handle/1911/4144

2013-03-01 09:41:06,421 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 2,5959,0

2013-03-01 09:41:06,422 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 2,5959,0

2013-03-01 09:41:06,422 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/3/handle/1911/4144

2013-03-01 09:41:06,425 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/4/handle/1911/4144

2013-03-01 09:41:06,428 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/5/handle/1911/4144

2013-03-01 09:41:06,432 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/6/handle/1911/4144

2013-03-01 09:41:06,436 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 2,5959,0

2013-03-01 09:41:06,437 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/7/handle/1911/4144

2013-03-01 09:41:06,441 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 2,5959,0

2013-03-01 09:41:06,441 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/8/handle/1911/4144

2013-03-01 09:41:06,449 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 2,5959,0

2013-03-01 09:41:06,452 INFO org.dspace.usage.LoggerUsageEventListener @ anonymous:session_id=27E233E766518A84EE79737568CEF4F3:ip_addr=66.249.74.48:view_item:handle=1911/4144

2013-03-01 09:41:06,454 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT collection.* FROM collection, collection2item WHERE collection2item.collection_id=collection.collection_id AND collection2item.item_id= ? " with parameters: 5959

2013-03-01 09:41:06,454 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 85

2013-03-01 09:41:06,454 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,56

2013-03-01 09:41:06,455 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 56

2013-03-01 09:41:06,455 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,2

2013-03-01 09:41:06,455 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from epersongroup where eperson_group_id = ? " with parameters: 105

2013-03-01 09:41:06,456 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 2

2013-03-01 09:41:06,457 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ HttpConnectionManager.getConnection: config = HostConfiguration[host=http://localhost:8080], timeout = 0

2013-03-01 09:41:06,457 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Getting free connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:41:06,457 DEBUG org.apache.commons.httpclient.HttpConnection @ Connection is stale, closing...

2013-03-01 09:41:06,457 DEBUG org.apache.commons.httpclient.HttpConnection @ Open connection to localhost:8080

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "POST /solr/statistics/update?wt=javabin&version=2 HTTP/1.1[\r][\n]"

2013-03-01 09:41:06,458 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Adding Host request header

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "User-Agent: Solr[org.apache.solr.client.solrj.impl.CommonsHttpSolrServer] 1.0[\r][\n]"

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "Host: localhost:8080[\r][\n]"

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "Transfer-Encoding: chunked[\r][\n]"

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "Content-Type: application/xml; charset=UTF-8[\r][\n]"

2013-03-01 09:41:06,458 DEBUG httpclient.wire.header @ >> "[\r][\n]"

2013-03-01 09:41:06,459 DEBUG httpclient.wire.content @ >> "2a5[\r][\n]"

2013-03-01 09:41:06,459 DEBUG httpclient.wire.content @ >> "<add><doc boost="1.0"><field name="ip">66.249.74.48</field><field name="dns">crawl-66-249-74-48.googlebot.com.</field><field name="continent">NA</field><field name="countryCode">US</field><field name="city">Mountain View</field><field name="latitude">37.419205</field><field name="longitude">-122.0574</field><field name="isBot">false</field><field name="userAgent">Mozilla/5.0 (compatible; Googlebot/2.1; +http://www.google.com/bot.html)</field><field name="id">5959</field><field name="type">2</field><field name="owningColl">56</field><field name="owningComm">2</field><field name="time">2013-03-01T09:41:06.456Z</field><field name="statistics_type">view</field></doc></add>"

2013-03-01 09:41:06,459 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:41:06,459 DEBUG httpclient.wire.content @ >> "0"

2013-03-01 09:41:06,459 DEBUG httpclient.wire.content @ >> "[\r][\n]"

2013-03-01 09:41:06,459 DEBUG org.apache.commons.httpclient.methods.EntityEnclosingMethod @ Request body sent

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "HTTP/1.1 200 OK[\r][\n]"

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "Server: Apache-Coyote/1.1[\r][\n]"

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "Content-Type: application/octet-stream[\r][\n]"

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "Content-Length: 40[\r][\n]"

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "Date: Fri, 01 Mar 2013 15:41:06 GMT[\r][\n]"

2013-03-01 09:41:06,462 DEBUG httpclient.wire.header @ << "[\r][\n]"

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Default charset used: ISO-8859-1

2013-03-01 09:41:06,462 DEBUG httpclient.wire.content @ << "[0x1][0xa1][0xe0].responseHeader[0xa2][0xe0]&status[0x6][0x0][0x0][0x0][0x0][0xe0]%QTimeA"

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Resorting to protocol version default close connection policy

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.HttpMethodBase @ Should NOT close connection, using HTTP/1.1

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.HttpConnection @ Releasing connection back to connection manager.

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Freeing connection, hostConfig=HostConfiguration[host=http://localhost:8080]

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.util.IdleConnectionHandler @ Adding connection at: 1362152466462

2013-03-01 09:41:06,462 DEBUG org.apache.commons.httpclient.MultiThreadedHttpConnectionManager @ Notifying no-one, there are no waiting threads

2013-03-01 09:41:06,462 ERROR org.dspace.statistics.SolrLoggerUsageEventListener @ Invalid version (expected 2, but 1) or the data in not in 'javabin' format

2013-03-01 09:41:06,463 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/9/handle/1911/4144

2013-03-01 09:41:06,469 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore hit for PK_G-file-jndi:/localhost/aspects/protodocument.xml

2013-03-01 09:41:06,470 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/9/handle/1911/4144 resolved to cocoon://DRI/9/handle/1911/4144?pipelinehash=823411183535858997

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/9/handle/1911/4144?pipelinehash=823411183535858997_T-Navigation--214330452987127766

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,470 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/8/handle/1911/4144 resolved to cocoon://DRI/8/handle/1911/4144?pipelinehash=-845512182688501614

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/8/handle/1911/4144?pipelinehash=-845512182688501614_T-Navigation--214330452987127766

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,470 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/7/handle/1911/4144 resolved to cocoon://DRI/7/handle/1911/4144?pipelinehash=4413450087085768505

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/7/handle/1911/4144?pipelinehash=4413450087085768505_T-Navigation--214330452987127766

2013-03-01 09:41:06,470 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/6/handle/1911/4144 resolved to cocoon://DRI/6/handle/1911/4144?pipelinehash=481694154310340080

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/6/handle/1911/4144?pipelinehash=481694154310340080_T-SystemwideAlerts-1_T-Navigation--5367372201529954577

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/5/handle/1911/4144 resolved to cocoon://DRI/5/handle/1911/4144?pipelinehash=-4390653463939612324

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/5/handle/1911/4144?pipelinehash=-4390653463939612324_T-Navigation-1197377441727752154

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/4/handle/1911/4144 resolved to cocoon://DRI/4/handle/1911/4144?pipelinehash=1612213689356882624

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/4/handle/1911/4144?pipelinehash=1612213689356882624

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/3/handle/1911/4144 resolved to cocoon://DRI/3/handle/1911/4144?pipelinehash=7020870323137642266

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/3/handle/1911/4144?pipelinehash=7020870323137642266

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/2/handle/1911/4144 resolved to cocoon://DRI/2/handle/1911/4144?pipelinehash=8930741788356481921

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/2/handle/1911/4144?pipelinehash=8930741788356481921

2013-03-01 09:41:06,471 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,471 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/1/handle/1911/4144 resolved to cocoon://DRI/1/handle/1911/4144?pipelinehash=-1047930631699833831

2013-03-01 09:41:06,472 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/1/handle/1911/4144?pipelinehash=-1047930631699833831_T-PageNotFound--7032582799019003668

2013-03-01 09:41:06,472 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,498 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Using locale 'en_US'

2013-03-01 09:41:06,498 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Default catalogue is messages

2013-03-01 09:41:06,499 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-file-cocoon://DRI/handle/1911/4144?pipelinehash=-1837799913936867391_T-IncludePageMeta--5534495057400678945_T-IncludePageMeta-7145676799531262490_T-IncludePageMeta-7904007307692048974_T-xslt-jndi:/localhost/themes/Mirage/Mirage.xsl_T-i18n-context://i18n/?en_US__S-xhtml-;doctype-public=-//W3C//DTD XHTML 1.0 Strict//EN;doctype-system=http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd;encoding=UTF-8;indent=yes

2013-03-01 09:41:06,499 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:06,513 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:41:06,514 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Using locale 'en_US'

2013-03-01 09:41:06,515 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Default catalogue is messages

2013-03-01 09:41:06,520 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:06,520 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:06,520 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.general.go_home'

2013-03-01 09:41:06,520 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:06,520 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.general.go_home from catalogue null

2013-03-01 09:41:08,388 DEBUG org.dspace.springmvc.CocoonForwardController @ CocoonForwardController!!!!!

2013-03-01 09:41:08,392 DEBUG org.dspace.authenticate.IPAuthentication @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:authenticated:special_groups=

2013-03-01 09:41:08,392 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from handle where handle = ? " with parameters: 1911/8598

2013-03-01 09:41:08,393 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "select * from collection where collection_id = ? " with parameters: 82

2013-03-01 09:41:08,393 DEBUG org.dspace.content.Collection @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:find_collection:collection_id=82

2013-03-01 09:41:08,393 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 3,82

2013-03-01 09:41:08,394 DEBUG org.dspace.handle.HandleManager @ Resolved handle 1911/8598 to collection 82

2013-03-01 09:41:08,397 DEBUG org.dspace.app.xmlui.cocoon.DSpaceLocaleAction @ Found locale: en_US

2013-03-01 09:41:08,399 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/1/handle/1911/8598/browse

2013-03-01 09:41:08,402 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/2/handle/1911/8598/browse

2013-03-01 09:41:08,405 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 3,82,0

2013-03-01 09:41:08,406 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/3/handle/1911/8598/browse

2013-03-01 09:41:08,408 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/4/handle/1911/8598/browse

2013-03-01 09:41:08,411 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/5/handle/1911/8598/browse

2013-03-01 09:41:08,415 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/6/handle/1911/8598/browse

2013-03-01 09:41:08,418 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 3,82,0

2013-03-01 09:41:08,419 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/7/handle/1911/8598/browse

2013-03-01 09:41:08,423 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 3,82,0

2013-03-01 09:41:08,423 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/8/handle/1911/8598/browse

2013-03-01 09:41:08,428 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ aspectgenerator path: cocoon://DRI/9/handle/1911/8598/browse

2013-03-01 09:41:08,433 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore hit for PK_G-file-jndi:/localhost/aspects/protodocument.xml

2013-03-01 09:41:08,434 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/9/handle/1911/8598/browse resolved to cocoon://DRI/9/handle/1911/8598/browse?pipelinehash=823411183535858997

2013-03-01 09:41:08,434 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/9/handle/1911/8598/browse?pipelinehash=823411183535858997_T-Navigation--2757406725201929411

2013-03-01 09:41:08,434 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,434 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/8/handle/1911/8598/browse resolved to cocoon://DRI/8/handle/1911/8598/browse?pipelinehash=-8568985817188267809

2013-03-01 09:41:08,435 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/8/handle/1911/8598/browse?pipelinehash=-8568985817188267809_T-Navigation--2757406725201929411_T-ConfigurableBrowse--5704046751311803517

2013-03-01 09:41:08,435 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,435 DEBUG org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:browse:

2013-03-01 09:41:08,435 INFO org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:browse_by_value:focus=null

2013-03-01 09:41:08,435 DEBUG org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:get_total_results:distinct=true

2013-03-01 09:41:08,435 DEBUG org.dspace.browse.BrowseDAOPostgres @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:executing_count_query:query=SELECT COUNT(*) AS num FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id

2013-03-01 09:41:08,435 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT COUNT(*) AS num FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id " with parameters: 82

2013-03-01 09:41:08,463 DEBUG org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:get_total_results_return:return=1

2013-03-01 09:41:08,463 DEBUG org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:get_focus_value:

2013-03-01 09:41:08,463 DEBUG org.dspace.browse.BrowseEngine @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:get_focus_value_return:return=Q

2013-03-01 09:41:08,463 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT COUNT(sort_value) AS offset FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE sort_value<? AND mappings.distinct_id=bi_4_dis.id" with parameters: 82,q

2013-03-01 09:41:08,497 DEBUG org.dspace.browse.BrowseDAOPostgres @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:executing_value_query:query=SELECT count(*) AS num, dvalues.value, dvalues.authority FROM (SELECT bi_4_dis.* FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id ORDER BY sort_value ASC NULLS LAST LIMIT ? OFFSET ? ) dvalues , bi_4_dmap WHERE dvalues.id = bi_4_dmap.distinct_id GROUP BY bi_4_dmap.distinct_id, dvalues.value, dvalues.authority, dvalues.sort_value ORDER BY sort_value ASC NULLS LAST

2013-03-01 09:41:08,497 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT count(*) AS num, dvalues.value, dvalues.authority FROM (SELECT bi_4_dis.* FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id ORDER BY sort_value ASC NULLS LAST LIMIT ? OFFSET ? ) dvalues , bi_4_dmap WHERE dvalues.id = bi_4_dmap.distinct_id GROUP BY bi_4_dmap.distinct_id, dvalues.value, dvalues.authority, dvalues.sort_value ORDER BY sort_value ASC NULLS LAST " with parameters: 82,20,1

2013-03-01 09:41:08,524 DEBUG org.dspace.browse.BrowseDAOPostgres @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:executing_value_query:query=SELECT count(*) AS num, dvalues.value, dvalues.authority FROM (SELECT bi_4_dis.* FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id ORDER BY sort_value ASC NULLS LAST LIMIT ? ) dvalues , bi_4_dmap WHERE dvalues.id = bi_4_dmap.distinct_id GROUP BY bi_4_dmap.distinct_id, dvalues.value, dvalues.authority, dvalues.sort_value ORDER BY sort_value ASC NULLS LAST

2013-03-01 09:41:08,524 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT count(*) AS num, dvalues.value, dvalues.authority FROM (SELECT bi_4_dis.* FROM bi_4_dis, (SELECT DISTINCT bi_4_dmap.distinct_id FROM collection2item, bi_4_dmap WHERE bi_4_dmap.item_id=collection2item.item_id AND collection2item.collection_id=? ) mappings WHERE bi_4_dis.id=mappings.distinct_id ORDER BY sort_value ASC NULLS LAST LIMIT ? ) dvalues , bi_4_dmap WHERE dvalues.id = bi_4_dmap.distinct_id GROUP BY bi_4_dmap.distinct_id, dvalues.value, dvalues.authority, dvalues.sort_value ORDER BY sort_value ASC NULLS LAST " with parameters: 82,20

2013-03-01 09:41:08,997 INFO org.dspace.app.xmlui.aspect.artifactbrowser.ConfigurableBrowse @ anonymous:session_id=53C20EE6B612BA69CCDE4A1034A3C9AF:ip_addr=66.249.74.48:browse:org.dspace.app.xmlui.utils.DSpaceValidity@1ff99e90

2013-03-01 09:41:08,997 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/7/handle/1911/8598/browse resolved to cocoon://DRI/7/handle/1911/8598/browse?pipelinehash=3178633760810356437

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/7/handle/1911/8598/browse?pipelinehash=3178633760810356437_T-Navigation--2757406725201929411

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/6/handle/1911/8598/browse resolved to cocoon://DRI/6/handle/1911/8598/browse?pipelinehash=8482030616282332038

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/6/handle/1911/8598/browse?pipelinehash=8482030616282332038_T-SystemwideAlerts-1_T-Navigation--5367372201529954577

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/5/handle/1911/8598/browse resolved to cocoon://DRI/5/handle/1911/8598/browse?pipelinehash=5534988331175727610

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/5/handle/1911/8598/browse?pipelinehash=5534988331175727610_T-Navigation-1197377441727752154

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/4/handle/1911/8598/browse resolved to cocoon://DRI/4/handle/1911/8598/browse?pipelinehash=2648919231354058379

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/4/handle/1911/8598/browse?pipelinehash=2648919231354058379

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/3/handle/1911/8598/browse resolved to cocoon://DRI/3/handle/1911/8598/browse?pipelinehash=-1032214463420449406

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/3/handle/1911/8598/browse?pipelinehash=-1032214463420449406

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/2/handle/1911/8598/browse resolved to cocoon://DRI/2/handle/1911/8598/browse?pipelinehash=-2571778862387622862

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/2/handle/1911/8598/browse?pipelinehash=-2571778862387622862

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:08,998 DEBUG org.dspace.app.xmlui.cocoon.AspectGenerator @ Source cocoon://DRI/1/handle/1911/8598/browse resolved to cocoon://DRI/1/handle/1911/8598/browse?pipelinehash=-7444153420277580937

2013-03-01 09:41:08,998 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-aspect-cocoon://DRI/1/handle/1911/8598/browse?pipelinehash=-7444153420277580937_T-PageNotFound-6742262910440751882

2013-03-01 09:41:08,999 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:09,022 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Using locale 'en_US'

2013-03-01 09:41:09,022 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Default catalogue is messages

2013-03-01 09:41:09,023 DEBUG net.sf.ehcache.Cache @ cocoon-ehcacheCache: cocoon-ehcacheMemoryStore miss for PK_G-file-cocoon://DRI/handle/1911/8598/browse?pipelinehash=-5234210821826083350_T-IncludePageMeta--5534495057400678945_T-IncludePageMeta-7145676799531262490_T-IncludePageMeta-7904007307692048974_T-xslt-jndi:/localhost/themes/Mirage/Mirage.xsl_T-i18n-context://i18n/?en_US__S-xhtml-;doctype-public=-//W3C//DTD XHTML 1.0 Strict//EN;doctype-system=http://www.w3.org/TR/xhtml1/DTD/xhtml1-strict.dtd;encoding=UTF-8;indent=yes

2013-03-01 09:41:09,023 DEBUG net.sf.ehcache.Cache @ cocoon-ehcache cache - Miss

2013-03-01 09:41:09,030 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 82

2013-03-01 09:41:09,049 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM Handle WHERE resource_type_id = ? AND resource_id = ?" with parameters: 4,28

2013-03-01 09:41:09,049 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 28

2013-03-01 09:41:09,049 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 4,28,1

2013-03-01 09:41:09,050 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT * FROM resourcepolicy WHERE resource_type_id= ? AND resource_id= ? AND action_id= ? " with parameters: 4,28,3

2013-03-01 09:41:09,053 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2collection WHERE community.community_id=community2collection.community_id AND community2collection.collection_id= ? " with parameters: 82

2013-03-01 09:41:09,053 DEBUG org.dspace.storage.rdbms.DatabaseManager @ Running query "SELECT community.* FROM community, community2community WHERE community2community.parent_comm_id=community.community_id AND community2community.child_comm_id= ? " with parameters: 28

2013-03-01 09:41:09,063 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,063 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,063 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.default.textarea.value'

2013-03-01 09:41:09,063 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,063 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.default.textarea.value from catalogue null

2013-03-01 09:41:09,069 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,069 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,069 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.default.textarea.value'

2013-03-01 09:41:09,069 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,069 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.default.textarea.value from catalogue null

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject'

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject from catalogue default

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,070 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'Thresher'

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: translate

2013-03-01 09:41:09,071 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End of translate with params. Fragment for substitution : Browsing by Subject

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject'

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject from catalogue default

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'Thresher'

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,073 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: translate

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End of translate with params. Fragment for substitution : Browsing by Subject

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.structural.head-subtitle'

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,074 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.structural.head-subtitle from catalogue null

2013-03-01 09:41:09,075 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,075 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,075 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.structural.login'

2013-03-01 09:41:09,075 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,075 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.structural.login from catalogue null

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.general.dspace_home'

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.general.dspace_home from catalogue default

2013-03-01 09:41:09,076 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.trail.metadata.subject'

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.trail.metadata.subject from catalogue default

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'Thresher'

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: translate

2013-03-01 09:41:09,077 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End of translate with params. Fragment for substitution : Browsing by Subject

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject'

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.title.metadata.subject from catalogue default

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'Thresher'

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: translate

2013-03-01 09:41:09,078 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End of translate with params. Fragment for substitution : Browsing by Subject

2013-03-01 09:41:09,109 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,109 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,109 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.general.starts_with'

2013-03-01 09:41:09,109 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,109 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.general.starts_with from catalogue default

2013-03-01 09:41:09,111 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.general.starts_with_help from catalogue null

2013-03-01 09:41:09,112 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.general.go from catalogue null

2013-03-01 09:41:09,118 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,118 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,118 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.general.order'

2013-03-01 09:41:09,118 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,118 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.general.order from catalogue default

2013-03-01 09:41:09,121 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,121 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,121 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.order.asc'

2013-03-01 09:41:09,121 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,121 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.order.asc from catalogue default

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.order.desc'

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.order.desc from catalogue default

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.general.rpp'

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,122 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.general.rpp from catalogue default

2013-03-01 09:41:09,126 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.general.update from catalogue null

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.structural.pagination-info'

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.structural.pagination-info from catalogue null

2013-03-01 09:41:09,127 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = '1'

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = '1'

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = '1'

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: translate

2013-03-01 09:41:09,128 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End of translate with params. Fragment for substitution : Now showing items - of

2013-03-01 09:41:09,129 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.ArtifactBrowser.ConfigurableBrowse.subject.column_heading'

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.ArtifactBrowser.ConfigurableBrowse.subject.column_heading from catalogue default

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: translate

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: translate

2013-03-01 09:41:09,130 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: text

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: text

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = 'xmlui.dri2xhtml.structural.pagination-info'

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: text

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Getting key xmlui.dri2xhtml.structural.pagination-info from catalogue null

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Starting i18n element: param

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ Start i18n element: param

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ i18n message text = '1'

2013-03-01 09:41:09,131 DEBUG org.dspace.app.xmlui.cocoon.DSpaceI18NTransformer @ End i18n element: param