Skip to content

Instantly share code, notes, and snippets.

@bobsilverberg
Created January 7, 2020 19:35
Show Gist options
  • Save bobsilverberg/1914bc9b7039074dd325f20771a80ad3 to your computer and use it in GitHub Desktop.
Save bobsilverberg/1914bc9b7039074dd325f20771a80ad3 to your computer and use it in GitHub Desktop.
22"}, "severity": 200}
{"Timestamp": 1578424948294715904, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=f5ceff4f-dea0-45fc-9313-2861136d0eb5; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:28.292954"}, "severity": 200}
{"Timestamp": 1578424948298687232, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424948445936384, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "f5ceff4f-dea0-45fc-9313-2861136d0eb5", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 0.15262239999719895}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[f5ceff4f-dea0-45fc-9313-2861136d0eb5] succeeded in 0.15262239999719895s: None"}, "severity": 200}
{"Timestamp": 1578424948463024384, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=f5ceff4f-dea0-45fc-9313-2861136d0eb5; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=163; current_dt=2020-01-07 19:22:28.455757"}, "severity": 200}
{"Timestamp": 1578424948465187328, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "ff7aaed8-7252-4d58-a54d-cf8496c2bdab", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 1.1301466000004439}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[ff7aaed8-7252-4d58-a54d-cf8496c2bdab] succeeded in 1.1301466000004439s: None"}, "severity": 200}
{"Timestamp": 1578424948466362880, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=ff7aaed8-7252-4d58-a54d-cf8496c2bdab; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=1130; current_dt=2020-01-07 19:22:28.465628"}, "severity": 200}
{"Timestamp": 1578424948469235456, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=52904966-b72f-4813-9ab9-50e47f80c672; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:28.469112"}, "severity": 200}
{"Timestamp": 1578424948472575488, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424948756913152, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "52904966-b72f-4813-9ab9-50e47f80c672", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.2878008999978192}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[52904966-b72f-4813-9ab9-50e47f80c672] succeeded in 0.2878008999978192s: None"}, "severity": 200}
{"Timestamp": 1578424948782742016, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=52904966-b72f-4813-9ab9-50e47f80c672; name=olympia.addons.tasks.index_addons; run_time=298; current_dt=2020-01-07 19:22:28.767442"}, "severity": 200}
{"Timestamp": 1578424948899321856, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424948936728576, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=b68511d0-b0a4-4405-9001-51607770c716; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:28.936483"}, "severity": 200}
{"Timestamp": 1578424948951706368, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424949102205184, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=66c23f0e-a28c-4a34-9f46-d30f621aeae6; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:29.094228"}, "severity": 200}
{"Timestamp": 1578424949122374656, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424949488549120, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "66c23f0e-a28c-4a34-9f46-d30f621aeae6", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.3959398000006331}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[66c23f0e-a28c-4a34-9f46-d30f621aeae6] succeeded in 0.3959398000006331s: None"}, "severity": 200}
{"Timestamp": 1578424949507423488, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=66c23f0e-a28c-4a34-9f46-d30f621aeae6; name=olympia.addons.tasks.index_addons; run_time=402; current_dt=2020-01-07 19:22:29.496792"}, "severity": 200}
{"Timestamp": 1578424949734052608, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=a48a5a78-3b52-4612-8092-570c3dddc8a3; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:29.731197"}, "severity": 200}
{"Timestamp": 1578424949744129024, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424950093775104, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "a48a5a78-3b52-4612-8092-570c3dddc8a3", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 0.36101439999765716}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[a48a5a78-3b52-4612-8092-570c3dddc8a3] succeeded in 0.36101439999765716s: None"}, "severity": 200}
{"Timestamp": 1578424950117099776, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=a48a5a78-3b52-4612-8092-570c3dddc8a3; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=372; current_dt=2020-01-07 19:22:30.103603"}, "severity": 200}
{"Timestamp": 1578424950120535040, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "b68511d0-b0a4-4405-9001-51607770c716", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 1.1842164000117918}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[b68511d0-b0a4-4405-9001-51607770c716] succeeded in 1.1842164000117918s: None"}, "severity": 200}
{"Timestamp": 1578424950122080768, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=b68511d0-b0a4-4405-9001-51607770c716; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=1185; current_dt=2020-01-07 19:22:30.121136"}, "severity": 200}
{"Timestamp": 1578424950126129152, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=b51133e9-d4e4-437a-a83b-973fa43f20bf; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:30.125892"}, "severity": 200}
{"Timestamp": 1578424950130139904, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424950583649024, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "b51133e9-d4e4-437a-a83b-973fa43f20bf", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.45754059999308083}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[b51133e9-d4e4-437a-a83b-973fa43f20bf] succeeded in 0.45754059999308083s: None"}, "severity": 200}
{"Timestamp": 1578424950606402816, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=b51133e9-d4e4-437a-a83b-973fa43f20bf; name=olympia.addons.tasks.index_addons; run_time=467; current_dt=2020-01-07 19:22:30.592511"}, "severity": 200}
{"Timestamp": 1578424950760332544, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424951056515328, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=f16a0490-917d-4e06-b8a6-cc840b6f6f4a; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:31.052612"}, "severity": 200}
{"Timestamp": 1578424951066465792, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424952579680768, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=d487a4c5-8034-4941-8e32-9646db3ae910; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:32.576871"}, "severity": 200}
{"Timestamp": 1578424952596385792, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424953351674880, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "d487a4c5-8034-4941-8e32-9646db3ae910", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.7758173000038369}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[d487a4c5-8034-4941-8e32-9646db3ae910] succeeded in 0.7758173000038369s: None"}, "severity": 200}
{"Timestamp": 1578424953563433472, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=d487a4c5-8034-4941-8e32-9646db3ae910; name=olympia.addons.tasks.index_addons; run_time=806; current_dt=2020-01-07 19:22:33.382824"}, "severity": 200}
{"Timestamp": 1578424953807910912, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=78bebaf7-c696-4d95-bf93-1e73ea637c5a; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:33.806596"}, "severity": 200}
{"Timestamp": 1578424953815787008, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424955094133504, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "78bebaf7-c696-4d95-bf93-1e73ea637c5a", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 1.2865407000062987}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[78bebaf7-c696-4d95-bf93-1e73ea637c5a] succeeded in 1.2865407000062987s: None"}, "severity": 200}
{"Timestamp": 1578424955113411584, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=78bebaf7-c696-4d95-bf93-1e73ea637c5a; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=1297; current_dt=2020-01-07 19:22:35.103412"}, "severity": 200}
{"Timestamp": 1578424955117464320, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "f16a0490-917d-4e06-b8a6-cc840b6f6f4a", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 4.065255300010904}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[f16a0490-917d-4e06-b8a6-cc840b6f6f4a] succeeded in 4.065255300010904s: None"}, "severity": 200}
{"Timestamp": 1578424955119091200, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=f16a0490-917d-4e06-b8a6-cc840b6f6f4a; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=4066; current_dt=2020-01-07 19:22:35.118436"}, "severity": 200}
{"Timestamp": 1578424955125145600, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=ee83d698-d640-4f00-a1c7-d8b3c5283d00; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:35.124997"}, "severity": 200}
{"Timestamp": 1578424955131078656, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424956292256256, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "ee83d698-d640-4f00-a1c7-d8b3c5283d00", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 1.167353800003184}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[ee83d698-d640-4f00-a1c7-d8b3c5283d00] succeeded in 1.167353800003184s: None"}, "severity": 200}
{"Timestamp": 1578424956521993728, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=ee83d698-d640-4f00-a1c7-d8b3c5283d00; name=olympia.addons.tasks.index_addons; run_time=1290; current_dt=2020-01-07 19:22:36.414980"}, "severity": 200}
{"Timestamp": 1578424957014159872, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424957472584704, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=6eb7bf7b-ff67-4a5d-9b36-a61c124fbe36; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:37.462800"}, "severity": 200}
{"Timestamp": 1578424957553201152, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424958752124928, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=35a38a26-a219-4eae-b562-8dcd9abefd09; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:38.738639"}, "severity": 200}
{"Timestamp": 1578424958771115520, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424960728866816, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "35a38a26-a219-4eae-b562-8dcd9abefd09", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 1.9907042999984697}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[35a38a26-a219-4eae-b562-8dcd9abefd09] succeeded in 1.9907042999984697s: None"}, "severity": 200}
{"Timestamp": 1578424960769912576, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=35a38a26-a219-4eae-b562-8dcd9abefd09; name=olympia.addons.tasks.index_addons; run_time=1998; current_dt=2020-01-07 19:22:40.736727"}, "severity": 200}
{"Timestamp": 1578424960916689152, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=26afd747-b139-4763-b171-24933729cd74; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:40.915412"}, "severity": 200}
{"Timestamp": 1578424960926843904, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424962773194496, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "26afd747-b139-4763-b171-24933729cd74", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 1.857805500010727}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[26afd747-b139-4763-b171-24933729cd74] succeeded in 1.857805500010727s: None"}, "severity": 200}
{"Timestamp": 1578424962800297216, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=26afd747-b139-4763-b171-24933729cd74; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=1867; current_dt=2020-01-07 19:22:42.782082"}, "severity": 200}
{"Timestamp": 1578424962803991040, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "6eb7bf7b-ff67-4a5d-9b36-a61c124fbe36", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 5.341872199991485}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[6eb7bf7b-ff67-4a5d-9b36-a61c124fbe36] succeeded in 5.341872199991485s: None"}, "severity": 200}
{"Timestamp": 1578424962806850816, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=6eb7bf7b-ff67-4a5d-9b36-a61c124fbe36; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=5343; current_dt=2020-01-07 19:22:42.805350"}, "severity": 200}
{"Timestamp": 1578424962813435392, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=d5d1a6e5-83a8-40fb-82ec-7954e2c66db5; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:42.813273"}, "severity": 200}
{"Timestamp": 1578424962817508608, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424963328435200, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "d5d1a6e5-83a8-40fb-82ec-7954e2c66db5", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.5152492999914102}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[d5d1a6e5-83a8-40fb-82ec-7954e2c66db5] succeeded in 0.5152492999914102s: None"}, "severity": 200}
{"Timestamp": 1578424963348489216, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=d5d1a6e5-83a8-40fb-82ec-7954e2c66db5; name=olympia.addons.tasks.index_addons; run_time=520; current_dt=2020-01-07 19:22:43.333424"}, "severity": 200}
{"Timestamp": 1578424963644648704, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424964262526976, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=3423e396-6efa-4bfd-bcd3-b8f05e37f47e; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:44.258989"}, "severity": 200}
{"Timestamp": 1578424964271788288, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424965777511680, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=5491daaa-a2d9-48e6-8e3c-d2996e50fd13; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:45.773950"}, "severity": 200}
{"Timestamp": 1578424965798059776, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424966533050112, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "5491daaa-a2d9-48e6-8e3c-d2996e50fd13", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.7605360000015935}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[5491daaa-a2d9-48e6-8e3c-d2996e50fd13] succeeded in 0.7605360000015935s: None"}, "severity": 200}
{"Timestamp": 1578424966574017792, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=5491daaa-a2d9-48e6-8e3c-d2996e50fd13; name=olympia.addons.tasks.index_addons; run_time=764; current_dt=2020-01-07 19:22:46.537834"}, "severity": 200}
{"Timestamp": 1578424966813062912, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=5a10576f-b5fc-4b03-a3c3-2ae4aebf0c26; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:46.811081"}, "severity": 200}
{"Timestamp": 1578424966822569728, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424967266610176, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "5a10576f-b5fc-4b03-a3c3-2ae4aebf0c26", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 0.45582350000040606}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[5a10576f-b5fc-4b03-a3c3-2ae4aebf0c26] succeeded in 0.45582350000040606s: None"}, "severity": 200}
{"Timestamp": 1578424967289031680, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=5a10576f-b5fc-4b03-a3c3-2ae4aebf0c26; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=469; current_dt=2020-01-07 19:22:47.280781"}, "severity": 200}
{"Timestamp": 1578424967291510272, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "3423e396-6efa-4bfd-bcd3-b8f05e37f47e", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 3.0675929999997607}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[3423e396-6efa-4bfd-bcd3-b8f05e37f47e] succeeded in 3.0675929999997607s: None"}, "severity": 200}
{"Timestamp": 1578424967293253632, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=3423e396-6efa-4bfd-bcd3-b8f05e37f47e; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=3034; current_dt=2020-01-07 19:22:47.292537"}, "severity": 200}
{"Timestamp": 1578424967296829696, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=40377771-1c71-4b3b-aeb9-3549bf0d6814; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:47.296687"}, "severity": 200}
{"Timestamp": 1578424967300444416, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424967960800768, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "40377771-1c71-4b3b-aeb9-3549bf0d6814", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.6641103000001749}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[40377771-1c71-4b3b-aeb9-3549bf0d6814] succeeded in 0.6641103000001749s: None"}, "severity": 200}
{"Timestamp": 1578424967975783936, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=40377771-1c71-4b3b-aeb9-3549bf0d6814; name=olympia.addons.tasks.index_addons; run_time=671; current_dt=2020-01-07 19:22:47.967857"}, "severity": 200}
{"Timestamp": 1578424968092816384, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424968129137920, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=68638948-6348-4d07-a865-3bc5ef1fd10a; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:48.125070"}, "severity": 200}
{"Timestamp": 1578424968140218112, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424968223870976, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=733264ae-70e0-424b-ac3a-00ad7e70ef24; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:48.221882"}, "severity": 200}
{"Timestamp": 1578424968237818112, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424968754815488, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "733264ae-70e0-424b-ac3a-00ad7e70ef24", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.5330334999889601}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[733264ae-70e0-424b-ac3a-00ad7e70ef24] succeeded in 0.5330334999889601s: None"}, "severity": 200}
{"Timestamp": 1578424968769439744, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=733264ae-70e0-424b-ac3a-00ad7e70ef24; name=olympia.addons.tasks.index_addons; run_time=539; current_dt=2020-01-07 19:22:48.760419"}, "severity": 200}
{"Timestamp": 1578424968943855872, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=eb761d66-0e2a-4e07-a8bd-3ba01a84498a; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:48.942242"}, "severity": 200}
{"Timestamp": 1578424968949413120, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424969294495488, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "eb761d66-0e2a-4e07-a8bd-3ba01a84498a", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 0.34950159999425523}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[eb761d66-0e2a-4e07-a8bd-3ba01a84498a] succeeded in 0.34950159999425523s: None"}, "severity": 200}
{"Timestamp": 1578424969342559488, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=eb761d66-0e2a-4e07-a8bd-3ba01a84498a; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=370; current_dt=2020-01-07 19:22:49.312324"}, "severity": 200}
{"Timestamp": 1578424969348878848, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "68638948-6348-4d07-a865-3bc5ef1fd10a", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 1.2237527999968734}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[68638948-6348-4d07-a865-3bc5ef1fd10a] succeeded in 1.2237527999968734s: None"}, "severity": 200}
{"Timestamp": 1578424969351972352, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=68638948-6348-4d07-a865-3bc5ef1fd10a; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=1224; current_dt=2020-01-07 19:22:49.349788"}, "severity": 200}
{"Timestamp": 1578424969360880896, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=e9311f73-c6ff-4ee8-ba6b-fd25fea66bac; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:49.360750"}, "severity": 200}
{"Timestamp": 1578424969366566144, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424969817238784, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "e9311f73-c6ff-4ee8-ba6b-fd25fea66bac", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.45649139999295585}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[e9311f73-c6ff-4ee8-ba6b-fd25fea66bac] succeeded in 0.45649139999295585s: None"}, "severity": 200}
{"Timestamp": 1578424969845497600, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=e9311f73-c6ff-4ee8-ba6b-fd25fea66bac; name=olympia.addons.tasks.index_addons; run_time=468; current_dt=2020-01-07 19:22:49.828098"}, "severity": 200}
{"Timestamp": 1578424970079991808, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@50/m] Updating review denorms."}, "severity": 200}
{"Timestamp": 1578424970250934016, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=b930f6fd-a7b2-4357-8430-c1bd2adcdd17; name=olympia.ratings.tasks.addon_rating_aggregates; current_dt=2020-01-07 19:22:50.246865"}, "severity": 200}
{"Timestamp": 1578424970270405632, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating total reviews and average ratings."}, "severity": 200}
{"Timestamp": 1578424970427089408, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=5f1147da-806a-45cf-a69e-8d7ec8cb99b9; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:50.410597"}, "severity": 200}
{"Timestamp": 1578424970455142912, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424970906173184, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "5f1147da-806a-45cf-a69e-8d7ec8cb99b9", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.4966063000028953}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[5f1147da-806a-45cf-a69e-8d7ec8cb99b9] succeeded in 0.4966063000028953s: None"}, "severity": 200}
{"Timestamp": 1578424970951251712, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=5f1147da-806a-45cf-a69e-8d7ec8cb99b9; name=olympia.addons.tasks.index_addons; run_time=521; current_dt=2020-01-07 19:22:50.931661"}, "severity": 200}
{"Timestamp": 1578424971049858304, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=57288ad8-0d56-4d37-b917-6221e1ccfd87; name=olympia.ratings.tasks.addon_bayesian_rating; current_dt=2020-01-07 19:22:51.046375"}, "severity": 200}
{"Timestamp": 1578424971075374080, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating bayesian ratings."}, "severity": 200}
{"Timestamp": 1578424971172438784, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "57288ad8-0d56-4d37-b917-6221e1ccfd87", "name": "olympia.ratings.tasks.addon_bayesian_rating", "return_value": "None", "runtime": 0.12459819999639876}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_bayesian_rating[57288ad8-0d56-4d37-b917-6221e1ccfd87] succeeded in 0.12459819999639876s: None"}, "severity": 200}
{"Timestamp": 1578424971193251840, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=57288ad8-0d56-4d37-b917-6221e1ccfd87; name=olympia.ratings.tasks.addon_bayesian_rating; run_time=141; current_dt=2020-01-07 19:22:51.187517"}, "severity": 200}
{"Timestamp": 1578424971197045504, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "b930f6fd-a7b2-4357-8430-c1bd2adcdd17", "name": "olympia.ratings.tasks.addon_rating_aggregates", "return_value": "None", "runtime": 0.9509723999944981}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.ratings.tasks.addon_rating_aggregates[b930f6fd-a7b2-4357-8430-c1bd2adcdd17] succeeded in 0.9509723999944981s: None"}, "severity": 200}
{"Timestamp": 1578424971198736128, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=b930f6fd-a7b2-4357-8430-c1bd2adcdd17; name=olympia.ratings.tasks.addon_rating_aggregates; run_time=951; current_dt=2020-01-07 19:22:51.197645"}, "severity": 200}
{"Timestamp": 1578424971208151296, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=8c3a5f10-2c57-403f-85bf-dff84a1d7bb3; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:51.207971"}, "severity": 200}
{"Timestamp": 1578424971214718720, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424971641827584, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "8c3a5f10-2c57-403f-85bf-dff84a1d7bb3", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.4338936999993166}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[8c3a5f10-2c57-403f-85bf-dff84a1d7bb3] succeeded in 0.4338936999993166s: None"}, "severity": 200}
{"Timestamp": 1578424971660997888, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=8c3a5f10-2c57-403f-85bf-dff84a1d7bb3; name=olympia.addons.tasks.index_addons; run_time=441; current_dt=2020-01-07 19:22:51.648592"}, "severity": 200}
{"Timestamp": 1578424971885753344, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon 41 with basket because of addonuser change"}, "severity": 200}
{"Timestamp": 1578424971914053120, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=86417529-0d63-4c17-924e-a6495e20df00; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:22:51.903086"}, "severity": 200}
{"Timestamp": 1578424971949618944, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon 41 with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578424971951305984, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "86417529-0d63-4c17-924e-a6495e20df00", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.04823770000075456}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[86417529-0d63-4c17-924e-a6495e20df00] succeeded in 0.04823770000075456s: None"}, "severity": 200}
{"Timestamp": 1578424971956657664, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=86417529-0d63-4c17-924e-a6495e20df00; name=olympia.amo.tasks.sync_object_to_basket; run_time=51; current_dt=2020-01-07 19:22:51.954761"}, "severity": 200}
{"Timestamp": 1578424972135372800, "Type": "z.users", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Updating 11139.is_public from False to True"}, "severity": 200}
{"Timestamp": 1578424972288462336, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=1ac757b8-3936-40d4-a478-6d94be306b5c; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:52.282094"}, "severity": 200}
{"Timestamp": 1578424972314841600, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424973962659840, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "1ac757b8-3936-40d4-a478-6d94be306b5c", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 1.6806862999947043}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[1ac757b8-3936-40d4-a478-6d94be306b5c] succeeded in 1.6806862999947043s: None"}, "severity": 200}
{"Timestamp": 1578424973980542208, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=1ac757b8-3936-40d4-a478-6d94be306b5c; name=olympia.addons.tasks.index_addons; run_time=1689; current_dt=2020-01-07 19:22:53.971406"}, "severity": 200}
{"Timestamp": 1578424974273447680, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=57fa65e4-e982-466f-9af9-b96295fa7ef4; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:22:54.272240"}, "severity": 200}
{"Timestamp": 1578424974287251200, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 41-41. [1]"}, "severity": 200}
{"Timestamp": 1578424974879860736, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "57fa65e4-e982-466f-9af9-b96295fa7ef4", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 0.6073322000011103}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[57fa65e4-e982-466f-9af9-b96295fa7ef4] succeeded in 0.6073322000011103s: None"}, "severity": 200}
{"Timestamp": 1578424974918019840, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=57fa65e4-e982-466f-9af9-b96295fa7ef4; name=olympia.addons.tasks.index_addons; run_time=618; current_dt=2020-01-07 19:22:54.890406"}, "severity": 200}
{"Timestamp": 1578424976002426112, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=f0b82ec4-84d4-42da-95b5-d7800935c772; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:22:56.001078"}, "severity": 200}
{"Timestamp": 1578424976014760192, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578424977014990080, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "f0b82ec4-84d4-42da-95b5-d7800935c772", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 1.0143742999935057}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[f0b82ec4-84d4-42da-95b5-d7800935c772] succeeded in 1.0143742999935057s: None"}, "severity": 200}
{"Timestamp": 1578424977031641088, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=f0b82ec4-84d4-42da-95b5-d7800935c772; name=olympia.bandwagon.tasks.collection_meta; run_time=1021; current_dt=2020-01-07 19:22:57.022987"}, "severity": 200}
{"Timestamp": 1578424977504251392, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=a127ef52-25f2-49e1-8c80-7e33428d0a40; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:22:57.500465"}, "severity": 200}
{"Timestamp": 1578424977517723392, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578424978209373952, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "a127ef52-25f2-49e1-8c80-7e33428d0a40", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 0.7092456000100356}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[a127ef52-25f2-49e1-8c80-7e33428d0a40] succeeded in 0.7092456000100356s: None"}, "severity": 200}
{"Timestamp": 1578424978226334720, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=a127ef52-25f2-49e1-8c80-7e33428d0a40; name=olympia.bandwagon.tasks.collection_meta; run_time=717; current_dt=2020-01-07 19:22:58.217551"}, "severity": 200}
{"Timestamp": 1578424978332062208, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 27"}, "severity": 400}
{"Timestamp": 1578424978345924864, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=7d8918f8-0f61-4ec4-83ff-ef6acfba58cf; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:22:58.342089"}, "severity": 200}
{"Timestamp": 1578424978363596288, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578424978543325440, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "7d8918f8-0f61-4ec4-83ff-ef6acfba58cf", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 0.20029120000253897}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[7d8918f8-0f61-4ec4-83ff-ef6acfba58cf] succeeded in 0.20029120000253897s: None"}, "severity": 200}
{"Timestamp": 1578424978622126080, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=7d8918f8-0f61-4ec4-83ff-ef6acfba58cf; name=olympia.bandwagon.tasks.collection_meta; run_time=220; current_dt=2020-01-07 19:22:58.562692"}, "severity": 200}
Created addon Ui-Addon for testing successfully
{"Timestamp": 1578424979722675200, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon None with basket because of name change"}, "severity": 200}
{"Timestamp": 1578424979732872960, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=29ab79ba-2131-46ae-91c8-65adff5d0c51; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:22:59.732519"}, "severity": 200}
{"Timestamp": 1578424979757414912, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon None with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578424979758408192, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "29ab79ba-2131-46ae-91c8-65adff5d0c51", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.025757399998838082}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[29ab79ba-2131-46ae-91c8-65adff5d0c51] succeeded in 0.025757399998838082s: None"}, "severity": 200}
{"Timestamp": 1578424979762043392, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=29ab79ba-2131-46ae-91c8-65adff5d0c51; name=olympia.amo.tasks.sync_object_to_basket; run_time=28; current_dt=2020-01-07 19:22:59.760526"}, "severity": 200}
{"Timestamp": 1578424981875015424, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Changing add-on status [42]: 4 => 0 (no listed version with valid file)."}, "severity": 200}
{"Timestamp": 1578424982089323776, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon 42 with basket because of attribute change"}, "severity": 200}
{"Timestamp": 1578424982104445184, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=7160d744-9ddb-4eb5-8b87-f261f21abbba; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:23:02.103454"}, "severity": 200}
{"Timestamp": 1578424982123101696, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon 42 with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578424982125073152, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "7160d744-9ddb-4eb5-8b87-f261f21abbba", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.021722500008763745}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[7160d744-9ddb-4eb5-8b87-f261f21abbba] succeeded in 0.021722500008763745s: None"}, "severity": 200}
{"Timestamp": 1578424982131002368, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=7160d744-9ddb-4eb5-8b87-f261f21abbba; name=olympia.amo.tasks.sync_object_to_basket; run_time=24; current_dt=2020-01-07 19:23:02.127664"}, "severity": 200}
{"Timestamp": 1578424982135916032, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 12"}, "severity": 400}
{"Timestamp": 1578424983405452032, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=e65bd382-1491-4913-a1df-4b27660d598d; name=olympia.addons.tasks.version_changed; current_dt=2020-01-07 19:23:03.400364"}, "severity": 200}
{"Timestamp": 1578424984248718592, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating last updated for 42."}, "severity": 200}
{"Timestamp": 1578424984410274560, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating appsupport for [42]."}, "severity": 200}
{"Timestamp": 1578424985075499008, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "e65bd382-1491-4913-a1df-4b27660d598d", "name": "olympia.addons.tasks.version_changed", "return_value": "None", "runtime": 1.6739249999955064}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.version_changed[e65bd382-1491-4913-a1df-4b27660d598d] succeeded in 1.6739249999955064s: None"}, "severity": 200}
{"Timestamp": 1578424985091638016, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=e65bd382-1491-4913-a1df-4b27660d598d; name=olympia.addons.tasks.version_changed; run_time=1679; current_dt=2020-01-07 19:23:05.079429"}, "severity": 200}
{"Timestamp": 1578424985100172544, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Version changed from current: None to 0.2 for addon 42: Ui-Test Theme"}, "severity": 200}
{"Timestamp": 1578424985661571584, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=e5d32198-d3fb-42aa-8bf1-8b782c9203bb; name=olympia.tags.tasks.update_tag_stat; current_dt=2020-01-07 19:23:05.659598"}, "severity": 200}
{"Timestamp": 1578424985768299008, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@1000/m] Calculating stats for tag 1"}, "severity": 200}
{"Timestamp": 1578424985928729088, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "e5d32198-d3fb-42aa-8bf1-8b782c9203bb", "name": "olympia.tags.tasks.update_tag_stat", "return_value": "None", "runtime": 0.2692989000061061}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.tags.tasks.update_tag_stat[e5d32198-d3fb-42aa-8bf1-8b782c9203bb] succeeded in 0.2692989000061061s: None"}, "severity": 200}
{"Timestamp": 1578424985944283136, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=e5d32198-d3fb-42aa-8bf1-8b782c9203bb; name=olympia.tags.tasks.update_tag_stat; run_time=276; current_dt=2020-01-07 19:23:05.935493"}, "severity": 200}
{"Timestamp": 1578424986008518144, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 25"}, "severity": 400}
{"Timestamp": 1578424986345916672, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=0f9c8872-fa47-4aed-8011-c19b63cf8e96; name=olympia.tags.tasks.update_tag_stat; current_dt=2020-01-07 19:23:06.338594"}, "severity": 200}
{"Timestamp": 1578424986470524928, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@1000/m] Calculating stats for tag 2"}, "severity": 200}
{"Timestamp": 1578424986672979200, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "0f9c8872-fa47-4aed-8011-c19b63cf8e96", "name": "olympia.tags.tasks.update_tag_stat", "return_value": "None", "runtime": 0.33513129998755176}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.tags.tasks.update_tag_stat[0f9c8872-fa47-4aed-8011-c19b63cf8e96] succeeded in 0.33513129998755176s: None"}, "severity": 200}
{"Timestamp": 1578424986689451008, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=0f9c8872-fa47-4aed-8011-c19b63cf8e96; name=olympia.tags.tasks.update_tag_stat; run_time=342; current_dt=2020-01-07 19:23:06.680260"}, "severity": 200}
{"Timestamp": 1578424986752610048, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 25"}, "severity": 400}
{"Timestamp": 1578424986840696320, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=a4be4969-e15c-4194-bb2b-c9c672616736; name=olympia.tags.tasks.update_tag_stat; current_dt=2020-01-07 19:23:06.835979"}, "severity": 200}
{"Timestamp": 1578424987036690944, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@1000/m] Calculating stats for tag 3"}, "severity": 200}
{"Timestamp": 1578424987145726976, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "a4be4969-e15c-4194-bb2b-c9c672616736", "name": "olympia.tags.tasks.update_tag_stat", "return_value": "None", "runtime": 0.30899370000406634}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.tags.tasks.update_tag_stat[a4be4969-e15c-4194-bb2b-c9c672616736] succeeded in 0.30899370000406634s: None"}, "severity": 200}
{"Timestamp": 1578424987162938368, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=a4be4969-e15c-4194-bb2b-c9c672616736; name=olympia.tags.tasks.update_tag_stat; run_time=314; current_dt=2020-01-07 19:23:07.149606"}, "severity": 200}
{"Timestamp": 1578424987198310400, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 25"}, "severity": 400}
{"Timestamp": 1578424987310658560, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=bfaddaad-35e6-460e-8e82-07a885f65897; name=olympia.tags.tasks.update_tag_stat; current_dt=2020-01-07 19:23:07.307615"}, "severity": 200}
{"Timestamp": 1578424987392183296, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@1000/m] Calculating stats for tag 4"}, "severity": 200}
{"Timestamp": 1578424987733577728, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "bfaddaad-35e6-460e-8e82-07a885f65897", "name": "olympia.tags.tasks.update_tag_stat", "return_value": "None", "runtime": 0.4248420000076294}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.tags.tasks.update_tag_stat[bfaddaad-35e6-460e-8e82-07a885f65897] succeeded in 0.4248420000076294s: None"}, "severity": 200}
{"Timestamp": 1578424987776023296, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=bfaddaad-35e6-460e-8e82-07a885f65897; name=olympia.tags.tasks.update_tag_stat; run_time=445; current_dt=2020-01-07 19:23:07.752984"}, "severity": 200}
{"Timestamp": 1578424987852394752, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 25"}, "severity": 400}
{"Timestamp": 1578424988088889600, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=0226a681-51a2-4c98-8c4d-690adeb392ee; name=olympia.tags.tasks.update_tag_stat; current_dt=2020-01-07 19:23:08.084309"}, "severity": 200}
{"Timestamp": 1578424988167160832, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@1000/m] Calculating stats for tag 5"}, "severity": 200}
{"Timestamp": 1578424988358523648, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "0226a681-51a2-4c98-8c4d-690adeb392ee", "name": "olympia.tags.tasks.update_tag_stat", "return_value": "None", "runtime": 0.27412299999559764}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.tags.tasks.update_tag_stat[0226a681-51a2-4c98-8c4d-690adeb392ee] succeeded in 0.27412299999559764s: None"}, "severity": 200}
{"Timestamp": 1578424988375524864, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=0226a681-51a2-4c98-8c4d-690adeb392ee; name=olympia.tags.tasks.update_tag_stat; run_time=279; current_dt=2020-01-07 19:23:08.363858"}, "severity": 200}
{"Timestamp": 1578424988469647360, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 25"}, "severity": 400}
{"Timestamp": 1578424988544766976, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon 42 with basket because of addonuser change"}, "severity": 200}
{"Timestamp": 1578424988561107456, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=5e05fbee-022c-409c-83a4-05e2dd711a8e; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:23:08.555080"}, "severity": 200}
{"Timestamp": 1578424988572785920, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon 42 with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578424988573121536, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "5e05fbee-022c-409c-83a4-05e2dd711a8e", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.02018310000130441}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[5e05fbee-022c-409c-83a4-05e2dd711a8e] succeeded in 0.02018310000130441s: None"}, "severity": 200}
{"Timestamp": 1578424988574610944, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=5e05fbee-022c-409c-83a4-05e2dd711a8e; name=olympia.amo.tasks.sync_object_to_basket; run_time=19; current_dt=2020-01-07 19:23:08.574179"}, "severity": 200}
{"Timestamp": 1578424988669099776, "Type": "z.users", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not changing 11120.is_public from True"}, "severity": 200}
{"Timestamp": 1578424988683542784, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=c10424cd-3ed9-4680-964d-7e6db2cca0c9; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:23:08.679608"}, "severity": 200}
{"Timestamp": 1578424988692171520, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 42-42. [1]"}, "severity": 200}
{"Timestamp": 1578424990738550272, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "c10424cd-3ed9-4680-964d-7e6db2cca0c9", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 2.059577199994237}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[c10424cd-3ed9-4680-964d-7e6db2cca0c9] succeeded in 2.059577199994237s: None"}, "severity": 200}
{"Timestamp": 1578424990751432704, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=c10424cd-3ed9-4680-964d-7e6db2cca0c9; name=olympia.addons.tasks.index_addons; run_time=2065; current_dt=2020-01-07 19:23:10.744336"}, "severity": 200}
{"Timestamp": 1578424991383350272, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=f27da4ce-1581-4c61-a50f-5fa061ebf349; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:23:11.379768"}, "severity": 200}
{"Timestamp": 1578424991397593344, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 42-42. [1]"}, "severity": 200}
{"Timestamp": 1578425233882914048, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "f27da4ce-1581-4c61-a50f-5fa061ebf349", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 242.78251199999067}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[f27da4ce-1581-4c61-a50f-5fa061ebf349] succeeded in 242.78251199999067s: None"}, "severity": 200}
{"Timestamp": 1578425233903316224, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=f27da4ce-1581-4c61-a50f-5fa061ebf349; name=olympia.addons.tasks.index_addons; run_time=242513; current_dt=2020-01-07 19:27:13.892877"}, "severity": 200}
{"Timestamp": 1578425238698003200, "Type": "z.users", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not changing 11120.is_public from True"}, "severity": 200}
{"Timestamp": 1578425260851959808, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=03bde2a6-4111-439d-bfba-c63326918e00; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:27:40.847838"}, "severity": 200}
{"Timestamp": 1578425260862281728, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 42-42. [1]"}, "severity": 200}
{"Timestamp": 1578425263136173312, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "03bde2a6-4111-439d-bfba-c63326918e00", "name": "olympia.addons.tasks.index_addons", "return_value": "None", "runtime": 2.2893621000112034}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.index_addons[03bde2a6-4111-439d-bfba-c63326918e00] succeeded in 2.2893621000112034s: None"}, "severity": 200}
{"Timestamp": 1578425263178270720, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=03bde2a6-4111-439d-bfba-c63326918e00; name=olympia.addons.tasks.index_addons; run_time=2293; current_dt=2020-01-07 19:27:43.140715"}, "severity": 200}
{"Timestamp": 1578425265586216704, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=104631e2-0a88-4e1b-b897-2c399bade172; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:27:45.582194"}, "severity": 200}
{"Timestamp": 1578425265641875456, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578425266046006272, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "104631e2-0a88-4e1b-b897-2c399bade172", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 0.46391940000467}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[104631e2-0a88-4e1b-b897-2c399bade172] succeeded in 0.46391940000467s: None"}, "severity": 200}
{"Timestamp": 1578425266065643008, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=104631e2-0a88-4e1b-b897-2c399bade172; name=olympia.bandwagon.tasks.collection_meta; run_time=470; current_dt=2020-01-07 19:27:46.052839"}, "severity": 200}
{"Timestamp": 1578425266914141696, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=35f8983f-9666-4941-97b1-c8315eef2451; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:27:46.901429"}, "severity": 200}
{"Timestamp": 1578425266969850112, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578425267551512320, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "35f8983f-9666-4941-97b1-c8315eef2451", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 0.6512632000085432}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[35f8983f-9666-4941-97b1-c8315eef2451] succeeded in 0.6512632000085432s: None"}, "severity": 200}
{"Timestamp": 1578425267576445696, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=35f8983f-9666-4941-97b1-c8315eef2451; name=olympia.bandwagon.tasks.collection_meta; run_time=664; current_dt=2020-01-07 19:27:47.565244"}, "severity": 200}
{"Timestamp": 1578425267657536256, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 27"}, "severity": 400}
{"Timestamp": 1578425267679111424, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=7dde06cd-47b8-44ed-9d34-e76684112a04; name=olympia.bandwagon.tasks.collection_meta; current_dt=2020-01-07 19:27:47.667006"}, "severity": 200}
{"Timestamp": 1578425267691233792, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating collection metadata."}, "severity": 200}
{"Timestamp": 1578425268217774848, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "7dde06cd-47b8-44ed-9d34-e76684112a04", "name": "olympia.bandwagon.tasks.collection_meta", "return_value": "None", "runtime": 0.5518129999982193}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.bandwagon.tasks.collection_meta[7dde06cd-47b8-44ed-9d34-e76684112a04] succeeded in 0.5518129999982193s: None"}, "severity": 200}
{"Timestamp": 1578425268241160448, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=7dde06cd-47b8-44ed-9d34-e76684112a04; name=olympia.bandwagon.tasks.collection_meta; run_time=557; current_dt=2020-01-07 19:27:48.224703"}, "severity": 200}
Created Theme Ui-Test Theme for testing successfully
{"Timestamp": 1578425269064900608, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon None with basket because of name change"}, "severity": 200}
{"Timestamp": 1578425269085965824, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=181c1ee6-4ca2-4a43-8153-3a6ab1cb5a8a; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:27:49.074015"}, "severity": 200}
{"Timestamp": 1578425269213836032, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon None with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578425269216322560, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "181c1ee6-4ca2-4a43-8153-3a6ab1cb5a8a", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.1431084999931045}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[181c1ee6-4ca2-4a43-8153-3a6ab1cb5a8a] succeeded in 0.1431084999931045s: None"}, "severity": 200}
{"Timestamp": 1578425269218705920, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=181c1ee6-4ca2-4a43-8153-3a6ab1cb5a8a; name=olympia.amo.tasks.sync_object_to_basket; run_time=142; current_dt=2020-01-07 19:27:49.216859"}, "severity": 200}
{"Timestamp": 1578425271621479168, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Changing add-on status [43]: 4 => 0 (no listed version with valid file)."}, "severity": 200}
{"Timestamp": 1578425271912891648, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Triggering a sync of addon 43 with basket because of attribute change"}, "severity": 200}
{"Timestamp": 1578425271919830016, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=d1c3c9d7-2e46-40cc-89e1-6ecf3dadc27d; name=olympia.amo.tasks.sync_object_to_basket; current_dt=2020-01-07 19:27:51.917534"}, "severity": 200}
{"Timestamp": 1578425271958090496, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Not synchronizing addon 43 with basket because \"basket-amo-sync\" switch is off."}, "severity": 200}
{"Timestamp": 1578425271963545600, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "d1c3c9d7-2e46-40cc-89e1-6ecf3dadc27d", "name": "olympia.amo.tasks.sync_object_to_basket", "return_value": "None", "runtime": 0.04573190001246985}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.amo.tasks.sync_object_to_basket[d1c3c9d7-2e46-40cc-89e1-6ecf3dadc27d] succeeded in 0.04573190001246985s: None"}, "severity": 200}
{"Timestamp": 1578425271967506944, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=d1c3c9d7-2e46-40cc-89e1-6ecf3dadc27d; name=olympia.amo.tasks.sync_object_to_basket; run_time=48; current_dt=2020-01-07 19:27:51.965410"}, "severity": 200}
{"Timestamp": 1578425271970158848, "Type": "z.amo.activity", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 4, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Activity log called with no user: 12"}, "severity": 400}
{"Timestamp": 1578425275034114816, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=b603b824-c540-4ab9-a255-d6f36b5f5f67; name=olympia.addons.tasks.version_changed; current_dt=2020-01-07 19:27:55.031333"}, "severity": 200}
{"Timestamp": 1578425275998533376, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating last updated for 43."}, "severity": 200}
{"Timestamp": 1578425276373673472, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "[1@None] Updating appsupport for [43]."}, "severity": 200}
{"Timestamp": 1578425278753105152, "Type": "celery.app.trace", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"data": {"id": "b603b824-c540-4ab9-a255-d6f36b5f5f67", "name": "olympia.addons.tasks.version_changed", "return_value": "None", "runtime": 3.71968699998979}, "uid": "", "remoteAddressChain": "", "msg": "Task olympia.addons.tasks.version_changed[b603b824-c540-4ab9-a255-d6f36b5f5f67] succeeded in 3.71968699998979s: None"}, "severity": 200}
{"Timestamp": 1578425278794895616, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=b603b824-c540-4ab9-a255-d6f36b5f5f67; name=olympia.addons.tasks.version_changed; run_time=3729; current_dt=2020-01-07 19:27:58.760454"}, "severity": 200}
{"Timestamp": 1578425278806042112, "Type": "z.addons", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Version changed from current: None to 0.1 for addon 43: Add\u00f4n 990671b848d54be2ac3a4a9586de2aac"}, "severity": 200}
{"Timestamp": 1578425280025415936, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "starting task timer; id=7fbcf4c1-01de-45fa-b39b-2e394e876d93; name=olympia.addons.tasks.index_addons; current_dt=2020-01-07 19:28:00.021739"}, "severity": 200}
{"Timestamp": 1578425280128977920, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "Indexing addons 43-43. [1]"}, "severity": 200}
{"Timestamp": 1578425491276524544, "Type": "z.task", "Logger": "http_app_addons", "Hostname": "3b4862b183dc", "EnvVersion": "2.0", "Severity": 6, "Pid": 1692, "Fields": {"uid": "<anon>", "remoteAddressChain": "", "msg": "tracking task run time; id=7fbcf4c1-01de-45fa-b39b-2e394e876d93; name=olympia.addons.tasks.index_addons; run_time=210458; current_dt=2020-01-07 19:31:30.479754"}, "severity": 200}
Traceback (most recent call last):
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 421, in _make_request
six.raise_from(e, None)
File "<string>", line 3, in raise_from
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 416, in _make_request
httplib_response = conn.getresponse()
File "/deps/lib/python3.6/site-packages/raven/breadcrumbs.py", line 390, in getresponse
rv = real_getresponse(self, *args, **kwargs)
File "/usr/local/lib/python3.6/http/client.py", line 1346, in getresponse
response.begin()
File "/usr/local/lib/python3.6/http/client.py", line 307, in begin
version, status, reason = self._read_status()
File "/usr/local/lib/python3.6/http/client.py", line 268, in _read_status
line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
File "/usr/local/lib/python3.6/socket.py", line 586, in readinto
return self._sock.recv_into(b)
socket.timeout: timed out
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/deps/lib/python3.6/site-packages/elasticsearch/connection/http_urllib3.py", line 115, in perform_request
response = self.pool.urlopen(method, url, body, retries=False, headers=self.headers, **kw)
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 720, in urlopen
method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
File "/deps/lib/python3.6/site-packages/urllib3/util/retry.py", line 376, in increment
raise six.reraise(type(error), error, _stacktrace)
File "/deps/lib/python3.6/site-packages/urllib3/packages/six.py", line 735, in reraise
raise value
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 672, in urlopen
chunked=chunked,
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 423, in _make_request
self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
File "/deps/lib/python3.6/site-packages/urllib3/connectionpool.py", line 331, in _raise_timeout
self, url, "Read timed out. (read timeout=%s)" % timeout_value
urllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host='elasticsearch', port=9200): Read timed out. (read timeout=30)
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "manage.py", line 11, in <module>
execute_from_command_line(sys.argv)
File "/deps/lib/python3.6/site-packages/django/core/management/__init__.py", line 381, in execute_from_command_line
utility.execute()
File "/deps/lib/python3.6/site-packages/django/core/management/__init__.py", line 375, in execute
self.fetch_command(subcommand).run_from_argv(self.argv)
File "/deps/lib/python3.6/site-packages/django/core/management/base.py", line 323, in run_from_argv
self.execute(*args, **cmd_options)
File "/deps/lib/python3.6/site-packages/django/core/management/base.py", line 364, in execute
output = self.handle(*args, **options)
File "/code/src/olympia/landfill/management/commands/generate_default_addons_for_frontend.py", line 84, in handle
serializer.create_featured_collections()
File "/code/src/olympia/landfill/serializers.py", line 375, in create_featured_collections
addon = addon_factory(type=amo.ADDON_EXTENSION)
File "/code/src/olympia/amo/tests/__init__.py", line 727, in addon_factory
addon.save()
File "/code/src/olympia/addons/models.py", line 494, in save
super(Addon, self).save(**kw)
File "/code/src/olympia/amo/models.py", line 239, in save
result = super(OnChangeMixin, self).save(*args, **kw)
File "/code/src/olympia/amo/models.py", line 346, in save
return super(SaveUpdateMixin, self).save(**kwargs)
File "/deps/lib/python3.6/site-packages/django/db/models/base.py", line 741, in save
force_update=force_update, update_fields=update_fields)
File "/deps/lib/python3.6/site-packages/django/db/models/base.py", line 790, in save_base
update_fields=update_fields, raw=raw, using=using,
File "/deps/lib/python3.6/site-packages/django/dispatch/dispatcher.py", line 175, in send
for receiver in self._live_receivers(sender)
File "/deps/lib/python3.6/site-packages/django/dispatch/dispatcher.py", line 175, in <listcomp>
for receiver in self._live_receivers(sender)
File "/code/src/olympia/addons/models.py", line 1520, in update_search_index
tasks.index_addons.delay([instance.id])
File "/deps/lib/python3.6/site-packages/celery/app/task.py", line 427, in delay
return self.apply_async(args, kwargs)
File "/code/src/olympia/amo/celery.py", line 67, in apply_async
return super().apply_async(args=args, kwargs=kwargs, **options)
File "/deps/lib/python3.6/site-packages/post_request_task/task.py", line 102, in apply_async
args=args, kwargs=kwargs, **extrakw)
File "/deps/lib/python3.6/site-packages/post_request_task/task.py", line 95, in original_apply_async
args=args, kwargs=kwargs, **extrakw)
File "/deps/lib/python3.6/site-packages/celery/app/task.py", line 552, in apply_async
link=link, link_error=link_error, **options)
File "/code/src/olympia/amo/celery.py", line 74, in apply
return super().apply(args=args, kwargs=kwargs, **options)
File "/deps/lib/python3.6/site-packages/celery/app/task.py", line 774, in apply
ret = tracer(task_id, args, kwargs, request)
File "/deps/lib/python3.6/site-packages/celery/app/trace.py", line 399, in trace_task
I, R, state, retval = on_error(task_request, exc, uuid)
File "/deps/lib/python3.6/site-packages/celery/app/trace.py", line 385, in trace_task
R = retval = fun(*args, **kwargs)
File "/code/src/olympia/amo/decorators.py", line 108, in wrapper
return f(*args, **kw)
File "/code/src/olympia/addons/tasks.py", line 147, in index_addons
kw.pop('index', None), transforms, Addon.unfiltered)
File "/code/src/olympia/lib/es/utils.py", line 55, in index_objects
return helpers.bulk(es, bulk)
File "/deps/lib/python3.6/site-packages/elasticsearch/helpers/__init__.py", line 257, in bulk
for ok, item in streaming_bulk(client, actions, **kwargs):
File "/deps/lib/python3.6/site-packages/elasticsearch/helpers/__init__.py", line 192, in streaming_bulk
raise_on_error, **kwargs)
File "/deps/lib/python3.6/site-packages/elasticsearch/helpers/__init__.py", line 99, in _process_bulk_chunk
raise e
File "/deps/lib/python3.6/site-packages/elasticsearch/helpers/__init__.py", line 95, in _process_bulk_chunk
resp = client.bulk('\n'.join(bulk_actions) + '\n', **kwargs)
File "/deps/lib/python3.6/site-packages/elasticsearch/client/utils.py", line 73, in _wrapped
return func(*args, params=params, **kwargs)
File "/deps/lib/python3.6/site-packages/elasticsearch/client/__init__.py", line 1174, in bulk
doc_type, '_bulk'), params=params, body=self._bulk_body(body))
File "/deps/lib/python3.6/site-packages/elasticsearch/transport.py", line 312, in perform_request
status, headers, data = connection.perform_request(method, url, params, body, ignore=ignore, timeout=timeout)
File "/deps/lib/python3.6/site-packages/elasticsearch/connection/http_urllib3.py", line 123, in perform_request
raise ConnectionTimeout('TIMEOUT', str(e), e)
elasticsearch.exceptions.ConnectionTimeout: ConnectionTimeout caused by - ReadTimeoutError(HTTPConnectionPool(host='elasticsearch', port=9200): Read timed out. (read timeout=30))
Makefile-docker:81: recipe for target 'populate_data' failed
make: *** [populate_data] Error 1
make: *** [initialize] Error 2
~/Documents/gitRepos/addons-server[master*]$
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment