diff --git a/__init__.py b/__init__.py index 78133ec..58b499a 100644 --- a/__init__.py +++ b/__init__.py @@ -209,7 +209,8 @@ class property_cache_pickle(object): self._cached_props[self.UID_TAG] = self._source_instance.uid() self._cached_props[self.DATA_VERSION_TAG] = self._source_instance.data_version() self._cached_props[self.STORAGE_VERSION_TAG] = self.STORAGE_VERSION - self._save_cache() + if self._store_on_get: + self._save_cache() def _load_cache(self): if os.path.exists(self._cache_filename): diff --git a/_testresults_/unittest.json b/_testresults_/unittest.json index 585b7cd..6e13469 100644 --- a/_testresults_/unittest.json +++ b/_testresults_/unittest.json @@ -1,11 +1,11 @@ { "coverage_information": [ { - "branch_coverage": 79.31, + "branch_coverage": 78.33, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching", "files": [ { - "branch_coverage": 79.31, + "branch_coverage": 78.33, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching/__init__.py", "fragments": [ { @@ -335,155 +335,165 @@ }, { "coverage_state": "covered", - "end": 212, + "end": 211, "start": 206 }, { - "coverage_state": "clean", + "coverage_state": "partially-covered", + "end": 212, + "start": 212 + }, + { + "coverage_state": "covered", "end": 213, "start": 213 }, { - "coverage_state": "covered", - "end": 219, + "coverage_state": "clean", + "end": 214, "start": 214 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 220, - "start": 220 + "start": 215 }, { - "coverage_state": "covered", - "end": 222, + "coverage_state": "clean", + "end": 221, "start": 221 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 223, - "start": 223 + "start": 222 }, { - "coverage_state": "covered", - "end": 225, + "coverage_state": "clean", + "end": 224, "start": 224 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 226, - "start": 226 + "start": 225 }, { - "coverage_state": "covered", + "coverage_state": "clean", "end": 227, "start": 227 }, { - "coverage_state": "partially-covered", + "coverage_state": "covered", "end": 228, "start": 228 }, { - "coverage_state": "uncovered", + "coverage_state": "partially-covered", "end": 229, "start": 229 }, { - "coverage_state": "covered", - "end": 231, + "coverage_state": "uncovered", + "end": 230, "start": 230 }, { - "coverage_state": "partially-covered", + "coverage_state": "covered", "end": 232, - "start": 232 + "start": 231 }, { - "coverage_state": "covered", - "end": 235, + "coverage_state": "partially-covered", + "end": 233, "start": 233 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 236, - "start": 236 + "start": 234 }, { - "coverage_state": "covered", - "end": 242, + "coverage_state": "clean", + "end": 237, "start": 237 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 243, - "start": 243 + "start": 238 }, { - "coverage_state": "covered", - "end": 246, + "coverage_state": "clean", + "end": 244, "start": 244 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 247, - "start": 247 + "start": 245 }, { - "coverage_state": "covered", + "coverage_state": "clean", "end": 248, "start": 248 }, { - "coverage_state": "clean", - "end": 250, + "coverage_state": "covered", + "end": 249, "start": 249 }, { - "coverage_state": "covered", + "coverage_state": "clean", "end": 251, - "start": 251 + "start": 250 }, { - "coverage_state": "clean", - "end": 272, + "coverage_state": "covered", + "end": 252, "start": 252 }, + { + "coverage_state": "clean", + "end": 273, + "start": 253 + }, { "coverage_state": "covered", - "end": 278, - "start": 273 + "end": 279, + "start": 274 }, { "coverage_state": "clean", - "end": 279, - "start": 279 - }, - { - "coverage_state": "covered", - "end": 281, + "end": 280, "start": 280 }, { - "coverage_state": "clean", + "coverage_state": "covered", "end": 282, - "start": 282 + "start": 281 + }, + { + "coverage_state": "clean", + "end": 283, + "start": 283 }, { "coverage_state": "covered", - "end": 288, - "start": 283 + "end": 289, + "start": 284 }, { "coverage_state": "clean", "end": null, - "start": 289 + "start": 290 } ], - "line_coverage": 89.44, + "line_coverage": 89.51, "name": "caching.__init__.py" } ], - "line_coverage": 89.44, + "line_coverage": 89.51, "name": "caching" } ], @@ -529,7 +539,7 @@ "Name": "caching", "State": "Released", "Supported Interpreters": "python3", - "Version": "df0033510331110d2a749ab2e6ec5f9f" + "Version": "5b76bef0032d8f8905a892a334f0f5b8" }, "testrun_list": [ { @@ -550,8 +560,8 @@ "testcases": { "caching.property_cache_json: Test cached data (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.830849, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1847613, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -562,13 +572,13 @@ "message": "caching.property_cache_json: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 830.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.49566841125488, + "relativeCreated": 47.393083572387695, "stack_info": null, "testcaseLogger": [ { @@ -576,8 +586,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,832", - "created": 1726999299.8320267, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.185488, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -590,8 +600,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,831", - "created": 1726999299.8310149, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.184825, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -601,23 +611,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 831.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.66160774230957, + "relativeCreated": 47.45674133300781, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,831", - "created": 1726999299.8311253, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1848829, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -627,34 +637,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": 831.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.7719955444336, + "relativeCreated": 47.51467704772949, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 832.0, + "msecs": 185.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 80.6734561920166, + "relativeCreated": 48.11978340148926, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0009014606475830078 + "time_consumption": 0.0006051063537597656 }, { "args": [], - "asctime": "2024-09-22 12:01:39,832", - "created": 1726999299.8322976, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.1856582, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -665,15 +675,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 832.0, + "msecs": 185.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 80.94429969787598, + "relativeCreated": 48.29001426696777, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -682,8 +692,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-22 12:01:39,832", - "created": 1726999299.8326523, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.1858501, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -700,8 +710,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-22 12:01:39,832", - "created": 1726999299.8324304, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.1857302, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -711,15 +721,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": 832.0, + "msecs": 185.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.07709884643555, + "relativeCreated": 48.362016677856445, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -729,8 +739,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-22 12:01:39,832", - "created": 1726999299.8325212, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.1857796, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -740,41 +750,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": 832.0, + "msecs": 185.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.16793632507324, + "relativeCreated": 48.41136932373047, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 832.0, + "msecs": 185.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.2990665435791, + "relativeCreated": 48.48194122314453, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00013113021850585938 + "time_consumption": 7.05718994140625e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0018033981323242188, - "time_finished": "2024-09-22 12:01:39,832", - "time_start": "2024-09-22 12:01:39,830" + "time_consumption": 0.001088857650756836, + "time_finished": "2024-09-23 07:59:55,185", + "time_start": "2024-09-23 07:59:55,184" }, "caching.property_cache_json: Test cached data (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,832", - "created": 1726999299.832839, + "asctime": "2024-09-23 07:59:55,185", + "created": 1727071195.1859434, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -785,13 +795,13 @@ "message": "caching.property_cache_json: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 832.0, + "msecs": 185.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.48574829101562, + "relativeCreated": 48.57516288757324, "stack_info": null, "testcaseLogger": [ { @@ -799,8 +809,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,833", - "created": 1726999299.8338294, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1866655, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -813,8 +823,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,833", - "created": 1726999299.8330023, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1860027, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -824,23 +834,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 833.0, + "msecs": 186.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.6490650177002, + "relativeCreated": 48.63452911376953, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,833", - "created": 1726999299.833109, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1860597, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -850,34 +860,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": 833.0, + "msecs": 186.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 81.7556381225586, + "relativeCreated": 48.691511154174805, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 833.0, + "msecs": 186.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 82.47613906860352, + "relativeCreated": 49.297332763671875, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0007205009460449219 + "time_consumption": 0.0006058216094970703 }, { "args": [], - "asctime": "2024-09-22 12:01:39,834", - "created": 1726999299.834106, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1868336, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -888,15 +898,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 834.0, + "msecs": 186.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 82.75270462036133, + "relativeCreated": 49.46541786193848, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -905,8 +915,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-22 12:01:39,834", - "created": 1726999299.8344505, + "asctime": "2024-09-23 07:59:55,187", + "created": 1727071195.1870227, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -923,8 +933,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-22 12:01:39,834", - "created": 1726999299.8342357, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1869056, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -934,15 +944,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": 834.0, + "msecs": 186.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 82.88240432739258, + "relativeCreated": 49.53742027282715, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -952,8 +962,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-22 12:01:39,834", - "created": 1726999299.8343287, + "asctime": "2024-09-23 07:59:55,186", + "created": 1727071195.1869566, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -963,41 +973,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": 834.0, + "msecs": 186.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 82.97538757324219, + "relativeCreated": 49.58844184875488, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 834.0, + "msecs": 187.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 83.09721946716309, + "relativeCreated": 49.654483795166016, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00012183189392089844 + "time_consumption": 6.604194641113281e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.001611471176147461, - "time_finished": "2024-09-22 12:01:39,834", - "time_start": "2024-09-22 12:01:39,832" + "time_consumption": 0.0010793209075927734, + "time_finished": "2024-09-23 07:59:55,187", + "time_start": "2024-09-23 07:59:55,185" }, "caching.property_cache_json: Test execution of save callback (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,849", - "created": 1726999299.8492773, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1954594, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1008,19 +1018,19 @@ "message": "caching.property_cache_json: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 849.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 97.92399406433105, + "relativeCreated": 58.091163635253906, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,849", - "created": 1726999299.849504, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1955254, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -1031,15 +1041,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 849.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 98.15073013305664, + "relativeCreated": 58.15720558166504, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -1048,8 +1058,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,850", - "created": 1726999299.850037, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.195777, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1066,8 +1076,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,849", - "created": 1726999299.849862, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1956708, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1077,15 +1087,15 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 849.0, + "msecs": 195.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 98.50883483886719, + "relativeCreated": 58.30264091491699, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -1095,8 +1105,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,849", - "created": 1726999299.849942, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1957276, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1106,41 +1116,41 @@ "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 849.0, + "msecs": 195.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 98.58870506286621, + "relativeCreated": 58.359384536743164, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 850.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 98.68383407592773, + "relativeCreated": 58.40873718261719, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 9.512901306152344e-05 + "time_consumption": 4.935264587402344e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0007598400115966797, - "time_finished": "2024-09-22 12:01:39,850", - "time_start": "2024-09-22 12:01:39,849" + "time_consumption": 0.00031757354736328125, + "time_finished": "2024-09-23 07:59:55,195", + "time_start": "2024-09-23 07:59:55,195" }, "caching.property_cache_json: Test full initialised JSON-Cache-Object": { "args": null, - "asctime": "2024-09-22 12:01:39,825", - "created": 1726999299.8256323, + "asctime": "2024-09-23 07:59:55,181", + "created": 1727071195.1811836, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1151,13 +1161,13 @@ "message": "caching.property_cache_json: Test full initialised JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 825.0, + "msecs": 181.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 74.2790699005127, + "relativeCreated": 43.81537437438965, "stack_info": null, "testcaseLogger": [ { @@ -1165,8 +1175,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,826", - "created": 1726999299.8269844, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1821191, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1179,8 +1189,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,825", - "created": 1726999299.8258805, + "asctime": "2024-09-23 07:59:55,181", + "created": 1727071195.1813195, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1190,23 +1200,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 825.0, + "msecs": 181.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 74.52726364135742, + "relativeCreated": 43.95127296447754, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,826", - "created": 1726999299.8260407, + "asctime": "2024-09-23 07:59:55,181", + "created": 1727071195.1814146, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1216,36 +1226,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": 826.0, + "msecs": 181.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 74.68748092651367, + "relativeCreated": 44.04640197753906, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 826.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 75.63114166259766, + "relativeCreated": 44.75092887878418, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0009436607360839844 + "time_consumption": 0.0007045269012451172 }, { "args": [ "property_cache_json" ], - "asctime": "2024-09-22 12:01:39,827", - "created": 1726999299.8272943, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1823046, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -1260,8 +1270,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-22 12:01:39,827", - "created": 1726999299.8272245, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.182266, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -1271,37 +1281,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": 827.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 75.87122917175293, + "relativeCreated": 44.89779472351074, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 827.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 75.94108581542969, + "relativeCreated": 44.936418533325195, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 6.985664367675781e-05 + "time_consumption": 3.8623809814453125e-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-22 12:01:39,827", - "created": 1726999299.8277056, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1825294, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1318,8 +1328,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-22 12:01:39,827", - "created": 1726999299.8274398, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1823845, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1329,15 +1339,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": 827.0, + "msecs": 182.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.08652114868164, + "relativeCreated": 45.01628875732422, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -1347,8 +1357,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-22 12:01:39,827", - "created": 1726999299.8275366, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1824377, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1358,41 +1368,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": 827.0, + "msecs": 182.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.18331909179688, + "relativeCreated": 45.06945610046387, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 827.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.35235786437988, + "relativeCreated": 45.16124725341797, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001690387725830078 + "time_consumption": 9.179115295410156e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0020732879638671875, - "time_finished": "2024-09-22 12:01:39,827", - "time_start": "2024-09-22 12:01:39,825" + "time_consumption": 0.0013458728790283203, + "time_finished": "2024-09-23 07:59:55,182", + "time_start": "2024-09-23 07:59:55,181" }, "caching.property_cache_json: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,841", - "created": 1726999299.8417025, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.1913915, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1403,13 +1413,13 @@ "message": "caching.property_cache_json: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 841.0, + "msecs": 191.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 90.34919738769531, + "relativeCreated": 54.02326583862305, "stack_info": null, "testcaseLogger": [ { @@ -1417,8 +1427,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,843", - "created": 1726999299.8431456, + "asctime": "2024-09-23 07:59:55,192", + "created": 1727071195.1921148, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1431,8 +1441,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,841", - "created": 1726999299.8419297, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.1914566, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1442,23 +1452,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 841.0, + "msecs": 191.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 90.5764102935791, + "relativeCreated": 54.08835411071777, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,842", - "created": 1726999299.8421047, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.1915162, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1468,37 +1478,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": 842.0, + "msecs": 191.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 90.75140953063965, + "relativeCreated": 54.147958755493164, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 843.0, + "msecs": 192.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 91.79234504699707, + "relativeCreated": 54.74662780761719, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0010409355163574219 + "time_consumption": 0.0005986690521240234 }, { "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-22 12:01:39,844", - "created": 1726999299.8449895, + "asctime": "2024-09-23 07:59:55,192", + "created": 1727071195.192985, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1515,8 +1525,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-22 12:01:39,844", - "created": 1726999299.8445797, + "asctime": "2024-09-23 07:59:55,192", + "created": 1727071195.19286, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1526,15 +1536,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": 844.0, + "msecs": 192.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 93.22643280029297, + "relativeCreated": 55.49168586730957, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -1544,8 +1554,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-22 12:01:39,844", - "created": 1726999299.8447618, + "asctime": "2024-09-23 07:59:55,192", + "created": 1727071195.1929157, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1555,41 +1565,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": 844.0, + "msecs": 192.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 93.40858459472656, + "relativeCreated": 55.547475814819336, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 844.0, + "msecs": 192.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 93.63627433776855, + "relativeCreated": 55.61685562133789, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0002276897430419922 + "time_consumption": 6.937980651855469e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.003287076950073242, - "time_finished": "2024-09-22 12:01:39,844", - "time_start": "2024-09-22 12:01:39,841" + "time_consumption": 0.0015935897827148438, + "time_finished": "2024-09-23 07:59:55,192", + "time_start": "2024-09-23 07:59:55,191" }, "caching.property_cache_json: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,845", - "created": 1726999299.8452923, + "asctime": "2024-09-23 07:59:55,193", + "created": 1727071195.1930807, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1600,13 +1610,13 @@ "message": "caching.property_cache_json: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 845.0, + "msecs": 193.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 93.93906593322754, + "relativeCreated": 55.71246147155762, "stack_info": null, "testcaseLogger": [ { @@ -1614,8 +1624,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,846", - "created": 1726999299.8465333, + "asctime": "2024-09-23 07:59:55,193", + "created": 1727071195.1937945, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1628,8 +1638,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,845", - "created": 1726999299.8454783, + "asctime": "2024-09-23 07:59:55,193", + "created": 1727071195.1931422, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1639,23 +1649,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 845.0, + "msecs": 193.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 94.12503242492676, + "relativeCreated": 55.77397346496582, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,845", - "created": 1726999299.845637, + "asctime": "2024-09-23 07:59:55,193", + "created": 1727071195.1931984, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1665,37 +1675,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": 845.0, + "msecs": 193.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 94.2838191986084, + "relativeCreated": 55.83024024963379, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 846.0, + "msecs": 193.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 95.18003463745117, + "relativeCreated": 56.426286697387695, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0008962154388427734 + "time_consumption": 0.0005960464477539062 }, { "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-22 12:01:39,848", - "created": 1726999299.8489242, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1953635, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1712,8 +1722,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-22 12:01:39,848", - "created": 1726999299.8485436, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1952329, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1723,15 +1733,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": 848.0, + "msecs": 195.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 97.19038009643555, + "relativeCreated": 57.86466598510742, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -1741,8 +1751,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-22 12:01:39,848", - "created": 1726999299.8487282, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1952958, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1752,41 +1762,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": 848.0, + "msecs": 195.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 97.37491607666016, + "relativeCreated": 57.927608489990234, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 848.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 97.57089614868164, + "relativeCreated": 57.99531936645508, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00019598007202148438 + "time_consumption": 6.771087646484375e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0036318302154541016, - "time_finished": "2024-09-22 12:01:39,848", - "time_start": "2024-09-22 12:01:39,845" + "time_consumption": 0.002282857894897461, + "time_finished": "2024-09-23 07:59:55,195", + "time_start": "2024-09-23 07:59:55,193" }, "caching.property_cache_json: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,834", - "created": 1726999299.8346317, + "asctime": "2024-09-23 07:59:55,187", + "created": 1727071195.1871173, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1797,13 +1807,13 @@ "message": "caching.property_cache_json: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 834.0, + "msecs": 187.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 83.27841758728027, + "relativeCreated": 49.749135971069336, "stack_info": null, "testcaseLogger": [ { @@ -1811,8 +1821,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,835", - "created": 1726999299.8356025, + "asctime": "2024-09-23 07:59:55,187", + "created": 1727071195.1878023, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1825,8 +1835,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,834", - "created": 1726999299.8347945, + "asctime": "2024-09-23 07:59:55,187", + "created": 1727071195.1871798, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1836,23 +1846,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 834.0, + "msecs": 187.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 83.44125747680664, + "relativeCreated": 49.811601638793945, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,834", - "created": 1726999299.8348923, + "asctime": "2024-09-23 07:59:55,187", + "created": 1727071195.187236, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1862,37 +1872,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": 834.0, + "msecs": 187.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 83.53900909423828, + "relativeCreated": 49.867868423461914, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 835.0, + "msecs": 187.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 84.24925804138184, + "relativeCreated": 50.434112548828125, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0007102489471435547 + "time_consumption": 0.0005662441253662109 }, { "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-22 12:01:39,836", - "created": 1726999299.836869, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.1886804, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1909,8 +1919,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-22 12:01:39,836", - "created": 1726999299.8366292, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.188558, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1920,15 +1930,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": 836.0, + "msecs": 188.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.27588844299316, + "relativeCreated": 51.18989944458008, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -1938,8 +1948,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-22 12:01:39,836", - "created": 1726999299.8367424, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.188614, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1949,41 +1959,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": 836.0, + "msecs": 188.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.3891372680664, + "relativeCreated": 51.245689392089844, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 836.0, + "msecs": 188.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.51573753356934, + "relativeCreated": 51.31220817565918, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001266002655029297 + "time_consumption": 6.651878356933594e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0022373199462890625, - "time_finished": "2024-09-22 12:01:39,836", - "time_start": "2024-09-22 12:01:39,834" + "time_consumption": 0.0015630722045898438, + "time_finished": "2024-09-23 07:59:55,188", + "time_start": "2024-09-23 07:59:55,187" }, "caching.property_cache_json: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,837", - "created": 1726999299.8370626, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.1887772, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -1994,13 +2004,13 @@ "message": "caching.property_cache_json: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 837.0, + "msecs": 188.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.7093334197998, + "relativeCreated": 51.409006118774414, "stack_info": null, "testcaseLogger": [ { @@ -2008,8 +2018,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,838", - "created": 1726999299.8381765, + "asctime": "2024-09-23 07:59:55,189", + "created": 1727071195.1895015, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2022,8 +2032,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,837", - "created": 1726999299.8372402, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.188838, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2033,23 +2043,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 837.0, + "msecs": 188.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.88695526123047, + "relativeCreated": 51.46980285644531, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,837", - "created": 1726999299.8373528, + "asctime": "2024-09-23 07:59:55,188", + "created": 1727071195.1888943, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2059,37 +2069,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": 837.0, + "msecs": 188.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 85.9994888305664, + "relativeCreated": 51.52606964111328, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 838.0, + "msecs": 189.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 86.8232250213623, + "relativeCreated": 52.13332176208496, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0008237361907958984 + "time_consumption": 0.0006072521209716797 }, { "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-22 12:01:39,841", - "created": 1726999299.841378, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.1912882, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2106,8 +2116,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-22 12:01:39,840", - "created": 1726999299.840947, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.191141, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2117,15 +2127,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": 840.0, + "msecs": 191.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 89.59364891052246, + "relativeCreated": 53.772687911987305, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -2135,8 +2145,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-22 12:01:39,841", - "created": 1726999299.8411405, + "asctime": "2024-09-23 07:59:55,191", + "created": 1727071195.1912153, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2146,41 +2156,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": 841.0, + "msecs": 191.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 89.78724479675293, + "relativeCreated": 53.84707450866699, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 841.0, + "msecs": 191.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 90.02470970153809, + "relativeCreated": 53.92003059387207, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00023746490478515625 + "time_consumption": 7.295608520507812e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.004315376281738281, - "time_finished": "2024-09-22 12:01:39,841", - "time_start": "2024-09-22 12:01:39,837" + "time_consumption": 0.0025110244750976562, + "time_finished": "2024-09-23 07:59:55,191", + "time_start": "2024-09-23 07:59:55,188" }, "caching.property_cache_json: Test internal key usage": { "args": null, - "asctime": "2024-09-22 12:01:39,850", - "created": 1726999299.8503225, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.195871, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2191,13 +2201,13 @@ "message": "caching.property_cache_json: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 850.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 98.9692211151123, + "relativeCreated": 58.502912521362305, "stack_info": null, "testcaseLogger": [ { @@ -2205,8 +2215,8 @@ "property_cache_json", "True" ], - "asctime": "2024-09-22 12:01:39,851", - "created": 1726999299.851764, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.196431, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2219,8 +2229,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,850", - "created": 1726999299.850567, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.195934, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2230,23 +2240,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 850.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 99.21383857727051, + "relativeCreated": 58.56585502624512, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.json" ], - "asctime": "2024-09-22 12:01:39,850", - "created": 1726999299.8507779, + "asctime": "2024-09-23 07:59:55,195", + "created": 1727071195.1959898, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2256,36 +2266,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": 850.0, + "msecs": 195.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 99.42460060119629, + "relativeCreated": 58.62164497375488, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 851.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 100.41069984436035, + "relativeCreated": 59.06271934509277, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0009860992431640625 + "time_consumption": 0.0004410743713378906 }, { "args": [ "property_cache_json" ], - "asctime": "2024-09-22 12:01:39,852", - "created": 1726999299.8525712, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1966026, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -2300,8 +2310,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-22 12:01:39,852", - "created": 1726999299.8524306, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1965666, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -2311,37 +2321,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": 852.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.07731819152832, + "relativeCreated": 59.19837951660156, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 852.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.21798515319824, + "relativeCreated": 59.2343807220459, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00014066696166992188 + "time_consumption": 3.600120544433594e-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-22 12:01:39,852", - "created": 1726999299.8529987, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.19674, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2358,8 +2368,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-22 12:01:39,852", - "created": 1726999299.8527586, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.196661, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2369,15 +2379,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": 852.0, + "msecs": 196.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.40538215637207, + "relativeCreated": 59.29279327392578, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -2387,8 +2397,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-22 12:01:39,852", - "created": 1726999299.8528724, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.196698, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2398,37 +2408,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": 852.0, + "msecs": 196.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.51910781860352, + "relativeCreated": 59.32974815368652, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 852.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.64546966552734, + "relativeCreated": 59.3717098236084, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00012636184692382812 + "time_consumption": 4.1961669921875e-05 }, { "args": [ "5", "" ], - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8532274, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1968448, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2445,8 +2455,8 @@ "5", "" ], - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8531125, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1967883, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2456,15 +2466,15 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 853.0, + "msecs": 196.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.75919532775879, + "relativeCreated": 59.420108795166016, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -2474,8 +2484,8 @@ "5", "" ], - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8531725, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1968172, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2485,41 +2495,41 @@ "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 853.0, + "msecs": 196.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.81927680969238, + "relativeCreated": 59.448957443237305, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 853.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 101.87411308288574, + "relativeCreated": 59.476613998413086, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 5.4836273193359375e-05 + "time_consumption": 2.765655517578125e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0029048919677734375, - "time_finished": "2024-09-22 12:01:39,853", - "time_start": "2024-09-22 12:01:39,850" + "time_consumption": 0.0009737014770507812, + "time_finished": "2024-09-23 07:59:55,196", + "time_start": "2024-09-23 07:59:55,195" }, "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object": { "args": null, - "asctime": "2024-09-22 12:01:39,827", - "created": 1726999299.8279035, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.182638, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2530,13 +2540,13 @@ "message": "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 827.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.55024528503418, + "relativeCreated": 45.26972770690918, "stack_info": null, "testcaseLogger": [ { @@ -2544,8 +2554,8 @@ "property_cache_json", "False" ], - "asctime": "2024-09-22 12:01:39,828", - "created": 1726999299.8284273, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1829443, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2558,8 +2568,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,828", - "created": 1726999299.8280785, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1827037, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2569,23 +2579,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 828.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.72524452209473, + "relativeCreated": 45.33553123474121, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.json" ], - "asctime": "2024-09-22 12:01:39,828", - "created": 1726999299.8281946, + "asctime": "2024-09-23 07:59:55,182", + "created": 1727071195.1827645, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2595,34 +2605,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": 828.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 76.84135437011719, + "relativeCreated": 45.39632797241211, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 828.0, + "msecs": 182.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 77.07405090332031, + "relativeCreated": 45.57609558105469, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.000232696533203125 + "time_consumption": 0.00017976760864257812 }, { "args": [], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8300378, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.184366, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2633,15 +2643,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 830.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 78.68456840515137, + "relativeCreated": 46.997785568237305, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2649,8 +2659,8 @@ "args": [ "property_cache_json" ], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8303387, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.184531, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2665,8 +2675,8 @@ "args": [ "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8302698, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1844904, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2676,37 +2686,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": 830.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 78.91654968261719, + "relativeCreated": 47.12224006652832, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 830.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 78.98545265197754, + "relativeCreated": 47.162771224975586, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 6.890296936035156e-05 + "time_consumption": 4.0531158447265625e-05 }, { "args": [ "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "" ], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8305895, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1846652, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2723,8 +2733,8 @@ "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", "" ], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8304498, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1845906, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2734,15 +2744,15 @@ "lineno": 22, "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", "module": "test", - "msecs": 830.0, + "msecs": 184.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.09655570983887, + "relativeCreated": 47.22237586975098, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -2752,8 +2762,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2024-09-22 12:01:39,830", - "created": 1726999299.8305173, + "asctime": "2024-09-23 07:59:55,184", + "created": 1727071195.1846263, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2763,41 +2773,41 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 830.0, + "msecs": 184.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.16402816772461, + "relativeCreated": 47.25813865661621, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 830.0, + "msecs": 184.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 79.23626899719238, + "relativeCreated": 47.297000885009766, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 7.224082946777344e-05 + "time_consumption": 3.886222839355469e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.002686023712158203, - "time_finished": "2024-09-22 12:01:39,830", - "time_start": "2024-09-22 12:01:39,827" + "time_consumption": 0.002027273178100586, + "time_finished": "2024-09-23 07:59:55,184", + "time_start": "2024-09-23 07:59:55,182" }, "caching.property_cache_pickle: Test cached data (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8566031, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1989448, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -2808,13 +2818,13 @@ "message": "caching.property_cache_pickle: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 856.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 105.24988174438477, + "relativeCreated": 61.57660484313965, "stack_info": null, "testcaseLogger": [ { @@ -2822,8 +2832,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,857", - "created": 1726999299.857356, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1995258, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2836,8 +2846,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.856716, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.199001, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2847,23 +2857,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 856.0, + "msecs": 199.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 105.3626537322998, + "relativeCreated": 61.63287162780762, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8568048, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1990564, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2873,34 +2883,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": 856.0, + "msecs": 199.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 105.45158386230469, + "relativeCreated": 61.68818473815918, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 857.0, + "msecs": 199.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.0028076171875, + "relativeCreated": 62.157630920410156, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0005512237548828125 + "time_consumption": 0.00046944618225097656 }, { "args": [], - "asctime": "2024-09-22 12:01:39,857", - "created": 1726999299.8575716, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1996953, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -2911,15 +2921,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 857.0, + "msecs": 199.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.21833801269531, + "relativeCreated": 62.32714653015137, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2928,8 +2938,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-22 12:01:39,857", - "created": 1726999299.8579214, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.199886, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2946,8 +2956,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-22 12:01:39,857", - "created": 1726999299.8577013, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1997674, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2957,15 +2967,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": 857.0, + "msecs": 199.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.34803771972656, + "relativeCreated": 62.39914894104004, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -2975,8 +2985,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-22 12:01:39,857", - "created": 1726999299.857793, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1998205, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2986,41 +2996,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": 857.0, + "msecs": 199.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.43982887268066, + "relativeCreated": 62.45231628417969, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 857.0, + "msecs": 199.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.5680980682373, + "relativeCreated": 62.51788139343262, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00012826919555664062 + "time_consumption": 6.556510925292969e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.001318216323852539, - "time_finished": "2024-09-22 12:01:39,857", - "time_start": "2024-09-22 12:01:39,856" + "time_consumption": 0.0009412765502929688, + "time_finished": "2024-09-23 07:59:55,199", + "time_start": "2024-09-23 07:59:55,198" }, "caching.property_cache_pickle: Test cached data (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,858", - "created": 1726999299.8581398, + "asctime": "2024-09-23 07:59:55,199", + "created": 1727071195.1999803, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3031,13 +3041,13 @@ "message": "caching.property_cache_pickle: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 858.0, + "msecs": 199.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.78648948669434, + "relativeCreated": 62.612056732177734, "stack_info": null, "testcaseLogger": [ { @@ -3045,8 +3055,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,858", - "created": 1726999299.858887, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.200597, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3059,8 +3069,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,858", - "created": 1726999299.858249, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.2000377, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3070,23 +3080,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 858.0, + "msecs": 200.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.89568519592285, + "relativeCreated": 62.66951560974121, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,858", - "created": 1726999299.8583405, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.2000933, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3096,34 +3106,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": 858.0, + "msecs": 200.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 106.98723793029785, + "relativeCreated": 62.725067138671875, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 858.0, + "msecs": 200.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 107.53369331359863, + "relativeCreated": 63.22884559631348, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0005464553833007812 + "time_consumption": 0.0005037784576416016 }, { "args": [], - "asctime": "2024-09-22 12:01:39,859", - "created": 1726999299.8591032, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.200748, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -3134,15 +3144,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 859.0, + "msecs": 200.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 107.74993896484375, + "relativeCreated": 63.379764556884766, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3151,8 +3161,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-22 12:01:39,859", - "created": 1726999299.8594627, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.200939, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3169,8 +3179,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-22 12:01:39,859", - "created": 1726999299.8592415, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.200822, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3180,15 +3190,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": 859.0, + "msecs": 200.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 107.88822174072266, + "relativeCreated": 63.45391273498535, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -3198,8 +3208,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-22 12:01:39,859", - "created": 1726999299.8593345, + "asctime": "2024-09-23 07:59:55,200", + "created": 1727071195.2008712, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3209,41 +3219,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": 859.0, + "msecs": 200.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 107.98120498657227, + "relativeCreated": 63.50302696228027, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 859.0, + "msecs": 200.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 108.1094741821289, + "relativeCreated": 63.57073783874512, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00012826919555664062 + "time_consumption": 6.771087646484375e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0013229846954345703, - "time_finished": "2024-09-22 12:01:39,859", - "time_start": "2024-09-22 12:01:39,858" + "time_consumption": 0.0009586811065673828, + "time_finished": "2024-09-23 07:59:55,200", + "time_start": "2024-09-23 07:59:55,199" }, "caching.property_cache_pickle: Test execution of save callback (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,868", - "created": 1726999299.86894, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.2070835, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3254,19 +3264,19 @@ "message": "caching.property_cache_pickle: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 868.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.58685111999512, + "relativeCreated": 69.71526145935059, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.8690636, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.2071424, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -3277,15 +3287,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 869.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.71035194396973, + "relativeCreated": 69.77415084838867, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3294,8 +3304,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.869391, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.207363, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3312,8 +3322,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.8692632, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.2072573, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3323,15 +3333,15 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 869.0, + "msecs": 207.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.90990829467773, + "relativeCreated": 69.88906860351562, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -3341,8 +3351,8 @@ "True", "" ], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.8693337, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.207313, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3352,41 +3362,41 @@ "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 869.0, + "msecs": 207.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.9804801940918, + "relativeCreated": 69.94485855102539, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 869.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 118.03770065307617, + "relativeCreated": 69.99468803405762, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 5.7220458984375e-05 + "time_consumption": 4.982948303222656e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0004508495330810547, - "time_finished": "2024-09-22 12:01:39,869", - "time_start": "2024-09-22 12:01:39,868" + "time_consumption": 0.00027942657470703125, + "time_finished": "2024-09-23 07:59:55,207", + "time_start": "2024-09-23 07:59:55,207" }, "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8534203, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.1969397, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3397,13 +3407,13 @@ "message": "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 853.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 102.0669937133789, + "relativeCreated": 59.57150459289551, "stack_info": null, "testcaseLogger": [ { @@ -3411,8 +3421,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,854", - "created": 1726999299.8542874, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1975293, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3425,8 +3435,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8535473, + "asctime": "2024-09-23 07:59:55,196", + "created": 1727071195.196998, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3436,23 +3446,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 853.0, + "msecs": 196.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 102.19407081604004, + "relativeCreated": 59.62967872619629, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,853", - "created": 1726999299.8536735, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1970534, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3462,36 +3472,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": 853.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 102.32019424438477, + "relativeCreated": 59.68523025512695, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 854.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 102.93412208557129, + "relativeCreated": 60.16111373901367, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0006139278411865234 + "time_consumption": 0.00047588348388671875 }, { "args": [ "property_cache_pickle" ], - "asctime": "2024-09-22 12:01:39,854", - "created": 1726999299.8545618, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.197691, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -3506,8 +3516,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-22 12:01:39,854", - "created": 1726999299.8544931, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1976552, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -3517,37 +3527,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": 854.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.13987731933594, + "relativeCreated": 60.2869987487793, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 854.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.20854187011719, + "relativeCreated": 60.32276153564453, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 6.866455078125e-05 + "time_consumption": 3.5762786865234375e-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-22 12:01:39,854", - "created": 1726999299.8549182, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1978738, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3564,8 +3574,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-22 12:01:39,854", - "created": 1726999299.8546965, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1977608, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3575,15 +3585,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": 854.0, + "msecs": 197.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.34324836730957, + "relativeCreated": 60.39261817932129, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -3593,8 +3603,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-22 12:01:39,854", - "created": 1726999299.8547854, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1978068, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3604,41 +3614,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": 854.0, + "msecs": 197.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.43217849731445, + "relativeCreated": 60.43863296508789, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 854.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.56497764587402, + "relativeCreated": 60.50562858581543, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001327991485595703 + "time_consumption": 6.699562072753906e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0014979839324951172, - "time_finished": "2024-09-22 12:01:39,854", - "time_start": "2024-09-22 12:01:39,853" + "time_consumption": 0.0009341239929199219, + "time_finished": "2024-09-23 07:59:55,197", + "time_start": "2024-09-23 07:59:55,196" }, "caching.property_cache_pickle: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,863", - "created": 1726999299.863558, + "asctime": "2024-09-23 07:59:55,204", + "created": 1727071195.2041287, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3649,13 +3659,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 863.0, + "msecs": 204.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 112.20479011535645, + "relativeCreated": 66.76054000854492, "stack_info": null, "testcaseLogger": [ { @@ -3663,8 +3673,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,864", - "created": 1726999299.8643355, + "asctime": "2024-09-23 07:59:55,204", + "created": 1727071195.2047074, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3677,8 +3687,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,863", - "created": 1726999299.8636723, + "asctime": "2024-09-23 07:59:55,204", + "created": 1727071195.2041874, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3688,23 +3698,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 863.0, + "msecs": 204.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 112.3189926147461, + "relativeCreated": 66.8191909790039, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,863", - "created": 1726999299.8637638, + "asctime": "2024-09-23 07:59:55,204", + "created": 1727071195.2042425, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3714,37 +3724,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": 863.0, + "msecs": 204.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 112.4105453491211, + "relativeCreated": 66.87426567077637, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 864.0, + "msecs": 204.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 112.98227310180664, + "relativeCreated": 67.33918190002441, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0005717277526855469 + "time_consumption": 0.0004649162292480469 }, { "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-22 12:01:39,865", - "created": 1726999299.865646, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.2054503, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3761,8 +3771,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-22 12:01:39,865", - "created": 1726999299.8652558, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.205315, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3772,15 +3782,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": 865.0, + "msecs": 205.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 113.90256881713867, + "relativeCreated": 67.9469108581543, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -3790,8 +3800,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-22 12:01:39,865", - "created": 1726999299.8654537, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.2053819, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3801,41 +3811,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": 865.0, + "msecs": 205.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 114.10045623779297, + "relativeCreated": 68.01366806030273, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 865.0, + "msecs": 205.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 114.29262161254883, + "relativeCreated": 68.08209419250488, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00019216537475585938 + "time_consumption": 6.842613220214844e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.002087831497192383, - "time_finished": "2024-09-22 12:01:39,865", - "time_start": "2024-09-22 12:01:39,863" + "time_consumption": 0.001321554183959961, + "time_finished": "2024-09-23 07:59:55,205", + "time_start": "2024-09-23 07:59:55,204" }, "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,866", - "created": 1726999299.8662899, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.205607, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -3846,13 +3856,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 866.0, + "msecs": 205.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 114.93659019470215, + "relativeCreated": 68.23873519897461, "stack_info": null, "testcaseLogger": [ { @@ -3860,8 +3870,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,867", - "created": 1726999299.8674836, + "asctime": "2024-09-23 07:59:55,206", + "created": 1727071195.2061877, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3874,8 +3884,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,866", - "created": 1726999299.8665743, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.205667, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3885,23 +3895,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 866.0, + "msecs": 205.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 115.22102355957031, + "relativeCreated": 68.2988166809082, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,866", - "created": 1726999299.866778, + "asctime": "2024-09-23 07:59:55,205", + "created": 1727071195.2057216, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3911,37 +3921,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": 866.0, + "msecs": 205.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 115.42463302612305, + "relativeCreated": 68.35341453552246, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 867.0, + "msecs": 206.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 116.13035202026367, + "relativeCreated": 68.81952285766602, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.000705718994140625 + "time_consumption": 0.0004661083221435547 }, { "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-22 12:01:39,868", - "created": 1726999299.8687303, + "asctime": "2024-09-23 07:59:55,206", + "created": 1727071195.206988, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3958,8 +3968,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-22 12:01:39,868", - "created": 1726999299.868463, + "asctime": "2024-09-23 07:59:55,206", + "created": 1727071195.2068546, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3969,15 +3979,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": 206.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.10977554321289, + "relativeCreated": 69.48637962341309, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -3987,8 +3997,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-22 12:01:39,868", - "created": 1726999299.868587, + "asctime": "2024-09-23 07:59:55,206", + "created": 1727071195.2069182, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3998,41 +4008,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": 868.0, + "msecs": 206.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.2337532043457, + "relativeCreated": 69.5500373840332, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 868.0, + "msecs": 206.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 117.37704277038574, + "relativeCreated": 69.61989402770996, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00014328956604003906 + "time_consumption": 6.985664367675781e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0024404525756835938, - "time_finished": "2024-09-22 12:01:39,868", - "time_start": "2024-09-22 12:01:39,866" + "time_consumption": 0.0013811588287353516, + "time_finished": "2024-09-23 07:59:55,206", + "time_start": "2024-09-23 07:59:55,205" }, "caching.property_cache_pickle: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2024-09-22 12:01:39,859", - "created": 1726999299.8596387, + "asctime": "2024-09-23 07:59:55,201", + "created": 1727071195.2010322, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4043,13 +4053,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 859.0, + "msecs": 201.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 108.28542709350586, + "relativeCreated": 63.66395950317383, "stack_info": null, "testcaseLogger": [ { @@ -4057,8 +4067,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,860", - "created": 1726999299.8603816, + "asctime": "2024-09-23 07:59:55,201", + "created": 1727071195.2016146, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4071,8 +4081,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,859", - "created": 1726999299.8597474, + "asctime": "2024-09-23 07:59:55,201", + "created": 1727071195.201089, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4082,23 +4092,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 859.0, + "msecs": 201.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 108.39414596557617, + "relativeCreated": 63.720703125, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,859", - "created": 1726999299.8598385, + "asctime": "2024-09-23 07:59:55,201", + "created": 1727071195.201145, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4108,37 +4118,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": 859.0, + "msecs": 201.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 108.48522186279297, + "relativeCreated": 63.77673149108887, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 860.0, + "msecs": 201.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 109.02833938598633, + "relativeCreated": 64.24641609191895, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0005431175231933594 + "time_consumption": 0.0004696846008300781 }, { "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-22 12:01:39,861", - "created": 1726999299.861321, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.202375, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4155,8 +4165,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-22 12:01:39,861", - "created": 1726999299.8610969, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.202233, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4166,15 +4176,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": 861.0, + "msecs": 202.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 109.74359512329102, + "relativeCreated": 64.8648738861084, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -4184,8 +4194,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-22 12:01:39,861", - "created": 1726999299.8611977, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.202307, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4195,41 +4205,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": 861.0, + "msecs": 202.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 109.84444618225098, + "relativeCreated": 64.93878364562988, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 861.0, + "msecs": 202.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 109.96770858764648, + "relativeCreated": 65.00673294067383, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001232624053955078 + "time_consumption": 6.794929504394531e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.001682281494140625, - "time_finished": "2024-09-22 12:01:39,861", - "time_start": "2024-09-22 12:01:39,859" + "time_consumption": 0.0013427734375, + "time_finished": "2024-09-23 07:59:55,202", + "time_start": "2024-09-23 07:59:55,201" }, "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2024-09-22 12:01:39,861", - "created": 1726999299.8614974, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.2024686, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4240,13 +4250,13 @@ "message": "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 861.0, + "msecs": 202.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 110.14413833618164, + "relativeCreated": 65.10043144226074, "stack_info": null, "testcaseLogger": [ { @@ -4254,8 +4264,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,862", - "created": 1726999299.8622346, + "asctime": "2024-09-23 07:59:55,203", + "created": 1727071195.2030509, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4268,8 +4278,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,861", - "created": 1726999299.8616073, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.2025266, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4279,23 +4289,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 861.0, + "msecs": 202.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 110.25404930114746, + "relativeCreated": 65.15836715698242, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,861", - "created": 1726999299.8617005, + "asctime": "2024-09-23 07:59:55,202", + "created": 1727071195.2025805, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4305,37 +4315,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": 861.0, + "msecs": 202.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 110.34727096557617, + "relativeCreated": 65.21224975585938, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 862.0, + "msecs": 203.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 110.88132858276367, + "relativeCreated": 65.68264961242676, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0005340576171875 + "time_consumption": 0.0004703998565673828 }, { "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-22 12:01:39,863", - "created": 1726999299.8633728, + "asctime": "2024-09-23 07:59:55,204", + "created": 1727071195.2040315, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4352,8 +4362,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-22 12:01:39,863", - "created": 1726999299.863136, + "asctime": "2024-09-23 07:59:55,203", + "created": 1727071195.2038708, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4363,15 +4373,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": 203.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 111.78278923034668, + "relativeCreated": 66.50257110595703, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -4381,8 +4391,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-22 12:01:39,863", - "created": 1726999299.8632417, + "asctime": "2024-09-23 07:59:55,203", + "created": 1727071195.2039587, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4392,41 +4402,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": 203.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 111.88840866088867, + "relativeCreated": 66.59054756164551, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 863.0, + "msecs": 204.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 112.01953887939453, + "relativeCreated": 66.66326522827148, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00013113021850585938 + "time_consumption": 7.271766662597656e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0018754005432128906, - "time_finished": "2024-09-22 12:01:39,863", - "time_start": "2024-09-22 12:01:39,861" + "time_consumption": 0.0015628337860107422, + "time_finished": "2024-09-23 07:59:55,204", + "time_start": "2024-09-23 07:59:55,202" }, "caching.property_cache_pickle: Test internal key usage": { "args": null, - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.8695648, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.2074633, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4437,13 +4447,13 @@ "message": "caching.property_cache_pickle: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 869.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 118.21150779724121, + "relativeCreated": 70.09506225585938, "stack_info": null, "testcaseLogger": [ { @@ -4451,8 +4461,8 @@ "property_cache_pickle", "True" ], - "asctime": "2024-09-22 12:01:39,870", - "created": 1726999299.8705044, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.207935, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4465,8 +4475,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.8696918, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.207519, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4476,23 +4486,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 869.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 118.33858489990234, + "relativeCreated": 70.15085220336914, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.pkl" ], - "asctime": "2024-09-22 12:01:39,869", - "created": 1726999299.869826, + "asctime": "2024-09-23 07:59:55,207", + "created": 1727071195.2075734, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4502,36 +4512,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": 869.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 118.47281455993652, + "relativeCreated": 70.2052116394043, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 870.0, + "msecs": 207.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 119.15111541748047, + "relativeCreated": 70.56689262390137, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0006783008575439453 + "time_consumption": 0.0003616809844970703 }, { "args": [ "property_cache_pickle" ], - "asctime": "2024-09-22 12:01:39,870", - "created": 1726999299.8709216, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.208099, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -4546,8 +4556,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-22 12:01:39,870", - "created": 1726999299.870809, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.208063, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -4557,37 +4567,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": 870.0, + "msecs": 208.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 119.45581436157227, + "relativeCreated": 70.6946849822998, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 870.0, + "msecs": 208.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 119.5683479309082, + "relativeCreated": 70.73068618774414, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001125335693359375 + "time_consumption": 3.600120544433594e-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-22 12:01:39,871", - "created": 1726999299.8713791, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.2082305, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4604,8 +4614,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-22 12:01:39,871", - "created": 1726999299.8711085, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.2081542, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4615,15 +4625,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": 871.0, + "msecs": 208.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 119.75526809692383, + "relativeCreated": 70.7859992980957, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -4633,8 +4643,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-22 12:01:39,871", - "created": 1726999299.8712373, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.20819, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4644,37 +4654,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": 208.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 119.88401412963867, + "relativeCreated": 70.82176208496094, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 871.0, + "msecs": 208.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 120.0258731842041, + "relativeCreated": 70.8622932434082, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0001418590545654297 + "time_consumption": 4.0531158447265625e-05 }, { "args": [ "5", "" ], - "asctime": "2024-09-22 12:01:39,871", - "created": 1726999299.8717508, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.2083359, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4691,8 +4701,8 @@ "5", "" ], - "asctime": "2024-09-22 12:01:39,871", - "created": 1726999299.8715463, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.2082784, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4702,15 +4712,15 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 871.0, + "msecs": 208.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 120.1930046081543, + "relativeCreated": 70.91021537780762, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -4720,8 +4730,8 @@ "5", "" ], - "asctime": "2024-09-22 12:01:39,871", - "created": 1726999299.8716495, + "asctime": "2024-09-23 07:59:55,208", + "created": 1727071195.208308, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4731,41 +4741,41 @@ "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 871.0, + "msecs": 208.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 120.29623985290527, + "relativeCreated": 70.93977928161621, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 871.0, + "msecs": 208.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 120.39756774902344, + "relativeCreated": 70.9676742553711, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00010132789611816406 + "time_consumption": 2.7894973754882812e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0021860599517822266, - "time_finished": "2024-09-22 12:01:39,871", - "time_start": "2024-09-22 12:01:39,869" + "time_consumption": 0.0008726119995117188, + "time_finished": "2024-09-23 07:59:55,208", + "time_start": "2024-09-23 07:59:55,207" }, "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2024-09-22 12:01:39,855", - "created": 1726999299.8551068, + "asctime": "2024-09-23 07:59:55,197", + "created": 1727071195.1979659, "exc_info": null, "exc_text": null, "filename": "__init__.py", @@ -4776,13 +4786,13 @@ "message": "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 855.0, + "msecs": 197.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.75356674194336, + "relativeCreated": 60.59765815734863, "stack_info": null, "testcaseLogger": [ { @@ -4790,8 +4800,8 @@ "property_cache_pickle", "False" ], - "asctime": "2024-09-22 12:01:39,855", - "created": 1726999299.8555126, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1981986, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4804,8 +4814,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2024-09-22 12:01:39,855", - "created": 1726999299.855225, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1980228, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4815,23 +4825,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 855.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.87182235717773, + "relativeCreated": 60.654640197753906, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.pkl" ], - "asctime": "2024-09-22 12:01:39,855", - "created": 1726999299.8553317, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1980777, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4841,34 +4851,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": 855.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 103.97839546203613, + "relativeCreated": 60.709476470947266, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 855.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 104.15935516357422, + "relativeCreated": 60.83035469055176, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.00018095970153808594 + "time_consumption": 0.00012087821960449219 }, { "args": [], - "asctime": "2024-09-22 12:01:39,855", - "created": 1726999299.8559484, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.198564, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4879,15 +4889,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 855.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 104.59518432617188, + "relativeCreated": 61.19585037231445, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -4895,8 +4905,8 @@ "args": [ "property_cache_pickle" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8561795, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.198722, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4909,10 +4919,10 @@ "moduleLogger": [ { "args": [ - "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" + "{'unicode': 'unicode', 'str': 'string', 'integer': 17}" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.856116, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1986861, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4920,39 +4930,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: {'unicode': 'unicode', 'str': 'string', 'integer': 17}", "module": "test_no_load_on_init", - "msecs": 856.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 104.76279258728027, + "relativeCreated": 61.31792068481445, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 856.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 104.82621192932129, + "relativeCreated": 61.35368347167969, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 6.341934204101562e-05 + "time_consumption": 3.5762786865234375e-05 }, { "args": [ - "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", + "{'unicode': 'unicode', 'str': 'string', 'integer': 17}", "" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8564296, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1988513, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4960,17 +4970,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 {'unicode': 'unicode', 'str': 'string', 'integer': 17} and Type is ).", "module": "test", "moduleLogger": [ { "args": [ "Cache object", - "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", + "{ 'unicode': 'unicode', 'str': 'string', 'integer': 17 }", "" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8562906, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1987789, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4978,17 +4988,17 @@ "levelname": "DEBUG", "levelno": 10, "lineno": 22, - "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", + "message": "Result (Cache object): { 'unicode': 'unicode', 'str': 'string', 'integer': 17 } ()", "module": "test", - "msecs": 856.0, + "msecs": 198.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 104.93731498718262, + "relativeCreated": 61.41066551208496, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" }, { @@ -4998,8 +5008,8 @@ "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2024-09-22 12:01:39,856", - "created": 1726999299.8563578, + "asctime": "2024-09-23 07:59:55,198", + "created": 1727071195.1988134, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -5009,40 +5019,40 @@ "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 856.0, + "msecs": 198.0, "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 105.00454902648926, + "relativeCreated": 61.44523620605469, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread" } ], - "msecs": 856.0, + "msecs": 198.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": 291252, + "process": 308082, "processName": "MainProcess", - "relativeCreated": 105.07631301879883, + "relativeCreated": 61.483144760131836, "stack_info": null, - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 7.176399230957031e-05 + "time_consumption": 3.790855407714844e-05 } ], - "thread": 139667813142592, + "thread": 140535965610048, "threadName": "MainThread", - "time_consumption": 0.0013227462768554688, - "time_finished": "2024-09-22 12:01:39,856", - "time_start": "2024-09-22 12:01:39,855" + "time_consumption": 0.0008854866027832031, + "time_finished": "2024-09-23 07:59:55,198", + "time_start": "2024-09-23 07:59:55,197" } }, "testrun_id": "p3", - "time_consumption": 0.041495323181152344, + "time_consumption": 0.025263071060180664, "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 136daf1..4fb8c19 100644 Binary files a/_testresults_/unittest.pdf and b/_testresults_/unittest.pdf differ