diff --git a/_testresults_/unittest.json b/_testresults_/unittest.json index cf8529f..3d39f3a 100644 --- a/_testresults_/unittest.json +++ b/_testresults_/unittest.json @@ -1,11 +1,11 @@ { "coverage_information": [ { - "branch_coverage": 91.3, + "branch_coverage": 88.0, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching", "files": [ { - "branch_coverage": 91.3, + "branch_coverage": 88.0, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching/__init__.py", "fragments": [ { @@ -203,10 +203,15 @@ "end": 135, "start": 135 }, + { + "coverage_state": "uncovered", + "end": 137, + "start": 136 + }, { "coverage_state": "clean", "end": 138, - "start": 136 + "start": 138 }, { "coverage_state": "covered", @@ -215,13 +220,13 @@ }, { "coverage_state": "clean", - "end": 140, + "end": 142, "start": 140 }, { "coverage_state": "covered", "end": 143, - "start": 141 + "start": 143 }, { "coverage_state": "clean", @@ -230,18 +235,18 @@ }, { "coverage_state": "covered", - "end": 145, + "end": 147, "start": 145 }, { "coverage_state": "clean", - "end": 146, - "start": 146 + "end": 148, + "start": 148 }, { "coverage_state": "covered", "end": 149, - "start": 147 + "start": 149 }, { "coverage_state": "clean", @@ -250,165 +255,205 @@ }, { "coverage_state": "covered", - "end": 151, + "end": 153, "start": 151 }, { "coverage_state": "clean", - "end": 152, - "start": 152 + "end": 154, + "start": 154 }, { "coverage_state": "covered", - "end": 161, - "start": 153 + "end": 155, + "start": 155 + }, + { + "coverage_state": "clean", + "end": 156, + "start": 156 + }, + { + "coverage_state": "covered", + "end": 165, + "start": 157 }, { "coverage_state": "uncovered", - "end": 163, - "start": 162 + "end": 167, + "start": 166 }, { "coverage_state": "clean", - "end": 164, - "start": 164 + "end": 168, + "start": 168 }, { "coverage_state": "covered", - "end": 178, - "start": 165 + "end": 174, + "start": 169 + }, + { + "coverage_state": "partially-covered", + "end": 175, + "start": 175 + }, + { + "coverage_state": "uncovered", + "end": 176, + "start": 176 + }, + { + "coverage_state": "covered", + "end": 183, + "start": 177 }, { "coverage_state": "clean", - "end": 179, - "start": 179 + "end": 184, + "start": 184 }, { "coverage_state": "covered", - "end": 185, - "start": 180 + "end": 190, + "start": 185 }, { "coverage_state": "clean", - "end": 186, - "start": 186 - }, - { - "coverage_state": "covered", - "end": 188, - "start": 187 - }, - { - "coverage_state": "clean", - "end": 189, - "start": 189 - }, - { - "coverage_state": "covered", "end": 191, - "start": 190 + "start": 191 + }, + { + "coverage_state": "covered", + "end": 193, + "start": 192 }, { "coverage_state": "clean", - "end": 192, - "start": 192 + "end": 194, + "start": 194 + }, + { + "coverage_state": "covered", + "end": 196, + "start": 195 + }, + { + "coverage_state": "clean", + "end": 197, + "start": 197 }, { "coverage_state": "covered", "end": 198, - "start": 193 + "start": 198 }, { - "coverage_state": "clean", + "coverage_state": "partially-covered", "end": 199, "start": 199 }, { - "coverage_state": "covered", - "end": 205, + "coverage_state": "uncovered", + "end": 200, "start": 200 }, - { - "coverage_state": "clean", - "end": 206, - "start": 206 - }, { "coverage_state": "covered", - "end": 209, - "start": 207 + "end": 204, + "start": 201 }, { "coverage_state": "clean", - "end": 210, - "start": 210 + "end": 205, + "start": 205 }, { "coverage_state": "covered", "end": 211, - "start": 211 + "start": 206 }, { "coverage_state": "clean", - "end": 213, + "end": 212, "start": 212 }, { "coverage_state": "covered", - "end": 214, - "start": 214 + "end": 215, + "start": 213 }, { "coverage_state": "clean", - "end": 251, - "start": 215 + "end": 216, + "start": 216 }, { "coverage_state": "covered", - "end": 252, - "start": 252 + "end": 217, + "start": 217 }, { "coverage_state": "clean", - "end": 253, - "start": 253 + "end": 219, + "start": 218 }, { "coverage_state": "covered", + "end": 220, + "start": 220 + }, + { + "coverage_state": "clean", + "end": 257, + "start": 221 + }, + { + "coverage_state": "covered", + "end": 258, + "start": 258 + }, + { + "coverage_state": "clean", "end": 259, - "start": 254 + "start": 259 }, { - "coverage_state": "clean", - "end": 260, + "coverage_state": "covered", + "end": 265, "start": 260 }, + { + "coverage_state": "clean", + "end": 266, + "start": 266 + }, { "coverage_state": "covered", - "end": 262, - "start": 261 + "end": 268, + "start": 267 }, { "coverage_state": "clean", - "end": 263, - "start": 263 + "end": 269, + "start": 269 }, { "coverage_state": "covered", - "end": 269, - "start": 264 + "end": 275, + "start": 270 }, { "coverage_state": "clean", "end": null, - "start": 270 + "start": 276 } ], - "line_coverage": 95.45, + "line_coverage": 92.7, "name": "caching.__init__.py" } ], - "line_coverage": 95.45, + "line_coverage": 92.7, "name": "caching" } ], @@ -454,7 +499,7 @@ "Name": "caching", "State": "Released", "Supported Interpreters": "python3", - "Version": "624db9f532db2ba202265378292f8af1" + "Version": "03683b9fee192b005ed723f0f14eecd5" }, "testrun_list": [ { @@ -475,8 +520,8 @@ "testcases": { "caching.property_cache_json: Test cached data (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.861257, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6383705, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -487,13 +532,13 @@ "message": "caching.property_cache_json: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 861.0, + "msecs": 638.0, "msg": "caching.property_cache_json: Test cached data (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.17933654785156, + "relativeCreated": 80.34706115722656, "stack_info": null, "testcaseLogger": [ { @@ -501,8 +546,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8616097, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6389399, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -515,8 +560,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8613248, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6384854, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -526,23 +571,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 861.0, + "msecs": 638.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.247047424316406, + "relativeCreated": 80.46197891235352, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8613813, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6385722, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -552,34 +597,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 861.0, + "msecs": 638.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.30355262756348, + "relativeCreated": 80.54876327514648, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 861.0, + "msecs": 638.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.53195762634277, + "relativeCreated": 80.9164047241211, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00022840499877929688 + "time_consumption": 0.0003676414489746094 }, { "args": [], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.861781, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.6392052, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -590,15 +635,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 861.0, + "msecs": 639.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.703142166137695, + "relativeCreated": 81.18176460266113, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -607,8 +652,8 @@ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'uncached': 'uncached_data_of_class'}", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.86199, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.639552, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -625,8 +670,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.86186, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.6393342, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -636,15 +681,15 @@ "lineno": 22, "message": "Result (Cached data): { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 861.0, + "msecs": 639.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.782297134399414, + "relativeCreated": 81.31074905395508, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -654,8 +699,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8619146, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.639424, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -665,41 +710,41 @@ "lineno": 26, "message": "Expectation (Cached data): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 861.0, + "msecs": 639.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.83689498901367, + "relativeCreated": 81.40063285827637, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 861.0, + "msecs": 639.0, "msg": "Cached data is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.912235260009766, + "relativeCreated": 81.5286636352539, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 7.534027099609375e-05 + "time_consumption": 0.00012803077697753906 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0007328987121582031, - "time_finished": "2024-09-15 14:31:27,861", - "time_start": "2024-09-15 14:31:27,861" + "time_consumption": 0.0011816024780273438, + "time_finished": "2024-09-15 16:36:11,639", + "time_start": "2024-09-15 16:36:11,638" }, "caching.property_cache_json: Test cached data (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862095, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.639728, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -710,13 +755,13 @@ "message": "caching.property_cache_json: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 862.0, + "msecs": 639.0, "msg": "caching.property_cache_json: Test cached data (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.017377853393555, + "relativeCreated": 81.70461654663086, "stack_info": null, "testcaseLogger": [ { @@ -724,8 +769,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862442, + "asctime": "2024-09-15 16:36:11,640", + "created": 1726410971.6402786, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -738,8 +783,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.8621604, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.639834, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -749,23 +794,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 862.0, + "msecs": 639.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.08270454406738, + "relativeCreated": 81.81047439575195, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862213, + "asctime": "2024-09-15 16:36:11,639", + "created": 1726410971.6399157, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -775,34 +820,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 862.0, + "msecs": 639.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.13515663146973, + "relativeCreated": 81.89225196838379, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 862.0, + "msecs": 640.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.36427688598633, + "relativeCreated": 82.25512504577637, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00022912025451660156 + "time_consumption": 0.0003628730773925781 }, { "args": [], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862602, + "asctime": "2024-09-15 16:36:11,640", + "created": 1726410971.6405468, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -813,15 +858,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 862.0, + "msecs": 640.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.52425575256348, + "relativeCreated": 82.52334594726562, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -830,8 +875,8 @@ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'uncached': 'uncached_data_of_class'}", "" ], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862803, + "asctime": "2024-09-15 16:36:11,640", + "created": 1726410971.6408794, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -848,8 +893,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.8626785, + "asctime": "2024-09-15 16:36:11,640", + "created": 1726410971.6406744, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -859,15 +904,15 @@ "lineno": 22, "message": "Result (Cached data): { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 862.0, + "msecs": 640.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.60078811645508, + "relativeCreated": 82.65089988708496, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -877,8 +922,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.8627317, + "asctime": "2024-09-15 16:36:11,640", + "created": 1726410971.6407614, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -888,41 +933,41 @@ "lineno": 26, "message": "Expectation (Cached data): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 862.0, + "msecs": 640.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.65395545959473, + "relativeCreated": 82.73792266845703, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 862.0, + "msecs": 640.0, "msg": "Cached data is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.725242614746094, + "relativeCreated": 82.8559398651123, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 7.128715515136719e-05 + "time_consumption": 0.00011801719665527344 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0007078647613525391, - "time_finished": "2024-09-15 14:31:27,862", - "time_start": "2024-09-15 14:31:27,862" + "time_consumption": 0.0011513233184814453, + "time_finished": "2024-09-15 16:36:11,640", + "time_start": "2024-09-15 16:36:11,639" }, "caching.property_cache_json: Test execution of save callback (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8693867, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6500828, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -933,19 +978,19 @@ "message": "caching.property_cache_json: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 869.0, + "msecs": 650.0, "msg": "caching.property_cache_json: Test execution of save callback (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.30893325805664, + "relativeCreated": 92.05937385559082, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8695095, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6501942, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -956,15 +1001,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 869.0, + "msecs": 650.0, "msg": "Installing save_callback, which sets a variable to True on execution.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_save_callback.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.431718826293945, + "relativeCreated": 92.17071533203125, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -973,8 +1018,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8698702, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.65059, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -991,8 +1036,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8697495, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6504636, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1002,15 +1047,15 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 869.0, + "msecs": 650.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.67180633544922, + "relativeCreated": 92.44012832641602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -1020,8 +1065,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8698153, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.650532, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1031,41 +1076,41 @@ "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 869.0, + "msecs": 650.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.73760986328125, + "relativeCreated": 92.50855445861816, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 869.0, + "msecs": 650.0, "msg": "Save callback execution variable is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.79244613647461, + "relativeCreated": 92.56649017333984, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 5.4836273193359375e-05 + "time_consumption": 5.793571472167969e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00048351287841796875, - "time_finished": "2024-09-15 14:31:27,869", - "time_start": "2024-09-15 14:31:27,869" + "time_consumption": 0.0005071163177490234, + "time_finished": "2024-09-15 16:36:11,650", + "time_start": "2024-09-15 16:36:11,650" }, "caching.property_cache_json: Test full initialised JSON-Cache-Object": { "args": null, - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8580208, + "asctime": "2024-09-15 16:36:11,633", + "created": 1726410971.633747, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1076,13 +1121,13 @@ "message": "caching.property_cache_json: Test full initialised JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 858.0, + "msecs": 633.0, "msg": "caching.property_cache_json: Test full initialised JSON-Cache-Object", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 48.94304275512695, + "relativeCreated": 75.72364807128906, "stack_info": null, "testcaseLogger": [ { @@ -1090,8 +1135,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.858648, + "asctime": "2024-09-15 16:36:11,634", + "created": 1726410971.6347072, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1104,8 +1149,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8581693, + "asctime": "2024-09-15 16:36:11,633", + "created": 1726410971.6339958, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1115,23 +1160,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 858.0, + "msecs": 633.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.09157752990723, + "relativeCreated": 75.97231864929199, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8582685, + "asctime": "2024-09-15 16:36:11,634", + "created": 1726410971.6341255, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1141,36 +1186,36 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 858.0, + "msecs": 634.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.19075965881348, + "relativeCreated": 76.10201835632324, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 858.0, + "msecs": 634.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.570322036743164, + "relativeCreated": 76.68375968933105, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0003795623779296875 + "time_consumption": 0.0005817413330078125 }, { "args": [ "property_cache_json" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8588293, + "asctime": "2024-09-15 16:36:11,634", + "created": 1726410971.6349998, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -1185,8 +1230,8 @@ "args": [ "{'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.858788, + "asctime": "2024-09-15 16:36:11,634", + "created": 1726410971.6349337, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -1196,37 +1241,37 @@ "lineno": 20, "message": "Using storage object of cache class for comparison: {'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}", "module": "test_load_on_init", - "msecs": 858.0, + "msecs": 634.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.71027374267578, + "relativeCreated": 76.91025733947754, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 858.0, + "msecs": 634.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.75152015686035, + "relativeCreated": 76.97629928588867, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 4.124641418457031e-05 + "time_consumption": 6.604194641113281e-05 }, { "args": [ "{'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}", "" ], - "asctime": "2024-09-15 14:31:27,859", - "created": 1726403487.8590798, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.635411, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1243,8 +1288,8 @@ "{ 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'float': 3.14159, 'integer': 17, 'list': [ 1, 'two', '3', 4 ], 'str': 'string', 'unicode': 'unicode' }", "" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8589203, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.6351492, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1254,15 +1299,15 @@ "lineno": 22, "message": "Result (Cache object): { 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'float': 3.14159, 'integer': 17, 'list': [ 1, 'two', '3', 4 ], 'str': 'string', 'unicode': 'unicode' } ()", "module": "test", - "msecs": 858.0, + "msecs": 635.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.84259605407715, + "relativeCreated": 77.12578773498535, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -1272,8 +1317,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } }", "" ], - "asctime": "2024-09-15 14:31:27,858", - "created": 1726403487.8589797, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.6352463, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1283,41 +1328,41 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } } ()", "module": "test", - "msecs": 858.0, + "msecs": 635.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 49.90196228027344, + "relativeCreated": 77.22282409667969, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 859.0, + "msecs": 635.0, "msg": "Cache object is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 50.002098083496094, + "relativeCreated": 77.38757133483887, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00010013580322265625 + "time_consumption": 0.0001647472381591797 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010590553283691406, - "time_finished": "2024-09-15 14:31:27,859", - "time_start": "2024-09-15 14:31:27,858" + "time_consumption": 0.0016639232635498047, + "time_finished": "2024-09-15 16:36:11,635", + "time_start": "2024-09-15 16:36:11,633" }, "caching.property_cache_json: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.8658504, + "asctime": "2024-09-15 16:36:11,645", + "created": 1726410971.645726, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1328,13 +1373,13 @@ "message": "caching.property_cache_json: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 865.0, + "msecs": 645.0, "msg": "caching.property_cache_json: Test get from source caused by changed uid (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.772708892822266, + "relativeCreated": 87.70251274108887, "stack_info": null, "testcaseLogger": [ { @@ -1342,8 +1387,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,866", - "created": 1726403487.8662002, + "asctime": "2024-09-15 16:36:11,646", + "created": 1726410971.6463842, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1356,8 +1401,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.8659184, + "asctime": "2024-09-15 16:36:11,645", + "created": 1726410971.6458964, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1367,23 +1412,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 865.0, + "msecs": 645.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.84065818786621, + "relativeCreated": 87.87298202514648, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.8659725, + "asctime": "2024-09-15 16:36:11,646", + "created": 1726410971.6460032, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1393,37 +1438,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 865.0, + "msecs": 646.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.894779205322266, + "relativeCreated": 87.97979354858398, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 866.0, + "msecs": 646.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.12246894836426, + "relativeCreated": 88.36078643798828, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0002276897430419922 + "time_consumption": 0.0003809928894042969 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,866", - "created": 1726403487.8668396, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.647202, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1440,8 +1485,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,866", - "created": 1726403487.866658, + "asctime": "2024-09-15 16:36:11,646", + "created": 1726410971.6469781, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1451,15 +1496,15 @@ "lineno": 22, "message": "Result (Instance data after changing uid): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 866.0, + "msecs": 646.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.58023262023926, + "relativeCreated": 88.95468711853027, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -1469,8 +1514,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,866", - "created": 1726403487.866743, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.6470761, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1480,41 +1525,41 @@ "lineno": 26, "message": "Expectation (Instance data after changing uid): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 866.0, + "msecs": 647.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.665348052978516, + "relativeCreated": 89.05267715454102, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 866.0, + "msecs": 647.0, "msg": "Instance data after changing uid is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.76190757751465, + "relativeCreated": 89.17856216430664, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 9.655952453613281e-05 + "time_consumption": 0.000125885009765625 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0009891986846923828, - "time_finished": "2024-09-15 14:31:27,866", - "time_start": "2024-09-15 14:31:27,865" + "time_consumption": 0.0014760494232177734, + "time_finished": "2024-09-15 16:36:11,647", + "time_start": "2024-09-15 16:36:11,645" }, "caching.property_cache_json: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,866", - "created": 1726403487.8669605, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.6473746, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1525,13 +1570,13 @@ "message": "caching.property_cache_json: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 866.0, + "msecs": 647.0, "msg": "caching.property_cache_json: Test get from source caused by changed uid (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.88278579711914, + "relativeCreated": 89.35117721557617, "stack_info": null, "testcaseLogger": [ { @@ -1539,8 +1584,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,867", - "created": 1726403487.8673685, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.6479356, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1553,8 +1598,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,867", - "created": 1726403487.867038, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.6474872, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1564,23 +1609,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 867.0, + "msecs": 647.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 57.96027183532715, + "relativeCreated": 89.46371078491211, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,867", - "created": 1726403487.8671093, + "asctime": "2024-09-15 16:36:11,647", + "created": 1726410971.6475725, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1590,37 +1635,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 867.0, + "msecs": 647.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 58.031558990478516, + "relativeCreated": 89.54906463623047, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 867.0, + "msecs": 647.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 58.290719985961914, + "relativeCreated": 89.91217613220215, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00025916099548339844 + "time_consumption": 0.0003631114959716797 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8691795, + "asctime": "2024-09-15 16:36:11,649", + "created": 1726410971.6499052, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1637,8 +1682,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,868", - "created": 1726403487.8689442, + "asctime": "2024-09-15 16:36:11,649", + "created": 1726410971.6496594, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1648,15 +1693,15 @@ "lineno": 22, "message": "Result (Instance data after changing uid): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 868.0, + "msecs": 649.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 59.86642837524414, + "relativeCreated": 91.63594245910645, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -1666,8 +1711,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,869", - "created": 1726403487.8690543, + "asctime": "2024-09-15 16:36:11,649", + "created": 1726410971.6497617, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1677,41 +1722,41 @@ "lineno": 26, "message": "Expectation (Instance data after changing uid): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 869.0, + "msecs": 649.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 59.97657775878906, + "relativeCreated": 91.73822402954102, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 869.0, + "msecs": 649.0, "msg": "Instance data after changing uid is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 60.10174751281738, + "relativeCreated": 91.88175201416016, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001251697540283203 + "time_consumption": 0.00014352798461914062 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.002218961715698242, - "time_finished": "2024-09-15 14:31:27,869", - "time_start": "2024-09-15 14:31:27,866" + "time_consumption": 0.0025305747985839844, + "time_finished": "2024-09-15 16:36:11,649", + "time_start": "2024-09-15 16:36:11,647" }, "caching.property_cache_json: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.8629057, + "asctime": "2024-09-15 16:36:11,641", + "created": 1726410971.6410477, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1722,13 +1767,13 @@ "message": "caching.property_cache_json: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 862.0, + "msecs": 641.0, "msg": "caching.property_cache_json: Test get from source caused by increased data version (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.82800102233887, + "relativeCreated": 83.02426338195801, "stack_info": null, "testcaseLogger": [ { @@ -1736,8 +1781,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8632543, + "asctime": "2024-09-15 16:36:11,641", + "created": 1726410971.6416054, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1750,8 +1795,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,862", - "created": 1726403487.862972, + "asctime": "2024-09-15 16:36:11,641", + "created": 1726410971.641159, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1761,23 +1806,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 862.0, + "msecs": 641.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.8942813873291, + "relativeCreated": 83.13560485839844, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8630264, + "asctime": "2024-09-15 16:36:11,641", + "created": 1726410971.641243, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1787,37 +1832,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 863.0, + "msecs": 641.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 53.94864082336426, + "relativeCreated": 83.21952819824219, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 863.0, + "msecs": 641.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.17656898498535, + "relativeCreated": 83.58192443847656, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00022792816162109375 + "time_consumption": 0.000362396240234375 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.863742, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.6425982, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1834,8 +1879,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8636103, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.6423776, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1845,15 +1890,15 @@ "lineno": 22, "message": "Result (Instance data after increasing data_version): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 863.0, + "msecs": 642.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.532527923583984, + "relativeCreated": 84.35416221618652, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -1863,8 +1908,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8636694, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.6424792, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1874,41 +1919,41 @@ "lineno": 26, "message": "Expectation (Instance data after increasing data_version): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 863.0, + "msecs": 642.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.59165573120117, + "relativeCreated": 84.45572853088379, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 863.0, + "msecs": 642.0, "msg": "Instance data after increasing data_version is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.66437339782715, + "relativeCreated": 84.57469940185547, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 7.271766662597656e-05 + "time_consumption": 0.00011897087097167969 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0008363723754882812, - "time_finished": "2024-09-15 14:31:27,863", - "time_start": "2024-09-15 14:31:27,862" + "time_consumption": 0.001550436019897461, + "time_finished": "2024-09-15 16:36:11,642", + "time_start": "2024-09-15 16:36:11,641" }, "caching.property_cache_json: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.863844, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.6427658, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1919,13 +1964,13 @@ "message": "caching.property_cache_json: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 863.0, + "msecs": 642.0, "msg": "caching.property_cache_json: Test get from source caused by increased data version (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.766178131103516, + "relativeCreated": 84.74230766296387, "stack_info": null, "testcaseLogger": [ { @@ -1933,8 +1978,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,864", - "created": 1726403487.8641913, + "asctime": "2024-09-15 16:36:11,643", + "created": 1726410971.643325, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1947,8 +1992,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8639116, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.642877, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1958,23 +2003,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 863.0, + "msecs": 642.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.83388900756836, + "relativeCreated": 84.8536491394043, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,863", - "created": 1726403487.8639643, + "asctime": "2024-09-15 16:36:11,642", + "created": 1726410971.6429625, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1984,37 +2029,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 863.0, + "msecs": 642.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 54.886579513549805, + "relativeCreated": 84.93900299072266, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 864.0, + "msecs": 643.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 55.11355400085449, + "relativeCreated": 85.30163764953613, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0002269744873046875 + "time_consumption": 0.00036263465881347656 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.8657439, + "asctime": "2024-09-15 16:36:11,645", + "created": 1726410971.645531, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2031,8 +2076,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.865598, + "asctime": "2024-09-15 16:36:11,645", + "created": 1726410971.645273, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2042,15 +2087,15 @@ "lineno": 22, "message": "Result (Instance data after increasing data_version): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 865.0, + "msecs": 645.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.52022361755371, + "relativeCreated": 87.2495174407959, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -2060,8 +2105,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,865", - "created": 1726403487.8656602, + "asctime": "2024-09-15 16:36:11,645", + "created": 1726410971.645399, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2071,41 +2116,41 @@ "lineno": 26, "message": "Expectation (Instance data after increasing data_version): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 865.0, + "msecs": 645.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.58245086669922, + "relativeCreated": 87.37564086914062, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 865.0, + "msecs": 645.0, "msg": "Instance data after increasing data_version is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 56.66613578796387, + "relativeCreated": 87.50748634338379, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 8.368492126464844e-05 + "time_consumption": 0.00013184547424316406 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0018999576568603516, - "time_finished": "2024-09-15 14:31:27,865", - "time_start": "2024-09-15 14:31:27,863" + "time_consumption": 0.002765178680419922, + "time_finished": "2024-09-15 16:36:11,645", + "time_start": "2024-09-15 16:36:11,642" }, "caching.property_cache_json: Test internal key usage": { "args": null, - "asctime": "2024-09-15 14:31:27,870", - "created": 1726403487.8700788, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6507537, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2116,13 +2161,13 @@ "message": "caching.property_cache_json: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 870.0, + "msecs": 650.0, "msg": "caching.property_cache_json: Test internal key usage", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 61.00106239318848, + "relativeCreated": 92.73028373718262, "stack_info": null, "testcaseLogger": [ { @@ -2130,8 +2175,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-15 14:31:27,870", - "created": 1726403487.8708, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6512315, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2144,8 +2189,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,870", - "created": 1726403487.870248, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6508617, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2155,23 +2200,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 870.0, + "msecs": 650.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 61.170339584350586, + "relativeCreated": 92.83828735351562, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.json" ], - "asctime": "2024-09-15 14:31:27,870", - "created": 1726403487.870406, + "asctime": "2024-09-15 16:36:11,650", + "created": 1726410971.6509454, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2181,36 +2226,36 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.json as cache file.", "module": "test_helpers", - "msecs": 870.0, + "msecs": 650.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 61.32817268371582, + "relativeCreated": 92.92197227478027, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 870.0, + "msecs": 651.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 61.7222785949707, + "relativeCreated": 93.20807456970215, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0003941059112548828 + "time_consumption": 0.000286102294921875 }, { "args": [ "property_cache_json" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8710992, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6515033, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -2225,8 +2270,8 @@ "args": [ "{'__property_cache_data_version_': 'no second data version', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '_property_cache_uid_': 'no uid'}" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8710265, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6514401, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -2236,37 +2281,37 @@ "lineno": 20, "message": "Using storage object of cache class for comparison: {'__property_cache_data_version_': 'no second data version', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '_property_cache_uid_': 'no uid'}", "module": "test_internal_keys", - "msecs": 871.0, + "msecs": 651.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 61.94877624511719, + "relativeCreated": 93.41669082641602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 871.0, + "msecs": 651.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.021493911743164, + "relativeCreated": 93.47987174987793, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 7.271766662597656e-05 + "time_consumption": 6.318092346191406e-05 }, { "args": [ "{'__property_cache_data_version_': 'no second data version', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '_property_cache_uid_': 'no uid'}", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8713806, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.651742, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2283,8 +2328,8 @@ "{ '__property_cache_data_version_': 'no second data version', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '_property_cache_uid_': 'no uid' }", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.871217, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.651603, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2294,15 +2339,15 @@ "lineno": 22, "message": "Result (Cache): { '__property_cache_data_version_': 'no second data version', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '_property_cache_uid_': 'no uid' } ()", "module": "test", - "msecs": 871.0, + "msecs": 651.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.139272689819336, + "relativeCreated": 93.57953071594238, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -2312,8 +2357,8 @@ "{ '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' }", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.871293, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6516693, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2323,37 +2368,37 @@ "lineno": 26, "message": "Expectation (Cache): result = { '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' } ()", "module": "test", - "msecs": 871.0, + "msecs": 651.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.215328216552734, + "relativeCreated": 93.64581108093262, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 871.0, + "msecs": 651.0, "msg": "Cache is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.30282783508301, + "relativeCreated": 93.7185287475586, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 8.749961853027344e-05 + "time_consumption": 7.271766662597656e-05 }, { "args": [ "5", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.871603, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6519372, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2370,8 +2415,8 @@ "5", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8714793, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6518328, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2381,15 +2426,15 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 871.0, + "msecs": 651.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.401533126831055, + "relativeCreated": 93.80936622619629, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -2399,8 +2444,8 @@ "5", "" ], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.871542, + "asctime": "2024-09-15 16:36:11,651", + "created": 1726410971.6518862, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2410,41 +2455,41 @@ "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 871.0, + "msecs": 651.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.464237213134766, + "relativeCreated": 93.86277198791504, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 871.0, + "msecs": 651.0, "msg": "Keyfilter returnvalue for 5 () is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.525272369384766, + "relativeCreated": 93.91379356384277, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 6.103515625e-05 + "time_consumption": 5.1021575927734375e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.001524209976196289, - "time_finished": "2024-09-15 14:31:27,871", - "time_start": "2024-09-15 14:31:27,870" + "time_consumption": 0.0011835098266601562, + "time_finished": "2024-09-15 16:36:11,651", + "time_start": "2024-09-15 16:36:11,650" }, "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object": { "args": null, - "asctime": "2024-09-15 14:31:27,859", - "created": 1726403487.8592005, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.635614, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2455,13 +2500,13 @@ "message": "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 859.0, + "msecs": 635.0, "msg": "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 50.122737884521484, + "relativeCreated": 77.5904655456543, "stack_info": null, "testcaseLogger": [ { @@ -2469,8 +2514,8 @@ "property_cache_json", "False" ], - "asctime": "2024-09-15 14:31:27,859", - "created": 1726403487.8594744, + "asctime": "2024-09-15 16:36:11,636", + "created": 1726410971.6360443, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2483,8 +2528,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,859", - "created": 1726403487.8592715, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.6357322, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2494,23 +2539,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 859.0, + "msecs": 635.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 50.19378662109375, + "relativeCreated": 77.70872116088867, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.json" ], - "asctime": "2024-09-15 14:31:27,859", - "created": 1726403487.8593316, + "asctime": "2024-09-15 16:36:11,635", + "created": 1726410971.635824, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2520,34 +2565,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.json as cache file.", "module": "test_helpers", - "msecs": 859.0, + "msecs": 635.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 50.253868103027344, + "relativeCreated": 77.80051231384277, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 859.0, + "msecs": 636.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 50.39668083190918, + "relativeCreated": 78.02081108093262, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00014281272888183594 + "time_consumption": 0.00022029876708984375 }, { "args": [], - "asctime": "2024-09-15 14:31:27,860", - "created": 1726403487.8608408, + "asctime": "2024-09-15 16:36:11,637", + "created": 1726410971.6376202, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2558,15 +2603,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 860.0, + "msecs": 637.0, "msg": "Partially initialising cache object by requesting some information.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 51.763057708740234, + "relativeCreated": 79.59675788879395, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2574,8 +2619,8 @@ "args": [ "property_cache_json" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.861004, + "asctime": "2024-09-15 16:36:11,637", + "created": 1726410971.6379137, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2590,8 +2635,8 @@ "args": [ "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2024-09-15 14:31:27,860", - "created": 1726403487.8609605, + "asctime": "2024-09-15 16:36:11,637", + "created": 1726410971.6378453, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2601,37 +2646,37 @@ "lineno": 23, "message": "Using storage object of cache class for comparison: {'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "module": "test_no_load_on_init", - "msecs": 860.0, + "msecs": 637.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 51.88274383544922, + "relativeCreated": 79.82182502746582, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 861.0, + "msecs": 637.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 51.926374435424805, + "relativeCreated": 79.89025115966797, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 4.363059997558594e-05 + "time_consumption": 6.842613220214844e-05 }, { "args": [ "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8611522, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6381605, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2648,8 +2693,8 @@ "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.86107, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6380231, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2659,15 +2704,15 @@ "lineno": 22, "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", "module": "test", - "msecs": 861.0, + "msecs": 638.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 51.992177963256836, + "relativeCreated": 79.99968528747559, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -2677,8 +2722,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2024-09-15 14:31:27,861", - "created": 1726403487.8611097, + "asctime": "2024-09-15 16:36:11,638", + "created": 1726410971.6380897, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2688,41 +2733,41 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 861.0, + "msecs": 638.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.0319938659668, + "relativeCreated": 80.06620407104492, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 861.0, + "msecs": 638.0, "msg": "Cache object is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 52.074432373046875, + "relativeCreated": 80.13701438903809, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 4.2438507080078125e-05 + "time_consumption": 7.081031799316406e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0019516944885253906, - "time_finished": "2024-09-15 14:31:27,861", - "time_start": "2024-09-15 14:31:27,859" + "time_consumption": 0.002546548843383789, + "time_finished": "2024-09-15 16:36:11,638", + "time_start": "2024-09-15 16:36:11,635" }, "caching.property_cache_pickle: Test cached data (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8745885, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.654658, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2733,13 +2778,13 @@ "message": "caching.property_cache_pickle: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 874.0, + "msecs": 654.0, "msg": "caching.property_cache_pickle: Test cached data (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.51074981689453, + "relativeCreated": 96.6346263885498, "stack_info": null, "testcaseLogger": [ { @@ -2747,8 +2792,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.875, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.655036, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2761,8 +2806,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8747017, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.654762, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2772,23 +2817,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 874.0, + "msecs": 654.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.62399864196777, + "relativeCreated": 96.73857688903809, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8747919, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.6548445, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2798,34 +2843,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 874.0, + "msecs": 654.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.71412086486816, + "relativeCreated": 96.82106971740723, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 875.0, + "msecs": 655.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.92226028442383, + "relativeCreated": 97.01251983642578, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00020813941955566406 + "time_consumption": 0.0001914501190185547 }, { "args": [], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.8752425, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.6552558, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -2836,15 +2881,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 875.0, + "msecs": 655.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.16473197937012, + "relativeCreated": 97.23234176635742, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2853,8 +2898,8 @@ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'uncached': 'uncached_data_of_class'}", "" ], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.8756156, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.6555886, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2871,8 +2916,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.8753788, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.655379, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2882,15 +2927,15 @@ "lineno": 22, "message": "Result (Cached data): { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 875.0, + "msecs": 655.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.30110740661621, + "relativeCreated": 97.35560417175293, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -2900,8 +2945,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.8754802, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.6554646, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2911,41 +2956,41 @@ "lineno": 26, "message": "Expectation (Cached data): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 875.0, + "msecs": 655.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.40243530273438, + "relativeCreated": 97.44119644165039, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 875.0, + "msecs": 655.0, "msg": "Cached data is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.53785705566406, + "relativeCreated": 97.5651741027832, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001354217529296875 + "time_consumption": 0.0001239776611328125 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010271072387695312, - "time_finished": "2024-09-15 14:31:27,875", - "time_start": "2024-09-15 14:31:27,874" + "time_consumption": 0.0009305477142333984, + "time_finished": "2024-09-15 16:36:11,655", + "time_start": "2024-09-15 16:36:11,654" }, "caching.property_cache_pickle: Test cached data (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.875801, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.6557553, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2956,13 +3001,13 @@ "message": "caching.property_cache_pickle: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 875.0, + "msecs": 655.0, "msg": "caching.property_cache_pickle: Test cached data (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.72334671020508, + "relativeCreated": 97.7318286895752, "stack_info": null, "testcaseLogger": [ { @@ -2970,8 +3015,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.8762777, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6561275, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2984,8 +3029,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,875", - "created": 1726403487.8759143, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.6558554, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2995,23 +3040,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 875.0, + "msecs": 655.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.83659553527832, + "relativeCreated": 97.83196449279785, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.8760028, + "asctime": "2024-09-15 16:36:11,655", + "created": 1726410971.655937, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3021,34 +3066,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 876.0, + "msecs": 655.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 66.925048828125, + "relativeCreated": 97.91350364685059, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 876.0, + "msecs": 656.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.1999454498291, + "relativeCreated": 98.10400009155273, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00027489662170410156 + "time_consumption": 0.00019049644470214844 }, { "args": [], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.8765206, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6563458, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -3059,15 +3104,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 876.0, + "msecs": 656.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.4428939819336, + "relativeCreated": 98.32239151000977, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3076,8 +3121,8 @@ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'uncached': 'uncached_data_of_class'}", "" ], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.8768954, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6566799, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3094,8 +3139,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.876661, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6564755, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3105,15 +3150,15 @@ "lineno": 22, "message": "Result (Cached data): { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 876.0, + "msecs": 656.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.58332252502441, + "relativeCreated": 98.45209121704102, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -3123,8 +3168,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' }", "" ], - "asctime": "2024-09-15 14:31:27,876", - "created": 1726403487.876771, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6565628, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3134,41 +3179,41 @@ "lineno": 26, "message": "Expectation (Cached data): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 }, 'uncached': 'uncached_data_of_class' } ()", "module": "test", - "msecs": 876.0, + "msecs": 656.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.69323348999023, + "relativeCreated": 98.53935241699219, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 876.0, + "msecs": 656.0, "msg": "Cached data is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.81768798828125, + "relativeCreated": 98.65641593933105, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00012445449829101562 + "time_consumption": 0.00011706352233886719 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010943412780761719, - "time_finished": "2024-09-15 14:31:27,876", - "time_start": "2024-09-15 14:31:27,875" + "time_consumption": 0.0009245872497558594, + "time_finished": "2024-09-15 16:36:11,656", + "time_start": "2024-09-15 16:36:11,655" }, "caching.property_cache_pickle: Test execution of save callback (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8830657, + "asctime": "2024-09-15 16:36:11,662", + "created": 1726410971.6629856, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3179,19 +3224,19 @@ "message": "caching.property_cache_pickle: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 883.0, + "msecs": 662.0, "msg": "caching.property_cache_pickle: Test execution of save callback (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 73.98796081542969, + "relativeCreated": 104.96211051940918, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8831737, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.663093, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -3202,15 +3247,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 883.0, + "msecs": 663.0, "msg": "Installing save_callback, which sets a variable to True on execution.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_save_callback.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.0959644317627, + "relativeCreated": 105.06963729858398, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3219,8 +3264,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8834682, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6633885, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3237,8 +3282,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8833377, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.663268, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3248,15 +3293,15 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 883.0, + "msecs": 663.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.25999641418457, + "relativeCreated": 105.24463653564453, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -3266,8 +3311,8 @@ "True", "" ], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.883408, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6633334, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3277,41 +3322,41 @@ "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 883.0, + "msecs": 663.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.33032989501953, + "relativeCreated": 105.30996322631836, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 883.0, + "msecs": 663.0, "msg": "Save callback execution variable is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.39041137695312, + "relativeCreated": 105.36503791809082, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 6.008148193359375e-05 + "time_consumption": 5.507469177246094e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0004024505615234375, - "time_finished": "2024-09-15 14:31:27,883", - "time_start": "2024-09-15 14:31:27,883" + "time_consumption": 0.0004029273986816406, + "time_finished": "2024-09-15 16:36:11,663", + "time_start": "2024-09-15 16:36:11,662" }, "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8717942, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6520984, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3322,13 +3367,13 @@ "message": "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 871.0, + "msecs": 652.0, "msg": "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.71648406982422, + "relativeCreated": 94.07496452331543, "stack_info": null, "testcaseLogger": [ { @@ -3336,8 +3381,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8722456, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6524944, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3350,8 +3395,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,871", - "created": 1726403487.8719115, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6522017, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3361,23 +3406,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 871.0, + "msecs": 652.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.83378601074219, + "relativeCreated": 94.1781997680664, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8720114, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6522858, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3387,36 +3432,36 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 872.0, + "msecs": 652.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 62.93368339538574, + "relativeCreated": 94.26236152648926, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 872.0, + "msecs": 652.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.16781044006348, + "relativeCreated": 94.47097778320312, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00023412704467773438 + "time_consumption": 0.0002086162567138672 }, { "args": [ "property_cache_pickle" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.872495, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6527345, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -3431,8 +3476,8 @@ "args": [ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}}" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8724265, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6526704, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -3442,37 +3487,37 @@ "lineno": 20, "message": "Using storage object of cache class for comparison: {'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}}", "module": "test_load_on_init", - "msecs": 872.0, + "msecs": 652.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.34877014160156, + "relativeCreated": 94.64693069458008, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 872.0, + "msecs": 652.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.41719627380371, + "relativeCreated": 94.7110652923584, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 6.842613220214844e-05 + "time_consumption": 6.413459777832031e-05 }, { "args": [ "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}}", "" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8728735, + "asctime": "2024-09-15 16:36:11,653", + "created": 1726410971.6530602, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3489,8 +3534,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } }", "" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8726344, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6528542, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3500,15 +3545,15 @@ "lineno": 22, "message": "Result (Cache object): { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } } ()", "module": "test", - "msecs": 872.0, + "msecs": 652.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.556671142578125, + "relativeCreated": 94.83075141906738, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -3518,8 +3563,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } }", "" ], - "asctime": "2024-09-15 14:31:27,872", - "created": 1726403487.8727326, + "asctime": "2024-09-15 16:36:11,652", + "created": 1726410971.6529372, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3529,41 +3574,41 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [ 1, 'two', '3', 4 ], 'dict': { '1': 1, '2': 'two', '3': '3', '4': 4 } } ()", "module": "test", - "msecs": 872.0, + "msecs": 652.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.65489959716797, + "relativeCreated": 94.91372108459473, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 872.0, + "msecs": 653.0, "msg": "Cache object is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.79580497741699, + "relativeCreated": 95.03674507141113, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00014090538024902344 + "time_consumption": 0.00012302398681640625 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010793209075927734, - "time_finished": "2024-09-15 14:31:27,872", - "time_start": "2024-09-15 14:31:27,871" + "time_consumption": 0.0009617805480957031, + "time_finished": "2024-09-15 16:36:11,653", + "time_start": "2024-09-15 16:36:11,652" }, "caching.property_cache_pickle: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.880006, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.6597333, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3574,13 +3619,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 880.0, + "msecs": 659.0, "msg": "caching.property_cache_pickle: Test get from source caused by changed uid (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 70.92833518981934, + "relativeCreated": 101.70984268188477, "stack_info": null, "testcaseLogger": [ { @@ -3588,8 +3633,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.8803945, + "asctime": "2024-09-15 16:36:11,660", + "created": 1726410971.6601796, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3602,8 +3647,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.8801136, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.659839, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3613,23 +3658,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 880.0, + "msecs": 659.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.03586196899414, + "relativeCreated": 101.81546211242676, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.8802001, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.659924, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3639,37 +3684,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 880.0, + "msecs": 659.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.12240791320801, + "relativeCreated": 101.90057754516602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 880.0, + "msecs": 660.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.31671905517578, + "relativeCreated": 102.15616226196289, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00019431114196777344 + "time_consumption": 0.000255584716796875 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,881", - "created": 1726403487.8810306, + "asctime": "2024-09-15 16:36:11,660", + "created": 1726410971.6607792, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3686,8 +3731,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.880801, + "asctime": "2024-09-15 16:36:11,660", + "created": 1726410971.6605628, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3697,15 +3742,15 @@ "lineno": 22, "message": "Result (Instance data after changing uid): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 880.0, + "msecs": 660.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.72322273254395, + "relativeCreated": 102.5393009185791, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -3715,8 +3760,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,880", - "created": 1726403487.8809016, + "asctime": "2024-09-15 16:36:11,660", + "created": 1726410971.6606603, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3726,41 +3771,41 @@ "lineno": 26, "message": "Expectation (Instance data after changing uid): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 880.0, + "msecs": 660.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.8238353729248, + "relativeCreated": 102.63681411743164, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 881.0, + "msecs": 660.0, "msg": "Instance data after changing uid is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 71.95281982421875, + "relativeCreated": 102.75578498840332, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001289844512939453 + "time_consumption": 0.00011897087097167969 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.001024484634399414, - "time_finished": "2024-09-15 14:31:27,881", - "time_start": "2024-09-15 14:31:27,880" + "time_consumption": 0.0010459423065185547, + "time_finished": "2024-09-15 16:36:11,660", + "time_start": "2024-09-15 16:36:11,659" }, "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,881", - "created": 1726403487.8812006, + "asctime": "2024-09-15 16:36:11,660", + "created": 1726410971.6609526, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3771,13 +3816,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 881.0, + "msecs": 660.0, "msg": "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 72.12281227111816, + "relativeCreated": 102.92911529541016, "stack_info": null, "testcaseLogger": [ { @@ -3785,8 +3830,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,881", - "created": 1726403487.8815837, + "asctime": "2024-09-15 16:36:11,661", + "created": 1726410971.6613715, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3799,8 +3844,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,881", - "created": 1726403487.8813074, + "asctime": "2024-09-15 16:36:11,661", + "created": 1726410971.6610615, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3810,23 +3855,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 881.0, + "msecs": 661.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 72.22962379455566, + "relativeCreated": 103.03807258605957, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,881", - "created": 1726403487.8813899, + "asctime": "2024-09-15 16:36:11,661", + "created": 1726410971.661161, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3836,37 +3881,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 881.0, + "msecs": 661.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 72.3121166229248, + "relativeCreated": 103.13749313354492, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 881.0, + "msecs": 661.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 72.50595092773438, + "relativeCreated": 103.3480167388916, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001938343048095703 + "time_consumption": 0.0002105236053466797 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,882", - "created": 1726403487.8828926, + "asctime": "2024-09-15 16:36:11,662", + "created": 1726410971.662804, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3883,8 +3928,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,882", - "created": 1726403487.882662, + "asctime": "2024-09-15 16:36:11,662", + "created": 1726410971.662554, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3894,15 +3939,15 @@ "lineno": 22, "message": "Result (Instance data after changing uid): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 882.0, + "msecs": 662.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 73.58431816101074, + "relativeCreated": 104.53057289123535, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -3912,8 +3957,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,882", - "created": 1726403487.8827631, + "asctime": "2024-09-15 16:36:11,662", + "created": 1726410971.662674, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3923,41 +3968,41 @@ "lineno": 26, "message": "Expectation (Instance data after changing uid): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 882.0, + "msecs": 662.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 73.6854076385498, + "relativeCreated": 104.65049743652344, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 882.0, + "msecs": 662.0, "msg": "Instance data after changing uid is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 73.81486892700195, + "relativeCreated": 104.78043556213379, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00012946128845214844 + "time_consumption": 0.00012993812561035156 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.001692056655883789, - "time_finished": "2024-09-15 14:31:27,882", - "time_start": "2024-09-15 14:31:27,881" + "time_consumption": 0.0018513202667236328, + "time_finished": "2024-09-15 16:36:11,662", + "time_start": "2024-09-15 16:36:11,660" }, "caching.property_cache_pickle: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.8770747, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6568456, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3968,13 +4013,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 877.0, + "msecs": 656.0, "msg": "caching.property_cache_pickle: Test get from source caused by increased data version (full init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 67.99697875976562, + "relativeCreated": 98.82211685180664, "stack_info": null, "testcaseLogger": [ { @@ -3982,8 +4027,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.877477, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.6572206, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3996,8 +4041,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.877185, + "asctime": "2024-09-15 16:36:11,656", + "created": 1726410971.6569467, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4007,23 +4052,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 877.0, + "msecs": 656.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 68.10736656188965, + "relativeCreated": 98.9232063293457, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.8772767, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.6570303, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4033,37 +4078,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 877.0, + "msecs": 657.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 68.19891929626465, + "relativeCreated": 99.00689125061035, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 877.0, + "msecs": 657.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 68.39919090270996, + "relativeCreated": 99.1971492767334, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0002002716064453125 + "time_consumption": 0.00019025802612304688 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,878", - "created": 1726403487.8781083, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.65782, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4080,8 +4125,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.8778791, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.6575952, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4091,15 +4136,15 @@ "lineno": 22, "message": "Result (Instance data after increasing data_version): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 877.0, + "msecs": 657.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 68.8014030456543, + "relativeCreated": 99.57170486450195, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -4109,8 +4154,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,877", - "created": 1726403487.87798, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.6576898, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4120,41 +4165,41 @@ "lineno": 26, "message": "Expectation (Instance data after increasing data_version): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 877.0, + "msecs": 657.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 68.90225410461426, + "relativeCreated": 99.66635704040527, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 878.0, + "msecs": 657.0, "msg": "Instance data after increasing data_version is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 69.0305233001709, + "relativeCreated": 99.79653358459473, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00012826919555664062 + "time_consumption": 0.00013017654418945312 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010335445404052734, - "time_finished": "2024-09-15 14:31:27,878", - "time_start": "2024-09-15 14:31:27,877" + "time_consumption": 0.0009744167327880859, + "time_finished": "2024-09-15 16:36:11,657", + "time_start": "2024-09-15 16:36:11,656" }, "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2024-09-15 14:31:27,878", - "created": 1726403487.878284, + "asctime": "2024-09-15 16:36:11,657", + "created": 1726410971.6579907, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4165,13 +4210,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 878.0, + "msecs": 657.0, "msg": "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 69.20623779296875, + "relativeCreated": 99.96724128723145, "stack_info": null, "testcaseLogger": [ { @@ -4179,8 +4224,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,878", - "created": 1726403487.8786767, + "asctime": "2024-09-15 16:36:11,658", + "created": 1726410971.6583657, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4193,8 +4238,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,878", - "created": 1726403487.8783941, + "asctime": "2024-09-15 16:36:11,658", + "created": 1726410971.658093, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4204,23 +4249,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 878.0, + "msecs": 658.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 69.31638717651367, + "relativeCreated": 100.06952285766602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,878", - "created": 1726403487.8784792, + "asctime": "2024-09-15 16:36:11,658", + "created": 1726410971.6581757, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4230,37 +4275,37 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 878.0, + "msecs": 658.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 69.40150260925293, + "relativeCreated": 100.15225410461426, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 878.0, + "msecs": 658.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 69.59891319274902, + "relativeCreated": 100.3422737121582, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00019741058349609375 + "time_consumption": 0.0001900196075439453 }, { "args": [ "{'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}}", "" ], - "asctime": "2024-09-15 14:31:27,879", - "created": 1726403487.8798356, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.6595628, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4277,8 +4322,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,879", - "created": 1726403487.879589, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.659337, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4288,15 +4333,15 @@ "lineno": 22, "message": "Result (Instance data after increasing data_version): { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 879.0, + "msecs": 659.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 70.5113410949707, + "relativeCreated": 101.31359100341797, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -4306,8 +4351,8 @@ "{ 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } }", "" ], - "asctime": "2024-09-15 14:31:27,879", - "created": 1726403487.8796911, + "asctime": "2024-09-15 16:36:11,659", + "created": 1726410971.6594348, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4317,41 +4362,41 @@ "lineno": 26, "message": "Expectation (Instance data after increasing data_version): result = { 'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': [ 'one', 2, 3, '4' ], 'dict': { '1': '1', '2': 2, '3': 'three', '4': '4' } } ()", "module": "test", - "msecs": 879.0, + "msecs": 659.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 70.61338424682617, + "relativeCreated": 101.41134262084961, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 879.0, + "msecs": 659.0, "msg": "Instance data after increasing data_version is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 70.75786590576172, + "relativeCreated": 101.53937339782715, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.00014448165893554688 + "time_consumption": 0.00012803077697753906 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0015516281127929688, - "time_finished": "2024-09-15 14:31:27,879", - "time_start": "2024-09-15 14:31:27,878" + "time_consumption": 0.0015721321105957031, + "time_finished": "2024-09-15 16:36:11,659", + "time_start": "2024-09-15 16:36:11,657" }, "caching.property_cache_pickle: Test internal key usage": { "args": null, - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8836343, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6635482, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4362,13 +4407,13 @@ "message": "caching.property_cache_pickle: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 883.0, + "msecs": 663.0, "msg": "caching.property_cache_pickle: Test internal key usage", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.55658912658691, + "relativeCreated": 105.52477836608887, "stack_info": null, "testcaseLogger": [ { @@ -4376,8 +4421,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8840163, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6639209, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4390,8 +4435,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8837402, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6636484, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4401,23 +4446,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 883.0, + "msecs": 663.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.66244697570801, + "relativeCreated": 105.62491416931152, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.pkl" ], - "asctime": "2024-09-15 14:31:27,883", - "created": 1726403487.8838243, + "asctime": "2024-09-15 16:36:11,663", + "created": 1726410971.6637335, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4427,36 +4472,36 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.pkl as cache file.", "module": "test_helpers", - "msecs": 883.0, + "msecs": 663.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.74660873413086, + "relativeCreated": 105.71002960205078, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 884.0, + "msecs": 663.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 74.93853569030762, + "relativeCreated": 105.89742660522461, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001919269561767578 + "time_consumption": 0.00018739700317382812 }, { "args": [ "property_cache_pickle" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8842309, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6641424, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -4471,8 +4516,8 @@ "args": [ "{'_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version'}" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.884169, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6640828, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -4482,37 +4527,37 @@ "lineno": 20, "message": "Using storage object of cache class for comparison: {'_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version'}", "module": "test_internal_keys", - "msecs": 884.0, + "msecs": 664.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.09136199951172, + "relativeCreated": 106.05931282043457, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 884.0, + "msecs": 664.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.15311241149902, + "relativeCreated": 106.11891746520996, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 6.175041198730469e-05 + "time_consumption": 5.9604644775390625e-05 }, { "args": [ "{'_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version'}", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8844774, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6643796, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4529,8 +4574,8 @@ "{ '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' }", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.884331, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6642392, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4540,15 +4585,15 @@ "lineno": 22, "message": "Result (Cache): { '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' } ()", "module": "test", - "msecs": 884.0, + "msecs": 664.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.25324821472168, + "relativeCreated": 106.2157154083252, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -4558,8 +4603,8 @@ "{ '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' }", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8844001, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6643054, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4569,37 +4614,37 @@ "lineno": 26, "message": "Expectation (Cache): result = { '_property_cache_uid_': 'no uid', '__property_cache_uid_': 'no second uid', '_property_cache_data_version_': 'no data version', '__property_cache_data_version_': 'no second data version' } ()", "module": "test", - "msecs": 884.0, + "msecs": 664.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.32238960266113, + "relativeCreated": 106.28199577331543, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 884.0, + "msecs": 664.0, "msg": "Cache is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.39963722229004, + "relativeCreated": 106.35614395141602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 7.724761962890625e-05 + "time_consumption": 7.414817810058594e-05 }, { "args": [ "5", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8846805, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6645687, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4616,8 +4661,8 @@ "5", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8845687, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.6644652, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4627,15 +4672,15 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 884.0, + "msecs": 664.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.49095153808594, + "relativeCreated": 106.44173622131348, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -4645,8 +4690,8 @@ "5", "" ], - "asctime": "2024-09-15 14:31:27,884", - "created": 1726403487.8846257, + "asctime": "2024-09-15 16:36:11,664", + "created": 1726410971.664518, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4656,41 +4701,41 @@ "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 884.0, + "msecs": 664.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.54793357849121, + "relativeCreated": 106.49466514587402, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 884.0, + "msecs": 664.0, "msg": "Keyfilter returnvalue for 5 () is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 75.60276985168457, + "relativeCreated": 106.54520988464355, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 5.4836273193359375e-05 + "time_consumption": 5.054473876953125e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0010461807250976562, - "time_finished": "2024-09-15 14:31:27,884", - "time_start": "2024-09-15 14:31:27,883" + "time_consumption": 0.0010204315185546875, + "time_finished": "2024-09-15 16:36:11,664", + "time_start": "2024-09-15 16:36:11,663" }, "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2024-09-15 14:31:27,873", - "created": 1726403487.8730576, + "asctime": "2024-09-15 16:36:11,653", + "created": 1726410971.6532278, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4701,13 +4746,13 @@ "message": "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 873.0, + "msecs": 653.0, "msg": "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 63.9798641204834, + "relativeCreated": 95.20435333251953, "stack_info": null, "testcaseLogger": [ { @@ -4715,8 +4760,8 @@ "property_cache_pickle", "False" ], - "asctime": "2024-09-15 14:31:27,873", - "created": 1726403487.8734276, + "asctime": "2024-09-15 16:36:11,653", + "created": 1726410971.653573, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4729,8 +4774,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-15 14:31:27,873", - "created": 1726403487.873173, + "asctime": "2024-09-15 16:36:11,653", + "created": 1726410971.6533353, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4740,23 +4785,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 873.0, + "msecs": 653.0, "msg": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 64.09525871276855, + "relativeCreated": 95.31188011169434, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.pkl" ], - "asctime": "2024-09-15 14:31:27,873", - "created": 1726403487.8732643, + "asctime": "2024-09-15 16:36:11,653", + "created": 1726410971.6534188, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4766,34 +4811,34 @@ "lineno": 21, "message": "Initialising cached class with /home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.pkl as cache file.", "module": "test_helpers", - "msecs": 873.0, + "msecs": 653.0, "msg": "Initialising cached class with %s as cache file.", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 64.18657302856445, + "relativeCreated": 95.39532661437988, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 873.0, + "msecs": 653.0, "msg": "Initialising %s (load_all_on_init=%s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_helpers.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 64.34988975524902, + "relativeCreated": 95.5495834350586, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0001633167266845703 + "time_consumption": 0.00015425682067871094 }, { "args": [], - "asctime": "2024-09-15 14:31:27,873", - "created": 1726403487.8738995, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.6540277, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4804,15 +4849,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 873.0, + "msecs": 654.0, "msg": "Partially initialising cache object by requesting some information.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 64.82172012329102, + "relativeCreated": 96.00424766540527, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -4820,8 +4865,8 @@ "args": [ "property_cache_pickle" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8741326, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.6542528, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4834,10 +4879,10 @@ "moduleLogger": [ { "args": [ - "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" + "{'integer': 17, 'unicode': 'unicode', 'str': 'string'}" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8740654, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.6541905, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4845,39 +4890,39 @@ "levelname": "INFO", "levelno": 20, "lineno": 23, - "message": "Using storage object of cache class for comparison: {'integer': 17, 'str': 'string', 'unicode': 'unicode'}", + "message": "Using storage object of cache class for comparison: {'integer': 17, 'unicode': 'unicode', 'str': 'string'}", "module": "test_no_load_on_init", - "msecs": 874.0, + "msecs": 654.0, "msg": "Using storage object of cache class for comparison: %s", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 64.9876594543457, + "relativeCreated": 96.16708755493164, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 874.0, + "msecs": 654.0, "msg": "Extracting storage object from %s for comparison.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.05489349365234, + "relativeCreated": 96.22931480407715, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 6.723403930664062e-05 + "time_consumption": 6.222724914550781e-05 }, { "args": [ - "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", + "{'integer': 17, 'unicode': 'unicode', 'str': 'string'}", "" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8743997, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.654492, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4885,17 +4930,17 @@ "levelname": "INFO", "levelno": 20, "lineno": 184, - "message": "Cache object is correct (Content {'integer': 17, 'str': 'string', 'unicode': 'unicode'} and Type is ).", + "message": "Cache object is correct (Content {'integer': 17, 'unicode': 'unicode', 'str': 'string'} and Type is ).", "module": "test", "moduleLogger": [ { "args": [ "Cache object", - "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", + "{ 'integer': 17, 'unicode': 'unicode', 'str': 'string' }", "" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8742461, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.654359, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4903,17 +4948,17 @@ "levelname": "DEBUG", "levelno": 10, "lineno": 22, - "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", + "message": "Result (Cache object): { 'integer': 17, 'unicode': 'unicode', 'str': 'string' } ()", "module": "test", - "msecs": 874.0, + "msecs": 654.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.16838073730469, + "relativeCreated": 96.33564949035645, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" }, { @@ -4923,8 +4968,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2024-09-15 14:31:27,874", - "created": 1726403487.8743188, + "asctime": "2024-09-15 16:36:11,654", + "created": 1726410971.6544228, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4934,40 +4979,40 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 874.0, + "msecs": 654.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.24109840393066, + "relativeCreated": 96.39930725097656, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread" } ], - "msecs": 874.0, + "msecs": 654.0, "msg": "Cache object is correct (Content %s and Type is %s).", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 102584, + "process": 122365, "processName": "MainProcess", - "relativeCreated": 65.3219223022461, + "relativeCreated": 96.46844863891602, "stack_info": null, - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 8.082389831542969e-05 + "time_consumption": 6.914138793945312e-05 } ], - "thread": 139920156860480, + "thread": 140411494588480, "threadName": "MainThread", - "time_consumption": 0.0013420581817626953, - "time_finished": "2024-09-15 14:31:27,874", - "time_start": "2024-09-15 14:31:27,873" + "time_consumption": 0.0012640953063964844, + "time_finished": "2024-09-15 16:36:11,654", + "time_start": "2024-09-15 16:36:11,653" } }, "testrun_id": "p3", - "time_consumption": 0.0236968994140625, + "time_consumption": 0.027504444122314453, "uid_list_sorted": [ "caching.property_cache_json: Test full initialised JSON-Cache-Object", "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", diff --git a/_testresults_/unittest.pdf b/_testresults_/unittest.pdf index fd45628..74089b5 100644 Binary files a/_testresults_/unittest.pdf and b/_testresults_/unittest.pdf differ