briefcase icon indicating copy to clipboard operation
briefcase copied to clipboard

Published 20 hours ago • verified publisher icon getodk

Briefcase.log is a bit too chatty

Open yanokwa opened this issue 6 years ago • 1 comments

Software versions

Briefcase v1.11

Problem description

Briefcase.log seems a bit too chatty on production build. Maybe we should only output warnings or errors?

Other information

2018-06-15 12:40:23,598 [main] WARN  o.o.briefcase.util.FormCache - The serialized forms cache is incompatible due to an update on Briefcase
2018-06-15 12:41:50,482 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Downloading URL https://nafundi-test.appspot.com/formXml?formId=all-widgets-test into /var/folders/2l/pkx0trkd49s8r8xcqq_09j640000gn/T/briefcase_9168100366755734945_form.xml
2018-06-15 12:41:50,485 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/formXml?formId=all-widgets-test
2018-06-15 12:41:51,437 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 7.682 ms
2018-06-15 12:41:51,442 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 4.484 ms
2018-06-15 12:41:51,442 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:51,443 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Title: "All widgets"
2018-06-15 12:41:51,486 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 43.600 ms
2018-06-15 12:41:51,497 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 3.423 ms
2018-06-15 12:41:51,499 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 2.023 ms
2018-06-15 12:41:51,500 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:51,500 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Title: "All widgets"
2018-06-15 12:41:51,516 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 16.132 ms
2018-06-15 12:41:51,520 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 2.992 ms
2018-06-15 12:41:51,523 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 2.803 ms
2018-06-15 12:41:51,523 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:51,523 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Title: "All widgets"
2018-06-15 12:41:51,533 [pool-2-thread-1] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 9.767 ms
2018-06-15 12:41:51,887 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/view/submissionList?formId=all-widgets-test&cursor=&numEntries=100
2018-06-15 12:41:51,888 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/view/submissionList?formId=all-widgets-test&cursor=&numEntries=100
2018-06-15 12:41:52,531 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/view/submissionList?formId=all-widgets-test&cursor=%3Ccursor+xmlns%3D%22http%3A%2F%2Fwww.opendatakit.org%2Fcursor%22%3E%3CattributeName%3E_LAST_UPDATE_DATE%3C%2FattributeName%3E%3CattributeValue%3E2018-03-27T03%3A28%3A34.493%2B0000%3C%2FattributeValue%3E%3CuriLastReturnedValue%3Euuid%3Af6fc3c5c-d29f-4a90-91e0-c3eff25e2267%3C%2FuriLastReturnedValue%3E%3CisForwardCursor%3Etrue%3C%2FisForwardCursor%3E%3C%2Fcursor%3E&numEntries=100
2018-06-15 12:41:52,531 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/view/submissionList?formId=all-widgets-test&cursor=%3Ccursor+xmlns%3D%22http%3A%2F%2Fwww.opendatakit.org%2Fcursor%22%3E%3CattributeName%3E_LAST_UPDATE_DATE%3C%2FattributeName%3E%3CattributeValue%3E2018-03-27T03%3A28%3A34.493%2B0000%3C%2FattributeValue%3E%3CuriLastReturnedValue%3Euuid%3Af6fc3c5c-d29f-4a90-91e0-c3eff25e2267%3C%2FuriLastReturnedValue%3E%3CisForwardCursor%3Etrue%3C%2FisForwardCursor%3E%3C%2Fcursor%3E&numEntries=100
2018-06-15 12:41:52,966 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.ServerFetcher - already present - skipping fetch: uuid:06a062fe-60ef-44c9-9ab8-996d7c194c39
2018-06-15 12:41:52,967 [briefcase-pull-1-thread-1] INFO  o.o.briefcase.util.ServerFetcher - already present - skipping fetch: uuid:f6fc3c5c-d29f-4a90-91e0-c3eff25e2267
2018-06-15 12:41:52,978 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 0.167 ms
2018-06-15 12:41:52,978 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.115 ms
2018-06-15 12:41:52,978 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:52,978 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "accents"
2018-06-15 12:41:52,980 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 1.399 ms
2018-06-15 12:41:52,981 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 0.089 ms
2018-06-15 12:41:52,981 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.027 ms
2018-06-15 12:41:52,981 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:52,981 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "basic"
2018-06-15 12:41:52,982 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 0.622 ms
2018-06-15 12:41:52,983 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 0.217 ms
2018-06-15 12:41:52,983 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.041 ms
2018-06-15 12:41:52,983 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:52,983 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "Geo Tagger v2"
2018-06-15 12:41:52,984 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 0.509 ms
2018-06-15 12:41:52,990 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 2.667 ms
2018-06-15 12:41:52,992 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 2.568 ms
2018-06-15 12:41:52,993 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:41:52,993 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "All widgets"
2018-06-15 12:41:53,001 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 8.063 ms
2018-06-15 12:44:02,691 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 4.340 ms
2018-06-15 12:44:02,696 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.864 ms
2018-06-15 12:44:02,697 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:44:02,697 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "basic"
2018-06-15 12:44:02,712 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 15.606 ms
2018-06-15 12:44:06,899 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 0.318 ms
2018-06-15 12:44:06,899 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.068 ms
2018-06-15 12:44:06,899 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 12:44:06,899 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "basic"
2018-06-15 12:44:06,900 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 1.438 ms
2018-06-15 12:44:28,326 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/formUpload
2018-06-15 12:44:28,339 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - added form_def_file: basic.xml
2018-06-15 12:44:28,342 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/formUpload
2018-06-15 12:44:35,233 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Redirection to URI https://nafundi-test.appspot.com/formUpload
2018-06-15 12:44:35,234 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/submission
2018-06-15 12:44:35,236 [pool-2-thread-1] INFO  o.o.briefcase.util.FileSystemUtils - Creating database directory /Users/yanokwa/Downloads/ODK Briefcase Storage/forms/basic/info.hsqldb
2018-06-15 12:44:35,604 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/view/submissionList?formId=basic&cursor=&numEntries=100
2018-06-15 12:44:35,606 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/view/submissionList?formId=basic&cursor=&numEntries=100
2018-06-15 13:24:51,008 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 4.113 ms
2018-06-15 13:24:51,012 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.940 ms
2018-06-15 13:24:51,013 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 13:24:51,013 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "accents"
2018-06-15 13:24:51,032 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 18.427 ms
2018-06-15 13:24:54,161 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Reading XML and parsing with kXML2 finished in 0.612 ms
2018-06-15 13:24:54,161 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Consolidating text finished in 0.158 ms
2018-06-15 13:24:54,161 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Parsing form...
2018-06-15 13:24:54,161 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Title: "accents"
2018-06-15 13:24:54,163 [AWT-EventQueue-0] INFO  org.javarosa.xform.parse.XFormParser - Creating FormDef from parsed XML finished in 1.481 ms
2018-06-15 13:27:58,201 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/formUpload
2018-06-15 13:27:58,234 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - added form_def_file: accents.xml
2018-06-15 13:27:58,235 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Trying file /Users/yanokwa/Downloads/ODK Briefcase Storage/forms/accents/accents-media/test.csv
2018-06-15 13:27:58,235 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - added csv file test.csv
2018-06-15 13:27:58,238 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/formUpload
2018-06-15 13:28:03,573 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Redirection to URI https://nafundi-test.appspot.com/formUpload
2018-06-15 13:28:03,574 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/submission
2018-06-15 13:28:03,575 [pool-2-thread-1] INFO  o.o.briefcase.util.FileSystemUtils - Creating database directory /Users/yanokwa/Downloads/ODK Briefcase Storage/forms/accents/info.hsqldb
2018-06-15 13:28:03,921 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Parsing URL https://nafundi-test.appspot.com/view/submissionList?formId=accents&cursor=&numEntries=100
2018-06-15 13:28:03,922 [pool-2-thread-1] INFO  o.o.briefcase.util.AggregateUtils - Attempting URI https://nafundi-test.appspot.com/view/submissionList?formId=accents&cursor=&numEntries=100

yanokwa avatar Jun 15 '18 20:06 yanokwa

I think INFO for production is OK. Maybe we should review what gets logged and either remove some of these messages or downgrade them to DEBUG.

ggalmazor avatar Aug 30 '18 11:08 ggalmazor