diff --git a/_testresults_/unittest.json b/_testresults_/unittest.json index 22ce87c..cf8529f 100644 --- a/_testresults_/unittest.json +++ b/_testresults_/unittest.json @@ -1,27 +1,17 @@ { "coverage_information": [ { - "branch_coverage": 97.83, + "branch_coverage": 91.3, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching", "files": [ { - "branch_coverage": 97.83, + "branch_coverage": 91.3, "filepath": "/home/dirk/my_repositories/unittest/caching/pylibs/caching/__init__.py", "fragments": [ - { - "coverage_state": "clean", - "end": 3, - "start": 1 - }, - { - "coverage_state": "covered", - "end": 4, - "start": 4 - }, { "coverage_state": "clean", "end": 24, - "start": 5 + "start": 1 }, { "coverage_state": "covered", @@ -35,98 +25,108 @@ }, { "coverage_state": "covered", - "end": 33, + "end": 32, "start": 27 }, { "coverage_state": "clean", - "end": 34, - "start": 34 + "end": 33, + "start": 33 }, { "coverage_state": "covered", - "end": 39, - "start": 35 + "end": 38, + "start": 34 }, { "coverage_state": "clean", + "end": 39, + "start": 39 + }, + { + "coverage_state": "covered", "end": 40, "start": 40 }, { - "coverage_state": "covered", + "coverage_state": "clean", "end": 41, "start": 41 }, { - "coverage_state": "clean", - "end": 42, + "coverage_state": "covered", + "end": 44, "start": 42 }, + { + "coverage_state": "clean", + "end": 46, + "start": 45 + }, { "coverage_state": "covered", - "end": 45, - "start": 43 + "end": 47, + "start": 47 }, { "coverage_state": "clean", - "end": 47, - "start": 46 - }, - { - "coverage_state": "covered", - "end": 48, + "end": 80, "start": 48 }, + { + "coverage_state": "covered", + "end": 86, + "start": 81 + }, { "coverage_state": "clean", - "end": 81, - "start": 49 + "end": 87, + "start": 87 }, { "coverage_state": "covered", - "end": 84, - "start": 82 + "end": 88, + "start": 88 }, { "coverage_state": "clean", - "end": 85, - "start": 85 + "end": 89, + "start": 89 }, { "coverage_state": "covered", - "end": 91, - "start": 86 + "end": 97, + "start": 90 }, { "coverage_state": "clean", - "end": 92, - "start": 92 + "end": 98, + "start": 98 }, { "coverage_state": "covered", - "end": 93, - "start": 93 + "end": 99, + "start": 99 }, { "coverage_state": "clean", - "end": 100, - "start": 94 + "end": 106, + "start": 100 }, { "coverage_state": "covered", - "end": 108, - "start": 101 - }, - { - "coverage_state": "clean", "end": 109, - "start": 109 + "start": 107 + }, + { + "coverage_state": "partially-covered", + "end": 110, + "start": 110 }, { "coverage_state": "covered", "end": 111, - "start": 110 + "start": 111 }, { "coverage_state": "clean", @@ -134,39 +134,24 @@ "start": 112 }, { - "coverage_state": "covered", - "end": 114, + "coverage_state": "uncovered", + "end": 115, "start": 113 }, - { - "coverage_state": "clean", - "end": 115, - "start": 115 - }, { "coverage_state": "covered", - "end": 116, + "end": 118, "start": 116 }, { - "coverage_state": "clean", + "coverage_state": "partially-covered", "end": 119, - "start": 117 - }, - { - "coverage_state": "covered", - "end": 120, - "start": 120 - }, - { - "coverage_state": "clean", - "end": 121, - "start": 121 + "start": 119 }, { "coverage_state": "covered", "end": 124, - "start": 122 + "start": 120 }, { "coverage_state": "clean", @@ -174,7 +159,7 @@ "start": 125 }, { - "coverage_state": "covered", + "coverage_state": "uncovered", "end": 126, "start": 126 }, @@ -185,9 +170,49 @@ }, { "coverage_state": "covered", - "end": 139, + "end": 128, "start": 128 }, + { + "coverage_state": "clean", + "end": 129, + "start": 129 + }, + { + "coverage_state": "covered", + "end": 130, + "start": 130 + }, + { + "coverage_state": "clean", + "end": 131, + "start": 131 + }, + { + "coverage_state": "covered", + "end": 133, + "start": 132 + }, + { + "coverage_state": "clean", + "end": 134, + "start": 134 + }, + { + "coverage_state": "covered", + "end": 135, + "start": 135 + }, + { + "coverage_state": "clean", + "end": 138, + "start": 136 + }, + { + "coverage_state": "covered", + "end": 139, + "start": 139 + }, { "coverage_state": "clean", "end": 140, @@ -195,18 +220,28 @@ }, { "coverage_state": "covered", - "end": 146, + "end": 143, "start": 141 }, { "coverage_state": "clean", - "end": 147, - "start": 147 + "end": 144, + "start": 144 + }, + { + "coverage_state": "covered", + "end": 145, + "start": 145 + }, + { + "coverage_state": "clean", + "end": 146, + "start": 146 }, { "coverage_state": "covered", "end": 149, - "start": 148 + "start": 147 }, { "coverage_state": "clean", @@ -219,131 +254,161 @@ "start": 151 }, { - "coverage_state": "partially-covered", + "coverage_state": "clean", "end": 152, "start": 152 }, { "coverage_state": "covered", - "end": 153, + "end": 161, "start": 153 }, - { - "coverage_state": "clean", - "end": 154, - "start": 154 - }, { "coverage_state": "uncovered", - "end": 155, - "start": 155 - }, - { - "coverage_state": "covered", - "end": 159, - "start": 156 + "end": 163, + "start": 162 }, { "coverage_state": "clean", - "end": 160, - "start": 160 - }, - { - "coverage_state": "covered", - "end": 165, - "start": 161 - }, - { - "coverage_state": "clean", - "end": 166, - "start": 166 - }, - { - "coverage_state": "covered", - "end": 172, - "start": 167 - }, - { - "coverage_state": "clean", - "end": 173, - "start": 173 - }, - { - "coverage_state": "covered", - "end": 176, - "start": 174 - }, - { - "coverage_state": "clean", - "end": 177, - "start": 177 + "end": 164, + "start": 164 }, { "coverage_state": "covered", "end": 178, - "start": 178 + "start": 165 }, { "coverage_state": "clean", - "end": 180, + "end": 179, "start": 179 }, { "coverage_state": "covered", - "end": 181, - "start": 181 + "end": 185, + "start": 180 }, { "coverage_state": "clean", - "end": 218, - "start": 182 + "end": 186, + "start": 186 }, { "coverage_state": "covered", - "end": 219, - "start": 219 + "end": 188, + "start": 187 }, { "coverage_state": "clean", - "end": 220, - "start": 220 + "end": 189, + "start": 189 }, { "coverage_state": "covered", - "end": 226, - "start": 221 + "end": 191, + "start": 190 }, { "coverage_state": "clean", - "end": 227, - "start": 227 + "end": 192, + "start": 192 }, { "coverage_state": "covered", - "end": 229, - "start": 228 + "end": 198, + "start": 193 }, { "coverage_state": "clean", - "end": 230, - "start": 230 + "end": 199, + "start": 199 }, { "coverage_state": "covered", - "end": 236, - "start": 231 + "end": 205, + "start": 200 + }, + { + "coverage_state": "clean", + "end": 206, + "start": 206 + }, + { + "coverage_state": "covered", + "end": 209, + "start": 207 + }, + { + "coverage_state": "clean", + "end": 210, + "start": 210 + }, + { + "coverage_state": "covered", + "end": 211, + "start": 211 + }, + { + "coverage_state": "clean", + "end": 213, + "start": 212 + }, + { + "coverage_state": "covered", + "end": 214, + "start": 214 + }, + { + "coverage_state": "clean", + "end": 251, + "start": 215 + }, + { + "coverage_state": "covered", + "end": 252, + "start": 252 + }, + { + "coverage_state": "clean", + "end": 253, + "start": 253 + }, + { + "coverage_state": "covered", + "end": 259, + "start": 254 + }, + { + "coverage_state": "clean", + "end": 260, + "start": 260 + }, + { + "coverage_state": "covered", + "end": 262, + "start": 261 + }, + { + "coverage_state": "clean", + "end": 263, + "start": 263 + }, + { + "coverage_state": "covered", + "end": 269, + "start": 264 }, { "coverage_state": "clean", "end": null, - "start": 237 + "start": 270 } ], - "line_coverage": 99.06, + "line_coverage": 95.45, "name": "caching.__init__.py" } ], - "line_coverage": 99.06, + "line_coverage": 95.45, "name": "caching" } ], @@ -375,9 +440,9 @@ "specification": {}, "system_information": { "Architecture": "64bit", - "Distribution": "Ubuntu 22.04 Jammy Jellyfish", + "Distribution": "Debian GNU/Linux 12 bookworm", "Hostname": "ahorn", - "Kernel": "5.15.0-27-lowlatency (#28-Ubuntu SMP PREEMPT Tue Apr 19 15:27:08 UTC 2022)", + "Kernel": "6.1.0-17-amd64 (#1 SMP PREEMPT_DYNAMIC Debian 6.1.69-1 (2023-12-30))", "Machine": "x86_64", "Path": "/home/dirk/my_repositories/unittest/caching", "System": "Linux", @@ -389,12 +454,12 @@ "Name": "caching", "State": "Released", "Supported Interpreters": "python3", - "Version": "ce99f9454c5612dca5c8ea21cc03e83e" + "Version": "624db9f532db2ba202265378292f8af1" }, "testrun_list": [ { "heading_dict": {}, - "interpreter": "python 3.10.4 (final)", + "interpreter": "python 3.11.2 (final)", "name": "Default Testsession name", "number_of_failed_tests": 0, "number_of_possibly_failed_tests": 0, @@ -410,25 +475,25 @@ "testcases": { "caching.property_cache_json: Test cached data (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4012728, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.861257, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 31, + "lineno": 323, "message": "caching.property_cache_json: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 401.2727737426758, + "msecs": 861.0, "msg": "caching.property_cache_json: Test cached data (full init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.10986518859863, + "relativeCreated": 52.17933654785156, "stack_info": null, "testcaseLogger": [ { @@ -436,8 +501,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4017365, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8616097, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -450,8 +515,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4013686, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8613248, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -461,23 +526,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 401.3686180114746, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.20570945739746, + "relativeCreated": 52.247047424316406, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4014413, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8613813, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -487,34 +552,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": 401.4413356781006, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.27842712402344, + "relativeCreated": 52.30355262756348, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 401.7364978790283, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.57358932495117, + "relativeCreated": 52.53195762634277, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0002951622009277344 + "time_consumption": 0.00022840499877929688 }, { "args": [], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4019728, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.861781, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -525,15 +590,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 401.97277069091797, + "msecs": 861.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.80986213684082, + "relativeCreated": 52.703142166137695, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -542,15 +607,15 @@ "{'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": "2022-05-08 20:50:13,402", - "created": 1652035813.4022777, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.86199, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cached data is correct (Content {'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'} and Type is ).", "module": "test", "moduleLogger": [ @@ -560,8 +625,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": "2022-05-08 20:50:13,402", - "created": 1652035813.402089, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.86186, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -571,86 +636,87 @@ "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": 402.08911895751953, + "msecs": 861.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 73.92621040344238, + "relativeCreated": 52.782297134399414, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", "" ], - "asctime": "2022-05-08 20:50:13,402", - "created": 1652035813.402168, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8619146, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 402.16803550720215, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 861.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.005126953125, + "relativeCreated": 52.83689498901367, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 402.27770805358887, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.11479949951172, + "relativeCreated": 52.912235260009766, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010967254638671875 + "time_consumption": 7.534027099609375e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.001004934310913086, - "time_finished": "2022-05-08 20:50:13,402", - "time_start": "2022-05-08 20:50:13,401" + "time_consumption": 0.0007328987121582031, + "time_finished": "2024-09-15 14:31:27,861", + "time_start": "2024-09-15 14:31:27,861" }, "caching.property_cache_json: Test cached data (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,402", - "created": 1652035813.4024405, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862095, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 32, + "lineno": 323, "message": "caching.property_cache_json: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 402.44054794311523, + "msecs": 862.0, "msg": "caching.property_cache_json: Test cached data (partially init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.27763938903809, + "relativeCreated": 53.017377853393555, "stack_info": null, "testcaseLogger": [ { @@ -658,8 +724,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,402", - "created": 1652035813.402903, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862442, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -672,8 +738,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,402", - "created": 1652035813.402537, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.8621604, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -683,23 +749,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 402.53710746765137, + "msecs": 862.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.37419891357422, + "relativeCreated": 53.08270454406738, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,402", - "created": 1652035813.4026127, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862213, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -709,34 +775,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": 402.61268615722656, + "msecs": 862.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.44977760314941, + "relativeCreated": 53.13515663146973, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 402.90307998657227, + "msecs": 862.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.74017143249512, + "relativeCreated": 53.36427688598633, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0002903938293457031 + "time_consumption": 0.00022912025451660156 }, { "args": [], - "asctime": "2022-05-08 20:50:13,403", - "created": 1652035813.4031303, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862602, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -747,15 +813,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 403.13029289245605, + "msecs": 862.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 74.9673843383789, + "relativeCreated": 53.52425575256348, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -764,15 +830,15 @@ "{'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": "2022-05-08 20:50:13,403", - "created": 1652035813.403427, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862803, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cached data is correct (Content {'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'} and Type is ).", "module": "test", "moduleLogger": [ @@ -782,8 +848,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": "2022-05-08 20:50:13,403", - "created": 1652035813.403243, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.8626785, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -793,92 +859,93 @@ "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": 403.2430648803711, + "msecs": 862.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.08015632629395, + "relativeCreated": 53.60078811645508, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", "" ], - "asctime": "2022-05-08 20:50:13,403", - "created": 1652035813.4033194, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.8627317, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 403.3193588256836, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 862.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.15645027160645, + "relativeCreated": 53.65395545959473, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 403.4268856048584, + "msecs": 862.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.26397705078125, + "relativeCreated": 53.725242614746094, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010752677917480469 + "time_consumption": 7.128715515136719e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.000986337661743164, - "time_finished": "2022-05-08 20:50:13,403", - "time_start": "2022-05-08 20:50:13,402" + "time_consumption": 0.0007078647613525391, + "time_finished": "2024-09-15 14:31:27,862", + "time_start": "2024-09-15 14:31:27,862" }, "caching.property_cache_json: Test execution of save callback (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,410", - "created": 1652035813.4105308, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8693867, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 37, + "lineno": 323, "message": "caching.property_cache_json: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 410.53080558776855, + "msecs": 869.0, "msg": "caching.property_cache_json: Test execution of save callback (full init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.3678970336914, + "relativeCreated": 60.30893325805664, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,410", - "created": 1652035813.4106474, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8695095, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -889,15 +956,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 410.6473922729492, + "msecs": 869.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.48448371887207, + "relativeCreated": 60.431718826293945, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -906,15 +973,15 @@ "True", "" ], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4110336, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8698702, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Save callback execution variable is correct (Content True and Type is ).", "module": "test", "moduleLogger": [ @@ -924,8 +991,8 @@ "True", "" ], - "asctime": "2022-05-08 20:50:13,410", - "created": 1652035813.4109046, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8697495, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -935,86 +1002,87 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 410.9046459197998, + "msecs": 869.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.74173736572266, + "relativeCreated": 60.67180633544922, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Save callback execution variable", + "=", "True", "" ], - "asctime": "2022-05-08 20:50:13,410", - "created": 1652035813.4109845, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8698153, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 410.9845161437988, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 869.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.82160758972168, + "relativeCreated": 60.73760986328125, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 411.03363037109375, + "msecs": 869.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.8707218170166, + "relativeCreated": 60.79244613647461, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.9114227294921875e-05 + "time_consumption": 5.4836273193359375e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0005028247833251953, - "time_finished": "2022-05-08 20:50:13,411", - "time_start": "2022-05-08 20:50:13,410" + "time_consumption": 0.00048351287841796875, + "time_finished": "2024-09-15 14:31:27,869", + "time_start": "2024-09-15 14:31:27,869" }, "caching.property_cache_json: Test full initialised JSON-Cache-Object": { "args": null, - "asctime": "2022-05-08 20:50:13,397", - "created": 1652035813.3974512, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8580208, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 29, + "lineno": 323, "message": "caching.property_cache_json: Test full initialised JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 397.45116233825684, + "msecs": 858.0, "msg": "caching.property_cache_json: Test full initialised JSON-Cache-Object", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 69.28825378417969, + "relativeCreated": 48.94304275512695, "stack_info": null, "testcaseLogger": [ { @@ -1022,8 +1090,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3981302, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.858648, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1036,8 +1104,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,397", - "created": 1652035813.3976219, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8581693, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1047,23 +1115,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 397.62187004089355, + "msecs": 858.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 69.4589614868164, + "relativeCreated": 49.09157752990723, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,397", - "created": 1652035813.3977423, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8582685, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1073,52 +1141,52 @@ "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": 397.74227142333984, + "msecs": 858.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 69.5793628692627, + "relativeCreated": 49.19075965881348, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 398.1301784515381, + "msecs": 858.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 69.96726989746094, + "relativeCreated": 49.570322036743164, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0003879070281982422 + "time_consumption": 0.0003795623779296875 }, { "args": [ "property_cache_json" ], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3984208, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8588293, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", "funcName": "load_on_init", "levelname": "DEBUG", "levelno": 10, - "lineno": 24, + "lineno": 21, "message": "Extracting storage object from property_cache_json for comparison.", "module": "test_load_on_init", "moduleLogger": [ { "args": [ - "{'_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id', 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}" + "{'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3983183, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.858788, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -1126,73 +1194,46 @@ "levelname": "INFO", "levelno": 20, "lineno": 20, - "message": "Using storage object of cache class for comparison: {'_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id', 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'}", + "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": 398.3182907104492, + "msecs": 858.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.15538215637207, + "relativeCreated": 49.71027374267578, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3983757, - "exc_info": null, - "exc_text": null, - "filename": "test_load_on_init.py", - "funcName": "load_on_init", - "levelname": "INFO", - "levelno": 20, - "lineno": 21, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_load_on_init", - "msecs": 398.3757495880127, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 70.21284103393555, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 398.4208106994629, + "msecs": 858.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.25790214538574, + "relativeCreated": 49.75152015686035, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.506111145019531e-05 + "time_consumption": 4.124641418457031e-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": "2022-05-08 20:50:13,398", - "created": 1652035813.3987358, + "asctime": "2024-09-15 14:31:27,859", + "created": 1726403487.8590798, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cache object is correct (Content {'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, 'float': 3.14159, 'integer': 17, 'list': [1, 'two', '3', 4], 'str': 'string', 'unicode': 'unicode'} and Type is ).", "module": "test", "moduleLogger": [ @@ -1202,8 +1243,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": "2022-05-08 20:50:13,398", - "created": 1652035813.3985353, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8589203, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1213,86 +1254,87 @@ "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": 398.53525161743164, + "msecs": 858.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.37234306335449, + "relativeCreated": 49.84259605407715, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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 } }", "" ], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3986115, + "asctime": "2024-09-15 14:31:27,858", + "created": 1726403487.8589797, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 398.61154556274414, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 858.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.44863700866699, + "relativeCreated": 49.90196228027344, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 398.73576164245605, + "msecs": 859.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.5728530883789, + "relativeCreated": 50.002098083496094, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00012421607971191406 + "time_consumption": 0.00010013580322265625 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0012845993041992188, - "time_finished": "2022-05-08 20:50:13,398", - "time_start": "2022-05-08 20:50:13,397" + "time_consumption": 0.0010590553283691406, + "time_finished": "2024-09-15 14:31:27,859", + "time_start": "2024-09-15 14:31:27,858" }, "caching.property_cache_json: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,407", - "created": 1652035813.407108, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.8658504, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 35, + "lineno": 323, "message": "caching.property_cache_json: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 407.1080684661865, + "msecs": 865.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 78.94515991210938, + "relativeCreated": 56.772708892822266, "stack_info": null, "testcaseLogger": [ { @@ -1300,8 +1342,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,407", - "created": 1652035813.40755, + "asctime": "2024-09-15 14:31:27,866", + "created": 1726403487.8662002, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1314,8 +1356,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,407", - "created": 1652035813.4072082, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.8659184, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1325,23 +1367,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 407.2082042694092, + "msecs": 865.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 79.04529571533203, + "relativeCreated": 56.84065818786621, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,407", - "created": 1652035813.407282, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.8659725, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1351,44 +1393,44 @@ "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": 407.28211402893066, + "msecs": 865.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 79.11920547485352, + "relativeCreated": 56.894779205322266, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 407.5500965118408, + "msecs": 866.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 79.38718795776367, + "relativeCreated": 57.12246894836426, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00026798248291015625 + "time_consumption": 0.0002276897430419922 }, { "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": "2022-05-08 20:50:13,408", - "created": 1652035813.408251, + "asctime": "2024-09-15 14:31:27,866", + "created": 1726403487.8668396, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after changing uid is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -1398,8 +1440,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": "2022-05-08 20:50:13,408", - "created": 1652035813.4080546, + "asctime": "2024-09-15 14:31:27,866", + "created": 1726403487.866658, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1409,86 +1451,87 @@ "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": 408.0545902252197, + "msecs": 866.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 79.89168167114258, + "relativeCreated": 57.58023262023926, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,408", - "created": 1652035813.4081435, + "asctime": "2024-09-15 14:31:27,866", + "created": 1726403487.866743, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 408.1435203552246, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 866.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 79.98061180114746, + "relativeCreated": 57.665348052978516, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 408.2510471343994, + "msecs": 866.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 80.08813858032227, + "relativeCreated": 57.76190757751465, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010752677917480469 + "time_consumption": 9.655952453613281e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0011429786682128906, - "time_finished": "2022-05-08 20:50:13,408", - "time_start": "2022-05-08 20:50:13,407" + "time_consumption": 0.0009891986846923828, + "time_finished": "2024-09-15 14:31:27,866", + "time_start": "2024-09-15 14:31:27,865" }, "caching.property_cache_json: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,408", - "created": 1652035813.4084096, + "asctime": "2024-09-15 14:31:27,866", + "created": 1726403487.8669605, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 36, + "lineno": 323, "message": "caching.property_cache_json: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 408.40959548950195, + "msecs": 866.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 80.2466869354248, + "relativeCreated": 57.88278579711914, "stack_info": null, "testcaseLogger": [ { @@ -1496,8 +1539,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,408", - "created": 1652035813.4088686, + "asctime": "2024-09-15 14:31:27,867", + "created": 1726403487.8673685, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1510,8 +1553,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,408", - "created": 1652035813.4085076, + "asctime": "2024-09-15 14:31:27,867", + "created": 1726403487.867038, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1521,23 +1564,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 408.5075855255127, + "msecs": 867.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 80.34467697143555, + "relativeCreated": 57.96027183532715, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,408", - "created": 1652035813.4085813, + "asctime": "2024-09-15 14:31:27,867", + "created": 1726403487.8671093, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1547,44 +1590,44 @@ "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": 408.5812568664551, + "msecs": 867.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 80.41834831237793, + "relativeCreated": 58.031558990478516, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 408.86855125427246, + "msecs": 867.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 80.70564270019531, + "relativeCreated": 58.290719985961914, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0002872943878173828 + "time_consumption": 0.00025916099548339844 }, { "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": "2022-05-08 20:50:13,410", - "created": 1652035813.4103694, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8691795, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after changing uid is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -1594,8 +1637,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": "2022-05-08 20:50:13,410", - "created": 1652035813.4101715, + "asctime": "2024-09-15 14:31:27,868", + "created": 1726403487.8689442, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1605,86 +1648,87 @@ "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": 410.1715087890625, + "msecs": 868.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.00860023498535, + "relativeCreated": 59.86642837524414, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,410", - "created": 1652035813.4102597, + "asctime": "2024-09-15 14:31:27,869", + "created": 1726403487.8690543, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 410.2597236633301, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 869.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.09681510925293, + "relativeCreated": 59.97657775878906, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 410.3693962097168, + "msecs": 869.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 82.20648765563965, + "relativeCreated": 60.10174751281738, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010967254638671875 + "time_consumption": 0.0001251697540283203 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0019598007202148438, - "time_finished": "2022-05-08 20:50:13,410", - "time_start": "2022-05-08 20:50:13,408" + "time_consumption": 0.002218961715698242, + "time_finished": "2024-09-15 14:31:27,869", + "time_start": "2024-09-15 14:31:27,866" }, "caching.property_cache_json: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,403", - "created": 1652035813.4037044, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.8629057, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 33, + "lineno": 323, "message": "caching.property_cache_json: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 403.7044048309326, + "msecs": 862.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.54149627685547, + "relativeCreated": 53.82800102233887, "stack_info": null, "testcaseLogger": [ { @@ -1692,8 +1736,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,404", - "created": 1652035813.4041488, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8632543, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1706,8 +1750,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,403", - "created": 1652035813.4038038, + "asctime": "2024-09-15 14:31:27,862", + "created": 1726403487.862972, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1717,23 +1761,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 403.80382537841797, + "msecs": 862.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.64091682434082, + "relativeCreated": 53.8942813873291, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,403", - "created": 1652035813.4038787, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8630264, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1743,44 +1787,44 @@ "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": 403.87868881225586, + "msecs": 863.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.71578025817871, + "relativeCreated": 53.94864082336426, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 404.14881706237793, + "msecs": 863.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 75.98590850830078, + "relativeCreated": 54.17656898498535, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0002701282501220703 + "time_consumption": 0.00022792816162109375 }, { "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": "2022-05-08 20:50:13,404", - "created": 1652035813.4048398, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.863742, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after increasing data_version is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -1790,8 +1834,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": "2022-05-08 20:50:13,404", - "created": 1652035813.4046435, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8636103, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1801,86 +1845,87 @@ "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": 404.6435356140137, + "msecs": 863.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 76.48062705993652, + "relativeCreated": 54.532527923583984, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,404", - "created": 1652035813.404731, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8636694, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 404.73103523254395, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 863.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 76.5681266784668, + "relativeCreated": 54.59165573120117, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 404.83975410461426, + "msecs": 863.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 76.67684555053711, + "relativeCreated": 54.66437339782715, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001087188720703125 + "time_consumption": 7.271766662597656e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0011353492736816406, - "time_finished": "2022-05-08 20:50:13,404", - "time_start": "2022-05-08 20:50:13,403" + "time_consumption": 0.0008363723754882812, + "time_finished": "2024-09-15 14:31:27,863", + "time_start": "2024-09-15 14:31:27,862" }, "caching.property_cache_json: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,404", - "created": 1652035813.404999, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.863844, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 34, + "lineno": 323, "message": "caching.property_cache_json: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 404.9990177154541, + "msecs": 863.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 76.83610916137695, + "relativeCreated": 54.766178131103516, "stack_info": null, "testcaseLogger": [ { @@ -1888,8 +1933,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,405", - "created": 1652035813.4054377, + "asctime": "2024-09-15 14:31:27,864", + "created": 1726403487.8641913, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1902,8 +1947,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,405", - "created": 1652035813.405094, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8639116, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1913,23 +1958,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 405.0939083099365, + "msecs": 863.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 76.93099975585938, + "relativeCreated": 54.83388900756836, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,405", - "created": 1652035813.4051678, + "asctime": "2024-09-15 14:31:27,863", + "created": 1726403487.8639643, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -1939,44 +1984,44 @@ "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": 405.167818069458, + "msecs": 863.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 77.00490951538086, + "relativeCreated": 54.886579513549805, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 405.437707901001, + "msecs": 864.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 77.27479934692383, + "relativeCreated": 55.11355400085449, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00026988983154296875 + "time_consumption": 0.0002269744873046875 }, { "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": "2022-05-08 20:50:13,406", - "created": 1652035813.406947, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.8657439, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after increasing data_version is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -1986,8 +2031,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": "2022-05-08 20:50:13,406", - "created": 1652035813.406748, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.865598, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -1997,86 +2042,87 @@ "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": 406.74805641174316, + "msecs": 865.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 78.58514785766602, + "relativeCreated": 56.52022361755371, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,406", - "created": 1652035813.4068372, + "asctime": "2024-09-15 14:31:27,865", + "created": 1726403487.8656602, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 406.83722496032715, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 865.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 78.67431640625, + "relativeCreated": 56.58245086669922, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 406.94689750671387, + "msecs": 865.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 78.78398895263672, + "relativeCreated": 56.66613578796387, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010967254638671875 + "time_consumption": 8.368492126464844e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0019478797912597656, - "time_finished": "2022-05-08 20:50:13,406", - "time_start": "2022-05-08 20:50:13,404" + "time_consumption": 0.0018999576568603516, + "time_finished": "2024-09-15 14:31:27,865", + "time_start": "2024-09-15 14:31:27,863" }, "caching.property_cache_json: Test internal key usage": { "args": null, - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4111915, + "asctime": "2024-09-15 14:31:27,870", + "created": 1726403487.8700788, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 38, + "lineno": 323, "message": "caching.property_cache_json: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 411.191463470459, + "msecs": 870.0, "msg": "caching.property_cache_json: Test internal key usage", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.02855491638184, + "relativeCreated": 61.00106239318848, "stack_info": null, "testcaseLogger": [ { @@ -2084,8 +2130,8 @@ "property_cache_json", "True" ], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4115572, + "asctime": "2024-09-15 14:31:27,870", + "created": 1726403487.8708, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2098,8 +2144,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.411282, + "asctime": "2024-09-15 14:31:27,870", + "created": 1726403487.870248, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2109,23 +2155,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 411.2820625305176, + "msecs": 870.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.11915397644043, + "relativeCreated": 61.170339584350586, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.json" ], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4113538, + "asctime": "2024-09-15 14:31:27,870", + "created": 1726403487.870406, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2135,52 +2181,52 @@ "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": 411.35382652282715, + "msecs": 870.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.19091796875, + "relativeCreated": 61.32817268371582, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 411.5571975708008, + "msecs": 870.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.39428901672363, + "relativeCreated": 61.7222785949707, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0002033710479736328 + "time_consumption": 0.0003941059112548828 }, { "args": [ "property_cache_json" ], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4118357, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8710992, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", "funcName": "test_internal_keys", "levelname": "DEBUG", "levelno": 10, - "lineno": 24, + "lineno": 21, "message": "Extracting storage object from property_cache_json for comparison.", "module": "test_internal_keys", "moduleLogger": [ { "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', '_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id'}" + "{'__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": "2022-05-08 20:50:13,411", - "created": 1652035813.4117372, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8710265, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -2188,84 +2234,57 @@ "levelname": "INFO", "levelno": 20, "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', '_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id'}", + "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": 411.73720359802246, + "msecs": 871.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.57429504394531, + "relativeCreated": 61.94877624511719, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,411", - "created": 1652035813.4117916, - "exc_info": null, - "exc_text": null, - "filename": "test_internal_keys.py", - "funcName": "test_internal_keys", - "levelname": "INFO", - "levelno": 20, - "lineno": 21, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_internal_keys", - "msecs": 411.7915630340576, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 83.62865447998047, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 411.8356704711914, + "msecs": 871.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.67276191711426, + "relativeCreated": 62.021493911743164, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.410743713378906e-05 + "time_consumption": 7.271766662597656e-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'}", + "{'__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": "2022-05-08 20:50:13,412", - "created": 1652035813.4120429, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8713806, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, - "message": "Cache is correct (Content {'___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'} and Type is ).", + "lineno": 184, + "message": "Cache is correct (Content {'__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'} and Type is ).", "module": "test", "moduleLogger": [ { "args": [ "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' }", + "{ '__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": "2022-05-08 20:50:13,411", - "created": 1652035813.4119227, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.871217, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2273,74 +2292,75 @@ "levelname": "DEBUG", "levelno": 10, "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' } ()", + "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": 411.9226932525635, + "msecs": 871.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.75978469848633, + "relativeCreated": 62.139272689819336, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", + "=", + "{ '_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": "2022-05-08 20:50:13,411", - "created": 1652035813.4119787, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.871293, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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' } ()", + "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": 411.97872161865234, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 871.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.8158130645752, + "relativeCreated": 62.215328216552734, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 412.04285621643066, + "msecs": 871.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.87994766235352, + "relativeCreated": 62.30282783508301, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 6.413459777832031e-05 + "time_consumption": 8.749961853027344e-05 }, { "args": [ "5", "" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4122107, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.871603, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Keyfilter returnvalue for 5 () is correct (Content 5 and Type is ).", "module": "test", "moduleLogger": [ @@ -2350,8 +2370,8 @@ "5", "" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4121187, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8714793, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2361,86 +2381,87 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 412.11867332458496, + "msecs": 871.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 83.95576477050781, + "relativeCreated": 62.401533126831055, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Keyfilter returnvalue for 5 ()", + "=", "5", "" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.412167, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.871542, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 412.1670722961426, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 871.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.00416374206543, + "relativeCreated": 62.464237213134766, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 412.21070289611816, + "msecs": 871.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.04779434204102, + "relativeCreated": 62.525272369384766, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.363059997558594e-05 + "time_consumption": 6.103515625e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0010192394256591797, - "time_finished": "2022-05-08 20:50:13,412", - "time_start": "2022-05-08 20:50:13,411" + "time_consumption": 0.001524209976196289, + "time_finished": "2024-09-15 14:31:27,871", + "time_start": "2024-09-15 14:31:27,870" }, "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object": { "args": null, - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.3988926, + "asctime": "2024-09-15 14:31:27,859", + "created": 1726403487.8592005, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 30, + "lineno": 323, "message": "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 398.8926410675049, + "msecs": 859.0, "msg": "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.72973251342773, + "relativeCreated": 50.122737884521484, "stack_info": null, "testcaseLogger": [ { @@ -2448,8 +2469,8 @@ "property_cache_json", "False" ], - "asctime": "2022-05-08 20:50:13,399", - "created": 1652035813.3992326, + "asctime": "2024-09-15 14:31:27,859", + "created": 1726403487.8594744, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2462,8 +2483,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,398", - "created": 1652035813.398984, + "asctime": "2024-09-15 14:31:27,859", + "created": 1726403487.8592715, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2473,23 +2494,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 398.9839553833008, + "msecs": 859.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.82104682922363, + "relativeCreated": 50.19378662109375, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.json" ], - "asctime": "2022-05-08 20:50:13,399", - "created": 1652035813.3990617, + "asctime": "2024-09-15 14:31:27,859", + "created": 1726403487.8593316, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2499,34 +2520,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": 399.0616798400879, + "msecs": 859.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 70.89877128601074, + "relativeCreated": 50.253868103027344, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 399.2326259613037, + "msecs": 859.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 71.06971740722656, + "relativeCreated": 50.39668083190918, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001709461212158203 + "time_consumption": 0.00014281272888183594 }, { "args": [], - "asctime": "2022-05-08 20:50:13,400", - "created": 1652035813.4006217, + "asctime": "2024-09-15 14:31:27,860", + "created": 1726403487.8608408, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2537,15 +2558,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 400.6216526031494, + "msecs": 860.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.45874404907227, + "relativeCreated": 51.763057708740234, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2553,24 +2574,24 @@ "args": [ "property_cache_json" ], - "asctime": "2022-05-08 20:50:13,400", - "created": 1652035813.400904, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.861004, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", "funcName": "no_load_on_init", "levelname": "DEBUG", "levelno": 10, - "lineno": 27, + "lineno": 24, "message": "Extracting storage object from property_cache_json for comparison.", "module": "test_no_load_on_init", "moduleLogger": [ { "args": [ - "{'_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id', 'integer': 17, 'str': 'string', 'unicode': 'unicode'}" + "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2022-05-08 20:50:13,400", - "created": 1652035813.400802, + "asctime": "2024-09-15 14:31:27,860", + "created": 1726403487.8609605, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -2578,73 +2599,46 @@ "levelname": "INFO", "levelno": 20, "lineno": 23, - "message": "Using storage object of cache class for comparison: {'_property_cache_data_version_': 1, '_property_cache_uid_': 'my_unique_id', 'integer': 17, 'str': 'string', 'unicode': 'unicode'}", + "message": "Using storage object of cache class for comparison: {'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "module": "test_no_load_on_init", - "msecs": 400.8018970489502, + "msecs": 860.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.63898849487305, + "relativeCreated": 51.88274383544922, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,400", - "created": 1652035813.4008586, - "exc_info": null, - "exc_text": null, - "filename": "test_no_load_on_init.py", - "funcName": "no_load_on_init", - "levelname": "INFO", - "levelno": 20, - "lineno": 24, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_no_load_on_init", - "msecs": 400.85864067077637, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 72.69573211669922, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 400.90394020080566, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.74103164672852, + "relativeCreated": 51.926374435424805, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.5299530029296875e-05 + "time_consumption": 4.363059997558594e-05 }, { "args": [ "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "" ], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.4011092, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8611522, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cache object is correct (Content {'integer': 17, 'str': 'string', 'unicode': 'unicode'} and Type is ).", "module": "test", "moduleLogger": [ @@ -2654,8 +2648,8 @@ "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", "" ], - "asctime": "2022-05-08 20:50:13,400", - "created": 1652035813.4009943, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.86107, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2665,86 +2659,87 @@ "lineno": 22, "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", "module": "test", - "msecs": 400.99430084228516, + "msecs": 861.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.83139228820801, + "relativeCreated": 51.992177963256836, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Cache object", + "=", "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2022-05-08 20:50:13,401", - "created": 1652035813.401049, + "asctime": "2024-09-15 14:31:27,861", + "created": 1726403487.8611097, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 401.0488986968994, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 861.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.88599014282227, + "relativeCreated": 52.0319938659668, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 401.1092185974121, + "msecs": 861.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 72.94631004333496, + "relativeCreated": 52.074432373046875, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 6.031990051269531e-05 + "time_consumption": 4.2438507080078125e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0022165775299072266, - "time_finished": "2022-05-08 20:50:13,401", - "time_start": "2022-05-08 20:50:13,398" + "time_consumption": 0.0019516944885253906, + "time_finished": "2024-09-15 14:31:27,861", + "time_start": "2024-09-15 14:31:27,859" }, "caching.property_cache_pickle: Test cached data (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.414666, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8745885, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 44, + "lineno": 323, "message": "caching.property_cache_pickle: Test cached data (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 414.66593742370605, + "msecs": 874.0, "msg": "caching.property_cache_pickle: Test cached data (full init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.5030288696289, + "relativeCreated": 65.51074981689453, "stack_info": null, "testcaseLogger": [ { @@ -2752,8 +2747,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4149873, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.875, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2766,8 +2761,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4147635, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8747017, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2777,23 +2772,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 414.7634506225586, + "msecs": 874.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.60054206848145, + "relativeCreated": 65.62399864196777, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4148364, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8747919, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2803,34 +2798,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": 414.8364067077637, + "msecs": 874.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.67349815368652, + "relativeCreated": 65.71412086486816, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 414.98732566833496, + "msecs": 875.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.82441711425781, + "relativeCreated": 65.92226028442383, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00015091896057128906 + "time_consumption": 0.00020813941955566406 }, { "args": [], - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.4151833, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.8752425, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -2841,15 +2836,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 415.18330574035645, + "msecs": 875.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.0203971862793, + "relativeCreated": 66.16473197937012, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -2858,15 +2853,15 @@ "{'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": "2022-05-08 20:50:13,415", - "created": 1652035813.415475, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.8756156, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cached data is correct (Content {'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'} and Type is ).", "module": "test", "moduleLogger": [ @@ -2876,8 +2871,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": "2022-05-08 20:50:13,415", - "created": 1652035813.4152915, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.8753788, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -2887,86 +2882,87 @@ "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": 415.29154777526855, + "msecs": 875.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.1286392211914, + "relativeCreated": 66.30110740661621, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", "" ], - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.415368, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.8754802, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 415.36808013916016, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 875.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.20517158508301, + "relativeCreated": 66.40243530273438, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 415.47489166259766, + "msecs": 875.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.31198310852051, + "relativeCreated": 66.53785705566406, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001068115234375 + "time_consumption": 0.0001354217529296875 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008089542388916016, - "time_finished": "2022-05-08 20:50:13,415", - "time_start": "2022-05-08 20:50:13,414" + "time_consumption": 0.0010271072387695312, + "time_finished": "2024-09-15 14:31:27,875", + "time_start": "2024-09-15 14:31:27,874" }, "caching.property_cache_pickle: Test cached data (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.4156406, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.875801, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 45, + "lineno": 323, "message": "caching.property_cache_pickle: Test cached data (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 415.64059257507324, + "msecs": 875.0, "msg": "caching.property_cache_pickle: Test cached data (partially init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.4776840209961, + "relativeCreated": 66.72334671020508, "stack_info": null, "testcaseLogger": [ { @@ -2974,8 +2970,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.415961, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.8762777, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2988,8 +2984,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.4157374, + "asctime": "2024-09-15 14:31:27,875", + "created": 1726403487.8759143, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -2999,23 +2995,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 415.7373905181885, + "msecs": 875.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.57448196411133, + "relativeCreated": 66.83659553527832, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/cache_data_test_no_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,415", - "created": 1652035813.415811, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.8760028, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3025,34 +3021,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": 415.81106185913086, + "msecs": 876.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.64815330505371, + "relativeCreated": 66.925048828125, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 415.96102714538574, + "msecs": 876.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.7981185913086, + "relativeCreated": 67.1999454498291, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001499652862548828 + "time_consumption": 0.00027489662170410156 }, { "args": [], - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.4161549, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.8765206, "exc_info": null, "exc_text": null, "filename": "test_cached_data.py", @@ -3063,15 +3059,15 @@ "message": "Collecting data from cache instance.", "module": "test_cached_data", "moduleLogger": [], - "msecs": 416.1548614501953, + "msecs": 876.0, "msg": "Collecting data from cache instance.", "name": "__tLogger__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_cached_data.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 87.99195289611816, + "relativeCreated": 67.4428939819336, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3080,15 +3076,15 @@ "{'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": "2022-05-08 20:50:13,416", - "created": 1652035813.4164464, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.8768954, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cached data is correct (Content {'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'} and Type is ).", "module": "test", "moduleLogger": [ @@ -3098,8 +3094,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": "2022-05-08 20:50:13,416", - "created": 1652035813.4162617, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.876661, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3109,92 +3105,93 @@ "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": 416.2616729736328, + "msecs": 876.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.09876441955566, + "relativeCreated": 67.58332252502441, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", "" ], - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.41634, + "asctime": "2024-09-15 14:31:27,876", + "created": 1726403487.876771, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 416.3401126861572, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 876.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.17720413208008, + "relativeCreated": 67.69323348999023, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 416.4464473724365, + "msecs": 876.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.28353881835938, + "relativeCreated": 67.81768798828125, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010633468627929688 + "time_consumption": 0.00012445449829101562 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008058547973632812, - "time_finished": "2022-05-08 20:50:13,416", - "time_start": "2022-05-08 20:50:13,415" + "time_consumption": 0.0010943412780761719, + "time_finished": "2024-09-15 14:31:27,876", + "time_start": "2024-09-15 14:31:27,875" }, "caching.property_cache_pickle: Test execution of save callback (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.4215307, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8830657, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 50, + "lineno": 323, "message": "caching.property_cache_pickle: Test execution of save callback (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 421.53072357177734, + "msecs": 883.0, "msg": "caching.property_cache_pickle: Test execution of save callback (full init)", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.3678150177002, + "relativeCreated": 73.98796081542969, "stack_info": null, "testcaseLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.4216225, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8831737, "exc_info": null, "exc_text": null, "filename": "test_save_callback.py", @@ -3205,15 +3202,15 @@ "message": "Installing save_callback, which sets a variable to True on execution.", "module": "test_save_callback", "moduleLogger": [], - "msecs": 421.62251472473145, + "msecs": 883.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.4596061706543, + "relativeCreated": 74.0959644317627, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -3222,15 +3219,15 @@ "True", "" ], - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.421903, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8834682, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Save callback execution variable is correct (Content True and Type is ).", "module": "test", "moduleLogger": [ @@ -3240,8 +3237,8 @@ "True", "" ], - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.4217844, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8833377, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3251,86 +3248,87 @@ "lineno": 22, "message": "Result (Save callback execution variable): True ()", "module": "test", - "msecs": 421.7844009399414, + "msecs": 883.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.62149238586426, + "relativeCreated": 74.25999641418457, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Save callback execution variable", + "=", "True", "" ], - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.421857, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.883408, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Save callback execution variable): result = True ()", "module": "test", - "msecs": 421.8571186065674, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 883.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.69421005249023, + "relativeCreated": 74.33032989501953, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 421.9028949737549, + "msecs": 883.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.73998641967773, + "relativeCreated": 74.39041137695312, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.57763671875e-05 + "time_consumption": 6.008148193359375e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00037217140197753906, - "time_finished": "2022-05-08 20:50:13,421", - "time_start": "2022-05-08 20:50:13,421" + "time_consumption": 0.0004024505615234375, + "time_finished": "2024-09-15 14:31:27,883", + "time_start": "2024-09-15 14:31:27,883" }, "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4123614, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8717942, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 42, + "lineno": 323, "message": "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 412.36138343811035, + "msecs": 871.0, "msg": "caching.property_cache_pickle: Test full initialised PICKLE-Cache-Object", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.1984748840332, + "relativeCreated": 62.71648406982422, "stack_info": null, "testcaseLogger": [ { @@ -3338,8 +3336,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4126897, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8722456, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3352,8 +3350,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4124537, + "asctime": "2024-09-15 14:31:27,871", + "created": 1726403487.8719115, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3363,23 +3361,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 412.45365142822266, + "msecs": 871.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.29074287414551, + "relativeCreated": 62.83378601074219, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4125247, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8720114, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3389,52 +3387,52 @@ "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": 412.5247001647949, + "msecs": 872.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.36179161071777, + "relativeCreated": 62.93368339538574, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 412.6896858215332, + "msecs": 872.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.52677726745605, + "relativeCreated": 63.16781044006348, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00016498565673828125 + "time_consumption": 0.00023412704467773438 }, { "args": [ "property_cache_pickle" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4129329, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.872495, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", "funcName": "load_on_init", "levelname": "DEBUG", "levelno": 10, - "lineno": 24, + "lineno": 21, "message": "Extracting storage object from property_cache_pickle for comparison.", "module": "test_load_on_init", "moduleLogger": [ { "args": [ - "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}, '_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1}" + "{'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}}" ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4128377, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8724265, "exc_info": null, "exc_text": null, "filename": "test_load_on_init.py", @@ -3442,73 +3440,46 @@ "levelname": "INFO", "levelno": 20, "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}, '_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1}", + "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": 412.8377437591553, + "msecs": 872.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.67483520507812, + "relativeCreated": 63.34877014160156, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,412", - "created": 1652035813.4128904, - "exc_info": null, - "exc_text": null, - "filename": "test_load_on_init.py", - "funcName": "load_on_init", - "levelname": "INFO", - "levelno": 20, - "lineno": 21, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_load_on_init", - "msecs": 412.8904342651367, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_load_on_init.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 84.72752571105957, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 412.9328727722168, + "msecs": 872.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.76996421813965, + "relativeCreated": 63.41719627380371, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.2438507080078125e-05 + "time_consumption": 6.842613220214844e-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": "2022-05-08 20:50:13,413", - "created": 1652035813.4132166, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8728735, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Cache object is correct (Content {'str': 'string', 'unicode': 'unicode', 'integer': 17, 'float': 3.14159, 'list': [1, 'two', '3', 4], 'dict': {'1': 1, '2': 'two', '3': '3', '4': 4}} and Type is ).", "module": "test", "moduleLogger": [ @@ -3518,8 +3489,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": "2022-05-08 20:50:13,413", - "created": 1652035813.4130394, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8726344, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3529,86 +3500,87 @@ "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": 413.0394458770752, + "msecs": 872.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.87653732299805, + "relativeCreated": 63.556671142578125, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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 } }", "" ], - "asctime": "2022-05-08 20:50:13,413", - "created": 1652035813.4131103, + "asctime": "2024-09-15 14:31:27,872", + "created": 1726403487.8727326, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 413.11025619506836, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 872.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 84.94734764099121, + "relativeCreated": 63.65489959716797, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 413.21659088134766, + "msecs": 872.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.05368232727051, + "relativeCreated": 63.79580497741699, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010633468627929688 + "time_consumption": 0.00014090538024902344 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008552074432373047, - "time_finished": "2022-05-08 20:50:13,413", - "time_start": "2022-05-08 20:50:13,412" + "time_consumption": 0.0010793209075927734, + "time_finished": "2024-09-15 14:31:27,872", + "time_start": "2024-09-15 14:31:27,871" }, "caching.property_cache_pickle: Test get from source caused by changed uid (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,419", - "created": 1652035813.4190993, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.880006, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 48, + "lineno": 323, "message": "caching.property_cache_pickle: Test get from source caused by changed uid (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 419.0993309020996, + "msecs": 880.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 90.93642234802246, + "relativeCreated": 70.92833518981934, "stack_info": null, "testcaseLogger": [ { @@ -3616,8 +3588,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,419", - "created": 1652035813.419419, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.8803945, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3630,8 +3602,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,419", - "created": 1652035813.4191923, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.8801136, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3641,23 +3613,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 419.1923141479492, + "msecs": 880.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.02940559387207, + "relativeCreated": 71.03586196899414, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,419", - "created": 1652035813.4192681, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.8802001, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3667,44 +3639,44 @@ "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": 419.2681312561035, + "msecs": 880.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.10522270202637, + "relativeCreated": 71.12240791320801, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 419.4190502166748, + "msecs": 880.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.25614166259766, + "relativeCreated": 71.31671905517578, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00015091896057128906 + "time_consumption": 0.00019431114196777344 }, { "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": "2022-05-08 20:50:13,419", - "created": 1652035813.4199657, + "asctime": "2024-09-15 14:31:27,881", + "created": 1726403487.8810306, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after changing uid is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -3714,8 +3686,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": "2022-05-08 20:50:13,419", - "created": 1652035813.4197721, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.880801, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3725,86 +3697,87 @@ "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": 419.7721481323242, + "msecs": 880.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.60923957824707, + "relativeCreated": 71.72322273254395, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,419", - "created": 1652035813.419854, + "asctime": "2024-09-15 14:31:27,880", + "created": 1726403487.8809016, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 419.85392570495605, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 880.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.6910171508789, + "relativeCreated": 71.8238353729248, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 419.9657440185547, + "msecs": 881.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.80283546447754, + "relativeCreated": 71.95281982421875, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00011181831359863281 + "time_consumption": 0.0001289844512939453 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008664131164550781, - "time_finished": "2022-05-08 20:50:13,419", - "time_start": "2022-05-08 20:50:13,419" + "time_consumption": 0.001024484634399414, + "time_finished": "2024-09-15 14:31:27,881", + "time_start": "2024-09-15 14:31:27,880" }, "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,420", - "created": 1652035813.420125, + "asctime": "2024-09-15 14:31:27,881", + "created": 1726403487.8812006, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 49, + "lineno": 323, "message": "caching.property_cache_pickle: Test get from source caused by changed uid (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 420.12500762939453, + "msecs": 881.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 91.96209907531738, + "relativeCreated": 72.12281227111816, "stack_info": null, "testcaseLogger": [ { @@ -3812,8 +3785,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,420", - "created": 1652035813.420446, + "asctime": "2024-09-15 14:31:27,881", + "created": 1726403487.8815837, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3826,8 +3799,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,420", - "created": 1652035813.4202309, + "asctime": "2024-09-15 14:31:27,881", + "created": 1726403487.8813074, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3837,23 +3810,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 420.2308654785156, + "msecs": 881.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 92.06795692443848, + "relativeCreated": 72.22962379455566, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/uid_test_no_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,420", - "created": 1652035813.4203005, + "asctime": "2024-09-15 14:31:27,881", + "created": 1726403487.8813899, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -3863,44 +3836,44 @@ "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": 420.3004837036133, + "msecs": 881.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 92.13757514953613, + "relativeCreated": 72.3121166229248, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 420.44591903686523, + "msecs": 881.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 92.28301048278809, + "relativeCreated": 72.50595092773438, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00014543533325195312 + "time_consumption": 0.0001938343048095703 }, { "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": "2022-05-08 20:50:13,421", - "created": 1652035813.421378, + "asctime": "2024-09-15 14:31:27,882", + "created": 1726403487.8828926, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after changing uid is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -3910,8 +3883,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": "2022-05-08 20:50:13,421", - "created": 1652035813.4211924, + "asctime": "2024-09-15 14:31:27,882", + "created": 1726403487.882662, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -3921,86 +3894,87 @@ "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": 421.1924076080322, + "msecs": 882.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.02949905395508, + "relativeCreated": 73.58431816101074, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,421", - "created": 1652035813.4212742, + "asctime": "2024-09-15 14:31:27,882", + "created": 1726403487.8827631, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 421.27418518066406, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 882.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.11127662658691, + "relativeCreated": 73.6854076385498, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 421.37789726257324, + "msecs": 882.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.2149887084961, + "relativeCreated": 73.81486892700195, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010371208190917969 + "time_consumption": 0.00012946128845214844 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.001252889633178711, - "time_finished": "2022-05-08 20:50:13,421", - "time_start": "2022-05-08 20:50:13,420" + "time_consumption": 0.001692056655883789, + "time_finished": "2024-09-15 14:31:27,882", + "time_start": "2024-09-15 14:31:27,881" }, "caching.property_cache_pickle: Test get from source caused by increased data version (full init)": { "args": null, - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.4166024, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.8770747, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 46, + "lineno": 323, "message": "caching.property_cache_pickle: Test get from source caused by increased data version (full init)", "module": "__init__", "moduleLogger": [], - "msecs": 416.60237312316895, + "msecs": 877.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.4394645690918, + "relativeCreated": 67.99697875976562, "stack_info": null, "testcaseLogger": [ { @@ -4008,8 +3982,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.4169288, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.877477, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4022,8 +3996,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.416706, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.877185, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4033,23 +4007,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 416.7060852050781, + "msecs": 877.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.54317665100098, + "relativeCreated": 68.10736656188965, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,416", - "created": 1652035813.4167788, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.8772767, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4059,44 +4033,44 @@ "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": 416.7788028717041, + "msecs": 877.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.61589431762695, + "relativeCreated": 68.19891929626465, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 416.928768157959, + "msecs": 877.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 88.76585960388184, + "relativeCreated": 68.39919090270996, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001499652862548828 + "time_consumption": 0.0002002716064453125 }, { "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": "2022-05-08 20:50:13,417", - "created": 1652035813.4174495, + "asctime": "2024-09-15 14:31:27,878", + "created": 1726403487.8781083, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after increasing data_version is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -4106,8 +4080,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": "2022-05-08 20:50:13,417", - "created": 1652035813.417264, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.8778791, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4117,86 +4091,87 @@ "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": 417.2639846801758, + "msecs": 877.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.10107612609863, + "relativeCreated": 68.8014030456543, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,417", - "created": 1652035813.4173448, + "asctime": "2024-09-15 14:31:27,877", + "created": 1726403487.87798, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 417.3448085784912, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 877.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.18190002441406, + "relativeCreated": 68.90225410461426, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 417.4494743347168, + "msecs": 878.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.28656578063965, + "relativeCreated": 69.0305233001709, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010466575622558594 + "time_consumption": 0.00012826919555664062 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008471012115478516, - "time_finished": "2022-05-08 20:50:13,417", - "time_start": "2022-05-08 20:50:13,416" + "time_consumption": 0.0010335445404052734, + "time_finished": "2024-09-15 14:31:27,878", + "time_start": "2024-09-15 14:31:27,877" }, "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)": { "args": null, - "asctime": "2022-05-08 20:50:13,417", - "created": 1652035813.4176073, + "asctime": "2024-09-15 14:31:27,878", + "created": 1726403487.878284, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 47, + "lineno": 323, "message": "caching.property_cache_pickle: Test get from source caused by increased data version (partially init)", "module": "__init__", "moduleLogger": [], - "msecs": 417.60730743408203, + "msecs": 878.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/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.44439888000488, + "relativeCreated": 69.20623779296875, "stack_info": null, "testcaseLogger": [ { @@ -4204,8 +4179,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,417", - "created": 1652035813.4179385, + "asctime": "2024-09-15 14:31:27,878", + "created": 1726403487.8786767, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4218,8 +4193,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,417", - "created": 1652035813.4177134, + "asctime": "2024-09-15 14:31:27,878", + "created": 1726403487.8783941, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4229,23 +4204,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 417.7134037017822, + "msecs": 878.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.55049514770508, + "relativeCreated": 69.31638717651367, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/data_version_test_no_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,417", - "created": 1652035813.417787, + "asctime": "2024-09-15 14:31:27,878", + "created": 1726403487.8784792, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4255,44 +4230,44 @@ "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": 417.7870750427246, + "msecs": 878.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.62416648864746, + "relativeCreated": 69.40150260925293, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 417.9384708404541, + "msecs": 878.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 89.77556228637695, + "relativeCreated": 69.59891319274902, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001513957977294922 + "time_consumption": 0.00019741058349609375 }, { "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": "2022-05-08 20:50:13,418", - "created": 1652035813.4189403, + "asctime": "2024-09-15 14:31:27,879", + "created": 1726403487.8798356, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Instance data after increasing data_version is correct (Content {'str': '__string__', 'unicode': '__unicode__', 'integer': 34, 'float': 2.71828, 'list': ['one', 2, 3, '4'], 'dict': {'1': '1', '2': 2, '3': 'three', '4': '4'}} and Type is ).", "module": "test", "moduleLogger": [ @@ -4302,8 +4277,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": "2022-05-08 20:50:13,418", - "created": 1652035813.418745, + "asctime": "2024-09-15 14:31:27,879", + "created": 1726403487.879589, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4313,86 +4288,87 @@ "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": 418.7450408935547, + "msecs": 879.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 90.58213233947754, + "relativeCreated": 70.5113410949707, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' } }", "" ], - "asctime": "2022-05-08 20:50:13,418", - "created": 1652035813.4188318, + "asctime": "2024-09-15 14:31:27,879", + "created": 1726403487.8796911, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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": 418.83182525634766, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 879.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 90.66891670227051, + "relativeCreated": 70.61338424682617, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 418.94030570983887, + "msecs": 879.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 90.77739715576172, + "relativeCreated": 70.75786590576172, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00010848045349121094 + "time_consumption": 0.00014448165893554688 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.001332998275756836, - "time_finished": "2022-05-08 20:50:13,418", - "time_start": "2022-05-08 20:50:13,417" + "time_consumption": 0.0015516281127929688, + "time_finished": "2024-09-15 14:31:27,879", + "time_start": "2024-09-15 14:31:27,878" }, "caching.property_cache_pickle: Test internal key usage": { "args": null, - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.422052, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8836343, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 51, + "lineno": 323, "message": "caching.property_cache_pickle: Test internal key usage", "module": "__init__", "moduleLogger": [], - "msecs": 422.05190658569336, + "msecs": 883.0, "msg": "caching.property_cache_pickle: Test internal key usage", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.88899803161621, + "relativeCreated": 74.55658912658691, "stack_info": null, "testcaseLogger": [ { @@ -4400,8 +4376,8 @@ "property_cache_pickle", "True" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4223502, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8840163, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4414,8 +4390,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4221382, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8837402, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4425,23 +4401,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 422.1382141113281, + "msecs": 883.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 93.97530555725098, + "relativeCreated": 74.66244697570801, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/internal_keys_test.pkl" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4222069, + "asctime": "2024-09-15 14:31:27,883", + "created": 1726403487.8838243, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4451,52 +4427,52 @@ "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": 422.2068786621094, + "msecs": 883.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.04397010803223, + "relativeCreated": 74.74660873413086, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 422.3501682281494, + "msecs": 884.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.18725967407227, + "relativeCreated": 74.93853569030762, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.00014328956604003906 + "time_consumption": 0.0001919269561767578 }, { "args": [ "property_cache_pickle" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.422568, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8842309, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", "funcName": "test_internal_keys", "levelname": "DEBUG", "levelno": 10, - "lineno": 24, + "lineno": 21, "message": "Extracting storage object from property_cache_pickle for comparison.", "module": "test_internal_keys", "moduleLogger": [ { "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', '_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1}" + "{'_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": "2022-05-08 20:50:13,422", - "created": 1652035813.422479, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.884169, "exc_info": null, "exc_text": null, "filename": "test_internal_keys.py", @@ -4504,84 +4480,57 @@ "levelname": "INFO", "levelno": 20, "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', '_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1}", + "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": 422.47891426086426, + "msecs": 884.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.31600570678711, + "relativeCreated": 75.09136199951172, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4225273, - "exc_info": null, - "exc_text": null, - "filename": "test_internal_keys.py", - "funcName": "test_internal_keys", - "levelname": "INFO", - "levelno": 20, - "lineno": 21, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_internal_keys", - "msecs": 422.5273132324219, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_internal_keys.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 94.36440467834473, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 422.56808280944824, + "msecs": 884.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.4051742553711, + "relativeCreated": 75.15311241149902, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.076957702636719e-05 + "time_consumption": 6.175041198730469e-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'}", + "{'_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": "2022-05-08 20:50:13,422", - "created": 1652035813.4227796, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8844774, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, - "message": "Cache is correct (Content {'__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'} and Type is ).", + "lineno": 184, + "message": "Cache is correct (Content {'_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'} and Type is ).", "module": "test", "moduleLogger": [ { "args": [ "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' }", + "{ '_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": "2022-05-08 20:50:13,422", - "created": 1652035813.4226615, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.884331, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4589,74 +4538,75 @@ "levelname": "DEBUG", "levelno": 10, "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' } ()", + "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": 422.66154289245605, + "msecs": 884.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.4986343383789, + "relativeCreated": 75.25324821472168, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "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' }", + "=", + "{ '_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": "2022-05-08 20:50:13,422", - "created": 1652035813.4227173, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8844001, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "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' } ()", + "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": 422.7173328399658, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 884.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.55442428588867, + "relativeCreated": 75.32238960266113, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 422.7795600891113, + "msecs": 884.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.61665153503418, + "relativeCreated": 75.39963722229004, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 6.222724914550781e-05 + "time_consumption": 7.724761962890625e-05 }, { "args": [ "5", "" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4229472, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8846805, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, + "lineno": 184, "message": "Keyfilter returnvalue for 5 () is correct (Content 5 and Type is ).", "module": "test", "moduleLogger": [ @@ -4666,8 +4616,8 @@ "5", "" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.4228597, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8845687, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4677,86 +4627,87 @@ "lineno": 22, "message": "Result (Keyfilter returnvalue for 5 ()): 5 ()", "module": "test", - "msecs": 422.85966873168945, + "msecs": 884.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.6967601776123, + "relativeCreated": 75.49095153808594, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Keyfilter returnvalue for 5 ()", + "=", "5", "" ], - "asctime": "2022-05-08 20:50:13,422", - "created": 1652035813.422904, + "asctime": "2024-09-15 14:31:27,884", + "created": 1726403487.8846257, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Keyfilter returnvalue for 5 ()): result = 5 ()", "module": "test", - "msecs": 422.90401458740234, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 884.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.7411060333252, + "relativeCreated": 75.54793357849121, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 422.9471683502197, + "msecs": 884.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 94.78425979614258, + "relativeCreated": 75.60276985168457, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.315376281738281e-05 + "time_consumption": 5.4836273193359375e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0008952617645263672, - "time_finished": "2022-05-08 20:50:13,422", - "time_start": "2022-05-08 20:50:13,422" + "time_consumption": 0.0010461807250976562, + "time_finished": "2024-09-15 14:31:27,884", + "time_start": "2024-09-15 14:31:27,883" }, "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object": { "args": null, - "asctime": "2022-05-08 20:50:13,413", - "created": 1652035813.4133718, + "asctime": "2024-09-15 14:31:27,873", + "created": 1726403487.8730576, "exc_info": null, "exc_text": null, "filename": "__init__.py", - "funcName": "testrun", + "funcName": "testCase", "levelname": "INFO", "levelno": 20, - "lineno": 43, + "lineno": 323, "message": "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object", "module": "__init__", "moduleLogger": [], - "msecs": 413.3718013763428, + "msecs": 873.0, "msg": "caching.property_cache_pickle: Test partially initialised PICKLE-Cache-Object", "name": "__tLogger__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/__init__.py", - "process": 244296, + "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/report/__init__.py", + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.20889282226562, + "relativeCreated": 63.9798641204834, "stack_info": null, "testcaseLogger": [ { @@ -4764,8 +4715,8 @@ "property_cache_pickle", "False" ], - "asctime": "2022-05-08 20:50:13,413", - "created": 1652035813.413667, + "asctime": "2024-09-15 14:31:27,873", + "created": 1726403487.8734276, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4778,8 +4729,8 @@ "moduleLogger": [ { "args": [], - "asctime": "2022-05-08 20:50:13,413", - "created": 1652035813.4134667, + "asctime": "2024-09-15 14:31:27,873", + "created": 1726403487.873173, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4789,23 +4740,23 @@ "lineno": 17, "message": "Deleting cache file from filesystem to ensure identical conditions for each test run.", "module": "test_helpers", - "msecs": 413.4666919708252, + "msecs": 873.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.30378341674805, + "relativeCreated": 64.09525871276855, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "/home/dirk/my_repositories/unittest/caching/unittest/output_data/no_load_on_init.pkl" ], - "asctime": "2022-05-08 20:50:13,413", - "created": 1652035813.4135392, + "asctime": "2024-09-15 14:31:27,873", + "created": 1726403487.8732643, "exc_info": null, "exc_text": null, "filename": "test_helpers.py", @@ -4815,34 +4766,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": 413.53917121887207, + "msecs": 873.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.37626266479492, + "relativeCreated": 64.18657302856445, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 413.6669635772705, + "msecs": 873.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.50405502319336, + "relativeCreated": 64.34988975524902, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.0001277923583984375 + "time_consumption": 0.0001633167266845703 }, { "args": [], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4140403, + "asctime": "2024-09-15 14:31:27,873", + "created": 1726403487.8738995, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4853,15 +4804,15 @@ "message": "Partially initialising cache object by requesting some information.", "module": "test_no_load_on_init", "moduleLogger": [], - "msecs": 414.04032707214355, + "msecs": 873.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 85.8774185180664, + "relativeCreated": 64.82172012329102, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", "time_consumption": 0.0 }, @@ -4869,24 +4820,24 @@ "args": [ "property_cache_pickle" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4142802, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8741326, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", "funcName": "no_load_on_init", "levelname": "DEBUG", "levelno": 10, - "lineno": 27, + "lineno": 24, "message": "Extracting storage object from property_cache_pickle for comparison.", "module": "test_no_load_on_init", "moduleLogger": [ { "args": [ - "{'_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1, 'str': 'string', 'integer': 17, 'unicode': 'unicode'}" + "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4141774, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8740654, "exc_info": null, "exc_text": null, "filename": "test_no_load_on_init.py", @@ -4894,84 +4845,57 @@ "levelname": "INFO", "levelno": 20, "lineno": 23, - "message": "Using storage object of cache class for comparison: {'_property_cache_uid_': 'my_unique_id', '_property_cache_data_version_': 1, 'str': 'string', 'integer': 17, 'unicode': 'unicode'}", + "message": "Using storage object of cache class for comparison: {'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "module": "test_no_load_on_init", - "msecs": 414.17741775512695, + "msecs": 874.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.0145092010498, + "relativeCreated": 64.9876594543457, "stack_info": null, - "thread": 140672522477568, - "threadName": "MainThread" - }, - { - "args": [ - "_property_cache_data_version_", - "_property_cache_uid_" - ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4142358, - "exc_info": null, - "exc_text": null, - "filename": "test_no_load_on_init.py", - "funcName": "no_load_on_init", - "levelname": "INFO", - "levelno": 20, - "lineno": 24, - "message": "Deleting overhead keys: _property_cache_data_version_, _property_cache_uid_", - "module": "test_no_load_on_init", - "msecs": 414.23583030700684, - "msg": "Deleting overhead keys: %s, %s", - "name": "__unittest__", - "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/tests/test_no_load_on_init.py", - "process": 244296, - "processName": "MainProcess", - "relativeCreated": 86.07292175292969, - "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 414.2801761627197, + "msecs": 874.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.11726760864258, + "relativeCreated": 65.05489349365234, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 4.4345855712890625e-05 + "time_consumption": 6.723403930664062e-05 }, { "args": [ - "{'str': 'string', 'integer': 17, 'unicode': 'unicode'}", + "{'integer': 17, 'str': 'string', 'unicode': 'unicode'}", "" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4144878, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8743997, "exc_info": null, "exc_text": null, "filename": "test.py", "funcName": "equivalency_chk", "levelname": "INFO", "levelno": 20, - "lineno": 144, - "message": "Cache object is correct (Content {'str': 'string', 'integer': 17, 'unicode': 'unicode'} and Type is ).", + "lineno": 184, + "message": "Cache object is correct (Content {'integer': 17, 'str': 'string', 'unicode': 'unicode'} and Type is ).", "module": "test", "moduleLogger": [ { "args": [ "Cache object", - "{ 'str': 'string', 'integer': 17, 'unicode': 'unicode' }", + "{ 'integer': 17, 'str': 'string', 'unicode': 'unicode' }", "" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4143696, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8742461, "exc_info": null, "exc_text": null, "filename": "test.py", @@ -4979,70 +4903,71 @@ "levelname": "DEBUG", "levelno": 10, "lineno": 22, - "message": "Result (Cache object): { 'str': 'string', 'integer': 17, 'unicode': 'unicode' } ()", + "message": "Result (Cache object): { 'integer': 17, 'str': 'string', 'unicode': 'unicode' } ()", "module": "test", - "msecs": 414.3695831298828, + "msecs": 874.0, "msg": "Result (%s): %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.20667457580566, + "relativeCreated": 65.16838073730469, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" }, { "args": [ "Cache object", + "=", "{ 'str': 'string', 'unicode': 'unicode', 'integer': 17 }", "" ], - "asctime": "2022-05-08 20:50:13,414", - "created": 1652035813.4144237, + "asctime": "2024-09-15 14:31:27,874", + "created": 1726403487.8743188, "exc_info": null, "exc_text": null, "filename": "test.py", - "funcName": "__report_expectation_equivalency__", + "funcName": "__report_expectation__", "levelname": "DEBUG", "levelno": 10, "lineno": 26, "message": "Expectation (Cache object): result = { 'str': 'string', 'unicode': 'unicode', 'integer': 17 } ()", "module": "test", - "msecs": 414.42370414733887, - "msg": "Expectation (%s): result = %s (%s)", + "msecs": 874.0, + "msg": "Expectation (%s): result %s %s (%s)", "name": "__unittest__", "pathname": "/home/dirk/my_repositories/unittest/caching/unittest/src/unittest/test.py", - "process": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.26079559326172, + "relativeCreated": 65.24109840393066, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread" } ], - "msecs": 414.4878387451172, + "msecs": 874.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": 244296, + "process": 102584, "processName": "MainProcess", - "relativeCreated": 86.32493019104004, + "relativeCreated": 65.3219223022461, "stack_info": null, - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 6.413459777832031e-05 + "time_consumption": 8.082389831542969e-05 } ], - "thread": 140672522477568, + "thread": 139920156860480, "threadName": "MainThread", - "time_consumption": 0.001116037368774414, - "time_finished": "2022-05-08 20:50:13,414", - "time_start": "2022-05-08 20:50:13,413" + "time_consumption": 0.0013420581817626953, + "time_finished": "2024-09-15 14:31:27,874", + "time_start": "2024-09-15 14:31:27,873" } }, "testrun_id": "p3", - "time_consumption": 0.022353410720825195, + "time_consumption": 0.0236968994140625, "uid_list_sorted": [ "caching.property_cache_json: Test full initialised JSON-Cache-Object", "caching.property_cache_json: Test partially initialisation of JSON-Cache-Object", @@ -5068,6 +4993,6 @@ } ], "unittest_information": { - "Version": "e113c3759194c81e7df9e29b1debe00d" + "Version": "6120114abb148e96dd3b8bd41a7af82a" } } \ No newline at end of file diff --git a/_testresults_/unittest.pdf b/_testresults_/unittest.pdf index 43dadf8..fd45628 100644 Binary files a/_testresults_/unittest.pdf and b/_testresults_/unittest.pdf differ