Trying 256 buckets, 30 worker tasks, PostgreSQL - NEW SOLUTION (dynamic modify) =============================================================================== Default init wait time ====================== Attempt #1 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 21,109 | 0 | 2,603 | 82.1 | | | | | | | | | | | | | | getWorkBucket.createdNew | 257 | 97,141 | 11 | 5,252 | 378.0 | 172 | 12,999 | 11 | 1,202 | 50.6 | 13.38% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 20,968 | 20,968 | 20,968 | 20,968.0 | | | | | | | 1 | 20,963 | 20,963 | 20,963 | 20,963.0 | 99.98% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 167 | 0 | 16 | 5.8 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 463676.7100000001 Wall clock time: 22324 Earliest start time: 2021-04-13T18:23:01.864+02:00 Summary: Throughput: 2,687.7 per minute (1,000 items, 22.3 ms per item) Attempt #2 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 22,035 | 6 | 1,334 | 85.7 | | | | | | | | | | | | | | getWorkBucket.createdNew | 257 | 109,881 | 8 | 5,145 | 427.6 | 194 | 21,146 | 11 | 3,027 | 82.3 | 19.24% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,086 | 21,086 | 21,086 | 21,086.0 | | | | | | | 1 | 21,076 | 21,076 | 21,076 | 21,076.0 | 99.95% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 6,282 | 0 | 6,120 | 216.6 | 9 | 6,158 | 43 | 6,115 | 212.3 | 98.03% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 457535.50000000006 Wall clock time: 22582 Earliest start time: 2021-04-13T18:28:58.155+02:00 Summary: Throughput: 2,657.0 per minute (1,000 items, 22.6 ms per item) Attempt #3 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+---------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+---------+ | completeWorkBucket | 257 | 17,000 | 0 | 1,521 | 66.1 | | | | | | | | | | | | | | getWorkBucket.createdNew | 257 | 95,504 | 10 | 5,189 | 371.6 | 179 | 14,743 | 12 | 1,904 | 57.4 | 15.44% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,137 | 21,137 | 21,137 | 21,137.0 | | | | | | | 1 | 21,137 | 21,137 | 21,137 | 21,137.0 | 100.00% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 8,527 | 0 | 7,320 | 294.0 | 13 | 8,389 | 1,072 | 7,317 | 289.3 | 98.38% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+---------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 456045.5399999999 Wall clock time: 21971 Earliest start time: 2021-04-13T18:30:32.451+02:00 Summary: Throughput: 2,730.9 per minute (1,000 items, 22.0 ms per item) Attempt #4 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 23,889 | 11 | 6,011 | 93.0 | | | | | | | | | | | | | | getWorkBucket.createdNew | 257 | 104,050 | 15 | 5,239 | 404.9 | 205 | 23,364 | 10 | 4,276 | 90.9 | 22.45% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 27,543 | 27,543 | 27,543 | 27,543.0 | | | | | | | 1 | 20,996 | 20,996 | 20,996 | 20,996.0 | 76.23% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 7,606 | 0 | 7,498 | 262.3 | 8 | 7,492 | 7,492 | 7,492 | 258.3 | 98.50% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 451671.4 Wall clock time: 22032 Earliest start time: 2021-04-13T18:31:53.938+02:00 Summary: Throughput: 2,723.3 per minute (1,000 items, 22.0 ms per item) Attempt #5 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 20,347 | 10 | 2,601 | 79.2 | | | | | | | | | | | | | | getWorkBucket.createdNew | 257 | 98,631 | 6 | 5,284 | 383.8 | 187 | 19,047 | 11 | 3,102 | 74.1 | 19.31% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,262 | 21,262 | 21,262 | 21,262.0 | | | | | | | 1 | 21,246 | 21,246 | 21,246 | 21,246.0 | 99.92% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 161 | 0 | 16 | 5.6 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 458989.46 Wall clock time: 23963 Earliest start time: 2021-04-13T18:33:16.359+02:00 Summary: Throughput: 2,503.9 per minute (1,000 items, 24.0 ms per item) Trying 16 buckets, 4 worker tasks, PostgreSQL ============================================= Attempt #1 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 17 | 243 | 5 | 31 | 14.3 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 9,586 | 0 | 4,355 | 563.9 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,048 | 21,048 | 21,048 | 21,048.0 | | | | | | | 1 | 21,032 | 21,032 | 21,032 | 21,032.0 | 99.92% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 430473.8 Wall clock time: 125062 Earliest start time: 2021-04-13T18:34:55.287+02:00 Summary: Throughput: 479.8 per minute (1,000 items, 125.1 ms per item) Attempt #2 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 17 | 304 | 6 | 32 | 17.9 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 7,321 | 0 | 3,402 | 430.6 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,298 | 21,298 | 21,298 | 21,298.0 | | | | | | | 1 | 21,289 | 21,289 | 21,289 | 21,289.0 | 99.96% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 428933.25 Wall clock time: 117299 Earliest start time: 2021-04-13T18:38:20.427+02:00 Summary: Throughput: 511.5 per minute (1,000 items, 117.3 ms per item) Attempt #3 +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+---+------------+------------------+-----+-----+-----+---+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+---+------------+------------------+-----+-----+-----+---+ | completeWorkBucket | 17 | 312 | 11 | 31 | 18.4 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 15,525 | 10 | 5,276 | 913.2 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 10 | 10 | 10 | 10.0 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+---+------------+------------------+-----+-----+-----+---+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 437551.6200000001 Wall clock time: 128168 Earliest start time: 2021-04-13T18:41:18.040+02:00 Summary: Throughput: 468.1 per minute (1,000 items, 128.2 ms per item) Attempt #4 +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 17 | 318 | 10 | 34 | 18.7 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 9,193 | 2 | 5,234 | 540.8 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,292 | 21,292 | 21,292 | 21,292.0 | | | | | | | 1 | 21,280 | 21,280 | 21,280 | 21,280.0 | 99.94% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 439324.2699999999 Wall clock time: 115906 Earliest start time: 2021-04-13T18:46:11.093+02:00 Summary: Throughput: 517.7 per minute (1,000 items, 115.9 ms per item) Attempt #5 +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+-------+------------+------------------+-----+-----+-----+---+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+-------+------------+------------------+-----+-----+-----+---+ | completeWorkBucket | 17 | 244 | 0 | 23 | 14.4 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 15,113 | 0 | 4,502 | 889.0 | 1 | 42 | 42 | 42 | 2.5 | 0.28% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 16 | 0 | 16 | 5.3 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+-----+-------+-------+-----------+------------------+-----+-----+-----+-------+------------+------------------+-----+-----+-----+---+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 432159.16000000003 Wall clock time: 121575 Earliest start time: 2021-04-13T18:52:08.024+02:00 Summary: Throughput: 493.5 per minute (1,000 items, 121.6 ms per item) Low contention, zero initial wait time ====================================== Attempt #1 +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ | addObject.TaskType | 4 | 10 | 2 | 3 | 2.5 | | | | | | | | audit | 2,000 | 4,067 | 0 | 35 | 2.0 | | | | | | | | getObject.RoleType | 1,000 | 541 | 0 | 15 | 0.5 | | | | | | | | getObject.TaskType | 62 | 114 | 1 | 3 | 1.8 | | | | | | | | getObject.UserType | 3,000 | 2,039 | 0 | 15 | 0.7 | | | | | | | | modifyObject.TaskType | 274 | 1,749 | 0 | 16 | 6.4 | | | | | | | | modifyObject.UserType | 3,000 | 10,510 | 0 | 215 | 3.5 | 51 | 2,077 | 0 | 199 | 0.7 | 19.76% | | modifyObjectDynamically.TaskType | 22 | 111 | 1 | 14 | 5.0 | | | | | | | | searchObjects.FunctionLibraryType | 1 | 3 | 3 | 3 | 3.0 | | | | | | | | searchObjects.NodeType | 2 | 8 | 2 | 6 | 4.0 | | | | | | | | searchObjects.TaskType | 2,058 | 2,363 | 0 | 16 | 1.1 | | | | | | | | searchObjects.UserType | 1,033 | 1,127 | 0 | 25 | 1.1 | | | | | | | +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 17 | 292 | 14 | 26 | 17.2 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 293 | 12 | 30 | 17.2 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,705 | 21,705 | 21,705 | 21,705.0 | | | | | | | 1 | 21,693 | 21,693 | 21,693 | 21,693.0 | 99.94% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 11 | 3 | 4 | 3.7 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+---+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 463266.13 Wall clock time: 120208 Earliest start time: 2021-04-13T20:25:38.704+02:00 Summary: Throughput: 499.1 per minute (1,000 items, 120.2 ms per item) Attempt #2 +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+------+----------+ | addObject.TaskType | 4 | 16 | 0 | 16 | 4.0 | | | | | | | | audit | 2,000 | 2,145 | 0 | 35 | 1.1 | | | | | | | | getObject.RoleType | 1,000 | 331 | 0 | 16 | 0.3 | | | | | | | | getObject.TaskType | 60 | 114 | 0 | 16 | 1.9 | | | | | | | | getObject.UserType | 3,000 | 808 | 0 | 16 | 0.3 | | | | | | | | getVersion.SystemConfigurationType | 1 | 0 | 0 | 0 | 0.0 | | | | | | | | modifyObject.TaskType | 266 | 1,422 | 0 | 39 | 5.3 | 1 | 35 | 0 | 35 | 0.1 | 2.46% | | modifyObject.UserType | 3,000 | 6,271 | 0 | 130 | 2.1 | 96 | 3,813 | 0 | 130 | 1.3 | 60.80% | | modifyObjectDynamically.TaskType | 21 | 441 | 0 | 161 | 21.0 | 6 | 335 | 0 | 150 | 16.0 | 75.96% | | searchObjects.FunctionLibraryType | 1 | 3 | 3 | 3 | 3.0 | | | | | | | | searchObjects.NodeType | 2 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.TaskType | 2,058 | 2,024 | 0 | 17 | 1.0 | | | | | | | | searchObjects.UserType | 1,033 | 297 | 0 | 16 | 0.3 | | | | | | | +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+------+--------+------------+------------------+-----+-----+-----+---+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+------+--------+------------+------------------+-----+-----+-----+---+ | completeWorkBucket | 17 | 286 | 12 | 27 | 16.8 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 631 | 4 | 168 | 37.1 | 6 | 335 | 28 | 150 | 19.7 | 53.09% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 6 | 0 | 6 | 2.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+------+--------+------------+------------------+-----+-----+-----+---+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 436921.02999999985 Wall clock time: 119835 Earliest start time: 2021-04-13T20:29:00.202+02:00 Summary: Throughput: 500.7 per minute (1,000 items, 119.8 ms per item) Attempt #3 +-----------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ | addObject.TaskType | 4 | 3 | 0 | 2 | 0.8 | | | | | | | | audit | 2,000 | 1,342 | 0 | 36 | 0.7 | | | | | | | | getObject.RoleType | 1,000 | 362 | 0 | 16 | 0.4 | | | | | | | | getObject.TaskType | 62 | 138 | 0 | 16 | 2.2 | | | | | | | | getObject.UserType | 3,000 | 698 | 0 | 16 | 0.2 | | | | | | | | modifyObject.TaskType | 269 | 1,730 | 0 | 180 | 6.4 | 4 | 221 | 0 | 180 | 0.8 | 12.77% | | modifyObject.UserType | 3,000 | 4,586 | 0 | 171 | 1.5 | 80 | 2,893 | 0 | 171 | 1.0 | 63.08% | | modifyObjectDynamically.TaskType | 22 | 295 | 0 | 95 | 13.4 | 4 | 200 | 0 | 83 | 9.1 | 67.80% | | searchObjects.FunctionLibraryType | 1 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.NodeType | 2 | 16 | 1 | 15 | 8.0 | | | | | | | | searchObjects.TaskType | 2,058 | 1,844 | 0 | 16 | 0.9 | | | | | | | | searchObjects.UserType | 1,032 | 307 | 0 | 19 | 0.3 | | | | | | | +-----------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+------+--------+------------+------------------+--------+--------+----------+---------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+------+--------+------------+------------------+--------+--------+----------+---------+ | completeWorkBucket | 17 | 282 | 7 | 31 | 16.6 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 689 | 0 | 241 | 40.5 | 4 | 200 | 29 | 83 | 11.8 | 29.03% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,076 | 21,076 | 21,076 | 21,076.0 | | | | | | | 1 | 21,076 | 21,076 | 21,076 | 21,076.0 | 100.00% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 15 | 0 | 15 | 5.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+------+--------+------------+------------------+--------+--------+----------+---------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 432933.06000000006 Wall clock time: 117762 Earliest start time: 2021-04-13T20:31:52.328+02:00 Summary: Throughput: 509.5 per minute (1,000 items, 117.8 ms per item) Attempt #4 +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ | addObject.TaskType | 4 | 0 | 0 | 0 | 0.0 | | | | | | | | audit | 2,000 | 2,615 | 0 | 39 | 1.3 | | | | | | | | getObject.RoleType | 1,000 | 456 | 0 | 16 | 0.5 | | | | | | | | getObject.TaskType | 60 | 126 | 0 | 16 | 2.1 | | | | | | | | getObject.UserType | 3,000 | 1,310 | 0 | 16 | 0.4 | | | | | | | | getVersion.SystemConfigurationType | 1 | 0 | 0 | 0 | 0.0 | | | | | | | | modifyObject.TaskType | 267 | 1,732 | 0 | 89 | 6.5 | 3 | 118 | 0 | 89 | 0.4 | 6.81% | | modifyObject.UserType | 3,000 | 6,694 | 0 | 154 | 2.2 | 50 | 1,771 | 0 | 145 | 0.6 | 26.46% | | modifyObjectDynamically.TaskType | 21 | 261 | 0 | 138 | 12.4 | 3 | 146 | 0 | 126 | 7.0 | 55.94% | | searchObjects.FunctionLibraryType | 1 | 2 | 2 | 2 | 2.0 | | | | | | | | searchObjects.NodeType | 2 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.TaskType | 2,058 | 1,964 | 0 | 17 | 1.0 | | | | | | | | searchObjects.UserType | 1,033 | 607 | 0 | 19 | 0.6 | | | | | | | +------------------------------------+-------+-----------------+-----+-----+------+---------+------------------+-----+-----+-----+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+-----+--------+------------+------------------+-----+-----+-----+---+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+-----+--------+------------+------------------+-----+-----+-----+---+ | completeWorkBucket | 17 | 379 | 6 | 113 | 22.3 | 2 | 89 | 89 | 89 | 5.2 | 23.48% | | | | | | | | getWorkBucket.createdNew | 17 | 481 | 0 | 153 | 28.3 | 3 | 146 | 20 | 126 | 8.6 | 30.35% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 7 | 7 | 7 | 7.0 | | | | | | | | | | | | | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 12 | 4 | 4 | 4.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+-----+-----+------+-----------+------------------+-----+-----+-----+--------+------------+------------------+-----+-----+-----+---+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 445142.7500000002 Wall clock time: 114404 Earliest start time: 2021-04-13T20:34:45.670+02:00 Summary: Throughput: 524.5 per minute (1,000 items, 114.4 ms per item) Attempt #5 +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ | addObject.TaskType | 4 | 8 | 1 | 3 | 2.0 | | | | | | | | audit | 2,000 | 3,109 | 0 | 45 | 1.6 | | | | | | | | getObject.RoleType | 1,000 | 537 | 0 | 16 | 0.5 | | | | | | | | getObject.TaskType | 62 | 144 | 0 | 16 | 2.3 | | | | | | | | getObject.UserType | 3,000 | 1,708 | 0 | 16 | 0.6 | | | | | | | | modifyObject.TaskType | 271 | 1,588 | 0 | 57 | 5.9 | 1 | 47 | 0 | 47 | 0.2 | 2.96% | | modifyObject.UserType | 3,000 | 8,007 | 0 | 151 | 2.7 | 40 | 1,521 | 0 | 141 | 0.5 | 19.00% | | modifyObjectDynamically.TaskType | 22 | 148 | 0 | 52 | 6.7 | 1 | 41 | 0 | 41 | 1.9 | 27.70% | | searchObjects.FunctionLibraryType | 1 | 4 | 4 | 4 | 4.0 | | | | | | | | searchObjects.NodeType | 2 | 5 | 2 | 3 | 2.5 | | | | | | | | searchObjects.TaskType | 2,058 | 2,092 | 0 | 16 | 1.0 | | | | | | | | searchObjects.UserType | 1,033 | 866 | 0 | 19 | 0.8 | | | | | | | +-----------------------------------+-------+-----------------+-----+-----+-----+---------+------------------+-----+-----+-----+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 17 | 269 | 1 | 28 | 15.8 | | | | | | | | | | | | | | getWorkBucket.createdNew | 17 | 390 | 0 | 79 | 22.9 | 1 | 41 | 41 | 41 | 2.4 | 10.51% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,235 | 21,235 | 21,235 | 21,235.0 | | | | | | | 1 | 21,220 | 21,220 | 21,220 | 21,220.0 | 99.93% | | getWorkBucket.noMoreBucketsNotScavenger | 3 | 0 | 0 | 0 | 0.0 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-----+-----+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 454560.74000000017 Wall clock time: 117254 Earliest start time: 2021-04-13T20:40:49.806+02:00 Summary: Throughput: 511.7 per minute (1,000 items, 117.3 ms per item) High contention, zero initial wait time ======================================= Attempt #1 +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | addObject.TaskType | 30 | 63 | 0 | 16 | 2.1 | | | | | | | | audit | 2,000 | 6,085 | 0 | 73 | 3.0 | 1 | 23 | 0 | 23 | 0.0 | 0.38% | | getObject.RoleType | 1,000 | 706 | 0 | 10 | 0.7 | | | | | | | | getObject.TaskType | 834 | 1,607 | 0 | 17 | 1.9 | | | | | | | | getObject.UserType | 3,000 | 2,537 | 0 | 20 | 0.8 | | | | | | | | modifyObject.TaskType | 1,957 | 31,892 | 0 | 1,746 | 16.3 | 183 | 13,811 | 0 | 1,732 | 7.1 | 43.31% | | modifyObject.UserType | 3,000 | 41,963 | 0 | 1,826 | 14.0 | 622 | 31,250 | 0 | 1,820 | 10.4 | 74.47% | | modifyObjectDynamically.TaskType | 288 | 44,423 | 0 | 5,712 | 154.2 | 283 | 41,634 | 0 | 5,704 | 144.6 | 93.72% | | searchObjects.FunctionLibraryType | 1 | 4 | 4 | 4 | 4.0 | | | | | | | | searchObjects.NodeType | 2 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.TaskType | 2,804 | 5,281 | 0 | 16 | 1.9 | 1 | 10 | 0 | 10 | 0.0 | 0.19% | | searchObjects.UserType | 1,257 | 2,333 | 0 | 68 | 1.9 | | | | | | | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 21,854 | 12 | 1,774 | 85.0 | 179 | 13,610 | 12 | 1,732 | 53.0 | 62.28% | | | | | | | | getWorkBucket.createdNew | 257 | 46,670 | 4 | 5,727 | 181.6 | 278 | 40,502 | 11 | 5,704 | 157.6 | 86.78% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,487 | 21,487 | 21,487 | 21,487.0 | | | | | | | 1 | 21,472 | 21,472 | 21,472 | 21,472.0 | 99.93% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 1,251 | 0 | 1,138 | 43.1 | 5 | 1,132 | 1,132 | 1,132 | 39.0 | 90.49% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-------+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 480451.18999999994 Wall clock time: 20345 Earliest start time: 2021-04-13T21:09:49.020+02:00 Summary: Throughput: 2,949.1 per minute (1,000 items, 20.3 ms per item) Attempt #2 +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | addObject.TaskType | 30 | 38 | 0 | 16 | 1.3 | | | | | | | | audit | 2,000 | 6,797 | 0 | 63 | 3.4 | 13 | 488 | 0 | 63 | 0.2 | 7.18% | | getObject.RoleType | 1,000 | 698 | 0 | 11 | 0.7 | | | | | | | | getObject.TaskType | 834 | 1,642 | 0 | 16 | 2.0 | | | | | | | | getObject.UserType | 3,000 | 2,577 | 0 | 16 | 0.9 | | | | | | | | modifyObject.TaskType | 1,945 | 35,928 | 0 | 2,164 | 18.5 | 258 | 18,127 | 0 | 2,158 | 9.3 | 50.45% | | modifyObject.UserType | 3,000 | 41,546 | 0 | 1,330 | 13.8 | 576 | 30,488 | 0 | 1,324 | 10.2 | 73.38% | | modifyObjectDynamically.TaskType | 288 | 33,608 | 0 | 4,397 | 116.7 | 252 | 30,881 | 0 | 4,386 | 107.2 | 91.89% | | searchObjects.FunctionLibraryType | 1 | 3 | 3 | 3 | 3.0 | | | | | | | | searchObjects.NodeType | 2 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.TaskType | 2,804 | 7,335 | 0 | 59 | 2.6 | 12 | 428 | 0 | 53 | 0.2 | 5.84% | | searchObjects.UserType | 1,257 | 1,949 | 0 | 98 | 1.6 | | | | | | | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 24,232 | 15 | 2,184 | 94.3 | 195 | 15,565 | 11 | 2,158 | 60.6 | 64.23% | | | | | | | | getWorkBucket.createdNew | 257 | 37,373 | 14 | 4,405 | 145.4 | 248 | 30,586 | 13 | 4,386 | 119.0 | 81.84% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,299 | 21,299 | 21,299 | 21,299.0 | | | | | | | 1 | 21,278 | 21,278 | 21,278 | 21,278.0 | 99.90% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 492 | 0 | 311 | 17.0 | 4 | 295 | 295 | 295 | 10.2 | 59.96% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 476553.59999999986 Wall clock time: 21132 Earliest start time: 2021-04-13T21:11:08.467+02:00 Summary: Throughput: 2,839.3 per minute (1,000 items, 21.1 ms per item) Attempt #3 +-----------------------------------+-------+-----------------+-----+-------+------+---------+------------------+-----+-------+------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-------+------+---------+------------------+-----+-------+------+----------+ | addObject.TaskType | 30 | 22 | 0 | 15 | 0.7 | | | | | | | | audit | 2,000 | 5,780 | 0 | 64 | 2.9 | 1 | 62 | 0 | 62 | 0.0 | 1.07% | | getObject.RoleType | 1,000 | 679 | 0 | 29 | 0.7 | | | | | | | | getObject.TaskType | 834 | 1,662 | 0 | 23 | 2.0 | | | | | | | | getObject.UserType | 3,000 | 2,407 | 0 | 74 | 0.8 | | | | | | | | modifyObject.TaskType | 1,946 | 33,748 | 0 | 2,352 | 17.3 | 204 | 16,005 | 0 | 2,343 | 8.2 | 47.43% | | modifyObject.UserType | 3,000 | 43,945 | 0 | 1,181 | 14.6 | 713 | 33,581 | 0 | 1,181 | 11.2 | 76.42% | | modifyObjectDynamically.TaskType | 288 | 26,389 | 0 | 1,433 | 91.6 | 259 | 23,576 | 0 | 1,417 | 81.9 | 89.34% | | searchObjects.FunctionLibraryType | 1 | 6 | 6 | 6 | 6.0 | | | | | | | | searchObjects.NodeType | 2 | 0 | 0 | 0 | 0.0 | | | | | | | | searchObjects.TaskType | 2,804 | 5,394 | 0 | 40 | 1.9 | 1 | 39 | 0 | 39 | 0.0 | 0.72% | | searchObjects.UserType | 1,257 | 2,256 | 0 | 83 | 1.8 | | | | | | | +-----------------------------------+-------+-----------------+-----+-------+------+---------+------------------+-----+-------+------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 24,136 | 8 | 2,372 | 93.9 | 200 | 15,881 | 10 | 2,343 | 61.8 | 65.80% | | | | | | | | getWorkBucket.createdNew | 257 | 29,069 | 15 | 1,444 | 113.1 | 253 | 22,621 | 13 | 1,417 | 88.0 | 77.82% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,424 | 21,424 | 21,424 | 21,424.0 | | | | | | | 1 | 21,401 | 21,401 | 21,401 | 21,401.0 | 99.89% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 1,100 | 0 | 919 | 37.9 | 6 | 955 | 39 | 916 | 32.9 | 86.82% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 485061.2300000001 Wall clock time: 20736 Earliest start time: 2021-04-13T21:12:27.591+02:00 Summary: Throughput: 2,893.5 per minute (1,000 items, 20.7 ms per item) Attempt #4 +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | addObject.TaskType | 30 | 79 | 1 | 4 | 2.6 | | | | | | | | audit | 2,000 | 6,609 | 0 | 95 | 3.3 | 1 | 87 | 0 | 87 | 0.0 | 1.32% | | getObject.RoleType | 1,000 | 810 | 0 | 11 | 0.8 | | | | | | | | getObject.TaskType | 834 | 1,748 | 0 | 12 | 2.1 | | | | | | | | getObject.UserType | 3,000 | 2,821 | 0 | 17 | 0.9 | | | | | | | | modifyObject.TaskType | 1,956 | 27,426 | 3 | 1,507 | 14.0 | 136 | 8,729 | 0 | 1,497 | 4.5 | 31.83% | | modifyObject.UserType | 3,000 | 51,345 | 1 | 1,299 | 17.1 | 707 | 39,130 | 0 | 1,294 | 13.0 | 76.21% | | modifyObjectDynamically.TaskType | 288 | 33,290 | 1 | 7,479 | 115.6 | 235 | 30,312 | 0 | 7,466 | 105.3 | 91.05% | | searchObjects.FunctionLibraryType | 1 | 5 | 5 | 5 | 5.0 | | | | | | | | searchObjects.NodeType | 2 | 9 | 4 | 5 | 4.5 | | | | | | | | searchObjects.TaskType | 2,804 | 6,101 | 1 | 33 | 2.2 | 3 | 46 | 0 | 28 | 0.0 | 0.75% | | searchObjects.UserType | 1,257 | 2,630 | 0 | 134 | 2.1 | | | | | | | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 17,102 | 16 | 1,528 | 66.5 | 129 | 8,452 | 11 | 1,497 | 32.9 | 49.42% | | | | | | | | getWorkBucket.createdNew | 257 | 37,070 | 17 | 7,498 | 144.2 | 235 | 30,312 | 11 | 7,466 | 117.9 | 81.77% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,838 | 21,838 | 21,838 | 21,838.0 | | | | | | | 1 | 21,824 | 21,824 | 21,824 | 21,824.0 | 99.94% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 156 | 3 | 9 | 5.4 | | | | | | | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 493323.1000000001 Wall clock time: 20939 Earliest start time: 2021-04-14T10:20:01.174+02:00 Summary: Throughput: 2,865.5 per minute (1,000 items, 20.9 ms per item) Attempt #5 +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Retries | Wasted time (ms) | Min | Max | Avg | Wasted % | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ | addObject.TaskType | 30 | 75 | 1 | 4 | 2.5 | | | | | | | | audit | 2,000 | 6,711 | 0 | 108 | 3.4 | 3 | 248 | 0 | 108 | 0.1 | 3.70% | | getObject.RoleType | 1,000 | 740 | 0 | 6 | 0.7 | | | | | | | | getObject.TaskType | 834 | 1,705 | 1 | 10 | 2.0 | | | | | | | | getObject.UserType | 3,000 | 2,737 | 0 | 6 | 0.9 | | | | | | | | modifyObject.TaskType | 1,951 | 31,708 | 3 | 1,421 | 16.3 | 183 | 12,695 | 0 | 1,409 | 6.5 | 40.04% | | modifyObject.UserType | 3,000 | 50,220 | 1 | 4,232 | 16.7 | 623 | 38,174 | 0 | 4,224 | 12.7 | 76.01% | | modifyObjectDynamically.TaskType | 288 | 40,502 | 1 | 5,846 | 140.6 | 268 | 37,452 | 0 | 5,845 | 130.0 | 92.47% | | searchObjects.FunctionLibraryType | 1 | 5 | 5 | 5 | 5.0 | | | | | | | | searchObjects.NodeType | 2 | 9 | 3 | 6 | 4.5 | | | | | | | | searchObjects.TaskType | 2,804 | 5,892 | 1 | 35 | 2.1 | | | | | | | | searchObjects.UserType | 1,257 | 2,554 | 0 | 88 | 2.0 | | | | | | | +-----------------------------------+-------+-----------------+-----+-------+-------+---------+------------------+-----+-------+-------+----------+ Work bucket management performance information +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | Operation | Count | Total time (ms) | Min | Max | Avg | Conflicts | Wasted time (ms) | Min | Max | Avg | % | Wait count | Waited time (ms) | Min | Max | Avg | % | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ | completeWorkBucket | 257 | 21,005 | 15 | 1,467 | 81.7 | 177 | 12,347 | 9 | 1,409 | 48.0 | 58.78% | | | | | | | | getWorkBucket.createdNew | 257 | 38,288 | 17 | 3,112 | 149.0 | 259 | 31,554 | 13 | 3,080 | 122.8 | 82.41% | | | | | | | | getWorkBucket.noMoreBucketsDefinite | 1 | 21,802 | 21,802 | 21,802 | 21,802.0 | | | | | | | 1 | 21,789 | 21,789 | 21,789 | 21,789.0 | 99.94% | | getWorkBucket.noMoreBucketsNotScavenger | 29 | 6,060 | 4 | 5,850 | 209.0 | 9 | 5,898 | 53 | 5,845 | 203.4 | 97.33% | | | | | | | +-----------------------------------------+-------+-----------------+--------+--------+----------+-----------+------------------+-----+-------+-------+--------+------------+------------------+--------+--------+----------+--------+ *** Performance information TaskPerformanceInformation: Parts: null => URI: null Items processed: 1000 Errors: 0 Progress: 1000 Processing time: 490769.9600000001 Wall clock time: 20857 Earliest start time: 2021-04-14T10:22:08.601+02:00 Summary: Throughput: 2,876.7 per minute (1,000 items, 20.9 ms per item)