I have a very basic set of select/insert/update queries that run at 1 minute intervals.
The job runs on extremely lightweight table and every minute processes approx the same amount of data. It is the only service that interacts with the tables in question. Within a 5 minute period the job runs in ~0.5 second on the first 4 iterations ( minutes 1,2,3,4,6,7,8,9,11,12,13 etc). However on the 5th iteration so at 05,10,15,20,25,30 etc the job goes from 0.5 second to 8-10seconds. Every 5 minutes it appears to get caught in some sort of lock that I can't locate. The code is exactly the same for each 1 minute iteration and the volume of data to be processed doesn't really change which suggests to me it is db side. I have attached the log file where you can see the job at 09:59:00 in less than a second, 10:00:00 in 8 seconds and then 10:01:00 in less than a second again. Any guidance or advice would be greatly appreciated. Regards Liam -- You received this message because you are subscribed to the Google Groups "H2 Database" group. To unsubscribe from this group and stop receiving emails from it, send an email to h2-database+unsubscr...@googlegroups.com. To view this discussion on the web visit https://groups.google.com/d/msgid/h2-database/f0f1e8af-c6e1-439b-92ab-0d9105a913be%40googlegroups.com.
2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get epics 01: 1 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 5 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 7 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 9 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 10 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 10 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 11 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 11 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 11 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 11 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 11 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 11 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910210958,offerVolume=39.0,bidVolume=19.0,totalVolume=58.0,diffVolume=20.0,ratioVolume=0.344827586] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 12 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 13 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910210959,offerVolume=0,bidVolume=12.0,totalVolume=12.0,diffVolume=-12.0,ratioVolume=-1.000000000] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 14 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 15 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 16 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 17 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=01,blockId=201910210958,offerVolume=20.0,bidVolume=22.0,totalVolume=42.0,diffVolume=-2.0,ratioVolume=-0.047619048] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 20 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 21 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 22 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 22 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 22 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 22 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 22 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 23 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 23 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 23 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 23 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 23 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=01,blockId=201910210958,offerVolume=106.0,bidVolume=96.0,totalVolume=202.0,diffVolume=10.0,ratioVolume=0.049504950] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 24 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 25 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=01,blockId=201910210959,offerVolume=4.0,bidVolume=0,totalVolume=4.0,diffVolume=4.0,ratioVolume=1.000000000] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 26 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 27 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 28 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 28 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 30 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 30 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 30 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 31 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=01,blockId=201910210958,offerVolume=41.0,bidVolume=79.0,totalVolume=120.0,diffVolume=-38.0,ratioVolume=-0.316666667] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 32 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 32 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=01,blockId=201910210959,offerVolume=0,bidVolume=1.0,totalVolume=1.0,diffVolume=-1.0,ratioVolume=-1.000000000] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 33 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 35 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 35 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 35 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 36 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 37 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 38 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=01,blockId=201910210958,offerVolume=21.0,bidVolume=15.0,totalVolume=36.0,diffVolume=6.0,ratioVolume=0.166666667] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 41 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 41 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 42 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 42 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 42 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 42 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=01,blockId=201910210959,offerVolume=2.0,bidVolume=2.0,totalVolume=4.0,diffVolume=0.0,ratioVolume=0] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 43 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 45 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 46 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 47 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910210958,offerVolume=99.0,bidVolume=213.0,totalVolume=312.0,diffVolume=-114.0,ratioVolume=-0.365384615] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 48 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 48 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910210959,offerVolume=0,bidVolume=56.0,totalVolume=56.0,diffVolume=-56.0,ratioVolume=-1.000000000] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 51 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 53 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 53 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 53 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 54 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 54 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 54 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=01,blockId=201910210958,offerVolume=6.0,bidVolume=1.0,totalVolume=7.0,diffVolume=5.0,ratioVolume=0.714285714] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 55 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 57 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 57 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 57 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 57 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 58 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 58 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 58 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=01,blockId=201910210958,offerVolume=88.0,bidVolume=69.0,totalVolume=157.0,diffVolume=19.0,ratioVolume=0.121019108] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 59 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - epics done 01: 59 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - ABQ add 01: 60 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 05: 0 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 2 2019-10-21 09:59:00 INFO MarketTradeDao:69 - Inserted 614 MarketTradeArchives prior to blockid: 201910210958 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 19 2019-10-21 09:59:00 INFO MarketTradeDao:80 - Deleted 614 MarketTrades prior to blockid: 201910210958 2019-10-21 09:59:00 INFO MarketTradeProcess:10 - Elapsed time for MarketTradeProcess: 41 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=05,blockId=201910210955,offerVolume=248.0,bidVolume=216.0,totalVolume=464.0,diffVolume=32.0,ratioVolume=0.068965517] 2019-10-21 09:59:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess 01: 103 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 44 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 45 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=05,blockId=201910210955,offerVolume=114.0,bidVolume=179.0,totalVolume=293.0,diffVolume=-65.0,ratioVolume=-0.221843003] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 47 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 50 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=05,blockId=201910210955,offerVolume=397.0,bidVolume=685.0,totalVolume=1082.0,diffVolume=-288.0,ratioVolume=-0.266173752] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 52 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 54 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=05,blockId=201910210955,offerVolume=366.0,bidVolume=546.0,totalVolume=912.0,diffVolume=-180.0,ratioVolume=-0.197368421] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 55 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 56 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=05,blockId=201910210955,offerVolume=106.0,bidVolume=116.0,totalVolume=222.0,diffVolume=-10.0,ratioVolume=-0.045045045] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 58 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 59 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=05,blockId=201910210955,offerVolume=407.0,bidVolume=807.0,totalVolume=1214.0,diffVolume=-400.0,ratioVolume=-0.329489292] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 60 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 61 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=05,blockId=201910210955,offerVolume=49.0,bidVolume=33.0,totalVolume=82.0,diffVolume=16.0,ratioVolume=0.195121951] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 64 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 66 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=05,blockId=201910210955,offerVolume=404.0,bidVolume=325.0,totalVolume=729.0,diffVolume=79.0,ratioVolume=0.108367627] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 05: 68 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 05: 68 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 60: 0 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 0 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 2 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=60,blockId=201910210900,offerVolume=3522.0,bidVolume=3976.0,totalVolume=7498.0,diffVolume=-454.0,ratioVolume=-0.060549480] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 4 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 6 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=60,blockId=201910210900,offerVolume=2715.0,bidVolume=2904.0,totalVolume=5619.0,diffVolume=-189.0,ratioVolume=-0.033635878] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 7 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 9 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=60,blockId=201910210900,offerVolume=7255.0,bidVolume=7527.0,totalVolume=14782.0,diffVolume=-272.0,ratioVolume=-0.018400758] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 10 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 11 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=60,blockId=201910210900,offerVolume=6336.0,bidVolume=6279.0,totalVolume=12615.0,diffVolume=57.0,ratioVolume=0.004518430] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 14 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 16 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=60,blockId=201910210900,offerVolume=1607.0,bidVolume=1629.0,totalVolume=3236.0,diffVolume=-22.0,ratioVolume=-0.006798517] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 17 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 19 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=60,blockId=201910210900,offerVolume=8018.0,bidVolume=8214.0,totalVolume=16232.0,diffVolume=-196.0,ratioVolume=-0.012074914] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 20 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 22 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=60,blockId=201910210900,offerVolume=543.0,bidVolume=660.0,totalVolume=1203.0,diffVolume=-117.0,ratioVolume=-0.097256858] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 24 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 26 2019-10-21 09:59:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=60,blockId=201910210900,offerVolume=4476.0,bidVolume=4616.0,totalVolume=9092.0,diffVolume=-140.0,ratioVolume=-0.015398152] 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 60: 27 2019-10-21 09:59:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 60: 27 2019-10-21 10:00:00 INFO Subscriber:45 - EGFB: Message subscribed: com.hazelcast.topic.impl.DataAwareMessage[source=candleminbuild] 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get epics 01: 0 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 9 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 10 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 18 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 18 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 27 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 27 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 27 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 28 2019-10-21 10:00:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910210959,offerVolume=38.0,bidVolume=43.0,totalVolume=81.0,diffVolume=-5.0,ratioVolume=-0.061728395] 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 307 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 312 2019-10-21 10:00:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910211000,offerVolume=0,bidVolume=10.0,totalVolume=10.0,diffVolume=-10.0,ratioVolume=-1.000000000] 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 491 2019-10-21 10:00:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 588 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 780 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 781 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 781 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 782 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 782 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 782 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 782 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 782 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 782 2019-10-21 10:00:01 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=01,blockId=201910210959,offerVolume=9.0,bidVolume=11.0,totalVolume=20.0,diffVolume=-2.0,ratioVolume=-0.100000000] 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 1020 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 1202 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 1393 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1393 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1393 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1394 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1394 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1395 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1395 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1395 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1395 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1395 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1395 2019-10-21 10:00:01 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=01,blockId=201910210959,offerVolume=135.0,bidVolume=65.0,totalVolume=200.0,diffVolume=70.0,ratioVolume=0.350000000] 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 1424 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 1433 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 1439 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1440 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1440 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1440 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1440 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 1440 2019-10-21 10:00:01 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=01,blockId=201910210959,offerVolume=107.0,bidVolume=86.0,totalVolume=193.0,diffVolume=21.0,ratioVolume=0.108808290] 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 1447 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 1448 2019-10-21 10:00:01 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=01,blockId=201910211000,offerVolume=0,bidVolume=44.0,totalVolume=44.0,diffVolume=-44.0,ratioVolume=-1.000000000] 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 1556 2019-10-21 10:00:01 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 1754 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 1943 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1957 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1958 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1959 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1960 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1961 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1961 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1961 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1961 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1961 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1962 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1962 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 1962 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 1962 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 1962 2019-10-21 10:00:02 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=01,blockId=201910210959,offerVolume=32.0,bidVolume=26.0,totalVolume=58.0,diffVolume=6.0,ratioVolume=0.103448276] 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 2113 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 2129 2019-10-21 10:00:02 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=01,blockId=201910211000,offerVolume=0,bidVolume=1.0,totalVolume=1.0,diffVolume=-1.0,ratioVolume=-1.000000000] 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 2320 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 2539 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 2556 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2556 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2556 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2556 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2556 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2557 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2558 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2559 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2561 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2562 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2563 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2563 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2563 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 2563 2019-10-21 10:00:02 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910210959,offerVolume=670.0,bidVolume=1485.0,totalVolume=2155.0,diffVolume=-815.0,ratioVolume=-0.378190255] 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 2575 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 2576 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2576 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2576 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2577 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2578 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2578 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2578 2019-10-21 10:00:02 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910211000,offerVolume=12.0,bidVolume=241.0,totalVolume=253.0,diffVolume=-229.0,ratioVolume=-0.905138340] 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 2583 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 2590 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 2597 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 2611 2019-10-21 10:00:02 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 2612 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=01,blockId=201910210959,offerVolume=2.0,bidVolume=8.0,totalVolume=10.0,diffVolume=-6.0,ratioVolume=-0.600000000] 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 2823 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 2943 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 3069 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3072 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3072 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3073 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3074 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 3075 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=01,blockId=201910210959,offerVolume=80.0,bidVolume=66.0,totalVolume=146.0,diffVolume=14.0,ratioVolume=0.095890411] 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 3215 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 3215 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 3215 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 3215 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=01,blockId=201910211000,offerVolume=8.0,bidVolume=1.0,totalVolume=9.0,diffVolume=7.0,ratioVolume=0.777777778] 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 3343 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - epics done 01: 3344 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - ABQ add 01: 3345 2019-10-21 10:00:03 INFO MarketTradeDao:69 - Inserted 360 MarketTradeArchives prior to blockid: 201910210959 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 05: 40 2019-10-21 10:00:03 INFO MarketTradeDao:80 - Deleted 360 MarketTrades prior to blockid: 201910210959 2019-10-21 10:00:03 INFO MarketTradeProcess:10 - Elapsed time for MarketTradeProcess: 63 2019-10-21 10:00:03 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess 01: 3408 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 63 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 67 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=05,blockId=201910210955,offerVolume=286.0,bidVolume=247.0,totalVolume=533.0,diffVolume=39.0,ratioVolume=0.073170732] 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=FTSE100,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=10.0,totalVolume=10.0,diffVolume=-10.0,ratioVolume=-1.000000000] 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 78 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 82 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=05,blockId=201910210955,offerVolume=123.0,bidVolume=190.0,totalVolume=313.0,diffVolume=-67.0,ratioVolume=-0.214057508] 2019-10-21 10:00:03 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:03 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 360 2019-10-21 10:00:04 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 556 2019-10-21 10:00:04 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=05,blockId=201910210955,offerVolume=528.0,bidVolume=750.0,totalVolume=1278.0,diffVolume=-222.0,ratioVolume=-0.173708920] 2019-10-21 10:00:04 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:04 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 1024 2019-10-21 10:00:04 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 1043 2019-10-21 10:00:04 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=05,blockId=201910210955,offerVolume=473.0,bidVolume=631.0,totalVolume=1104.0,diffVolume=-158.0,ratioVolume=-0.143115942] 2019-10-21 10:00:04 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=44.0,totalVolume=44.0,diffVolume=-44.0,ratioVolume=-1.000000000] 2019-10-21 10:00:04 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 1072 2019-10-21 10:00:04 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 1201 2019-10-21 10:00:04 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=05,blockId=201910210955,offerVolume=136.0,bidVolume=140.0,totalVolume=276.0,diffVolume=-4.0,ratioVolume=-0.014492754] 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=DAX,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=1.0,totalVolume=1.0,diffVolume=-1.0,ratioVolume=-1.000000000] 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 1634 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 1752 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=05,blockId=201910210955,offerVolume=1077.0,bidVolume=2236.0,totalVolume=3313.0,diffVolume=-1159.0,ratioVolume=-0.349833987] 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=WTI,blockIdType=05,blockId=201910211000,offerVolume=12.0,bidVolume=241.0,totalVolume=253.0,diffVolume=-229.0,ratioVolume=-0.905138340] 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 2172 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 2184 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=05,blockId=201910210955,offerVolume=51.0,bidVolume=41.0,totalVolume=92.0,diffVolume=10.0,ratioVolume=0.108695652] 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=SILVER,blockIdType=05,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 2197 2019-10-21 10:00:05 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 2201 2019-10-21 10:00:05 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=05,blockId=201910210955,offerVolume=484.0,bidVolume=391.0,totalVolume=875.0,diffVolume=93.0,ratioVolume=0.106285714] 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=GOLD,blockIdType=05,blockId=201910211000,offerVolume=8.0,bidVolume=1.0,totalVolume=9.0,diffVolume=7.0,ratioVolume=0.777777778] 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 05: 2482 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 05: 2482 2019-10-21 10:00:06 INFO Publisher:24 - EGFB: Footprint Message published for 5 minute Footprint trigger 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 60: 137 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 262 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 413 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=60,blockId=201910210900,offerVolume=3560.0,bidVolume=4007.0,totalVolume=7567.0,diffVolume=-447.0,ratioVolume=-0.059072288] 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=FTSE100,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=10.0,totalVolume=10.0,diffVolume=-10.0,ratioVolume=-1.000000000] 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 568 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 585 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=60,blockId=201910210900,offerVolume=2724.0,bidVolume=2915.0,totalVolume=5639.0,diffVolume=-191.0,ratioVolume=-0.033871254] 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 597 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 603 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=60,blockId=201910210900,offerVolume=7386.0,bidVolume=7592.0,totalVolume=14978.0,diffVolume=-206.0,ratioVolume=-0.013753505] 2019-10-21 10:00:06 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:06 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 851 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 968 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=60,blockId=201910210900,offerVolume=6443.0,bidVolume=6364.0,totalVolume=12807.0,diffVolume=79.0,ratioVolume=0.006168502] 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=44.0,totalVolume=44.0,diffVolume=-44.0,ratioVolume=-1.000000000] 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 1415 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 1426 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=60,blockId=201910210900,offerVolume=1637.0,bidVolume=1653.0,totalVolume=3290.0,diffVolume=-16.0,ratioVolume=-0.004863222] 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=DAX,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=1.0,totalVolume=1.0,diffVolume=-1.0,ratioVolume=-1.000000000] 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 1457 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 1469 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=60,blockId=201910210900,offerVolume=8688.0,bidVolume=9643.0,totalVolume=18331.0,diffVolume=-955.0,ratioVolume=-0.052097540] 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=WTI,blockIdType=60,blockId=201910211000,offerVolume=12.0,bidVolume=241.0,totalVolume=253.0,diffVolume=-229.0,ratioVolume=-0.905138340] 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 1631 2019-10-21 10:00:07 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 1700 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=60,blockId=201910210900,offerVolume=545.0,bidVolume=668.0,totalVolume=1213.0,diffVolume=-123.0,ratioVolume=-0.101401484] 2019-10-21 10:00:07 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=SILVER,blockIdType=60,blockId=201910211000,offerVolume=0,bidVolume=0,totalVolume=0,diffVolume=0,ratioVolume=0] 2019-10-21 10:00:08 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 1976 2019-10-21 10:00:08 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 1982 2019-10-21 10:00:08 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=60,blockId=201910210900,offerVolume=4556.0,bidVolume=4682.0,totalVolume=9238.0,diffVolume=-126.0,ratioVolume=-0.013639316] 2019-10-21 10:00:08 INFO FootprintAnalyticsDao:34 - Insert of footprintAnalytics: FootprintAnalytics[epic=GOLD,blockIdType=60,blockId=201910211000,offerVolume=8.0,bidVolume=1.0,totalVolume=9.0,diffVolume=7.0,ratioVolume=0.777777778] 2019-10-21 10:00:08 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 60: 2004 2019-10-21 10:00:08 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 60: 2005 2019-10-21 10:01:00 INFO Subscriber:45 - EGFB: Message subscribed: com.hazelcast.topic.impl.DataAwareMessage[source=candleminbuild] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get epics 01: 1 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 4 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 6 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 7 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 7 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910211000,offerVolume=42.0,bidVolume=32.0,totalVolume=74.0,diffVolume=10.0,ratioVolume=0.135135135] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 8 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 8 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=01,blockId=201910211001,offerVolume=0,bidVolume=3.0,totalVolume=3.0,diffVolume=-3.0,ratioVolume=-1.000000000] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 13 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 16 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 17 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 18 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 19 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 19 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=01,blockId=201910211000,offerVolume=25.0,bidVolume=30.0,totalVolume=55.0,diffVolume=-5.0,ratioVolume=-0.090909091] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 21 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 21 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=01,blockId=201910211001,offerVolume=1.0,bidVolume=0,totalVolume=1.0,diffVolume=1.0,ratioVolume=1.000000000] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 23 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 27 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 28 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 29 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 29 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=01,blockId=201910211000,offerVolume=60.0,bidVolume=4.0,totalVolume=64.0,diffVolume=56.0,ratioVolume=0.875000000] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 30 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 32 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 33 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 34 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 34 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 34 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 34 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=01,blockId=201910211000,offerVolume=30.0,bidVolume=152.0,totalVolume=182.0,diffVolume=-122.0,ratioVolume=-0.670329670] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 35 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 38 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 38 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 38 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 38 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 39 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 40 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 40 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 40 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 40 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=01,blockId=201910211000,offerVolume=22.0,bidVolume=26.0,totalVolume=48.0,diffVolume=-4.0,ratioVolume=-0.083333333] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 41 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 57 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 58 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 59 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 60 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 61 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 61 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910211000,offerVolume=696.0,bidVolume=966.0,totalVolume=1662.0,diffVolume=-270.0,ratioVolume=-0.162454874] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 63 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 63 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 63 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 63 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=01,blockId=201910211001,offerVolume=2.0,bidVolume=1.0,totalVolume=3.0,diffVolume=1.0,ratioVolume=0.333333333] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 64 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 66 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 66 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 67 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 69 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=01,blockId=201910211000,offerVolume=10.0,bidVolume=7.0,totalVolume=17.0,diffVolume=3.0,ratioVolume=0.176470588] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 71 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - get footprintmins 01: 73 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - insert dummy 01: 74 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 74 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 74 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 74 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 74 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 4 : 75 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 5 : 75 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 1 : 75 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=01,blockId=201910211000,offerVolume=28.0,bidVolume=38.0,totalVolume=66.0,diffVolume=-10.0,ratioVolume=-0.151515152] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 2 : 76 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 3 : 76 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=01,blockId=201910211001,offerVolume=12.0,bidVolume=0,totalVolume=12.0,diffVolume=12.0,ratioVolume=1.000000000] 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FPM LOOP 6 : 79 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - epics done 01: 80 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess - ABQ add 01: 80 2019-10-21 10:01:00 INFO MarketTradeDao:69 - Inserted 1148 MarketTradeArchives prior to blockid: 201910211000 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 05: 27 2019-10-21 10:01:00 INFO MarketTradeDao:80 - Deleted 1148 MarketTrades prior to blockid: 201910211000 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 78 2019-10-21 10:01:00 INFO MarketTradeProcess:10 - Elapsed time for MarketTradeProcess: 80 2019-10-21 10:01:00 INFO FootprintMinAnalyticsProcess:10 - Elapsed time for FootprintMinAnalyticsProcess 01: 162 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 83 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=05,blockId=201910211000,offerVolume=42.0,bidVolume=35.0,totalVolume=77.0,diffVolume=7.0,ratioVolume=0.090909091] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 85 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 89 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=05,blockId=201910211000,offerVolume=26.0,bidVolume=30.0,totalVolume=56.0,diffVolume=-4.0,ratioVolume=-0.071428571] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 92 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 96 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=05,blockId=201910211000,offerVolume=60.0,bidVolume=4.0,totalVolume=64.0,diffVolume=56.0,ratioVolume=0.875000000] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 98 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 101 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=05,blockId=201910211000,offerVolume=30.0,bidVolume=152.0,totalVolume=182.0,diffVolume=-122.0,ratioVolume=-0.670329670] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 104 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 107 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=05,blockId=201910211000,offerVolume=22.0,bidVolume=26.0,totalVolume=48.0,diffVolume=-4.0,ratioVolume=-0.083333333] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 109 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 113 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=05,blockId=201910211000,offerVolume=698.0,bidVolume=967.0,totalVolume=1665.0,diffVolume=-269.0,ratioVolume=-0.161561562] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 115 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 119 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=05,blockId=201910211000,offerVolume=10.0,bidVolume=7.0,totalVolume=17.0,diffVolume=3.0,ratioVolume=0.176470588] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 05: 121 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 05: 124 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=05,blockId=201910211000,offerVolume=40.0,bidVolume=38.0,totalVolume=78.0,diffVolume=2.0,ratioVolume=0.025641026] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 05: 126 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 05: 126 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get epic list 60: 0 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 1 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 2 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=FTSE100,blockIdType=60,blockId=201910211000,offerVolume=42.0,bidVolume=35.0,totalVolume=77.0,diffVolume=7.0,ratioVolume=0.090909091] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 3 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 4 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI NASDAQ100,blockIdType=60,blockId=201910211000,offerVolume=26.0,bidVolume=30.0,totalVolume=56.0,diffVolume=-4.0,ratioVolume=-0.071428571] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 6 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 7 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=BRITISHPOUND,blockIdType=60,blockId=201910211000,offerVolume=60.0,bidVolume=4.0,totalVolume=64.0,diffVolume=56.0,ratioVolume=0.875000000] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 10 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 11 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=MINI S&P 500,blockIdType=60,blockId=201910211000,offerVolume=30.0,bidVolume=152.0,totalVolume=182.0,diffVolume=-122.0,ratioVolume=-0.670329670] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 13 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 13 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=DAX,blockIdType=60,blockId=201910211000,offerVolume=22.0,bidVolume=26.0,totalVolume=48.0,diffVolume=-4.0,ratioVolume=-0.083333333] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 15 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 16 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=WTI,blockIdType=60,blockId=201910211000,offerVolume=698.0,bidVolume=967.0,totalVolume=1665.0,diffVolume=-269.0,ratioVolume=-0.161561562] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 18 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 19 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=SILVER,blockIdType=60,blockId=201910211000,offerVolume=10.0,bidVolume=7.0,totalVolume=17.0,diffVolume=3.0,ratioVolume=0.176470588] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get max id 60: 21 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - get rotations 60: 22 2019-10-21 10:01:00 INFO FootprintAnalyticsDao:76 - Update of footprintanalytics: FootprintAnalytics[epic=GOLD,blockIdType=60,blockId=201910211000,offerVolume=40.0,bidVolume=38.0,totalVolume=78.0,diffVolume=2.0,ratioVolume=0.025641026] 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess - epics done 60: 23 2019-10-21 10:01:00 INFO AnalyticsBuildProcess:10 - Elapsed time for AnalyticsBuildProcess 60: 23