[04:29:36.437] New invocation is queued and will start shortly
[04:29:37.612] Starting the invocation (attempt 1)
[04:29:37.655] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:29:37.656] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:29:37.656] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027393836357966960",
"parameters_json": "{\"builder_name\":\"win-upload-perfetto\",\"properties\":{}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-upload-perfetto",
"scheduler_invocation_id:9027393836357966960",
"scheduler_job_id:chromium/win-upload-perfetto",
"user_agent:luci-scheduler"
]
}
[04:29:40.650] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606969780046806",
"id": "8861963771876241280",
"parameters_json": "{\"builder_name\": \"win-upload-perfetto\", \"properties\": {}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606969780477257",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1810",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9027393836357966960",
"scheduler_job_id:chromium/win-upload-perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861963771876241280/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1606969780477417",
"url": "https://ci.chromium.org/b/8861963771876241280",
"utcnow_ts": "1606969780640448"
}
}
[04:29:40.650] Task URL: https://ci.chromium.org/b/8861963771876241280
[04:29:40.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:2:0) after 1m0s
[04:30:40.861] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:2:0)
[04:30:40.861] Timer tick, asking Buildbucket for the build status
[04:30:41.401] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:41.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:3:0) after 1m0s
[04:31:41.597] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:3:0)
[04:31:41.597] Timer tick, asking Buildbucket for the build status
[04:31:41.729] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:41.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:4:0) after 1m0s
[04:32:41.882] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:4:0)
[04:32:41.882] Timer tick, asking Buildbucket for the build status
[04:32:42.055] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:42.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:5:0) after 1m0s
[04:33:42.077] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:5:0)
[04:33:42.077] Timer tick, asking Buildbucket for the build status
[04:33:42.155] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:42.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:6:0) after 1m0s
[04:34:42.281] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:6:0)
[04:34:42.281] Timer tick, asking Buildbucket for the build status
[04:34:42.417] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:42.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:7:0) after 1m0s
[04:35:42.471] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:7:0)
[04:35:42.471] Timer tick, asking Buildbucket for the build status
[04:35:42.536] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:42.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:8:0) after 1m0s
[04:36:42.626] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:8:0)
[04:36:42.626] Timer tick, asking Buildbucket for the build status
[04:36:42.768] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:42.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:9:0) after 1m0s
[04:37:42.814] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:9:0)
[04:37:42.814] Timer tick, asking Buildbucket for the build status
[04:37:42.894] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:42.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:10:0) after 1m0s
[04:38:43.006] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:10:0)
[04:38:43.006] Timer tick, asking Buildbucket for the build status
[04:38:43.092] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:43.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:11:0) after 1m0s
[04:39:43.250] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:11:0)
[04:39:43.250] Timer tick, asking Buildbucket for the build status
[04:39:43.352] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:43.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:12:0) after 1m0s
[04:40:43.419] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:12:0)
[04:40:43.419] Timer tick, asking Buildbucket for the build status
[04:40:43.612] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:43.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:13:0) after 1m0s
[04:41:43.641] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:13:0)
[04:41:43.641] Timer tick, asking Buildbucket for the build status
[04:41:43.746] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:14:0) after 1m0s
[04:42:43.767] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:14:0)
[04:42:43.767] Timer tick, asking Buildbucket for the build status
[04:42:43.847] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:43.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:15:0) after 1m0s
[04:43:43.914] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:15:0)
[04:43:43.914] Timer tick, asking Buildbucket for the build status
[04:43:44.149] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:44.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:16:0) after 1m0s
[04:44:44.205] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:16:0)
[04:44:44.205] Timer tick, asking Buildbucket for the build status
[04:44:44.314] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:44.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:17:0) after 1m0s
[04:45:44.441] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:17:0)
[04:45:44.441] Timer tick, asking Buildbucket for the build status
[04:45:44.522] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:44.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:18:0) after 1m0s
[04:46:44.599] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:18:0)
[04:46:44.599] Timer tick, asking Buildbucket for the build status
[04:46:44.701] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:44.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:19:0) after 1m0s
[04:47:44.774] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:19:0)
[04:47:44.774] Timer tick, asking Buildbucket for the build status
[04:47:44.849] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:20:0) after 1m0s
[04:48:44.897] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:20:0)
[04:48:44.897] Timer tick, asking Buildbucket for the build status
[04:48:44.973] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:44.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:21:0) after 1m0s
[04:49:45.199] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:21:0)
[04:49:45.199] Timer tick, asking Buildbucket for the build status
[04:49:45.304] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:45.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:22:0) after 1m0s
[04:50:45.315] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:22:0)
[04:50:45.315] Timer tick, asking Buildbucket for the build status
[04:50:45.522] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:45.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:23:0) after 1m0s
[04:51:45.588] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:23:0)
[04:51:45.588] Timer tick, asking Buildbucket for the build status
[04:51:45.731] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:45.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:24:0) after 1m0s
[04:52:46.153] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:24:0)
[04:52:46.153] Timer tick, asking Buildbucket for the build status
[04:52:46.269] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:46.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:25:0) after 1m0s
[04:53:46.398] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:25:0)
[04:53:46.398] Timer tick, asking Buildbucket for the build status
[04:53:46.477] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:46.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:26:0) after 1m0s
[04:54:46.600] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:26:0)
[04:54:46.600] Timer tick, asking Buildbucket for the build status
[04:54:46.727] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:46.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:27:0) after 1m0s
[04:55:46.774] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:27:0)
[04:55:46.774] Timer tick, asking Buildbucket for the build status
[04:55:46.877] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:46.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:28:0) after 1m0s
[04:56:46.960] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:28:0)
[04:56:46.960] Timer tick, asking Buildbucket for the build status
[04:56:47.175] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:47.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:29:0) after 1m0s
[04:57:47.245] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:29:0)
[04:57:47.245] Timer tick, asking Buildbucket for the build status
[04:57:47.352] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:47.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:30:0) after 1m0s
[04:58:47.359] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:30:0)
[04:58:47.359] Timer tick, asking Buildbucket for the build status
[04:58:47.451] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:31:0) after 1m0s
[04:59:47.459] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:31:0)
[04:59:47.459] Timer tick, asking Buildbucket for the build status
[04:59:47.758] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:47.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:32:0) after 1m0s
[05:00:47.829] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:32:0)
[05:00:47.829] Timer tick, asking Buildbucket for the build status
[05:00:47.980] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:47.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:33:0) after 1m0s
[05:01:48.000] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:33:0)
[05:01:48.000] Timer tick, asking Buildbucket for the build status
[05:01:48.224] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:48.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:34:0) after 1m0s
[05:02:48.334] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:34:0)
[05:02:48.334] Timer tick, asking Buildbucket for the build status
[05:02:48.578] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:48.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:35:0) after 1m0s
[05:03:48.635] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:35:0)
[05:03:48.635] Timer tick, asking Buildbucket for the build status
[05:03:48.957] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:48.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:36:0) after 1m0s
[05:04:48.998] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:36:0)
[05:04:48.998] Timer tick, asking Buildbucket for the build status
[05:04:49.198] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:49.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:37:0) after 1m0s
[05:05:49.252] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:37:0)
[05:05:49.252] Timer tick, asking Buildbucket for the build status
[05:05:49.366] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:49.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:38:0) after 1m0s
[05:06:49.403] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:38:0)
[05:06:49.403] Timer tick, asking Buildbucket for the build status
[05:06:49.501] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:49.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:39:0) after 1m0s
[05:07:49.502] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:39:0)
[05:07:49.502] Timer tick, asking Buildbucket for the build status
[05:07:49.579] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:49.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:40:0) after 1m0s
[05:08:49.614] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:40:0)
[05:08:49.614] Timer tick, asking Buildbucket for the build status
[05:08:50.089] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:50.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:41:0) after 1m0s
[05:09:50.314] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:41:0)
[05:09:50.314] Timer tick, asking Buildbucket for the build status
[05:09:50.531] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:50.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:42:0) after 1m0s
[05:10:50.644] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:42:0)
[05:10:50.644] Timer tick, asking Buildbucket for the build status
[05:10:50.738] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:50.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:43:0) after 1m0s
[05:11:50.780] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:43:0)
[05:11:50.780] Timer tick, asking Buildbucket for the build status
[05:11:50.847] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:50.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:44:0) after 1m0s
[05:12:50.861] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:44:0)
[05:12:50.861] Timer tick, asking Buildbucket for the build status
[05:12:50.953] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:45:0) after 1m0s
[05:13:51.052] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:45:0)
[05:13:51.052] Timer tick, asking Buildbucket for the build status
[05:13:51.159] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:51.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:46:0) after 1m0s
[05:14:51.212] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:46:0)
[05:14:51.212] Timer tick, asking Buildbucket for the build status
[05:14:51.371] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:51.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:47:0) after 1m0s
[05:15:51.463] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:47:0)
[05:15:51.463] Timer tick, asking Buildbucket for the build status
[05:15:51.546] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:48:0) after 1m0s
[05:16:51.590] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:48:0)
[05:16:51.590] Timer tick, asking Buildbucket for the build status
[05:16:52.021] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:52.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:49:0) after 1m0s
[05:17:52.142] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:49:0)
[05:17:52.142] Timer tick, asking Buildbucket for the build status
[05:17:52.314] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:50:0) after 1m0s
[05:18:52.404] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:50:0)
[05:18:52.404] Timer tick, asking Buildbucket for the build status
[05:18:52.607] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:52.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:51:0) after 1m0s
[05:19:52.658] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:51:0)
[05:19:52.658] Timer tick, asking Buildbucket for the build status
[05:19:53.730] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:53.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:52:0) after 1m0s
[05:20:53.822] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:52:0)
[05:20:53.822] Timer tick, asking Buildbucket for the build status
[05:20:53.920] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:53.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:53:0) after 1m0s
[05:21:53.978] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:53:0)
[05:21:53.978] Timer tick, asking Buildbucket for the build status
[05:21:54.060] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:54.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:54:0) after 1m0s
[05:22:54.095] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:54:0)
[05:22:54.095] Timer tick, asking Buildbucket for the build status
[05:22:54.157] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:54.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:55:0) after 1m0s
[05:23:54.275] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:55:0)
[05:23:54.275] Timer tick, asking Buildbucket for the build status
[05:23:54.354] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:54.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:56:0) after 1m0s
[05:24:54.420] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:56:0)
[05:24:54.420] Timer tick, asking Buildbucket for the build status
[05:24:54.532] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:54.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:57:0) after 1m0s
[05:25:54.637] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:57:0)
[05:25:54.637] Timer tick, asking Buildbucket for the build status
[05:25:54.717] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:54.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:58:0) after 1m0s
[05:26:54.810] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:58:0)
[05:26:54.810] Timer tick, asking Buildbucket for the build status
[05:26:54.891] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:54.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:59:0) after 1m0s
[05:27:54.996] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:59:0)
[05:27:54.996] Timer tick, asking Buildbucket for the build status
[05:27:55.187] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:55.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:60:0) after 1m0s
[05:28:55.211] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:60:0)
[05:28:55.211] Timer tick, asking Buildbucket for the build status
[05:28:55.292] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:55.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:61:0) after 1m0s
[05:29:55.343] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:61:0)
[05:29:55.343] Timer tick, asking Buildbucket for the build status
[05:29:55.444] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:55.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:62:0) after 1m0s
[05:30:55.697] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:62:0)
[05:30:55.697] Timer tick, asking Buildbucket for the build status
[05:30:55.789] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:55.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:63:0) after 1m0s
[05:31:55.857] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:63:0)
[05:31:55.857] Timer tick, asking Buildbucket for the build status
[05:31:56.316] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:56.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:64:0) after 1m0s
[05:32:56.427] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:64:0)
[05:32:56.427] Timer tick, asking Buildbucket for the build status
[05:32:56.507] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:65:0) after 1m0s
[05:33:56.512] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:65:0)
[05:33:56.512] Timer tick, asking Buildbucket for the build status
[05:33:56.596] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:56.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:66:0) after 1m0s
[05:34:56.641] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:66:0)
[05:34:56.641] Timer tick, asking Buildbucket for the build status
[05:34:57.025] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:57.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:67:0) after 1m0s
[05:35:57.045] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:67:0)
[05:35:57.045] Timer tick, asking Buildbucket for the build status
[05:35:58.215] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:58.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:68:0) after 1m0s
[05:36:58.235] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:68:0)
[05:36:58.235] Timer tick, asking Buildbucket for the build status
[05:36:58.359] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:58.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:69:0) after 1m0s
[05:37:58.442] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:69:0)
[05:37:58.442] Timer tick, asking Buildbucket for the build status
[05:37:58.604] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:58.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:70:0) after 1m0s
[05:38:58.636] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:70:0)
[05:38:58.636] Timer tick, asking Buildbucket for the build status
[05:38:58.743] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:58.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:71:0) after 1m0s
[05:39:58.767] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:71:0)
[05:39:58.767] Timer tick, asking Buildbucket for the build status
[05:39:58.877] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:58.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:72:0) after 1m0s
[05:40:58.945] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:72:0)
[05:40:58.945] Timer tick, asking Buildbucket for the build status
[05:40:59.038] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:59.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:73:0) after 1m0s
[05:41:59.058] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:73:0)
[05:41:59.058] Timer tick, asking Buildbucket for the build status
[05:41:59.190] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:59.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:74:0) after 1m0s
[05:43:02.133] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:74:0)
[05:43:02.133] Timer tick, asking Buildbucket for the build status
[05:43:02.295] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:75:0) after 1m0s
[05:44:03.196] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:75:0)
[05:44:03.196] Timer tick, asking Buildbucket for the build status
[05:44:03.452] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:03.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:76:0) after 1m0s
[05:45:03.565] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:76:0)
[05:45:03.565] Timer tick, asking Buildbucket for the build status
[05:45:03.917] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:03.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:77:0) after 1m0s
[05:46:04.043] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:77:0)
[05:46:04.043] Timer tick, asking Buildbucket for the build status
[05:46:04.139] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:04.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:78:0) after 1m0s
[05:47:04.197] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:78:0)
[05:47:04.197] Timer tick, asking Buildbucket for the build status
[05:47:04.273] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:04.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:79:0) after 1m0s
[05:48:04.359] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:79:0)
[05:48:04.359] Timer tick, asking Buildbucket for the build status
[05:48:04.474] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:04.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:80:0) after 1m0s
[05:49:04.587] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:80:0)
[05:49:04.587] Timer tick, asking Buildbucket for the build status
[05:49:05.161] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:05.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:81:0) after 1m0s
[05:50:05.390] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:81:0)
[05:50:05.390] Timer tick, asking Buildbucket for the build status
[05:50:05.527] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:05.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:82:0) after 1m0s
[05:51:05.871] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:82:0)
[05:51:05.871] Timer tick, asking Buildbucket for the build status
[05:51:05.939] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:05.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:83:0) after 1m0s
[05:52:06.219] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:83:0)
[05:52:06.219] Timer tick, asking Buildbucket for the build status
[05:52:06.514] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:06.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:84:0) after 1m0s
[05:53:06.705] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:84:0)
[05:53:06.705] Timer tick, asking Buildbucket for the build status
[05:53:07.242] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:07.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:85:0) after 1m0s
[05:54:07.394] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:85:0)
[05:54:07.394] Timer tick, asking Buildbucket for the build status
[05:54:07.474] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:07.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:86:0) after 1m0s
[05:55:07.568] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:86:0)
[05:55:07.568] Timer tick, asking Buildbucket for the build status
[05:55:07.683] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:07.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:87:0) after 1m0s
[05:56:07.776] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:87:0)
[05:56:07.776] Timer tick, asking Buildbucket for the build status
[05:56:07.881] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:07.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:88:0) after 1m0s
[05:57:08.020] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:88:0)
[05:57:08.020] Timer tick, asking Buildbucket for the build status
[05:57:08.098] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:08.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:89:0) after 1m0s
[05:58:08.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:89:0)
[05:58:08.272] Timer tick, asking Buildbucket for the build status
[05:58:08.385] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:08.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:90:0) after 1m0s
[05:59:08.503] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:90:0)
[05:59:08.503] Timer tick, asking Buildbucket for the build status
[05:59:08.643] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:08.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:91:0) after 1m0s
[06:00:09.546] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:91:0)
[06:00:09.546] Timer tick, asking Buildbucket for the build status
[06:00:09.750] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:92:0) after 1m0s
[06:01:12.768] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:92:0)
[06:01:12.768] Timer tick, asking Buildbucket for the build status
[06:01:12.974] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:12.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:93:0) after 1m0s
[06:02:12.988] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:93:0)
[06:02:12.988] Timer tick, asking Buildbucket for the build status
[06:02:13.154] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:13.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:94:0) after 1m0s
[06:03:13.197] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:94:0)
[06:03:13.197] Timer tick, asking Buildbucket for the build status
[06:03:13.313] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:95:0) after 1m0s
[06:04:13.299] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:95:0)
[06:04:13.299] Timer tick, asking Buildbucket for the build status
[06:04:13.386] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:13.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:96:0) after 1m0s
[06:05:13.484] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:96:0)
[06:05:13.484] Timer tick, asking Buildbucket for the build status
[06:05:13.589] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:13.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:97:0) after 1m0s
[06:06:13.729] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:97:0)
[06:06:13.729] Timer tick, asking Buildbucket for the build status
[06:06:13.867] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:13.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:98:0) after 1m0s
[06:07:13.932] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:98:0)
[06:07:13.932] Timer tick, asking Buildbucket for the build status
[06:07:14.053] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:99:0) after 1m0s
[06:08:14.123] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:99:0)
[06:08:14.123] Timer tick, asking Buildbucket for the build status
[06:08:14.313] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:14.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:100:0) after 1m0s
[06:09:14.326] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:100:0)
[06:09:14.326] Timer tick, asking Buildbucket for the build status
[06:09:14.408] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:14.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:101:0) after 1m0s
[06:10:14.430] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:101:0)
[06:10:14.430] Timer tick, asking Buildbucket for the build status
[06:10:14.807] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:14.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:102:0) after 1m0s
[06:11:14.842] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:102:0)
[06:11:14.842] Timer tick, asking Buildbucket for the build status
[06:11:14.928] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:14.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:103:0) after 1m0s
[06:12:14.984] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:103:0)
[06:12:14.984] Timer tick, asking Buildbucket for the build status
[06:12:15.255] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:104:0) after 1m0s
[06:13:15.304] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:104:0)
[06:13:15.304] Timer tick, asking Buildbucket for the build status
[06:13:15.566] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:15.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:105:0) after 1m0s
[06:14:15.662] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:105:0)
[06:14:15.662] Timer tick, asking Buildbucket for the build status
[06:14:15.843] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:15.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:106:0) after 1m0s
[06:15:15.956] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:106:0)
[06:15:15.956] Timer tick, asking Buildbucket for the build status
[06:15:17.762] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:17.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:107:0) after 1m0s
[06:16:17.758] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:107:0)
[06:16:17.758] Timer tick, asking Buildbucket for the build status
[06:16:17.848] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:17.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:108:0) after 1m0s
[06:17:17.900] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:108:0)
[06:17:17.900] Timer tick, asking Buildbucket for the build status
[06:17:18.016] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:18.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:109:0) after 1m0s
[06:18:18.116] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:109:0)
[06:18:18.116] Timer tick, asking Buildbucket for the build status
[06:18:18.210] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:18.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:110:0) after 1m0s
[06:19:18.215] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:110:0)
[06:19:18.215] Timer tick, asking Buildbucket for the build status
[06:19:18.314] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:18.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:111:0) after 1m0s
[06:20:18.369] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:111:0)
[06:20:18.369] Timer tick, asking Buildbucket for the build status
[06:20:18.485] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:18.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:112:0) after 1m0s
[06:21:18.514] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:112:0)
[06:21:18.514] Timer tick, asking Buildbucket for the build status
[06:21:18.613] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:18.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:113:0) after 1m0s
[06:22:18.701] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:113:0)
[06:22:18.701] Timer tick, asking Buildbucket for the build status
[06:22:18.797] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:18.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:114:0) after 1m0s
[06:23:18.909] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:114:0)
[06:23:18.909] Timer tick, asking Buildbucket for the build status
[06:23:18.976] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:18.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:115:0) after 1m0s
[06:24:19.035] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:115:0)
[06:24:19.035] Timer tick, asking Buildbucket for the build status
[06:24:19.255] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:19.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:116:0) after 1m0s
[06:25:19.392] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:116:0)
[06:25:19.392] Timer tick, asking Buildbucket for the build status
[06:25:19.524] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:19.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:117:0) after 1m0s
[06:26:19.644] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:117:0)
[06:26:19.644] Timer tick, asking Buildbucket for the build status
[06:26:20.312] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:20.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:118:0) after 1m0s
[06:27:20.408] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:118:0)
[06:27:20.408] Timer tick, asking Buildbucket for the build status
[06:27:20.762] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:27:20.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:119:0) after 1m0s
[06:28:20.824] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:119:0)
[06:28:20.824] Timer tick, asking Buildbucket for the build status
[06:28:21.213] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:28:21.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:120:0) after 1m0s
[06:29:21.313] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:120:0)
[06:29:21.313] Timer tick, asking Buildbucket for the build status
[06:29:21.444] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:29:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:121:0) after 1m0s
[06:30:21.488] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:121:0)
[06:30:21.488] Timer tick, asking Buildbucket for the build status
[06:30:21.590] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:30:21.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:122:0) after 1m0s
[06:31:21.586] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:122:0)
[06:31:21.586] Timer tick, asking Buildbucket for the build status
[06:31:21.857] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:31:21.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:123:0) after 1m0s
[06:32:21.876] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:123:0)
[06:32:21.876] Timer tick, asking Buildbucket for the build status
[06:32:21.994] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:32:21.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:124:0) after 1m0s
[06:33:22.017] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:124:0)
[06:33:22.017] Timer tick, asking Buildbucket for the build status
[06:33:22.137] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:33:22.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:125:0) after 1m0s
[06:34:22.194] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:125:0)
[06:34:22.194] Timer tick, asking Buildbucket for the build status
[06:34:22.362] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:34:22.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:126:0) after 1m0s
[06:35:22.464] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:126:0)
[06:35:22.464] Timer tick, asking Buildbucket for the build status
[06:35:22.572] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:35:22.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:127:0) after 1m0s
[06:36:22.599] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:127:0)
[06:36:22.599] Timer tick, asking Buildbucket for the build status
[06:36:22.771] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:36:22.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:128:0) after 1m0s
[06:37:22.796] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:128:0)
[06:37:22.797] Timer tick, asking Buildbucket for the build status
[06:37:25.260] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:37:25.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:129:0) after 1m0s
[06:38:25.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:129:0)
[06:38:25.272] Timer tick, asking Buildbucket for the build status
[06:38:25.381] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:25.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:130:0) after 1m0s
[06:39:25.384] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:130:0)
[06:39:25.384] Timer tick, asking Buildbucket for the build status
[06:39:25.617] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:39:25.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:131:0) after 1m0s
[06:40:25.639] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:131:0)
[06:40:25.639] Timer tick, asking Buildbucket for the build status
[06:40:25.737] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:40:25.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:132:0) after 1m0s
[06:41:25.766] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:132:0)
[06:41:25.766] Timer tick, asking Buildbucket for the build status
[06:41:25.890] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:41:25.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:133:0) after 1m0s
[06:42:25.922] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:133:0)
[06:42:25.922] Timer tick, asking Buildbucket for the build status
[06:42:26.064] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:26.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:134:0) after 1m0s
[06:43:26.088] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:134:0)
[06:43:26.088] Timer tick, asking Buildbucket for the build status
[06:43:26.765] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:26.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:135:0) after 1m0s
[06:44:26.851] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:135:0)
[06:44:26.851] Timer tick, asking Buildbucket for the build status
[06:44:26.946] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:26.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:136:0) after 1m0s
[06:45:27.023] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:136:0)
[06:45:27.023] Timer tick, asking Buildbucket for the build status
[06:45:27.243] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:27.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:137:0) after 1m0s
[06:46:27.311] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:137:0)
[06:46:27.311] Timer tick, asking Buildbucket for the build status
[06:46:27.400] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:27.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:138:0) after 1m0s
[06:47:27.431] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:138:0)
[06:47:27.431] Timer tick, asking Buildbucket for the build status
[06:47:27.507] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:27.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:139:0) after 1m0s
[06:48:27.597] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:139:0)
[06:48:27.597] Timer tick, asking Buildbucket for the build status
[06:48:27.855] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:27.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:140:0) after 1m0s
[06:49:27.841] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:140:0)
[06:49:27.841] Timer tick, asking Buildbucket for the build status
[06:49:28.055] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:28.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:141:0) after 1m0s
[06:50:28.151] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:141:0)
[06:50:28.151] Timer tick, asking Buildbucket for the build status
[06:50:28.255] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:28.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:142:0) after 1m0s
[06:51:28.282] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:142:0)
[06:51:28.282] Timer tick, asking Buildbucket for the build status
[06:51:28.361] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:51:28.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:143:0) after 1m0s
[06:52:28.358] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:143:0)
[06:52:28.358] Timer tick, asking Buildbucket for the build status
[06:52:28.432] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:52:28.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:144:0) after 1m0s
[06:53:28.445] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:144:0)
[06:53:28.445] Timer tick, asking Buildbucket for the build status
[06:53:28.671] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:28.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:145:0) after 1m0s
[06:54:28.770] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:145:0)
[06:54:28.770] Timer tick, asking Buildbucket for the build status
[06:54:29.036] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:29.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:146:0) after 1m0s
[06:55:29.066] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:146:0)
[06:55:29.066] Timer tick, asking Buildbucket for the build status
[06:55:29.185] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:29.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:147:0) after 1m0s
[06:56:29.259] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:147:0)
[06:56:29.259] Timer tick, asking Buildbucket for the build status
[06:56:29.337] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:29.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:148:0) after 1m0s
[06:57:29.466] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:148:0)
[06:57:29.466] Timer tick, asking Buildbucket for the build status
[06:57:29.546] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:29.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:149:0) after 1m0s
[06:58:29.657] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:149:0)
[06:58:29.657] Timer tick, asking Buildbucket for the build status
[06:58:29.761] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:29.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:150:0) after 1m0s
[06:59:29.959] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:150:0)
[06:59:29.959] Timer tick, asking Buildbucket for the build status
[06:59:30.171] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:30.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:151:0) after 1m0s
[07:00:30.215] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:151:0)
[07:00:30.215] Timer tick, asking Buildbucket for the build status
[07:00:30.357] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:152:0) after 1m0s
[07:01:30.516] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:152:0)
[07:01:30.516] Timer tick, asking Buildbucket for the build status
[07:01:30.592] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:30.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:153:0) after 1m0s
[07:02:30.629] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:153:0)
[07:02:30.629] Timer tick, asking Buildbucket for the build status
[07:02:30.810] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:30.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:154:0) after 1m0s
[07:03:30.835] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:154:0)
[07:03:30.835] Timer tick, asking Buildbucket for the build status
[07:03:31.028] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:31.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:155:0) after 1m0s
[07:04:31.086] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:155:0)
[07:04:31.086] Timer tick, asking Buildbucket for the build status
[07:04:31.226] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:31.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:156:0) after 1m0s
[07:05:31.262] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:156:0)
[07:05:31.262] Timer tick, asking Buildbucket for the build status
[07:05:31.520] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:31.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:157:0) after 1m0s
[07:06:31.584] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:157:0)
[07:06:31.584] Timer tick, asking Buildbucket for the build status
[07:06:31.725] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:31.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:158:0) after 1m0s
[07:07:31.734] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:158:0)
[07:07:31.734] Timer tick, asking Buildbucket for the build status
[07:07:31.835] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:31.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:159:0) after 1m0s
[07:08:31.906] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:159:0)
[07:08:31.906] Timer tick, asking Buildbucket for the build status
[07:08:32.168] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:32.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:160:0) after 1m0s
[07:09:32.249] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:160:0)
[07:09:32.249] Timer tick, asking Buildbucket for the build status
[07:09:32.437] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:32.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:161:0) after 1m0s
[07:10:32.500] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:161:0)
[07:10:32.500] Timer tick, asking Buildbucket for the build status
[07:10:32.797] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:162:0) after 1m0s
[07:11:32.896] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:162:0)
[07:11:32.896] Timer tick, asking Buildbucket for the build status
[07:11:33.164] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:33.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:163:0) after 1m0s
[07:12:33.229] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:163:0)
[07:12:33.229] Timer tick, asking Buildbucket for the build status
[07:12:33.472] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:33.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:164:0) after 1m0s
[07:13:33.535] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:164:0)
[07:13:33.535] Timer tick, asking Buildbucket for the build status
[07:13:33.844] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:33.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:165:0) after 1m0s
[07:14:33.916] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:165:0)
[07:14:33.916] Timer tick, asking Buildbucket for the build status
[07:14:34.115] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:34.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:166:0) after 1m0s
[07:15:34.333] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:166:0)
[07:15:34.333] Timer tick, asking Buildbucket for the build status
[07:15:34.838] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:34.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:167:0) after 1m0s
[07:16:34.859] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:167:0)
[07:16:34.859] Timer tick, asking Buildbucket for the build status
[07:16:34.999] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:34.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:168:0) after 1m0s
[07:17:35.100] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:168:0)
[07:17:35.100] Timer tick, asking Buildbucket for the build status
[07:17:35.189] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:35.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:169:0) after 1m0s
[07:18:35.256] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:169:0)
[07:18:35.256] Timer tick, asking Buildbucket for the build status
[07:18:35.327] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:35.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:170:0) after 1m0s
[07:19:35.404] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:170:0)
[07:19:35.404] Timer tick, asking Buildbucket for the build status
[07:19:35.523] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:35.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:171:0) after 1m0s
[07:20:35.547] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:171:0)
[07:20:35.547] Timer tick, asking Buildbucket for the build status
[07:20:35.699] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:35.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:172:0) after 1m0s
[07:21:35.731] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:172:0)
[07:21:35.731] Timer tick, asking Buildbucket for the build status
[07:21:35.804] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:35.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:173:0) after 1m0s
[07:22:35.882] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:173:0)
[07:22:35.882] Timer tick, asking Buildbucket for the build status
[07:22:35.959] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:35.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:174:0) after 1m0s
[07:23:36.194] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:174:0)
[07:23:36.194] Timer tick, asking Buildbucket for the build status
[07:23:36.285] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:36.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:175:0) after 1m0s
[07:24:36.398] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:175:0)
[07:24:36.398] Timer tick, asking Buildbucket for the build status
[07:24:36.482] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:36.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:176:0) after 1m0s
[07:25:36.461] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:176:0)
[07:25:36.461] Timer tick, asking Buildbucket for the build status
[07:25:36.755] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:36.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:177:0) after 1m0s
[07:26:36.791] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:177:0)
[07:26:36.791] Timer tick, asking Buildbucket for the build status
[07:26:36.908] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:36.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:178:0) after 1m0s
[07:27:36.932] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:178:0)
[07:27:36.932] Timer tick, asking Buildbucket for the build status
[07:27:37.004] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:179:0) after 1m0s
[07:28:37.030] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:179:0)
[07:28:37.030] Timer tick, asking Buildbucket for the build status
[07:28:37.105] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:37.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:180:0) after 1m0s
[07:29:37.138] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:180:0)
[07:29:37.138] Timer tick, asking Buildbucket for the build status
[07:29:37.404] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:37.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:181:0) after 1m0s
[07:30:37.467] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:181:0)
[07:30:37.467] Timer tick, asking Buildbucket for the build status
[07:30:37.799] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:37.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:182:0) after 1m0s
[07:31:37.867] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:182:0)
[07:31:37.867] Timer tick, asking Buildbucket for the build status
[07:31:38.070] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:38.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:183:0) after 1m0s
[07:32:38.083] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:183:0)
[07:32:38.083] Timer tick, asking Buildbucket for the build status
[07:32:38.166] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:38.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:184:0) after 1m0s
[07:33:38.301] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:184:0)
[07:33:38.301] Timer tick, asking Buildbucket for the build status
[07:33:38.377] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:185:0) after 1m0s
[07:34:38.467] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:185:0)
[07:34:38.467] Timer tick, asking Buildbucket for the build status
[07:34:38.542] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:38.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:186:0) after 1m0s
[07:35:38.634] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:186:0)
[07:35:38.634] Timer tick, asking Buildbucket for the build status
[07:35:39.212] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:39.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:187:0) after 1m0s
[07:36:39.274] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:187:0)
[07:36:39.274] Timer tick, asking Buildbucket for the build status
[07:36:39.498] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:39.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:188:0) after 1m0s
[07:37:39.560] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:188:0)
[07:37:39.560] Timer tick, asking Buildbucket for the build status
[07:37:39.768] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:189:0) after 1m0s
[07:38:39.860] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:189:0)
[07:38:39.860] Timer tick, asking Buildbucket for the build status
[07:38:40.022] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:38:40.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:190:0) after 1m0s
[07:39:40.159] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:190:0)
[07:39:40.159] Timer tick, asking Buildbucket for the build status
[07:39:40.238] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:39:40.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:191:0) after 1m0s
[07:40:40.283] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:191:0)
[07:40:40.283] Timer tick, asking Buildbucket for the build status
[07:40:44.118] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:40:44.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:192:0) after 1m0s
[07:41:44.193] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:192:0)
[07:41:44.193] Timer tick, asking Buildbucket for the build status
[07:41:44.387] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:193:0) after 1m0s
[07:42:44.435] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:193:0)
[07:42:44.435] Timer tick, asking Buildbucket for the build status
[07:42:44.541] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:44.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:194:0) after 1m0s
[07:43:44.603] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:194:0)
[07:43:44.603] Timer tick, asking Buildbucket for the build status
[07:43:44.816] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:44.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:195:0) after 1m0s
[07:44:44.847] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:195:0)
[07:44:44.847] Timer tick, asking Buildbucket for the build status
[07:44:45.200] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:45.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:196:0) after 1m0s
[07:45:45.240] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:196:0)
[07:45:45.240] Timer tick, asking Buildbucket for the build status
[07:45:45.347] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:45.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:197:0) after 1m0s
[07:46:45.406] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:197:0)
[07:46:45.406] Timer tick, asking Buildbucket for the build status
[07:46:45.527] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:45.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:198:0) after 1m0s
[07:47:45.564] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:198:0)
[07:47:45.564] Timer tick, asking Buildbucket for the build status
[07:47:45.705] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:45.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:199:0) after 1m0s
[07:48:45.764] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:199:0)
[07:48:45.764] Timer tick, asking Buildbucket for the build status
[07:48:46.620] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:46.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:200:0) after 1m0s
[07:49:46.687] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:200:0)
[07:49:46.687] Timer tick, asking Buildbucket for the build status
[07:49:46.789] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:49:46.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:201:0) after 1m0s
[07:50:46.843] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:201:0)
[07:50:46.843] Timer tick, asking Buildbucket for the build status
[07:50:47.023] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:50:47.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:202:0) after 1m0s
[07:51:47.129] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:202:0)
[07:51:47.129] Timer tick, asking Buildbucket for the build status
[07:51:47.199] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:47.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:203:0) after 1m0s
[07:52:47.265] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:203:0)
[07:52:47.265] Timer tick, asking Buildbucket for the build status
[07:52:47.352] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:47.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:204:0) after 1m0s
[07:53:47.423] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:204:0)
[07:53:47.423] Timer tick, asking Buildbucket for the build status
[07:53:47.533] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:47.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:205:0) after 1m0s
[07:54:47.648] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:205:0)
[07:54:47.648] Timer tick, asking Buildbucket for the build status
[07:54:47.781] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:47.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:206:0) after 1m0s
[07:55:47.843] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:206:0)
[07:55:47.843] Timer tick, asking Buildbucket for the build status
[07:55:47.939] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:47.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:207:0) after 1m0s
[07:56:48.031] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:207:0)
[07:56:48.031] Timer tick, asking Buildbucket for the build status
[07:56:48.164] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:48.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:208:0) after 1m0s
[07:57:48.287] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:208:0)
[07:57:48.287] Timer tick, asking Buildbucket for the build status
[07:57:48.364] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:48.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:209:0) after 1m0s
[07:58:48.446] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:209:0)
[07:58:48.446] Timer tick, asking Buildbucket for the build status
[07:58:48.530] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:48.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:210:0) after 1m0s
[07:59:48.640] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:210:0)
[07:59:48.640] Timer tick, asking Buildbucket for the build status
[07:59:48.732] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:48.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:211:0) after 1m0s
[08:00:48.907] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:211:0)
[08:00:48.907] Timer tick, asking Buildbucket for the build status
[08:00:49.067] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:212:0) after 1m0s
[08:01:49.210] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:212:0)
[08:01:49.210] Timer tick, asking Buildbucket for the build status
[08:01:49.438] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:01:49.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:213:0) after 1m0s
[08:02:49.547] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:213:0)
[08:02:49.547] Timer tick, asking Buildbucket for the build status
[08:02:49.638] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:02:49.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:214:0) after 1m0s
[08:03:49.699] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:214:0)
[08:03:49.699] Timer tick, asking Buildbucket for the build status
[08:03:49.776] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:03:49.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:215:0) after 1m0s
[08:04:49.823] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:215:0)
[08:04:49.823] Timer tick, asking Buildbucket for the build status
[08:04:49.909] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:49.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:216:0) after 1m0s
[08:05:50.029] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:216:0)
[08:05:50.029] Timer tick, asking Buildbucket for the build status
[08:05:50.454] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:50.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:217:0) after 1m0s
[08:06:50.517] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:217:0)
[08:06:50.517] Timer tick, asking Buildbucket for the build status
[08:06:50.607] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:50.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:218:0) after 1m0s
[08:07:50.635] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:218:0)
[08:07:50.635] Timer tick, asking Buildbucket for the build status
[08:07:50.857] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:50.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:219:0) after 1m0s
[08:08:50.916] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:219:0)
[08:08:50.916] Timer tick, asking Buildbucket for the build status
[08:08:51.028] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:51.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:220:0) after 1m0s
[08:09:51.074] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:220:0)
[08:09:51.074] Timer tick, asking Buildbucket for the build status
[08:09:51.241] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:51.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:221:0) after 1m0s
[08:10:51.468] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:221:0)
[08:10:51.468] Timer tick, asking Buildbucket for the build status
[08:10:51.544] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:51.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:222:0) after 1m0s
[08:11:51.687] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:222:0)
[08:11:51.687] Timer tick, asking Buildbucket for the build status
[08:11:51.783] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:51.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:223:0) after 1m0s
[08:12:51.871] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:223:0)
[08:12:51.871] Timer tick, asking Buildbucket for the build status
[08:12:51.942] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:51.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:224:0) after 1m0s
[08:13:52.121] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:224:0)
[08:13:52.121] Timer tick, asking Buildbucket for the build status
[08:13:52.202] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:52.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:225:0) after 1m0s
[08:14:52.386] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:225:0)
[08:14:52.386] Timer tick, asking Buildbucket for the build status
[08:14:52.962] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:52.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:226:0) after 1m0s
[08:15:53.012] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:226:0)
[08:15:53.012] Timer tick, asking Buildbucket for the build status
[08:15:53.089] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:53.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:227:0) after 1m0s
[08:16:53.134] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:227:0)
[08:16:53.134] Timer tick, asking Buildbucket for the build status
[08:16:53.225] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:53.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:228:0) after 1m0s
[08:17:53.284] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:228:0)
[08:17:53.284] Timer tick, asking Buildbucket for the build status
[08:17:53.406] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:53.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:229:0) after 1m0s
[08:18:53.526] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:229:0)
[08:18:53.526] Timer tick, asking Buildbucket for the build status
[08:18:53.598] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:53.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:230:0) after 1m0s
[08:19:53.608] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:230:0)
[08:19:53.608] Timer tick, asking Buildbucket for the build status
[08:19:53.694] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:53.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:231:0) after 1m0s
[08:20:53.762] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:231:0)
[08:20:53.762] Timer tick, asking Buildbucket for the build status
[08:20:57.095] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:57.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:232:0) after 1m0s
[08:21:57.202] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:232:0)
[08:21:57.202] Timer tick, asking Buildbucket for the build status
[08:21:57.380] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:57.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:233:0) after 1m0s
[08:22:57.393] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:233:0)
[08:22:57.393] Timer tick, asking Buildbucket for the build status
[08:22:57.544] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:57.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:234:0) after 1m0s
[08:23:57.665] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:234:0)
[08:23:57.665] Timer tick, asking Buildbucket for the build status
[08:23:58.204] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:58.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:235:0) after 1m0s
[08:24:58.234] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:235:0)
[08:24:58.234] Timer tick, asking Buildbucket for the build status
[08:24:58.465] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:58.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:236:0) after 1m0s
[08:25:58.638] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:236:0)
[08:25:58.638] Timer tick, asking Buildbucket for the build status
[08:25:58.749] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:58.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:237:0) after 1m0s
[08:26:58.796] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:237:0)
[08:26:58.796] Timer tick, asking Buildbucket for the build status
[08:26:58.928] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:58.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:238:0) after 1m0s
[08:27:59.004] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:238:0)
[08:27:59.004] Timer tick, asking Buildbucket for the build status
[08:27:59.153] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:59.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:239:0) after 1m0s
[08:28:59.254] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:239:0)
[08:28:59.254] Timer tick, asking Buildbucket for the build status
[08:28:59.450] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:59.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:240:0) after 1m0s
[08:29:59.590] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:240:0)
[08:29:59.590] Timer tick, asking Buildbucket for the build status
[08:29:59.699] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:59.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:241:0) after 1m0s
[08:30:59.799] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:241:0)
[08:30:59.799] Timer tick, asking Buildbucket for the build status
[08:30:59.880] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:59.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:242:0) after 1m0s
[08:31:59.899] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:242:0)
[08:31:59.899] Timer tick, asking Buildbucket for the build status
[08:32:00.219] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:00.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:243:0) after 1m0s
[08:33:00.253] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:243:0)
[08:33:00.253] Timer tick, asking Buildbucket for the build status
[08:33:00.320] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:00.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:244:0) after 1m0s
[08:34:00.380] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:244:0)
[08:34:00.380] Timer tick, asking Buildbucket for the build status
[08:34:00.465] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:00.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:245:0) after 1m0s
[08:35:00.465] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:245:0)
[08:35:00.465] Timer tick, asking Buildbucket for the build status
[08:35:01.384] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:01.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:246:0) after 1m0s
[08:36:03.078] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:246:0)
[08:36:03.078] Timer tick, asking Buildbucket for the build status
[08:36:03.153] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:03.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:247:0) after 1m0s
[08:37:04.088] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:247:0)
[08:37:04.088] Timer tick, asking Buildbucket for the build status
[08:37:04.265] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:04.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:248:0) after 1m0s
[08:38:04.327] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:248:0)
[08:38:04.327] Timer tick, asking Buildbucket for the build status
[08:38:04.555] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:04.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:249:0) after 1m0s
[08:39:04.841] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:249:0)
[08:39:04.841] Timer tick, asking Buildbucket for the build status
[08:39:04.952] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:04.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:250:0) after 1m0s
[08:40:05.076] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:250:0)
[08:40:05.076] Timer tick, asking Buildbucket for the build status
[08:40:05.706] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:05.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:251:0) after 1m0s
[08:41:06.041] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:251:0)
[08:41:06.041] Timer tick, asking Buildbucket for the build status
[08:41:07.757] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:07.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:252:0) after 1m0s
[08:42:07.944] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:252:0)
[08:42:07.944] Timer tick, asking Buildbucket for the build status
[08:42:08.025] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:08.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:253:0) after 1m0s
[08:43:08.201] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:253:0)
[08:43:08.201] Timer tick, asking Buildbucket for the build status
[08:43:08.279] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:08.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:254:0) after 1m0s
[08:44:08.317] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:254:0)
[08:44:08.317] Timer tick, asking Buildbucket for the build status
[08:44:08.400] Build 8861963771876241280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:08.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:255:0) after 1m0s
[08:44:46.375] Received PubSub notification, asking Buildbucket for the build status
[08:44:46.457] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:08.437] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:255:0)
[08:45:08.437] Timer tick, asking Buildbucket for the build status
[08:45:08.554] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:08.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:257:0) after 1m0s
[08:46:08.624] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:257:0)
[08:46:08.624] Timer tick, asking Buildbucket for the build status
[08:46:08.820] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:08.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:258:0) after 1m0s
[08:47:08.831] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:258:0)
[08:47:08.831] Timer tick, asking Buildbucket for the build status
[08:47:08.939] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:08.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:259:0) after 1m0s
[08:48:08.980] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:259:0)
[08:48:08.980] Timer tick, asking Buildbucket for the build status
[08:48:09.047] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:09.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:260:0) after 1m0s
[08:49:09.126] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:260:0)
[08:49:09.126] Timer tick, asking Buildbucket for the build status
[08:49:09.234] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:09.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:261:0) after 1m0s
[08:50:09.285] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:261:0)
[08:50:09.285] Timer tick, asking Buildbucket for the build status
[08:50:09.553] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:09.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:262:0) after 1m0s
[08:51:09.595] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:262:0)
[08:51:09.595] Timer tick, asking Buildbucket for the build status
[08:51:09.652] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:09.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:263:0) after 1m0s
[08:52:09.801] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:263:0)
[08:52:09.801] Timer tick, asking Buildbucket for the build status
[08:52:10.024] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:10.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:264:0) after 1m0s
[08:53:10.055] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:264:0)
[08:53:10.055] Timer tick, asking Buildbucket for the build status
[08:53:10.148] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:10.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:265:0) after 1m0s
[08:54:10.200] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:265:0)
[08:54:10.200] Timer tick, asking Buildbucket for the build status
[08:54:10.422] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:10.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:266:0) after 1m0s
[08:55:10.450] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:266:0)
[08:55:10.450] Timer tick, asking Buildbucket for the build status
[08:55:11.721] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:11.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:267:0) after 1m0s
[08:56:11.913] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:267:0)
[08:56:11.913] Timer tick, asking Buildbucket for the build status
[08:56:11.979] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:11.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:268:0) after 1m0s
[08:57:11.990] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:268:0)
[08:57:11.990] Timer tick, asking Buildbucket for the build status
[08:57:12.109] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:12.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:269:0) after 1m0s
[08:58:12.206] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:269:0)
[08:58:12.206] Timer tick, asking Buildbucket for the build status
[08:58:12.504] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:270:0) after 1m0s
[08:59:12.531] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:270:0)
[08:59:12.531] Timer tick, asking Buildbucket for the build status
[08:59:12.604] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:271:0) after 1m0s
[09:00:12.779] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:271:0)
[09:00:12.779] Timer tick, asking Buildbucket for the build status
[09:00:12.956] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:272:0) after 1m0s
[09:01:12.975] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:272:0)
[09:01:12.975] Timer tick, asking Buildbucket for the build status
[09:01:13.095] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:273:0) after 1m0s
[09:02:13.131] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:273:0)
[09:02:13.131] Timer tick, asking Buildbucket for the build status
[09:02:13.382] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:274:0) after 1m0s
[09:03:13.475] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:274:0)
[09:03:13.475] Timer tick, asking Buildbucket for the build status
[09:03:13.605] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:275:0) after 1m0s
[09:04:13.677] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:275:0)
[09:04:13.677] Timer tick, asking Buildbucket for the build status
[09:04:13.759] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:276:0) after 1m0s
[09:05:13.904] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:276:0)
[09:05:13.904] Timer tick, asking Buildbucket for the build status
[09:05:14.397] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:14.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:277:0) after 1m0s
[09:06:14.420] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:277:0)
[09:06:14.420] Timer tick, asking Buildbucket for the build status
[09:06:14.506] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:14.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:278:0) after 1m0s
[09:07:14.577] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:278:0)
[09:07:14.577] Timer tick, asking Buildbucket for the build status
[09:07:14.652] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:14.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:279:0) after 1m0s
[09:08:14.685] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:279:0)
[09:08:14.685] Timer tick, asking Buildbucket for the build status
[09:08:14.742] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:14.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:280:0) after 1m0s
[09:09:14.875] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:280:0)
[09:09:14.875] Timer tick, asking Buildbucket for the build status
[09:09:14.957] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:14.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:281:0) after 1m0s
[09:10:15.008] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:281:0)
[09:10:15.008] Timer tick, asking Buildbucket for the build status
[09:10:15.144] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:15.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:282:0) after 1m0s
[09:11:15.172] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:282:0)
[09:11:15.172] Timer tick, asking Buildbucket for the build status
[09:11:15.970] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:15.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:283:0) after 1m0s
[09:12:16.086] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:283:0)
[09:12:16.086] Timer tick, asking Buildbucket for the build status
[09:12:16.338] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:16.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:284:0) after 1m0s
[09:13:16.365] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:284:0)
[09:13:16.365] Timer tick, asking Buildbucket for the build status
[09:13:16.513] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:16.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:285:0) after 1m0s
[09:14:16.604] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:285:0)
[09:14:16.604] Timer tick, asking Buildbucket for the build status
[09:14:16.781] Build 8861963771876241280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:16.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9027393836357966960:286:0) after 1m0s
[09:14:38.175] Received PubSub notification, asking Buildbucket for the build status
[09:14:38.450] Build 8861963771876241280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:14:38.450] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606986876708211",
"created_by": "project:chromium",
"created_ts": "1606969780046806",
"id": "8861963771876241280",
"parameters_json": "{\"builder_name\": \"win-upload-perfetto\", \"properties\": {}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"4fed84924dd6004580d2d47cc3f67c030697289d\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-8-1-7m4b\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1810, \"got_angle_revision\": \"8670d6183a8439622e5f4527e4971bafb1a9ffa7\", \"got_dawn_revision\": \"3668d352bc5fe13af27dc178d203f67032537a7f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"4fed84924dd6004580d2d47cc3f67c030697289d\", \"got_revision_cp\": \"refs/heads/master@{#833206}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"2c0399211ca667c8af5cd5e98bee65b180e356a2\", \"got_v8_revision_cp\": \"refs/heads/8.9.89@{#1}\", \"got_webrtc_revision\": \"6e7167456b5eba36c7985d6a74f1d191958d4e0f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32749}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#833206}_without_patch\": {\"upload_trace_processor\": \"6dabb1f634ed0fe62a3e50202cf128915163ed3c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_48ce158d992f85c54a400240cc3d77408bb96a2369de806c235fde7d7ef64068_v2\", \"builder_50caedf96d092a2fa7deb66b1ab2e23d963d80586891ff4a59d00bee7305ac9e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-8-1-7m4b\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606985085653515",
"status": "COMPLETED",
"status_changed_ts": "1606986877869673",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1810",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9027393836357966960",
"scheduler_job_id:chromium/win-upload-perfetto",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861963771876241280/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:503fae7393f16910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606986877876618",
"url": "https://ci.chromium.org/b/8861963771876241280",
"utcnow_ts": "1606986878389601"
}
}
[09:14:38.450] Invocation finished in 4h45m2.060891034s with status SUCCEEDED