-
Notifications
You must be signed in to change notification settings - Fork 3
/
Copy pathJ-ISIS-log.1
668 lines (668 loc) · 99.7 KB
/
J-ISIS-log.1
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
237
238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
269
270
271
272
273
274
275
276
277
278
279
280
281
282
283
284
285
286
287
288
289
290
291
292
293
294
295
296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
317
318
319
320
321
322
323
324
325
326
327
328
329
330
331
332
333
334
335
336
337
338
339
340
341
342
343
344
345
346
347
348
349
350
351
352
353
354
355
356
357
358
359
360
361
362
363
364
365
366
367
368
369
370
371
372
373
374
375
376
377
378
379
380
381
382
383
384
385
386
387
388
389
390
391
392
393
394
395
396
397
398
399
400
401
402
403
404
405
406
407
408
409
410
411
412
413
414
415
416
417
418
419
420
421
422
423
424
425
426
427
428
429
430
431
432
433
434
435
436
437
438
439
440
441
442
443
444
445
446
447
448
449
450
451
452
453
454
455
456
457
458
459
460
461
462
463
464
465
466
467
468
469
470
471
472
473
474
475
476
477
478
479
480
481
482
483
484
485
486
487
488
489
490
491
492
493
494
495
496
497
498
499
500
501
502
503
504
505
506
507
508
509
510
511
512
513
514
515
516
517
518
519
520
521
522
523
524
525
526
527
528
529
530
531
532
533
534
535
536
537
538
539
540
541
542
543
544
545
546
547
548
549
550
551
552
553
554
555
556
557
558
559
560
561
562
563
564
565
566
567
568
569
570
571
572
573
574
575
576
577
578
579
580
581
582
583
584
585
586
587
588
589
590
591
592
593
594
595
596
597
598
599
600
601
602
603
604
605
606
607
608
609
610
611
612
613
614
615
616
617
618
619
620
621
622
623
624
625
626
627
628
629
630
631
632
633
634
635
636
637
638
639
640
641
642
643
644
645
646
647
648
649
650
651
652
653
654
655
656
657
658
659
660
661
662
663
664
665
666
667
668
2017-04-03 19:05:45,834 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 8 milliseconds to get reply from server
2017-04-03 19:05:45,839 DEBUG [pool-4-thread-7] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:05:45,839 DEBUG [pool-4-thread-7] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=_270,terms.lower.incl=true,terms.regex=LENI.*,terms.regex.flag=[Ljava.lang.String;@7e3d30c4,terms.sort=index,terms.limit=200}]
2017-04-03 19:05:45,845 DEBUG [pool-4-thread-7] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=LENI.*&terms.fl=_270&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:05:45,847 DEBUG [pool-4-thread-7] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:1
2017-04-03 19:05:45,847 INFO [pool-4-thread-7] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [2]
2017-04-03 19:05:45,847 DEBUG [pool-4-thread-7] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:05:45,847 DEBUG [pool-4-thread-7] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 8 milliseconds to prepare reply on server side
2017-04-03 19:05:45,847 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 9 milliseconds to get reply from server
2017-04-03 19:05:48,900 DEBUG [pool-4-thread-8] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:05:48,905 DEBUG [pool-4-thread-8] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:05:48,905 DEBUG [pool-4-thread-8] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 5 milliseconds to prepare reply on server side
2017-04-03 19:05:48,905 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 6 milliseconds to get reply from server
2017-04-03 19:05:48,906 DEBUG [pool-4-thread-9] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:05:48,906 DEBUG [pool-4-thread-9] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=_270,terms.lower.incl=true,terms.regex=1.*,terms.regex.flag=[Ljava.lang.String;@26da29fb,terms.sort=index,terms.limit=200}]
2017-04-03 19:05:48,906 DEBUG [pool-4-thread-9] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=1.*&terms.fl=_270&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:05:48,907 DEBUG [pool-4-thread-9] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:1
2017-04-03 19:05:48,911 INFO [pool-4-thread-9] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [5]
2017-04-03 19:05:48,911 DEBUG [pool-4-thread-9] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:05:48,911 DEBUG [pool-4-thread-9] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 5 milliseconds to prepare reply on server side
2017-04-03 19:05:48,911 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 6 milliseconds to get reply from server
2017-04-03 19:05:53,668 DEBUG [pool-4-thread-10] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:05:53,671 DEBUG [pool-4-thread-10] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:05:53,671 DEBUG [pool-4-thread-10] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3 milliseconds to prepare reply on server side
2017-04-03 19:05:53,671 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3 milliseconds to get reply from server
2017-04-03 19:05:53,671 DEBUG [pool-4-thread-11] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [51]-> [Get Search Lucene]
2017-04-03 19:05:53,671 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:159] Search Lucene srcExpr: [(_270:"1966"
)] Lucene Search= [true]
2017-04-03 19:05:53,672 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:190] KeywordAnalyzer - Parsed Lucene query: [_270:1966]
2017-04-03 19:05:53,672 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:205] SimpleAnalyzer - Parsed Lucene query: [_270:1966]
2017-04-03 19:05:53,672 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:230] queryJisisAnalyzer - Parsed Lucene query: [_270:1966]
2017-04-03 19:05:53,673 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:315] queryKeywordAnalyzer Number of hits1 [1]
2017-04-03 19:05:53,674 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:320] querySimpleAnalyzer before
2017-04-03 19:05:53,674 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:328] queryJisisAnalyzer after
2017-04-03 19:05:53,677 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:331] querySimpleAnalyzer Number of hits2 [1]
2017-04-03 19:05:53,677 DEBUG [pool-4-thread-11] o.u.j.c.s.Search [Search.java:364] Returned Number of hits [1]
2017-04-03 19:05:53,677 DEBUG [pool-4-thread-11] o.u.j.c.s.DbHandle [DbHandle.java:2020] SERVER - searchLucene mfns.length=1
2017-04-03 19:05:53,677 DEBUG [pool-4-thread-11] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [51] e_ok: [TRUE] Message Obj Class: [[J]
------------]
2017-04-03 19:05:53,677 DEBUG [pool-4-thread-11] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 6 milliseconds to prepare reply on server side
2017-04-03 19:05:53,677 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 6 milliseconds to get reply from server
2017-04-03 19:05:53,678 DEBUG [pool-4-thread-12] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:05:53,678 DEBUG [pool-4-thread-12] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:05:53,678 DEBUG [pool-4-thread-12] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:05:53,679 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:05:53,679 DEBUG [pool-4-thread-13] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:05:53,679 DEBUG [pool-4-thread-13] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:05:53,679 DEBUG [pool-4-thread-13] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:05:53,679 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:05:53,680 DEBUG [pool-4-thread-14] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:05:53,680 DEBUG [pool-4-thread-14] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:05:53,735 DEBUG [pool-4-thread-14] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 55 milliseconds to prepare reply on server side
2017-04-03 19:05:53,735 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 55 milliseconds to get reply from server
2017-04-03 19:05:59,163 DEBUG [AWT-EventQueue-0] o.u.j.c.s.HandleDbRequest [ClientDatabaseProxy.java:310] Database: TestRepeatableLiteralClose Window i=0 TopComponent=Data Viewer (DEF_HOME//TestRepeatableLiteral)
2017-04-03 19:05:59,164 DEBUG [AWT-EventQueue-0] o.u.j.c.s.HandleDbRequest [ClientDatabaseProxy.java:310] Database: TestRepeatableLiteralClose Window i=1 TopComponent=Search Window (DEF_HOME//TestRepeatableLiteral)
2017-04-03 19:05:59,166 DEBUG [pool-4-thread-15] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [7]-> [Close Database]
2017-04-03 19:05:59,166 DEBUG [pool-4-thread-15] o.u.j.c.s.DbHandle [ClientConnection.java:84] SERVER - CientConnectiond userInfo=UserInfo- UserName=admin pwd=admin isAdmin=true permission={admin=true, oper=true, guest=true} host=DESKTOP-SRKGMDM IP=192.168.56.1 SocketAddress=/127.0.0.1:63515 remove connectionDatabase dbId=1
2017-04-03 19:05:59,166 DEBUG [pool-4-thread-15] o.u.j.c.s.DatabaseManager [DatabaseManager.java:75] SERVER - Attempt to close DbHandle for database TestRepeatableLiteral dbReferenceCount=1
2017-04-03 19:05:59,167 INFO [pool-4-thread-15] o.u.j.c.s.IsisDbEnv [IsisDbEnv.java:137] shutDown[config, data]
2017-04-03 19:05:59,179 INFO [pool-4-thread-15] o.u.j.c.s.BdbImpl [BdbImpl.java:822] SERVER - Database [TestRepeatableLiteral] closed
2017-04-03 19:05:59,179 INFO [pool-4-thread-15] o.u.j.c.s.DbHandle [DbHandle.java:987] SERVER - Database [TestRepeatableLiteral] closed
2017-04-03 19:05:59,179 DEBUG [pool-4-thread-15] o.u.j.c.s.DatabaseManager [DatabaseManager.java:80] SERVER - DbHandle removed for db TestRepeatableLiteral
2017-04-03 19:05:59,179 DEBUG [pool-4-thread-15] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [7] e_ok: [TRUE] Message Obj Class: [NULL]
------------]
2017-04-03 19:05:59,179 DEBUG [pool-4-thread-15] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 13 milliseconds to prepare reply on server side
2017-04-03 19:05:59,180 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 14 milliseconds to get reply from server
2017-04-03 19:05:59,180 ERROR [AWT-EventQueue-0] o.u.j.c.c.ConnectionInfo [ConnectionInfo.java:121] CLIENT - Wrong defaultDb_ [-1] for connection [127.0.0.1 (127.0.0.1) on port 1111]
2017-04-03 19:05:59,180 ERROR [AWT-EventQueue-0] o.u.j.c.c.ConnectionInfo [ConnectionInfo.java:121] CLIENT - Wrong defaultDb_ [-1] for connection [127.0.0.1 (127.0.0.1) on port 1111]
2017-04-03 19:06:01,676 DEBUG [pool-4-thread-16] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [3]-> [Get dbHomes]
2017-04-03 19:06:01,676 DEBUG [pool-4-thread-16] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [3] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:06:01,676 DEBUG [pool-4-thread-16] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:06:01,676 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:06:01,676 DEBUG [AWT-EventQueue-0] o.u.j.c.c.ConnectionNIO [ConnectionNIO.java:204] CLIENT - ConnectionNIO::Send msg to get getDbNames for dbHome=[DEF_HOME]
2017-04-03 19:06:01,677 DEBUG [pool-4-thread-17] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [4]-> [Get dbNames]
2017-04-03 19:06:01,686 DEBUG [pool-4-thread-17] o.u.j.c.s.CommandFactory [CommandFactory.java:280] SERVER - dbNames for dbHome DEF_HOME : [aa, aa from iso, aa from mods, AMJ_BOOKS, AMJ_LOAN, AMJ_Member, archive, artic, ASFA-CLI, ASFAEX, AUTOR, B1, BAse 929-1066, BDB-Test, BIBAN, BIBLO, BOOK, BORR, CDS, cds from mods, CDS-CLONE, cds0, cds80, cimle, clel, DC, DL-example, DLTest, eds-articles, epidoc, export-test, ferk, frag1, frak, Francesco, Francescxo, fsor2709, fsor2709.x52, fsor2709.x520, Gutenberg, ICOMOS, illus-to-delete, IMPORT-TEST2, Index3-test, innz, INNZ-CLI, innz-metadata, innz-test-bulk, Inspel, inz-test-import, ISA, isa1, ISIS-THES, LibAMJ, LIBCAT, LIBCAT-TEST, libros, LISTE, loans, louv-marc, louv-marc2, louv-test-fst, louv1 to delete, LOUV1-TEST, louv1-test-performance, louv1-to-delete, louvre, louvre-test, louvre-unimarc, louvre_initial, louv_marc, Lucene4, LvA, MARC, Marc-ABCD, MARC-louv, marc-louv-from-marcxml, MARC-XML-TEST, MARC1, marc1rec, marc1rec-exp, marc1rec-xml, marc20rec, marc20rec-exp, MARC21-AUTHORITY, MarcTest, MarcXml, musee, MyCDS, MyNewDb, nerk, NewDL, NewMarc1rec, noailles, nouaille, PATR, PATR_OLD, PERSO, PERSO-SR-VIVIANE, Personas, pourjc, prakash1, prakash2, recmt, recmt-todel, Records 929-1066, reformat-marc21, reformat-test, RMRL, sandbug, sandburg, sandburg-xml, sara, SC, SciELO, sel, SimpleDL, Spinaker, SPO, SPOF, SPOFDO, summerland, summerland-dc-rdf, summerland-marcxml, summerland-marcxml-2mods, summerland-marxml-2mods, summerland-mrc, szakd, TAM, Tamil, Tamil db, tdk, TECA, TECA0, TECA1, test, test to delete, test-db, test-import, Test-Import1, test-load, TestBDB, TestDataEntry, TestFST, TestImages, TestImagesDB, TestImport, TestRepeatableLiteral, Test_fst_change, thes, THES-ISIS, thesaurus-fr, to-delete, UFITAX, uni, unicode1, unimarc-template, URDU (RTL), users, VIAF, vispocom, VVFBIB, xtran, xtrans-test, xx, xx1, zola, zola-bnf]
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.r.AuthorizingRealm [AuthorizingRealm.java:319] Retrieving AuthorizationInfo for principals [admin]
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,686 TRACE [pool-4-thread-17] o.a.s.r.AuthorizingRealm [AuthorizingRealm.java:319] Retrieving AuthorizationInfo for principals [admin]
2017-04-03 19:06:01,687 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,687 TRACE [pool-4-thread-17] o.a.s.s.s.DelegatingSubject [DelegatingSubject.java:317] attempting to get session; create = false; session is null = true; session has id = false
2017-04-03 19:06:01,687 TRACE [pool-4-thread-17] o.a.s.r.AuthorizingRealm [AuthorizingRealm.java:319] Retrieving AuthorizationInfo for principals [admin]
2017-04-03 19:06:01,770 DEBUG [pool-4-thread-17] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [4] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.Object;]
------------]
2017-04-03 19:06:01,770 DEBUG [pool-4-thread-17] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 93 milliseconds to prepare reply on server side
2017-04-03 19:06:01,770 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 93 milliseconds to get reply from server
2017-04-03 19:06:01,771 DEBUG [AWT-EventQueue-0] o.u.j.c.c.ConnectionNIO [ConnectionNIO.java:206] CLIENT - ConnectionNIO::After sendMessage getDbNames dbHome=[DEF_HOME]
2017-04-03 19:06:01,771 DEBUG [AWT-EventQueue-0] o.u.j.c.c.ConnectionNIO [ConnectionNIO.java:216] CLIENT - ConnectionNIO::getDbNames dbHome=[DEF_HOME] dbNames=[[aa, aa from iso, aa from mods, AMJ_BOOKS, AMJ_LOAN, AMJ_Member, archive, artic, ASFA-CLI, ASFAEX, AUTOR, B1, BAse 929-1066, BDB-Test, BIBAN, BIBLO, BOOK, BORR, CDS, cds from mods, CDS-CLONE, cds0, cds80, cimle, clel, DC, DL-example, DLTest, eds-articles, epidoc, export-test, ferk, frag1, frak, Francesco, Francescxo, fsor2709, fsor2709.x52, fsor2709.x520, Gutenberg, ICOMOS, illus-to-delete, IMPORT-TEST2, Index3-test, innz, INNZ-CLI, innz-metadata, innz-test-bulk, Inspel, inz-test-import, ISA, isa1, ISIS-THES, LibAMJ, LIBCAT, LIBCAT-TEST, libros, LISTE, loans, louv-marc, louv-marc2, louv-test-fst, louv1 to delete, LOUV1-TEST, louv1-test-performance, louv1-to-delete, louvre, louvre-test, louvre-unimarc, louvre_initial, louv_marc, Lucene4, LvA, MARC, Marc-ABCD, MARC-louv, marc-louv-from-marcxml, MARC-XML-TEST, MARC1, marc1rec, marc1rec-exp, marc1rec-xml, marc20rec, marc20rec-exp, MARC21-AUTHORITY, MarcTest, MarcXml, musee, MyCDS, MyNewDb, nerk, NewDL, NewMarc1rec, noailles, nouaille, PATR, PATR_OLD, PERSO, PERSO-SR-VIVIANE, Personas, pourjc, prakash1, prakash2, recmt, recmt-todel, Records 929-1066, reformat-marc21, reformat-test, RMRL, sandbug, sandburg, sandburg-xml, sara, SC, SciELO, sel, SimpleDL, Spinaker, SPO, SPOF, SPOFDO, summerland, summerland-dc-rdf, summerland-marcxml, summerland-marcxml-2mods, summerland-marxml-2mods, summerland-mrc, szakd, TAM, Tamil, Tamil db, tdk, TECA, TECA0, TECA1, test, test to delete, test-db, test-import, Test-Import1, test-load, TestBDB, TestDataEntry, TestFST, TestImages, TestImagesDB, TestImport, TestRepeatableLiteral, Test_fst_change, thes, THES-ISIS, thesaurus-fr, to-delete, UFITAX, uni, unicode1, unimarc-template, URDU (RTL), users, VIAF, vispocom, VVFBIB, xtran, xtrans-test, xx, xx1, zola, zola-bnf]]
2017-04-03 19:06:07,418 DEBUG [pool-4-thread-18] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [6]-> [Get Database (Open)]
2017-04-03 19:06:07,418 INFO [pool-4-thread-18] o.u.j.c.s.CommandFactory [CommandFactory.java:410] SERVER - CommandGetDatabase [dbName: VIAF] [dbHome: DEF_HOME] [home: C:/jisis-workspace/home_test_db]
2017-04-03 19:06:08,254 TRACE [pool-4-thread-18] o.u.j.c.s.DbHandle [DbHandle.java:825] SERVER - ***Default FST reading****
2017-04-03 19:06:08,258 TRACE [pool-4-thread-18] o.u.j.c.s.DbHandle [DbHandle.java:827] SERVER - fst= [| 100 | 0 | v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)
| 100 | 4 | v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)
| 105 | 0 | v110^a,v110^b /, (v710^a,v710^b/)
| 105 | 0 | v111^a,| |v111^n,| |v111^d,| |v111^c,| |v111^e/ (v711^a,| |v711^n,| |v711^d,| |v711^c,| |v711^e/)
| 105 | 4 | v110^a,v110^b/ (v710^a,v710^b/)
| 105 | 4 | v111^a,| |v111^c,| |v111^e /(v711^a,| |v711^c,| |v711^e/)
]
2017-04-03 19:06:08,258 TRACE [pool-4-thread-18] o.u.j.c.s.DbHandle [DbHandle.java:828] SERVER - ***End Default FST reading****
2017-04-03 19:06:08,258 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)]
2017-04-03 19:06:08,259 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,259 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)]
2017-04-03 19:06:08,259 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,259 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v110^a,v110^b /, (v710^a,v710^b/)]
2017-04-03 19:06:08,259 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,261 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v111^a,| |v111^n,| |v111^d,| |v111^c,| |v111^e/ (v711^a,| |v711^n,| |v711^d,| |v711^c,| |v711^e/)]
2017-04-03 19:06:08,262 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,262 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v110^a,v110^b/ (v710^a,v710^b/)]
2017-04-03 19:06:08,262 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,263 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v111^a,| |v111^c,| |v111^e /(v711^a,| |v711^c,| |v711^e/)]
2017-04-03 19:06:08,297 INFO [pool-4-thread-18] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:06:08,297 TRACE [pool-4-thread-18] o.u.j.c.s.DbHandle [DbHandle.java:325] SERVER - makeDbHandle - New DbHandle id: -1 for Databaae: VIAF dbHome= DEF_HOME Home=C:/jisis-workspace/home_test_db
2017-04-03 19:06:08,297 DEBUG [pool-4-thread-18] o.u.j.c.s.DatabaseManager [DatabaseManager.java:47] SERVER - DatabaseManager - add DbHandle for VIAF
2017-04-03 19:06:08,297 DEBUG [pool-4-thread-18] o.u.j.c.s.DbHandle [ClientConnection.java:58] SERVER - CientConnectiond userInfo=UserInfo- UserName=admin pwd=admin isAdmin=true permission={admin=true, oper=true, guest=true} host=DESKTOP-SRKGMDM IP=192.168.56.1 SocketAddress=/127.0.0.1:63515 add connectionDatabaseorg.unesco.jisis.corelib.server.ConnectionDatabase@2ceb69da
2017-04-03 19:06:08,297 DEBUG [pool-4-thread-18] o.u.j.c.s.CommandFactory [CommandFactory.java:430] SERVER - ClientConnection after add connectionDatabase dbId [2] ClientConnection{clientSocketChannel_=java.nio.channels.SocketChannel[connected local=localhost/127.0.0.1:1111 remote=/127.0.0.1:63515], userInfo_=UserInfo- UserName=admin pwd=admin isAdmin=true permission={admin=true, oper=true, guest=true} host=DESKTOP-SRKGMDM IP=192.168.56.1 SocketAddress=/127.0.0.1:63515, connectionDatabaseList_=[org.unesco.jisis.corelib.server.ConnectionDatabase@2ceb69da]}
2017-04-03 19:06:08,298 DEBUG [pool-4-thread-18] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [6] e_ok: [TRUE] Message Obj Class: [java.lang.Integer]
------------]
2017-04-03 19:06:08,298 DEBUG [pool-4-thread-18] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 880 milliseconds to prepare reply on server side
2017-04-03 19:06:08,298 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 881 milliseconds to get reply from server
2017-04-03 19:06:08,298 DEBUG [pool-4-thread-19] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [31]-> [Get Default PFT Name]
2017-04-03 19:06:08,300 DEBUG [pool-4-thread-19] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [31] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:06:08,300 DEBUG [pool-4-thread-19] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 2 milliseconds to prepare reply on server side
2017-04-03 19:06:08,302 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 4 milliseconds to get reply from server
2017-04-03 19:06:08,303 DEBUG [pool-4-thread-20] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [31]-> [Get Default PFT Name]
2017-04-03 19:06:08,303 DEBUG [pool-4-thread-20] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [31] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:06:08,303 DEBUG [pool-4-thread-20] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:06:08,303 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:06:08,303 DEBUG [pool-4-thread-21] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [27]-> [Get PFT Names]
2017-04-03 19:06:08,304 DEBUG [pool-4-thread-21] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [27] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:06:08,304 DEBUG [pool-4-thread-21] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:06:08,304 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:06:08,304 DEBUG [pool-4-thread-22] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:06:08,304 DEBUG [pool-4-thread-22] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:06:08,304 DEBUG [pool-4-thread-22] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:06:08,304 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:06:08,305 DEBUG [pool-4-thread-23] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:06:08,305 DEBUG [pool-4-thread-23] o.u.j.c.s.DbHandle [DbHandle.java:1325] SERVER - ***PFT Decoded using file encoding [Cp1252]
2017-04-03 19:06:08,305 DEBUG [pool-4-thread-23] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:06:08,308 DEBUG [pool-4-thread-23] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3 milliseconds to prepare reply on server side
2017-04-03 19:06:08,308 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3 milliseconds to get reply from server
2017-04-03 19:06:08,309 DEBUG [pool-4-thread-24] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [58]-> [Get FST Names]
2017-04-03 19:06:08,309 DEBUG [pool-4-thread-24] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [58] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:06:08,309 DEBUG [pool-4-thread-24] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:06:08,309 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:06:08,309 DEBUG [pool-4-thread-25] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [59]-> [Get FST]
2017-04-03 19:06:08,310 DEBUG [pool-4-thread-25] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [59] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FieldSelectionTable]
------------]
2017-04-03 19:06:08,402 DEBUG [pool-4-thread-25] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 93 milliseconds to prepare reply on server side
2017-04-03 19:06:08,402 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 93 milliseconds to get reply from server
2017-04-03 19:06:08,403 DEBUG [pool-4-thread-26] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [10]-> [Get Default FST (index)]
2017-04-03 19:06:08,403 DEBUG [pool-4-thread-26] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [10] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FieldSelectionTable]
------------]
2017-04-03 19:06:08,403 DEBUG [pool-4-thread-26] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:06:08,403 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:06:08,403 DEBUG [pool-4-thread-27] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [23]-> [Get Worksheet Names]
2017-04-03 19:06:08,404 TRACE [pool-4-thread-27] o.u.j.c.s.DbHandle [DbHandle.java:891] SERVER - Server side getWorksheetNames
2017-04-03 19:06:08,407 TRACE [pool-4-thread-27] o.u.j.c.s.DbHandle [DbHandle.java:893] SERVER - Server side WKS path: [C:\jisis-workspace\home_test_db\VIAF\iwks]
2017-04-03 19:06:08,407 TRACE [pool-4-thread-27] o.u.j.c.s.DbHandle [DbHandle.java:905] SERVER - Number of woorksheets: [1]
2017-04-03 19:06:08,408 TRACE [pool-4-thread-27] o.u.j.c.s.DbHandle [DbHandle.java:908] SERVER - wkname[0] = [Default worksheet]
2017-04-03 19:06:08,408 DEBUG [pool-4-thread-27] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [23] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:06:08,408 DEBUG [pool-4-thread-27] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 5 milliseconds to prepare reply on server side
2017-04-03 19:06:08,408 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 5 milliseconds to get reply from server
2017-04-03 19:06:08,408 DEBUG [pool-4-thread-28] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [24]-> [Get Worksheet]
2017-04-03 19:06:08,411 DEBUG [pool-4-thread-28] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [24] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.WorksheetDef]
------------]
2017-04-03 19:06:08,411 DEBUG [pool-4-thread-28] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3 milliseconds to prepare reply on server side
2017-04-03 19:06:08,412 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 4 milliseconds to get reply from server
2017-04-03 19:06:08,412 DEBUG [pool-4-thread-29] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [26]-> [Get Last MFN]
2017-04-03 19:06:08,413 DEBUG [pool-4-thread-29] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [26] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:06:08,413 DEBUG [pool-4-thread-29] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:06:08,413 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:06:08,414 DEBUG [pool-4-thread-30] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [44]-> [Get Records Count]
2017-04-03 19:06:49,102 INFO [pool-4-thread-30] o.u.j.c.s.BdbImpl [BdbImpl.java:587] SERVER - Database Records Count=[31305939]
2017-04-03 19:06:49,102 INFO [pool-4-thread-30] o.u.j.c.s.BdbImpl [BdbImpl.java:588] SERVER - Time elapsed to get record count=[40688]
2017-04-03 19:06:49,102 DEBUG [pool-4-thread-30] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [44] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:06:49,102 DEBUG [pool-4-thread-30] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 40688 milliseconds to prepare reply on server side
2017-04-03 19:06:49,102 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 40689 milliseconds to get reply from server
2017-04-03 19:06:49,103 DEBUG [pool-4-thread-31] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [8]-> [Get FDT]
2017-04-03 19:06:49,137 DEBUG [pool-4-thread-31] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [8] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FieldDefinitionTable]
------------]
2017-04-03 19:06:49,137 DEBUG [pool-4-thread-31] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 34 milliseconds to prepare reply on server side
2017-04-03 19:06:49,138 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 35 milliseconds to get reply from server
2017-04-03 19:06:49,139 DEBUG [pool-4-thread-32] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:06:50,286 DEBUG [pool-4-thread-32] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:06:50,286 DEBUG [pool-4-thread-32] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1147 milliseconds to prepare reply on server side
2017-04-03 19:06:50,286 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1148 milliseconds to get reply from server
2017-04-03 19:06:50,287 DEBUG [pool-4-thread-33] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [46]-> [Get Dictionary Terms Count]
2017-04-03 19:07:07,295 DEBUG [pool-4-thread-33] o.u.j.c.i.Indexer [TermsCount.java:82] Fields Term count is done so far? true
2017-04-03 19:07:07,473 INFO [pool-4-thread-33] o.u.j.c.i.Indexer [Indexer.java:723] SERVER -Time elapsed to get number of dictionary terms: [17186]
2017-04-03 19:07:07,473 DEBUG [pool-4-thread-33] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [46] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:07,476 DEBUG [pool-4-thread-33] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 17189 milliseconds to prepare reply on server side
2017-04-03 19:07:07,476 DEBUG [pool-6-thread-3] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 17189 milliseconds to get reply from server
2017-04-03 19:07:07,477 DEBUG [pool-4-thread-34] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [44]-> [Get Records Count]
2017-04-03 19:07:10,680 INFO [pool-4-thread-34] o.u.j.c.s.BdbImpl [BdbImpl.java:587] SERVER - Database Records Count=[31305939]
2017-04-03 19:07:10,680 INFO [pool-4-thread-34] o.u.j.c.s.BdbImpl [BdbImpl.java:588] SERVER - Time elapsed to get record count=[3202]
2017-04-03 19:07:10,681 DEBUG [pool-4-thread-34] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [44] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:10,681 DEBUG [pool-4-thread-34] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3204 milliseconds to prepare reply on server side
2017-04-03 19:07:10,681 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3204 milliseconds to get reply from server
2017-04-03 19:07:10,681 DEBUG [pool-4-thread-35] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [15]-> [Get First Record]
2017-04-03 19:07:10,682 DEBUG [pool-4-thread-35] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [15] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:07:10,682 DEBUG [pool-4-thread-35] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:10,683 DEBUG [Default RequestProcessor] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:10,684 DEBUG [pool-4-thread-36] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [44]-> [Get Records Count]
2017-04-03 19:07:13,761 INFO [pool-4-thread-36] o.u.j.c.s.BdbImpl [BdbImpl.java:587] SERVER - Database Records Count=[31305939]
2017-04-03 19:07:13,761 INFO [pool-4-thread-36] o.u.j.c.s.BdbImpl [BdbImpl.java:588] SERVER - Time elapsed to get record count=[3076]
2017-04-03 19:07:13,761 DEBUG [pool-4-thread-36] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [44] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:13,764 DEBUG [pool-4-thread-36] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3080 milliseconds to prepare reply on server side
2017-04-03 19:07:13,765 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3081 milliseconds to get reply from server
2017-04-03 19:07:13,765 DEBUG [pool-4-thread-37] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [44]-> [Get Records Count]
2017-04-03 19:07:16,819 INFO [pool-4-thread-37] o.u.j.c.s.BdbImpl [BdbImpl.java:587] SERVER - Database Records Count=[31305939]
2017-04-03 19:07:16,819 INFO [pool-4-thread-37] o.u.j.c.s.BdbImpl [BdbImpl.java:588] SERVER - Time elapsed to get record count=[3054]
2017-04-03 19:07:16,819 DEBUG [pool-4-thread-37] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [44] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:16,819 DEBUG [pool-4-thread-37] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3054 milliseconds to prepare reply on server side
2017-04-03 19:07:16,819 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3054 milliseconds to get reply from server
2017-04-03 19:07:16,820 DEBUG [pool-4-thread-38] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [26]-> [Get Last MFN]
2017-04-03 19:07:16,820 DEBUG [pool-4-thread-38] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [26] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:16,820 DEBUG [pool-4-thread-38] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:16,821 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:16,825 DEBUG [pool-4-thread-39] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [27]-> [Get PFT Names]
2017-04-03 19:07:16,825 DEBUG [pool-4-thread-39] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [27] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:07:16,825 DEBUG [pool-4-thread-39] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:16,825 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:07:16,829 DEBUG [pool-4-thread-40] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [26]-> [Get Last MFN]
2017-04-03 19:07:16,830 DEBUG [pool-4-thread-40] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [26] e_ok: [TRUE] Message Obj Class: [java.lang.Long]
------------]
2017-04-03 19:07:16,830 DEBUG [pool-4-thread-40] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:16,830 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:16,830 DEBUG [pool-4-thread-41] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [116]-> [Get First Record Formatted]
2017-04-03 19:07:16,832 DEBUG [pool-4-thread-41] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [116] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:16,832 DEBUG [pool-4-thread-41] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 2 milliseconds to prepare reply on server side
2017-04-03 19:07:16,833 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3 milliseconds to get reply from server
2017-04-03 19:07:16,833 DEBUG [pool-4-thread-42] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:07:16,833 DEBUG [pool-4-thread-42] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:07:16,833 DEBUG [pool-4-thread-42] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:16,834 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:16,834 DEBUG [pool-4-thread-43] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:07:16,835 DEBUG [pool-4-thread-43] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:16,835 DEBUG [pool-4-thread-43] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:16,837 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3 milliseconds to get reply from server
2017-04-03 19:07:22,771 DEBUG [pool-4-thread-44] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [117]-> [Get Next Record Formatted]
2017-04-03 19:07:22,772 DEBUG [pool-4-thread-44] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [117] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:22,772 DEBUG [pool-4-thread-44] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:22,773 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 3 milliseconds to get reply from server
2017-04-03 19:07:23,106 DEBUG [pool-4-thread-45] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [117]-> [Get Next Record Formatted]
2017-04-03 19:07:23,107 DEBUG [pool-4-thread-45] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [117] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:23,107 DEBUG [pool-4-thread-45] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:23,108 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:23,314 DEBUG [pool-4-thread-46] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [117]-> [Get Next Record Formatted]
2017-04-03 19:07:23,316 DEBUG [pool-4-thread-46] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [117] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:23,316 DEBUG [pool-4-thread-46] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 2 milliseconds to prepare reply on server side
2017-04-03 19:07:23,316 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:23,498 DEBUG [pool-4-thread-47] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [117]-> [Get Next Record Formatted]
2017-04-03 19:07:23,499 DEBUG [pool-4-thread-47] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [117] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:23,499 DEBUG [pool-4-thread-47] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:23,499 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:23,706 DEBUG [pool-4-thread-48] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [117]-> [Get Next Record Formatted]
2017-04-03 19:07:23,707 DEBUG [pool-4-thread-48] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [117] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:23,707 DEBUG [pool-4-thread-48] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:23,707 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:24,490 DEBUG [pool-4-thread-49] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [119]-> [Get Last Record Formatted]
2017-04-03 19:07:24,491 DEBUG [pool-4-thread-49] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [119] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:24,491 DEBUG [pool-4-thread-49] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:24,491 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:26,066 DEBUG [pool-4-thread-50] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:26,067 DEBUG [pool-4-thread-50] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:26,067 DEBUG [pool-4-thread-50] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:26,067 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:26,282 DEBUG [pool-4-thread-51] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:26,283 DEBUG [pool-4-thread-51] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:26,283 DEBUG [pool-4-thread-51] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:26,284 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:26,490 DEBUG [pool-4-thread-52] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:26,491 DEBUG [pool-4-thread-52] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:26,491 DEBUG [pool-4-thread-52] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:26,491 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:26,698 DEBUG [pool-4-thread-53] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:26,699 DEBUG [pool-4-thread-53] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:26,699 DEBUG [pool-4-thread-53] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:26,700 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:26,931 DEBUG [pool-4-thread-54] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:26,931 DEBUG [pool-4-thread-54] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:26,931 DEBUG [pool-4-thread-54] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:26,932 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:27,130 DEBUG [pool-4-thread-55] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:27,131 DEBUG [pool-4-thread-55] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:27,131 DEBUG [pool-4-thread-55] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:27,131 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:27,331 DEBUG [pool-4-thread-56] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:27,331 DEBUG [pool-4-thread-56] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:27,332 DEBUG [pool-4-thread-56] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:07:27,332 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:27,555 DEBUG [pool-4-thread-57] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [118]-> [Get Previous Record Formatted]
2017-04-03 19:07:27,555 DEBUG [pool-4-thread-57] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [118] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:07:27,555 DEBUG [pool-4-thread-57] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:27,556 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:07:32,415 DEBUG [pool-4-thread-58] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [8]-> [Get FDT]
2017-04-03 19:07:32,483 DEBUG [pool-4-thread-58] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [8] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FieldDefinitionTable]
------------]
2017-04-03 19:07:32,484 DEBUG [pool-4-thread-58] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 69 milliseconds to prepare reply on server side
2017-04-03 19:07:32,484 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 69 milliseconds to get reply from server
2017-04-03 19:07:32,485 DEBUG [pool-4-thread-59] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [10]-> [Get Default FST (index)]
2017-04-03 19:07:32,485 DEBUG [pool-4-thread-59] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [10] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FieldSelectionTable]
------------]
2017-04-03 19:07:32,485 DEBUG [pool-4-thread-59] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:32,485 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:32,489 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)]
2017-04-03 19:07:32,490 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,490 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v100^a,v100^b,v100^c/ (v700^a,v700^b,v700^c/)]
2017-04-03 19:07:32,490 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,490 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v110^a,v110^b /, (v710^a,v710^b/)]
2017-04-03 19:07:32,491 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,491 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v111^a,| |v111^n,| |v111^d,| |v111^c,| |v111^e/ (v711^a,| |v711^n,| |v711^d,| |v711^c,| |v711^e/)]
2017-04-03 19:07:32,491 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,491 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v110^a,v110^b/ (v710^a,v710^b/)]
2017-04-03 19:07:32,492 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,492 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:90] Parsing following format:
[v111^a,| |v111^c,| |v111^e /(v711^a,| |v711^c,| |v711^e/)]
2017-04-03 19:07:32,492 INFO [AWT-EventQueue-0] o.u.j.c.p.ISISFormatter [ISISFormatter.java:94]
ISIS FMT Parser: PFT program parsed successfully.
2017-04-03 19:07:32,493 DEBUG [pool-4-thread-60] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [27]-> [Get PFT Names]
2017-04-03 19:07:32,589 DEBUG [pool-4-thread-60] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [27] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:07:32,589 DEBUG [pool-4-thread-60] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 96 milliseconds to prepare reply on server side
2017-04-03 19:07:32,589 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 97 milliseconds to get reply from server
2017-04-03 19:07:32,599 DEBUG [pool-4-thread-61] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [27]-> [Get PFT Names]
2017-04-03 19:07:32,599 DEBUG [pool-4-thread-61] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [27] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:07:32,599 DEBUG [pool-4-thread-61] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:32,599 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:32,602 DEBUG [pool-4-thread-62] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [27]-> [Get PFT Names]
2017-04-03 19:07:32,602 DEBUG [pool-4-thread-62] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [27] e_ok: [TRUE] Message Obj Class: [[Ljava.lang.String;]
------------]
2017-04-03 19:07:32,602 DEBUG [pool-4-thread-62] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:07:32,602 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:07:36,500 DEBUG [pool-4-thread-63] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:07:36,642 DEBUG [pool-4-thread-63] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:07:36,642 DEBUG [pool-4-thread-63] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 142 milliseconds to prepare reply on server side
2017-04-03 19:07:36,642 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 143 milliseconds to get reply from server
2017-04-03 19:07:36,643 DEBUG [pool-4-thread-64] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:07:36,643 DEBUG [pool-4-thread-64] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=[Ljava.lang.String;@66d51cae,terms.lower.incl=true,terms.regex=VI.*,terms.regex.flag=[Ljava.lang.String;@6812fe04,terms.sort=index,terms.limit=200}]
2017-04-03 19:07:36,643 DEBUG [pool-4-thread-64] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=VI.*&terms.fl=_100&terms.fl=_105&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:07:48,670 DEBUG [pool-4-thread-64] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:400
2017-04-03 19:07:48,673 INFO [pool-4-thread-64] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [12030]
2017-04-03 19:07:48,673 DEBUG [pool-4-thread-64] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:07:48,673 DEBUG [pool-4-thread-64] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 12030 milliseconds to prepare reply on server side
2017-04-03 19:07:48,674 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 12032 milliseconds to get reply from server
2017-04-03 19:08:00,309 DEBUG [pool-4-thread-65] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:08:00,441 DEBUG [pool-4-thread-65] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:08:00,441 DEBUG [pool-4-thread-65] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 132 milliseconds to prepare reply on server side
2017-04-03 19:08:00,441 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 133 milliseconds to get reply from server
2017-04-03 19:08:00,442 DEBUG [pool-4-thread-66] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [51]-> [Get Search Lucene]
2017-04-03 19:08:00,442 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:159] Search Lucene srcExpr: [(_100:"VI.SETTIMANA"
_105:"VI.SETTIMANA"
)] Lucene Search= [true]
2017-04-03 19:08:00,442 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:190] KeywordAnalyzer - Parsed Lucene query: [_100:VI.SETTIMANA _105:VI.SETTIMANA]
2017-04-03 19:08:00,442 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:205] SimpleAnalyzer - Parsed Lucene query: [_100:VI.SETTIMANA _105:VI.SETTIMANA]
2017-04-03 19:08:00,443 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:230] queryJisisAnalyzer - Parsed Lucene query: [_100:VI.SETTIMANA _105:VI.SETTIMANA]
2017-04-03 19:08:00,679 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:315] queryKeywordAnalyzer Number of hits1 [25]
2017-04-03 19:08:00,679 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:320] querySimpleAnalyzer before
2017-04-03 19:08:00,682 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:328] queryJisisAnalyzer after
2017-04-03 19:08:00,685 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:331] querySimpleAnalyzer Number of hits2 [25]
2017-04-03 19:08:00,685 DEBUG [pool-4-thread-66] o.u.j.c.s.Search [Search.java:364] Returned Number of hits [25]
2017-04-03 19:08:00,831 DEBUG [pool-4-thread-66] o.u.j.c.s.DbHandle [DbHandle.java:2020] SERVER - searchLucene mfns.length=25
2017-04-03 19:08:00,832 DEBUG [pool-4-thread-66] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [51] e_ok: [TRUE] Message Obj Class: [[J]
------------]
2017-04-03 19:08:00,832 DEBUG [pool-4-thread-66] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 390 milliseconds to prepare reply on server side
2017-04-03 19:08:00,832 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 391 milliseconds to get reply from server
2017-04-03 19:08:00,833 DEBUG [pool-4-thread-67] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:08:00,841 DEBUG [pool-4-thread-67] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:08:00,841 DEBUG [pool-4-thread-67] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 8 milliseconds to prepare reply on server side
2017-04-03 19:08:00,841 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 8 milliseconds to get reply from server
2017-04-03 19:08:00,841 DEBUG [pool-4-thread-68] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:08:00,842 DEBUG [pool-4-thread-68] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:08:00,842 DEBUG [pool-4-thread-68] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:08:00,842 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:08:00,843 DEBUG [pool-4-thread-69] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:08:00,843 DEBUG [pool-4-thread-69] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:08:00,846 DEBUG [pool-4-thread-69] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3 milliseconds to prepare reply on server side
2017-04-03 19:08:00,846 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 4 milliseconds to get reply from server
2017-04-03 19:08:08,906 DEBUG [pool-4-thread-70] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:08:08,913 DEBUG [pool-4-thread-70] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:08:08,914 DEBUG [pool-4-thread-70] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 8 milliseconds to prepare reply on server side
2017-04-03 19:08:08,914 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 8 milliseconds to get reply from server
2017-04-03 19:08:08,914 DEBUG [pool-4-thread-71] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:08:08,914 DEBUG [pool-4-thread-71] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:08:08,914 DEBUG [pool-4-thread-71] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:08,915 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:08:08,915 DEBUG [pool-4-thread-72] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:08:08,915 DEBUG [pool-4-thread-72] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:08:08,915 DEBUG [pool-4-thread-72] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:08,915 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:08:10,618 DEBUG [pool-4-thread-73] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:08:10,625 DEBUG [pool-4-thread-73] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:08:10,628 DEBUG [pool-4-thread-73] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 10 milliseconds to prepare reply on server side
2017-04-03 19:08:10,628 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 11 milliseconds to get reply from server
2017-04-03 19:08:10,629 DEBUG [pool-4-thread-74] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:08:10,629 DEBUG [pool-4-thread-74] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:08:10,629 DEBUG [pool-4-thread-74] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:10,629 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:08:10,630 DEBUG [pool-4-thread-75] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:08:10,630 DEBUG [pool-4-thread-75] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:08:10,630 DEBUG [pool-4-thread-75] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:10,630 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 0 milliseconds to get reply from server
2017-04-03 19:08:17,364 DEBUG [pool-4-thread-76] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:08:17,512 DEBUG [pool-4-thread-76] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:08:17,513 DEBUG [pool-4-thread-76] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 149 milliseconds to prepare reply on server side
2017-04-03 19:08:17,513 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 150 milliseconds to get reply from server
2017-04-03 19:08:17,513 DEBUG [pool-4-thread-77] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:08:17,514 DEBUG [pool-4-thread-77] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=[Ljava.lang.String;@4e01b4c2,terms.lower.incl=true,terms.regex=A.*,terms.regex.flag=[Ljava.lang.String;@40c64372,terms.sort=index,terms.limit=200}]
2017-04-03 19:08:17,517 DEBUG [pool-4-thread-77] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=A.*&terms.fl=_100&terms.fl=_105&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:08:17,764 DEBUG [pool-4-thread-77] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:400
2017-04-03 19:08:17,764 INFO [pool-4-thread-77] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [247]
2017-04-03 19:08:17,764 DEBUG [pool-4-thread-77] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:08:17,764 DEBUG [pool-4-thread-77] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 251 milliseconds to prepare reply on server side
2017-04-03 19:08:17,765 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 252 milliseconds to get reply from server
2017-04-03 19:08:18,284 DEBUG [pool-4-thread-78] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:08:18,422 DEBUG [pool-4-thread-78] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:08:18,422 DEBUG [pool-4-thread-78] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 138 milliseconds to prepare reply on server side
2017-04-03 19:08:18,422 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 139 milliseconds to get reply from server
2017-04-03 19:08:18,424 DEBUG [pool-4-thread-79] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:08:18,424 DEBUG [pool-4-thread-79] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=[Ljava.lang.String;@621fdf9e,terms.lower.incl=true,terms.regex=AB.*,terms.regex.flag=[Ljava.lang.String;@3b150676,terms.sort=index,terms.limit=200}]
2017-04-03 19:08:18,424 DEBUG [pool-4-thread-79] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=AB.*&terms.fl=_100&terms.fl=_105&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:08:18,682 DEBUG [pool-4-thread-79] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:400
2017-04-03 19:08:18,682 INFO [pool-4-thread-79] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [258]
2017-04-03 19:08:18,682 DEBUG [pool-4-thread-79] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:08:18,686 DEBUG [pool-4-thread-79] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 262 milliseconds to prepare reply on server side
2017-04-03 19:08:18,686 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 263 milliseconds to get reply from server
2017-04-03 19:08:32,940 DEBUG [pool-4-thread-80] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:08:33,065 DEBUG [pool-4-thread-80] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:08:33,065 DEBUG [pool-4-thread-80] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 125 milliseconds to prepare reply on server side
2017-04-03 19:08:33,065 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 125 milliseconds to get reply from server
2017-04-03 19:08:33,066 DEBUG [pool-4-thread-81] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [51]-> [Get Search Lucene]
2017-04-03 19:08:33,066 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:159] Search Lucene srcExpr: [(_100:"ABA SHA?UL, BEN TSIYON."
_105:"ABA SHA?UL, BEN TSIYON."
)] Lucene Search= [true]
2017-04-03 19:08:33,066 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:190] KeywordAnalyzer - Parsed Lucene query: [_100:ABA SHA?UL, BEN TSIYON. _105:ABA SHA?UL, BEN TSIYON.]
2017-04-03 19:08:33,067 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:205] SimpleAnalyzer - Parsed Lucene query: [_100:"ABA SHA?UL, BEN TSIYON." _105:"ABA SHA?UL, BEN TSIYON."]
2017-04-03 19:08:33,069 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:230] queryJisisAnalyzer - Parsed Lucene query: [_100:"ABA SHA?UL BEN TSIYON" _105:"ABA SHA?UL BEN TSIYON"]
2017-04-03 19:08:33,352 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:315] queryKeywordAnalyzer Number of hits1 [7]
2017-04-03 19:08:33,352 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:320] querySimpleAnalyzer before
2017-04-03 19:08:33,395 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:328] queryJisisAnalyzer after
2017-04-03 19:08:33,395 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:331] querySimpleAnalyzer Number of hits2 [8]
2017-04-03 19:08:33,395 DEBUG [pool-4-thread-81] o.u.j.c.s.Search [Search.java:364] Returned Number of hits [8]
2017-04-03 19:08:33,622 DEBUG [pool-4-thread-81] o.u.j.c.s.DbHandle [DbHandle.java:2020] SERVER - searchLucene mfns.length=8
2017-04-03 19:08:33,622 DEBUG [pool-4-thread-81] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [51] e_ok: [TRUE] Message Obj Class: [[J]
------------]
2017-04-03 19:08:33,622 DEBUG [pool-4-thread-81] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 556 milliseconds to prepare reply on server side
2017-04-03 19:08:33,622 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 557 milliseconds to get reply from server
2017-04-03 19:08:33,623 DEBUG [pool-4-thread-82] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:08:33,632 DEBUG [pool-4-thread-82] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:08:33,632 DEBUG [pool-4-thread-82] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 9 milliseconds to prepare reply on server side
2017-04-03 19:08:33,633 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 10 milliseconds to get reply from server
2017-04-03 19:08:33,633 DEBUG [pool-4-thread-83] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:08:33,633 DEBUG [pool-4-thread-83] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:08:33,633 DEBUG [pool-4-thread-83] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:33,634 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:08:33,635 DEBUG [pool-4-thread-84] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:08:33,635 DEBUG [pool-4-thread-84] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:08:33,635 DEBUG [pool-4-thread-84] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:08:33,635 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:09:26,482 DEBUG [pool-4-thread-85] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:09:26,620 DEBUG [pool-4-thread-85] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:09:26,620 DEBUG [pool-4-thread-85] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 138 milliseconds to prepare reply on server side
2017-04-03 19:09:26,621 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 140 milliseconds to get reply from server
2017-04-03 19:09:26,621 DEBUG [pool-4-thread-86] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [97]-> [Get Dictionary Term Suggestions Ex]
2017-04-03 19:09:26,621 DEBUG [pool-4-thread-86] o.u.j.c.s.CommandFactory [CommandFactory.java:1879] SERVER - =====list====
[{terms=true,terms.fl=[Ljava.lang.String;@2977eda4,terms.lower.incl=true,terms.regex=ABB.*,terms.regex.flag=[Ljava.lang.String;@5fe6da93,terms.sort=index,terms.limit=200}]
2017-04-03 19:09:26,621 DEBUG [pool-4-thread-86] o.u.j.c.s.CommandFactory [CommandFactory.java:1884] SERVER - =====params====
[{}]terms=true&terms.lower.incl=true&terms.regex=ABB.*&terms.fl=_100&terms.fl=_105&terms.regex.flag=case_insensitive&terms.regex.flag=unicode_case&terms.limit=200&terms.sort=index
2017-04-03 19:09:26,878 DEBUG [pool-4-thread-86] o.u.j.c.i.Indexer [Indexer.java:1546] Indexer getTermSuggestions -- Number of terms:400
2017-04-03 19:09:26,878 INFO [pool-4-thread-86] o.u.j.c.i.Indexer [Indexer.java:1553] SERVER -Time elapsed to get suggestions: [257]
2017-04-03 19:09:26,878 DEBUG [pool-4-thread-86] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [97] e_ok: [TRUE] Message Obj Class: [java.util.ArrayList]
------------]
2017-04-03 19:09:26,878 DEBUG [pool-4-thread-86] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 257 milliseconds to prepare reply on server side
2017-04-03 19:09:26,879 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 258 milliseconds to get reply from server
2017-04-03 19:09:34,133 DEBUG [pool-4-thread-87] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [125]-> [Check Index Format Version]
2017-04-03 19:09:34,266 DEBUG [pool-4-thread-87] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [125] e_ok: [TRUE] Message Obj Class: [java.lang.Boolean]
------------]
2017-04-03 19:09:34,266 DEBUG [pool-4-thread-87] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 133 milliseconds to prepare reply on server side
2017-04-03 19:09:34,266 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 134 milliseconds to get reply from server
2017-04-03 19:09:34,271 DEBUG [pool-4-thread-88] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [51]-> [Get Search Lucene]
2017-04-03 19:09:34,271 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:159] Search Lucene srcExpr: [(_100:"ABBACADABRA"
_105:"ABBACADABRA"
)] Lucene Search= [true]
2017-04-03 19:09:34,271 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:190] KeywordAnalyzer - Parsed Lucene query: [_100:ABBACADABRA _105:ABBACADABRA]
2017-04-03 19:09:34,271 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:205] SimpleAnalyzer - Parsed Lucene query: [_100:ABBACADABRA _105:ABBACADABRA]
2017-04-03 19:09:34,272 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:230] queryJisisAnalyzer - Parsed Lucene query: [_100:ABBACADABRA _105:ABBACADABRA]
2017-04-03 19:09:34,493 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:315] queryKeywordAnalyzer Number of hits1 [3]
2017-04-03 19:09:34,493 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:320] querySimpleAnalyzer before
2017-04-03 19:09:34,495 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:328] queryJisisAnalyzer after
2017-04-03 19:09:34,495 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:331] querySimpleAnalyzer Number of hits2 [3]
2017-04-03 19:09:34,495 DEBUG [pool-4-thread-88] o.u.j.c.s.Search [Search.java:364] Returned Number of hits [3]
2017-04-03 19:09:34,633 DEBUG [pool-4-thread-88] o.u.j.c.s.DbHandle [DbHandle.java:2020] SERVER - searchLucene mfns.length=3
2017-04-03 19:09:34,633 DEBUG [pool-4-thread-88] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [51] e_ok: [TRUE] Message Obj Class: [[J]
------------]
2017-04-03 19:09:34,633 DEBUG [pool-4-thread-88] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 362 milliseconds to prepare reply on server side
2017-04-03 19:09:34,634 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 364 milliseconds to get reply from server
2017-04-03 19:09:34,635 DEBUG [pool-4-thread-89] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:09:34,644 DEBUG [pool-4-thread-89] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:09:34,647 DEBUG [pool-4-thread-89] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 12 milliseconds to prepare reply on server side
2017-04-03 19:09:34,648 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 14 milliseconds to get reply from server
2017-04-03 19:09:34,648 DEBUG [pool-4-thread-90] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:09:34,648 DEBUG [pool-4-thread-90] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:09:34,649 DEBUG [pool-4-thread-90] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 1 milliseconds to prepare reply on server side
2017-04-03 19:09:34,649 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:09:34,650 DEBUG [pool-4-thread-91] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:09:34,650 DEBUG [pool-4-thread-91] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:09:34,650 DEBUG [pool-4-thread-91] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:09:34,650 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:09:41,874 DEBUG [pool-4-thread-92] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:09:41,876 DEBUG [pool-4-thread-92] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:09:41,876 DEBUG [pool-4-thread-92] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 2 milliseconds to prepare reply on server side
2017-04-03 19:09:41,876 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 2 milliseconds to get reply from server
2017-04-03 19:09:41,876 DEBUG [pool-4-thread-93] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:09:41,876 DEBUG [pool-4-thread-93] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:09:41,879 DEBUG [pool-4-thread-93] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 3 milliseconds to prepare reply on server side
2017-04-03 19:09:41,880 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 4 milliseconds to get reply from server
2017-04-03 19:09:41,880 DEBUG [pool-4-thread-94] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:09:41,880 DEBUG [pool-4-thread-94] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:09:41,880 DEBUG [pool-4-thread-94] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:09:41,881 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:09:44,474 DEBUG [pool-4-thread-95] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [115]-> [Get Record Formatted]
2017-04-03 19:09:44,482 DEBUG [pool-4-thread-95] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [115] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.common.FormattedRecord]
------------]
2017-04-03 19:09:44,482 DEBUG [pool-4-thread-95] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 8 milliseconds to prepare reply on server side
2017-04-03 19:09:44,482 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 8 milliseconds to get reply from server
2017-04-03 19:09:44,483 DEBUG [pool-4-thread-96] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [14]-> [Get Record]
2017-04-03 19:09:44,483 DEBUG [pool-4-thread-96] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [14] e_ok: [TRUE] Message Obj Class: [org.unesco.jisis.corelib.record.Record]
------------]
2017-04-03 19:09:44,483 DEBUG [pool-4-thread-96] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 0 milliseconds to prepare reply on server side
2017-04-03 19:09:44,484 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 1 milliseconds to get reply from server
2017-04-03 19:09:44,484 DEBUG [pool-4-thread-97] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:97] SERVER - HandleDbRequest Message Request - MSG ID= [29]-> [Get PFT]
2017-04-03 19:09:44,484 DEBUG [pool-4-thread-97] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:121] SERVER - HandleDbRequest Message Reply - reply= [Msg ID: [29] e_ok: [TRUE] Message Obj Class: [java.lang.String]
------------]
2017-04-03 19:09:44,488 DEBUG [pool-4-thread-97] o.u.j.c.s.HandleDbRequest [HandleDbRequest.java:130] SERVER - HandleDbRequest getResponse Exit 4 milliseconds to prepare reply on server side
2017-04-03 19:09:44,488 DEBUG [AWT-EventQueue-0] o.u.j.c.c.NioClient4 [NioClient4.java:120] CLIENT - NioClient4 4 milliseconds to get reply from server
2017-04-03 19:09:55,278 INFO [AWT-EventQueue-0] o.u.j.j.JavaISIS [JavaISIS.java:177] J-ISIS History saved
2017-04-03 19:09:55,279 DEBUG [AWT-EventQueue-0] o.u.j.c.s.DbServerService [DbServerService.java:271] Asking thread [org.unesco.jisis.corelib.server.CustomThreadPoolExecutor@7702af62[Running, pool size = 1, active threads = 1, queued tasks = 0, completed tasks = 0]] to stop.
2017-04-03 19:09:55,280 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.Server@be15902
2017-04-03 19:09:55,280 INFO [pool-3-thread-1] o.u.j.c.s.CustomThreadPoolExecutor [CustomThreadPoolExecutor.java:75] SERVER -Database Server Shutdown Date Mon Apr 03 19:09:55 CEST 2017
2017-04-03 19:09:55,280 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping [email protected]:8585
2017-04-03 19:09:55,280 INFO [pool-3-thread-1] o.u.j.c.s.CustomThreadPoolExecutor [CustomThreadPoolExecutor.java:109] SERVER - Database Server Terminated Mon Apr 03 19:09:55 CEST 2017
2017-04-03 19:09:55,280 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@70b05cc0
2017-04-03 19:09:55,280 DEBUG [qtp449185260-29 Selector0] o.e.j.i.nio [SelectorManager.java:299] Stopped Thread[qtp449185260-29 Selector0,5,IDE Main] on org.eclipse.jetty.io.nio.SelectorManager$1@3981d05c
2017-04-03 19:09:55,290 DEBUG [qtp449185260-30 Selector1] o.e.j.i.nio [SelectorManager.java:299] Stopped Thread[qtp449185260-30 Selector1,5,IDE Main] on org.eclipse.jetty.io.nio.SelectorManager$1@7928593d
2017-04-03 19:09:55,300 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@70b05cc0
2017-04-03 19:09:55,300 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
2017-04-03 19:09:55,301 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED null/null
2017-04-03 19:09:55,301 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED [email protected]:8585
2017-04-03 19:09:55,301 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.handler.ContextHandlerCollection@4e660486
2017-04-03 19:09:55,305 DEBUG [AWT-EventQueue-0] o.e.j.s.h.AbstractHandler [AbstractHandler.java:63] stopping org.eclipse.jetty.server.handler.ContextHandlerCollection@4e660486
2017-04-03 19:09:55,305 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.handler.DefaultHandler@4f4e6d01
2017-04-03 19:09:55,305 DEBUG [AWT-EventQueue-0] o.e.j.s.h.AbstractHandler [AbstractHandler.java:63] stopping org.eclipse.jetty.server.handler.DefaultHandler@4f4e6d01
2017-04-03 19:09:55,305 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.eclipse.jetty.server.handler.DefaultHandler@4f4e6d01
2017-04-03 19:09:55,305 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping o.e.j.s.ServletContextHandler{/,file:/C:/jisis-workspace/home_test_db/}
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.session.SessionHandler@574e674e
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.server.session.HashSessionManager@51164ce1
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.eclipse.jetty.server.session.HashSessionManager@51164ce1
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.servlet.ServletHandler@354b894
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.s.h.AbstractHandler [AbstractHandler.java:63] stopping org.eclipse.jetty.servlet.ServletHandler@354b894
2017-04-03 19:09:55,306 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.apache.jasper.servlet.JspServlet-1
2017-04-03 19:09:55,307 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.apache.jasper.servlet.JspServlet-1
2017-04-03 19:09:55,307 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:182] stopping org.eclipse.jetty.servlet.DefaultServlet-1
2017-04-03 19:09:55,307 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.eclipse.jetty.servlet.DefaultServlet-1
2017-04-03 19:09:55,307 DEBUG [AWT-EventQueue-0] o.e.j.u.c.AbstractLifeCycle [AbstractLifeCycle.java:191] STOPPED org.eclipse.jetty.servlet.ServletHandler@354b894