[16:16:09.721] New invocation is queued and will start shortly
[16:16:11.370] Starting the invocation (attempt 1)
[16:16:11.424] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:16:11.424] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:16:11.424] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028345950388268032",
"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:9028345950388268032",
"scheduler_job_id:chromium/win-upload-perfetto",
"user_agent:luci-scheduler"
]
}
[16:16:13.112] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606061771601155",
"id": "8862915887739583760",
"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": "1606061772714894",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1777",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9028345950388268032",
"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/8862915887739583760/+/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": "1606061772715041",
"url": "https://ci.chromium.org/b/8862915887739583760",
"utcnow_ts": "1606061773044919"
}
}
[16:16:13.112] Task URL: https://ci.chromium.org/b/8862915887739583760
[16:16:13.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:2:0) after 1m0s
[16:17:13.300] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:2:0)
[16:17:13.300] Timer tick, asking Buildbucket for the build status
[16:17:13.411] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:13.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:3:0) after 1m0s
[16:18:13.487] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:3:0)
[16:18:13.487] Timer tick, asking Buildbucket for the build status
[16:18:13.568] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:13.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:4:0) after 1m0s
[16:19:13.681] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:4:0)
[16:19:13.681] Timer tick, asking Buildbucket for the build status
[16:19:13.772] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:13.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:5:0) after 1m0s
[16:20:13.872] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:5:0)
[16:20:13.872] Timer tick, asking Buildbucket for the build status
[16:20:14.052] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:14.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:6:0) after 1m0s
[16:21:14.189] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:6:0)
[16:21:14.189] Timer tick, asking Buildbucket for the build status
[16:21:14.279] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:14.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:7:0) after 1m0s
[16:22:14.301] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:7:0)
[16:22:14.301] Timer tick, asking Buildbucket for the build status
[16:22:14.799] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:14.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:8:0) after 1m0s
[16:23:14.896] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:8:0)
[16:23:14.896] Timer tick, asking Buildbucket for the build status
[16:23:15.026] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:15.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:9:0) after 1m0s
[16:24:15.100] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:9:0)
[16:24:15.100] Timer tick, asking Buildbucket for the build status
[16:24:15.214] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:10:0) after 1m0s
[16:25:15.342] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:10:0)
[16:25:15.342] Timer tick, asking Buildbucket for the build status
[16:25:15.554] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:15.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:11:0) after 1m0s
[16:26:15.604] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:11:0)
[16:26:15.604] Timer tick, asking Buildbucket for the build status
[16:26:15.708] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:15.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:12:0) after 1m0s
[16:27:15.731] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:12:0)
[16:27:15.731] Timer tick, asking Buildbucket for the build status
[16:27:16.167] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:16.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:13:0) after 1m0s
[16:28:16.318] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:13:0)
[16:28:16.318] Timer tick, asking Buildbucket for the build status
[16:28:16.390] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:16.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:14:0) after 1m0s
[16:29:16.462] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:14:0)
[16:29:16.462] Timer tick, asking Buildbucket for the build status
[16:29:16.534] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:16.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:15:0) after 1m0s
[16:30:16.516] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:15:0)
[16:30:16.516] Timer tick, asking Buildbucket for the build status
[16:30:16.819] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:30:16.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:16:0) after 1m0s
[16:31:17.046] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:16:0)
[16:31:17.046] Timer tick, asking Buildbucket for the build status
[16:31:17.135] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:17:0) after 1m0s
[16:32:17.260] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:17:0)
[16:32:17.260] Timer tick, asking Buildbucket for the build status
[16:32:17.458] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:17.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:18:0) after 1m0s
[16:33:17.528] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:18:0)
[16:33:17.528] Timer tick, asking Buildbucket for the build status
[16:33:17.611] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:17.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:19:0) after 1m0s
[16:34:17.643] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:19:0)
[16:34:17.643] Timer tick, asking Buildbucket for the build status
[16:34:17.756] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:17.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:20:0) after 1m0s
[16:35:17.822] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:20:0)
[16:35:17.822] Timer tick, asking Buildbucket for the build status
[16:35:17.906] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:35:17.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:21:0) after 1m0s
[16:36:17.942] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:21:0)
[16:36:17.942] Timer tick, asking Buildbucket for the build status
[16:36:18.108] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:36:18.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:22:0) after 1m0s
[16:37:18.186] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:22:0)
[16:37:18.186] Timer tick, asking Buildbucket for the build status
[16:37:18.389] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:37:18.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:23:0) after 1m0s
[16:38:18.475] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:23:0)
[16:38:18.475] Timer tick, asking Buildbucket for the build status
[16:38:18.653] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:18.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:24:0) after 1m0s
[16:39:18.706] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:24:0)
[16:39:18.706] Timer tick, asking Buildbucket for the build status
[16:39:18.776] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:18.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:25:0) after 1m0s
[16:40:18.872] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:25:0)
[16:40:18.872] Timer tick, asking Buildbucket for the build status
[16:40:18.959] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:18.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:26:0) after 1m0s
[16:41:18.981] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:26:0)
[16:41:18.981] Timer tick, asking Buildbucket for the build status
[16:41:19.097] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:19.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:27:0) after 1m0s
[16:42:19.119] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:27:0)
[16:42:19.119] Timer tick, asking Buildbucket for the build status
[16:42:19.557] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:19.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:28:0) after 1m0s
[16:43:19.702] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:28:0)
[16:43:19.702] Timer tick, asking Buildbucket for the build status
[16:43:19.865] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:19.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:29:0) after 1m0s
[16:44:19.949] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:29:0)
[16:44:19.949] Timer tick, asking Buildbucket for the build status
[16:44:20.028] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:20.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:30:0) after 1m0s
[16:45:20.078] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:30:0)
[16:45:20.078] Timer tick, asking Buildbucket for the build status
[16:45:20.156] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:20.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:31:0) after 1m0s
[16:46:20.220] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:31:0)
[16:46:20.220] Timer tick, asking Buildbucket for the build status
[16:46:20.326] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:20.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:32:0) after 1m0s
[16:47:20.347] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:32:0)
[16:47:20.347] Timer tick, asking Buildbucket for the build status
[16:47:20.443] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:20.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:33:0) after 1m0s
[16:48:20.506] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:33:0)
[16:48:20.506] Timer tick, asking Buildbucket for the build status
[16:48:20.587] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:20.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:34:0) after 1m0s
[16:49:20.618] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:34:0)
[16:49:20.618] Timer tick, asking Buildbucket for the build status
[16:49:20.710] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:20.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:35:0) after 1m0s
[16:50:20.729] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:35:0)
[16:50:20.729] Timer tick, asking Buildbucket for the build status
[16:50:20.809] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:20.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:36:0) after 1m0s
[16:51:20.874] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:36:0)
[16:51:20.874] Timer tick, asking Buildbucket for the build status
[16:51:20.947] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:20.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:37:0) after 1m0s
[16:52:21.060] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:37:0)
[16:52:21.061] Timer tick, asking Buildbucket for the build status
[16:52:21.165] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:21.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:38:0) after 1m0s
[16:53:21.375] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:38:0)
[16:53:21.375] Timer tick, asking Buildbucket for the build status
[16:53:21.438] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:21.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:39:0) after 1m0s
[16:54:21.445] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:39:0)
[16:54:21.445] Timer tick, asking Buildbucket for the build status
[16:54:21.517] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:21.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:40:0) after 1m0s
[16:55:21.536] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:40:0)
[16:55:21.536] Timer tick, asking Buildbucket for the build status
[16:55:21.613] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:21.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:41:0) after 1m0s
[16:56:21.635] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:41:0)
[16:56:21.635] Timer tick, asking Buildbucket for the build status
[16:56:21.703] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:21.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:42:0) after 1m0s
[16:57:21.722] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:42:0)
[16:57:21.722] Timer tick, asking Buildbucket for the build status
[16:57:21.821] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:21.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:43:0) after 1m0s
[16:58:21.850] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:43:0)
[16:58:21.850] Timer tick, asking Buildbucket for the build status
[16:58:21.917] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:21.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:44:0) after 1m0s
[16:59:21.944] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:44:0)
[16:59:21.944] Timer tick, asking Buildbucket for the build status
[16:59:22.022] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:22.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:45:0) after 1m0s
[17:00:22.057] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:45:0)
[17:00:22.057] Timer tick, asking Buildbucket for the build status
[17:00:22.133] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:46:0) after 1m0s
[17:01:22.161] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:46:0)
[17:01:22.161] Timer tick, asking Buildbucket for the build status
[17:01:22.234] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:22.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:47:0) after 1m0s
[17:02:22.260] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:47:0)
[17:02:22.260] Timer tick, asking Buildbucket for the build status
[17:02:22.624] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:22.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:48:0) after 1m0s
[17:03:22.672] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:48:0)
[17:03:22.672] Timer tick, asking Buildbucket for the build status
[17:03:22.861] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:22.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:49:0) after 1m0s
[17:04:22.911] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:49:0)
[17:04:22.911] Timer tick, asking Buildbucket for the build status
[17:04:22.991] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:22.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:50:0) after 1m0s
[17:05:23.012] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:50:0)
[17:05:23.012] Timer tick, asking Buildbucket for the build status
[17:05:23.094] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:23.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:51:0) after 1m0s
[17:06:23.124] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:51:0)
[17:06:23.124] Timer tick, asking Buildbucket for the build status
[17:06:23.869] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:23.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:52:0) after 1m0s
[17:07:23.946] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:52:0)
[17:07:23.946] Timer tick, asking Buildbucket for the build status
[17:07:24.063] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:24.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:53:0) after 1m0s
[17:08:24.166] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:53:0)
[17:08:24.166] Timer tick, asking Buildbucket for the build status
[17:08:24.242] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:24.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:54:0) after 1m0s
[17:09:24.324] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:54:0)
[17:09:24.324] Timer tick, asking Buildbucket for the build status
[17:09:24.404] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:24.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:55:0) after 1m0s
[17:10:24.473] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:55:0)
[17:10:24.473] Timer tick, asking Buildbucket for the build status
[17:10:24.541] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:24.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:56:0) after 1m0s
[17:11:24.648] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:56:0)
[17:11:24.648] Timer tick, asking Buildbucket for the build status
[17:11:24.872] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:24.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:57:0) after 1m0s
[17:12:24.902] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:57:0)
[17:12:24.902] Timer tick, asking Buildbucket for the build status
[17:12:25.008] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:25.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:58:0) after 1m0s
[17:13:25.110] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:58:0)
[17:13:25.110] Timer tick, asking Buildbucket for the build status
[17:13:25.239] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:25.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:59:0) after 1m0s
[17:14:25.281] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:59:0)
[17:14:25.281] Timer tick, asking Buildbucket for the build status
[17:14:25.462] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:25.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:60:0) after 1m0s
[17:15:25.521] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:60:0)
[17:15:25.521] Timer tick, asking Buildbucket for the build status
[17:15:25.601] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:25.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:61:0) after 1m0s
[17:16:25.647] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:61:0)
[17:16:25.647] Timer tick, asking Buildbucket for the build status
[17:16:25.827] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:25.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:62:0) after 1m0s
[17:17:25.856] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:62:0)
[17:17:25.856] Timer tick, asking Buildbucket for the build status
[17:17:25.958] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:25.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:63:0) after 1m0s
[17:18:25.986] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:63:0)
[17:18:25.986] Timer tick, asking Buildbucket for the build status
[17:18:26.053] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:26.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:64:0) after 1m0s
[17:19:26.146] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:64:0)
[17:19:26.146] Timer tick, asking Buildbucket for the build status
[17:19:26.413] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:26.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:65:0) after 1m0s
[17:20:26.467] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:65:0)
[17:20:26.467] Timer tick, asking Buildbucket for the build status
[17:20:26.538] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:26.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:66:0) after 1m0s
[17:21:26.579] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:66:0)
[17:21:26.579] Timer tick, asking Buildbucket for the build status
[17:21:26.677] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:21:26.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:67:0) after 1m0s
[17:22:26.754] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:67:0)
[17:22:26.754] Timer tick, asking Buildbucket for the build status
[17:22:29.421] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:22:29.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:68:0) after 1m0s
[17:23:29.484] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:68:0)
[17:23:29.484] Timer tick, asking Buildbucket for the build status
[17:23:29.560] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:23:29.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:69:0) after 1m0s
[17:24:29.599] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:69:0)
[17:24:29.599] Timer tick, asking Buildbucket for the build status
[17:24:29.681] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:24:29.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:70:0) after 1m0s
[17:25:29.706] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:70:0)
[17:25:29.706] Timer tick, asking Buildbucket for the build status
[17:25:29.786] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:25:29.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:71:0) after 1m0s
[17:26:29.832] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:71:0)
[17:26:29.832] Timer tick, asking Buildbucket for the build status
[17:26:30.107] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:26:30.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:72:0) after 1m0s
[17:27:30.260] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:72:0)
[17:27:30.260] Timer tick, asking Buildbucket for the build status
[17:27:30.436] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:27:30.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:73:0) after 1m0s
[17:28:30.488] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:73:0)
[17:28:30.488] Timer tick, asking Buildbucket for the build status
[17:28:30.558] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:30.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:74:0) after 1m0s
[17:29:30.589] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:74:0)
[17:29:30.589] Timer tick, asking Buildbucket for the build status
[17:29:30.659] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:30.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:75:0) after 1m0s
[17:30:30.700] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:75:0)
[17:30:30.700] Timer tick, asking Buildbucket for the build status
[17:30:30.779] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:30.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:76:0) after 1m0s
[17:31:30.905] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:76:0)
[17:31:30.905] Timer tick, asking Buildbucket for the build status
[17:31:31.330] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:31.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:77:0) after 1m0s
[17:32:31.377] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:77:0)
[17:32:31.377] Timer tick, asking Buildbucket for the build status
[17:32:31.475] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:78:0) after 1m0s
[17:33:31.568] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:78:0)
[17:33:31.568] Timer tick, asking Buildbucket for the build status
[17:33:31.654] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:31.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:79:0) after 1m0s
[17:34:31.710] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:79:0)
[17:34:31.710] Timer tick, asking Buildbucket for the build status
[17:34:31.792] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:31.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:80:0) after 1m0s
[17:35:31.836] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:80:0)
[17:35:31.836] Timer tick, asking Buildbucket for the build status
[17:35:32.153] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:32.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:81:0) after 1m0s
[17:36:32.196] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:81:0)
[17:36:32.196] Timer tick, asking Buildbucket for the build status
[17:36:33.388] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:33.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:82:0) after 1m0s
[17:37:37.013] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:82:0)
[17:37:37.013] Timer tick, asking Buildbucket for the build status
[17:37:37.296] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:37.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:83:0) after 1m0s
[17:38:37.815] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:83:0)
[17:38:37.815] Timer tick, asking Buildbucket for the build status
[17:38:38.004] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:38.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:84:0) after 1m0s
[17:39:38.184] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:84:0)
[17:39:38.184] Timer tick, asking Buildbucket for the build status
[17:39:38.492] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:38.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:85:0) after 1m0s
[17:40:38.767] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:85:0)
[17:40:38.767] Timer tick, asking Buildbucket for the build status
[17:40:38.884] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:86:0) after 1m0s
[17:41:39.150] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:86:0)
[17:41:39.150] Timer tick, asking Buildbucket for the build status
[17:41:39.610] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:39.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:87:0) after 1m0s
[17:42:39.633] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:87:0)
[17:42:39.633] Timer tick, asking Buildbucket for the build status
[17:42:39.712] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:39.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:88:0) after 1m0s
[17:43:39.908] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:88:0)
[17:43:39.908] Timer tick, asking Buildbucket for the build status
[17:43:39.993] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:39.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:89:0) after 1m0s
[17:44:40.163] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:89:0)
[17:44:40.163] Timer tick, asking Buildbucket for the build status
[17:44:40.246] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:40.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:90:0) after 1m0s
[17:45:40.631] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:90:0)
[17:45:40.631] Timer tick, asking Buildbucket for the build status
[17:45:40.718] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:40.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:91:0) after 1m0s
[17:46:40.915] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:91:0)
[17:46:40.915] Timer tick, asking Buildbucket for the build status
[17:46:41.012] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:41.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:92:0) after 1m0s
[17:47:41.049] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:92:0)
[17:47:41.049] Timer tick, asking Buildbucket for the build status
[17:47:41.119] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:41.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:93:0) after 1m0s
[17:48:41.376] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:93:0)
[17:48:41.376] Timer tick, asking Buildbucket for the build status
[17:48:41.463] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:41.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:94:0) after 1m0s
[17:49:41.621] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:94:0)
[17:49:41.621] Timer tick, asking Buildbucket for the build status
[17:49:41.695] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:41.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:95:0) after 1m0s
[17:50:41.808] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:95:0)
[17:50:41.808] Timer tick, asking Buildbucket for the build status
[17:50:41.891] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:41.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:96:0) after 1m0s
[17:51:42.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:96:0)
[17:51:42.272] Timer tick, asking Buildbucket for the build status
[17:51:42.370] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:42.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:97:0) after 1m0s
[17:52:42.473] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:97:0)
[17:52:42.473] Timer tick, asking Buildbucket for the build status
[17:52:42.541] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:42.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:98:0) after 1m0s
[17:53:42.669] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:98:0)
[17:53:42.669] Timer tick, asking Buildbucket for the build status
[17:53:42.741] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:42.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:99:0) after 1m0s
[17:54:42.847] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:99:0)
[17:54:42.847] Timer tick, asking Buildbucket for the build status
[17:54:43.028] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:43.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:100:0) after 1m0s
[17:55:43.186] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:100:0)
[17:55:43.186] Timer tick, asking Buildbucket for the build status
[17:55:43.261] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:43.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:101:0) after 1m0s
[17:56:43.445] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:101:0)
[17:56:43.445] Timer tick, asking Buildbucket for the build status
[17:56:43.548] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:43.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:102:0) after 1m0s
[17:57:43.777] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:102:0)
[17:57:43.777] Timer tick, asking Buildbucket for the build status
[17:57:43.876] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:43.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:103:0) after 1m0s
[17:58:43.965] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:103:0)
[17:58:43.965] Timer tick, asking Buildbucket for the build status
[17:58:44.308] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:44.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:104:0) after 1m0s
[17:59:44.388] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:104:0)
[17:59:44.388] Timer tick, asking Buildbucket for the build status
[17:59:44.568] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:44.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:105:0) after 1m0s
[18:00:44.899] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:105:0)
[18:00:44.899] Timer tick, asking Buildbucket for the build status
[18:00:44.987] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:44.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:106:0) after 1m0s
[18:01:45.156] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:106:0)
[18:01:45.156] Timer tick, asking Buildbucket for the build status
[18:01:45.270] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:45.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:107:0) after 1m0s
[18:02:45.337] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:107:0)
[18:02:45.337] Timer tick, asking Buildbucket for the build status
[18:02:45.471] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:108:0) after 1m0s
[18:03:45.491] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:108:0)
[18:03:45.491] Timer tick, asking Buildbucket for the build status
[18:03:45.584] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:45.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:109:0) after 1m0s
[18:04:45.758] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:109:0)
[18:04:45.758] Timer tick, asking Buildbucket for the build status
[18:04:45.836] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:45.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:110:0) after 1m0s
[18:05:45.986] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:110:0)
[18:05:45.986] Timer tick, asking Buildbucket for the build status
[18:05:46.144] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:46.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:111:0) after 1m0s
[18:06:46.284] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:111:0)
[18:06:46.284] Timer tick, asking Buildbucket for the build status
[18:06:46.403] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:46.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:112:0) after 1m0s
[18:07:46.428] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:112:0)
[18:07:46.428] Timer tick, asking Buildbucket for the build status
[18:07:46.500] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:46.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:113:0) after 1m0s
[18:08:46.517] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:113:0)
[18:08:46.517] Timer tick, asking Buildbucket for the build status
[18:08:46.613] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:46.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:114:0) after 1m0s
[18:09:46.656] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:114:0)
[18:09:46.656] Timer tick, asking Buildbucket for the build status
[18:09:46.779] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:46.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:115:0) after 1m0s
[18:10:46.848] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:115:0)
[18:10:46.848] Timer tick, asking Buildbucket for the build status
[18:10:47.104] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:47.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:116:0) after 1m0s
[18:11:47.177] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:116:0)
[18:11:47.177] Timer tick, asking Buildbucket for the build status
[18:11:47.279] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:47.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:117:0) after 1m0s
[18:12:47.277] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:117:0)
[18:12:47.277] Timer tick, asking Buildbucket for the build status
[18:12:47.343] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:47.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:118:0) after 1m0s
[18:13:47.372] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:118:0)
[18:13:47.372] Timer tick, asking Buildbucket for the build status
[18:13:47.443] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:47.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:119:0) after 1m0s
[18:14:47.471] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:119:0)
[18:14:47.471] Timer tick, asking Buildbucket for the build status
[18:14:47.549] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:47.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:120:0) after 1m0s
[18:15:47.579] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:120:0)
[18:15:47.579] Timer tick, asking Buildbucket for the build status
[18:15:47.831] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:47.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:121:0) after 1m0s
[18:16:47.856] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:121:0)
[18:16:47.856] Timer tick, asking Buildbucket for the build status
[18:16:48.255] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:48.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:122:0) after 1m0s
[18:17:48.239] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:122:0)
[18:17:48.239] Timer tick, asking Buildbucket for the build status
[18:17:48.498] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:48.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:123:0) after 1m0s
[18:18:48.655] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:123:0)
[18:18:48.655] Timer tick, asking Buildbucket for the build status
[18:18:48.723] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:48.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:124:0) after 1m0s
[18:19:48.901] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:124:0)
[18:19:48.901] Timer tick, asking Buildbucket for the build status
[18:19:48.978] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:48.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:125:0) after 1m0s
[18:20:49.198] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:125:0)
[18:20:49.198] Timer tick, asking Buildbucket for the build status
[18:20:49.274] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:49.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:126:0) after 1m0s
[18:21:49.374] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:126:0)
[18:21:49.374] Timer tick, asking Buildbucket for the build status
[18:21:49.541] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:49.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:127:0) after 1m0s
[18:22:49.622] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:127:0)
[18:22:49.622] Timer tick, asking Buildbucket for the build status
[18:22:49.722] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:49.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:128:0) after 1m0s
[18:23:49.747] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:128:0)
[18:23:49.747] Timer tick, asking Buildbucket for the build status
[18:23:49.898] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:49.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:129:0) after 1m0s
[18:24:49.923] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:129:0)
[18:24:49.923] Timer tick, asking Buildbucket for the build status
[18:24:50.713] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:50.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:130:0) after 1m0s
[18:25:50.837] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:130:0)
[18:25:50.837] Timer tick, asking Buildbucket for the build status
[18:25:50.958] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:50.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:131:0) after 1m0s
[18:26:50.981] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:131:0)
[18:26:50.981] Timer tick, asking Buildbucket for the build status
[18:26:51.081] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:51.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:132:0) after 1m0s
[18:27:51.144] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:132:0)
[18:27:51.144] Timer tick, asking Buildbucket for the build status
[18:27:51.219] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:51.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:133:0) after 1m0s
[18:28:51.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:133:0)
[18:28:51.272] Timer tick, asking Buildbucket for the build status
[18:28:51.346] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:51.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:134:0) after 1m0s
[18:29:51.370] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:134:0)
[18:29:51.370] Timer tick, asking Buildbucket for the build status
[18:29:51.449] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:51.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:135:0) after 1m0s
[18:30:51.460] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:135:0)
[18:30:51.460] Timer tick, asking Buildbucket for the build status
[18:30:51.602] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:51.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:136:0) after 1m0s
[18:31:51.589] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:136:0)
[18:31:51.589] Timer tick, asking Buildbucket for the build status
[18:31:51.691] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:51.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:137:0) after 1m0s
[18:32:51.768] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:137:0)
[18:32:51.768] Timer tick, asking Buildbucket for the build status
[18:32:52.014] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:52.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:138:0) after 1m0s
[18:33:52.038] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:138:0)
[18:33:52.038] Timer tick, asking Buildbucket for the build status
[18:33:52.338] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:52.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:139:0) after 1m0s
[18:34:52.360] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:139:0)
[18:34:52.360] Timer tick, asking Buildbucket for the build status
[18:34:52.544] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:52.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:140:0) after 1m0s
[18:35:52.643] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:140:0)
[18:35:52.643] Timer tick, asking Buildbucket for the build status
[18:35:52.766] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:52.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:141:0) after 1m0s
[18:36:52.802] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:141:0)
[18:36:52.802] Timer tick, asking Buildbucket for the build status
[18:36:52.903] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:52.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:142:0) after 1m0s
[18:37:53.009] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:142:0)
[18:37:53.009] Timer tick, asking Buildbucket for the build status
[18:37:53.071] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:53.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:143:0) after 1m0s
[18:38:53.107] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:143:0)
[18:38:53.107] Timer tick, asking Buildbucket for the build status
[18:38:53.217] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:53.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:144:0) after 1m0s
[18:39:53.296] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:144:0)
[18:39:53.296] Timer tick, asking Buildbucket for the build status
[18:39:53.405] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:53.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:145:0) after 1m0s
[18:40:53.460] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:145:0)
[18:40:53.460] Timer tick, asking Buildbucket for the build status
[18:40:53.529] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:53.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:146:0) after 1m0s
[18:41:53.569] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:146:0)
[18:41:53.569] Timer tick, asking Buildbucket for the build status
[18:41:53.858] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:53.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:147:0) after 1m0s
[18:42:53.880] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:147:0)
[18:42:53.880] Timer tick, asking Buildbucket for the build status
[18:42:53.959] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:53.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:148:0) after 1m0s
[18:43:54.032] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:148:0)
[18:43:54.032] Timer tick, asking Buildbucket for the build status
[18:43:54.097] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:54.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:149:0) after 1m0s
[18:44:54.127] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:149:0)
[18:44:54.127] Timer tick, asking Buildbucket for the build status
[18:44:54.276] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:54.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:150:0) after 1m0s
[18:45:54.329] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:150:0)
[18:45:54.329] Timer tick, asking Buildbucket for the build status
[18:45:54.406] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:54.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:151:0) after 1m0s
[18:46:54.467] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:151:0)
[18:46:54.467] Timer tick, asking Buildbucket for the build status
[18:46:54.568] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:54.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:152:0) after 1m0s
[18:47:54.624] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:152:0)
[18:47:54.624] Timer tick, asking Buildbucket for the build status
[18:47:54.721] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:153:0) after 1m0s
[18:48:54.744] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:153:0)
[18:48:54.744] Timer tick, asking Buildbucket for the build status
[18:48:54.804] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:54.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:154:0) after 1m0s
[18:49:54.829] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:154:0)
[18:49:54.829] Timer tick, asking Buildbucket for the build status
[18:49:54.889] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:54.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:155:0) after 1m0s
[18:50:54.923] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:155:0)
[18:50:54.923] Timer tick, asking Buildbucket for the build status
[18:50:55.036] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:55.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:156:0) after 1m0s
[18:51:55.106] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:156:0)
[18:51:55.106] Timer tick, asking Buildbucket for the build status
[18:51:55.207] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:55.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:157:0) after 1m0s
[18:52:55.228] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:157:0)
[18:52:55.228] Timer tick, asking Buildbucket for the build status
[18:52:55.299] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:55.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:158:0) after 1m0s
[18:53:55.355] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:158:0)
[18:53:55.355] Timer tick, asking Buildbucket for the build status
[18:53:55.427] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:55.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:159:0) after 1m0s
[18:54:55.479] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:159:0)
[18:54:55.479] Timer tick, asking Buildbucket for the build status
[18:54:55.584] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:55.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:160:0) after 1m0s
[18:55:55.585] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:160:0)
[18:55:55.585] Timer tick, asking Buildbucket for the build status
[18:55:55.672] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:55.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:161:0) after 1m0s
[18:56:55.699] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:161:0)
[18:56:55.699] Timer tick, asking Buildbucket for the build status
[18:56:56.188] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:56.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:162:0) after 1m0s
[18:57:56.211] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:162:0)
[18:57:56.211] Timer tick, asking Buildbucket for the build status
[18:57:56.286] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:56.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:163:0) after 1m0s
[18:58:56.311] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:163:0)
[18:58:56.311] Timer tick, asking Buildbucket for the build status
[18:58:56.381] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:56.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:164:0) after 1m0s
[18:59:56.384] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:164:0)
[18:59:56.384] Timer tick, asking Buildbucket for the build status
[18:59:56.476] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:56.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:165:0) after 1m0s
[19:00:56.564] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:165:0)
[19:00:56.564] Timer tick, asking Buildbucket for the build status
[19:00:56.810] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:56.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:166:0) after 1m0s
[19:01:56.897] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:166:0)
[19:01:56.897] Timer tick, asking Buildbucket for the build status
[19:01:56.998] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:56.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:167:0) after 1m0s
[19:02:57.031] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:167:0)
[19:02:57.031] Timer tick, asking Buildbucket for the build status
[19:02:57.102] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:168:0) after 1m0s
[19:03:57.128] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:168:0)
[19:03:57.128] Timer tick, asking Buildbucket for the build status
[19:03:57.197] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:57.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:169:0) after 1m0s
[19:04:57.267] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:169:0)
[19:04:57.267] Timer tick, asking Buildbucket for the build status
[19:04:57.454] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:57.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:170:0) after 1m0s
[19:05:57.554] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:170:0)
[19:05:57.554] Timer tick, asking Buildbucket for the build status
[19:05:57.852] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:57.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:171:0) after 1m0s
[19:06:57.916] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:171:0)
[19:06:57.916] Timer tick, asking Buildbucket for the build status
[19:06:58.135] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:58.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:172:0) after 1m0s
[19:07:58.161] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:172:0)
[19:07:58.161] Timer tick, asking Buildbucket for the build status
[19:07:58.224] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:58.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:173:0) after 1m0s
[19:08:58.276] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:173:0)
[19:08:58.276] Timer tick, asking Buildbucket for the build status
[19:08:58.342] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:58.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:174:0) after 1m0s
[19:09:58.405] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:174:0)
[19:09:58.405] Timer tick, asking Buildbucket for the build status
[19:09:58.713] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:58.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:175:0) after 1m0s
[19:10:58.741] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:175:0)
[19:10:58.741] Timer tick, asking Buildbucket for the build status
[19:10:59.050] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:59.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:176:0) after 1m0s
[19:11:59.075] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:176:0)
[19:11:59.075] Timer tick, asking Buildbucket for the build status
[19:11:59.181] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:59.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:177:0) after 1m0s
[19:12:59.196] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:177:0)
[19:12:59.196] Timer tick, asking Buildbucket for the build status
[19:12:59.378] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:59.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:178:0) after 1m0s
[19:13:59.363] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:178:0)
[19:13:59.363] Timer tick, asking Buildbucket for the build status
[19:13:59.437] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:59.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:179:0) after 1m0s
[19:14:59.491] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:179:0)
[19:14:59.491] Timer tick, asking Buildbucket for the build status
[19:14:59.589] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:59.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:180:0) after 1m0s
[19:15:59.652] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:180:0)
[19:15:59.652] Timer tick, asking Buildbucket for the build status
[19:15:59.795] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:59.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:181:0) after 1m0s
[19:16:59.821] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:181:0)
[19:16:59.821] Timer tick, asking Buildbucket for the build status
[19:16:59.923] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:59.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:182:0) after 1m0s
[19:17:59.946] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:182:0)
[19:17:59.946] Timer tick, asking Buildbucket for the build status
[19:18:00.154] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:00.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:183:0) after 1m0s
[19:19:00.214] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:183:0)
[19:19:00.214] Timer tick, asking Buildbucket for the build status
[19:19:00.285] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:00.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:184:0) after 1m0s
[19:20:00.349] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:184:0)
[19:20:00.349] Timer tick, asking Buildbucket for the build status
[19:20:00.524] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:00.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:185:0) after 1m0s
[19:21:00.866] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:185:0)
[19:21:00.866] Timer tick, asking Buildbucket for the build status
[19:21:00.996] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:00.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:186:0) after 1m0s
[19:22:01.035] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:186:0)
[19:22:01.035] Timer tick, asking Buildbucket for the build status
[19:22:01.243] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:01.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:187:0) after 1m0s
[19:23:01.463] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:187:0)
[19:23:01.463] Timer tick, asking Buildbucket for the build status
[19:23:01.537] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:01.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:188:0) after 1m0s
[19:24:01.565] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:188:0)
[19:24:01.565] Timer tick, asking Buildbucket for the build status
[19:24:01.648] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:01.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:189:0) after 1m0s
[19:25:01.631] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:189:0)
[19:25:01.631] Timer tick, asking Buildbucket for the build status
[19:25:01.720] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:01.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:190:0) after 1m0s
[19:26:01.748] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:190:0)
[19:26:01.748] Timer tick, asking Buildbucket for the build status
[19:26:01.857] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:01.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:191:0) after 1m0s
[19:27:01.911] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:191:0)
[19:27:01.911] Timer tick, asking Buildbucket for the build status
[19:27:02.036] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:02.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:192:0) after 1m0s
[19:28:02.106] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:192:0)
[19:28:02.106] Timer tick, asking Buildbucket for the build status
[19:28:02.172] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:02.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:193:0) after 1m0s
[19:29:02.306] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:193:0)
[19:29:02.306] Timer tick, asking Buildbucket for the build status
[19:29:02.431] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:02.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:194:0) after 1m0s
[19:30:02.516] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:194:0)
[19:30:02.516] Timer tick, asking Buildbucket for the build status
[19:30:02.724] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:02.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:195:0) after 1m0s
[19:31:02.762] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:195:0)
[19:31:02.762] Timer tick, asking Buildbucket for the build status
[19:31:02.835] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:02.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:196:0) after 1m0s
[19:32:02.964] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:196:0)
[19:32:02.964] Timer tick, asking Buildbucket for the build status
[19:32:03.088] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:03.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:197:0) after 1m0s
[19:33:03.186] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:197:0)
[19:33:03.186] Timer tick, asking Buildbucket for the build status
[19:33:03.330] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:03.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:198:0) after 1m0s
[19:34:03.873] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:198:0)
[19:34:03.873] Timer tick, asking Buildbucket for the build status
[19:34:04.156] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:04.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:199:0) after 1m0s
[19:35:04.576] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:199:0)
[19:35:04.576] Timer tick, asking Buildbucket for the build status
[19:35:04.893] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:04.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:200:0) after 1m0s
[19:36:05.265] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:200:0)
[19:36:05.266] Timer tick, asking Buildbucket for the build status
[19:36:05.346] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:05.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:201:0) after 1m0s
[19:37:05.850] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:201:0)
[19:37:05.850] Timer tick, asking Buildbucket for the build status
[19:37:05.948] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:05.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:202:0) after 1m0s
[19:38:06.121] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:202:0)
[19:38:06.121] Timer tick, asking Buildbucket for the build status
[19:38:06.200] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:06.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:203:0) after 1m0s
[19:39:06.402] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:203:0)
[19:39:06.402] Timer tick, asking Buildbucket for the build status
[19:39:06.468] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:06.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:204:0) after 1m0s
[19:40:06.716] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:204:0)
[19:40:06.716] Timer tick, asking Buildbucket for the build status
[19:40:06.786] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:205:0) after 1m0s
[19:41:07.673] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:205:0)
[19:41:07.673] Timer tick, asking Buildbucket for the build status
[19:41:07.884] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:07.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:206:0) after 1m0s
[19:42:08.076] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:206:0)
[19:42:08.076] Timer tick, asking Buildbucket for the build status
[19:42:08.166] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:08.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:207:0) after 1m0s
[19:43:08.383] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:207:0)
[19:43:08.383] Timer tick, asking Buildbucket for the build status
[19:43:08.584] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:08.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:208:0) after 1m0s
[19:44:08.566] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:208:0)
[19:44:08.566] Timer tick, asking Buildbucket for the build status
[19:44:08.934] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:08.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:209:0) after 1m0s
[19:45:08.959] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:209:0)
[19:45:08.959] Timer tick, asking Buildbucket for the build status
[19:45:09.236] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:09.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:210:0) after 1m0s
[19:46:09.263] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:210:0)
[19:46:09.263] Timer tick, asking Buildbucket for the build status
[19:46:09.628] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:211:0) after 1m0s
[19:47:09.631] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:211:0)
[19:47:09.631] Timer tick, asking Buildbucket for the build status
[19:47:09.785] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:09.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:212:0) after 1m0s
[19:48:09.873] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:212:0)
[19:48:09.873] Timer tick, asking Buildbucket for the build status
[19:48:09.947] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:09.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:213:0) after 1m0s
[19:49:10.215] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:213:0)
[19:49:10.215] Timer tick, asking Buildbucket for the build status
[19:49:10.303] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:10.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:214:0) after 1m0s
[19:50:10.509] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:214:0)
[19:50:10.509] Timer tick, asking Buildbucket for the build status
[19:50:10.880] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:10.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:215:0) after 1m0s
[19:51:10.940] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:215:0)
[19:51:10.940] Timer tick, asking Buildbucket for the build status
[19:51:11.025] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:11.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:216:0) after 1m0s
[19:52:11.067] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:216:0)
[19:52:11.067] Timer tick, asking Buildbucket for the build status
[19:52:11.174] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:11.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:217:0) after 1m0s
[19:53:11.295] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:217:0)
[19:53:11.295] Timer tick, asking Buildbucket for the build status
[19:53:11.500] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:11.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:218:0) after 1m0s
[19:54:11.650] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:218:0)
[19:54:11.650] Timer tick, asking Buildbucket for the build status
[19:54:11.727] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:11.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:219:0) after 1m0s
[19:55:11.764] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:219:0)
[19:55:11.764] Timer tick, asking Buildbucket for the build status
[19:55:11.857] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:11.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:220:0) after 1m0s
[19:56:11.882] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:220:0)
[19:56:11.882] Timer tick, asking Buildbucket for the build status
[19:56:11.944] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:11.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:221:0) after 1m0s
[19:57:12.012] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:221:0)
[19:57:12.012] Timer tick, asking Buildbucket for the build status
[19:57:12.112] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:12.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:222:0) after 1m0s
[19:58:12.173] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:222:0)
[19:58:12.173] Timer tick, asking Buildbucket for the build status
[19:58:12.240] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:12.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:223:0) after 1m0s
[19:59:12.350] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:223:0)
[19:59:12.350] Timer tick, asking Buildbucket for the build status
[19:59:12.452] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:12.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:224:0) after 1m0s
[20:00:12.497] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:224:0)
[20:00:12.497] Timer tick, asking Buildbucket for the build status
[20:00:12.607] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:12.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:225:0) after 1m0s
[20:01:12.789] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:225:0)
[20:01:12.789] Timer tick, asking Buildbucket for the build status
[20:01:12.867] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:12.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:226:0) after 1m0s
[20:02:13.024] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:226:0)
[20:02:13.024] Timer tick, asking Buildbucket for the build status
[20:02:13.166] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:13.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:227:0) after 1m0s
[20:03:13.267] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:227:0)
[20:03:13.267] Timer tick, asking Buildbucket for the build status
[20:03:13.455] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:13.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:228:0) after 1m0s
[20:04:13.586] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:228:0)
[20:04:13.586] Timer tick, asking Buildbucket for the build status
[20:04:14.048] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:14.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:229:0) after 1m0s
[20:05:14.174] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:229:0)
[20:05:14.174] Timer tick, asking Buildbucket for the build status
[20:05:14.335] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:14.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:230:0) after 1m0s
[20:06:14.480] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:230:0)
[20:06:14.480] Timer tick, asking Buildbucket for the build status
[20:06:14.709] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:14.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:231:0) after 1m0s
[20:07:14.800] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:231:0)
[20:07:14.800] Timer tick, asking Buildbucket for the build status
[20:07:14.901] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:14.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:232:0) after 1m0s
[20:08:14.936] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:232:0)
[20:08:14.936] Timer tick, asking Buildbucket for the build status
[20:08:15.037] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:15.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:233:0) after 1m0s
[20:09:15.115] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:233:0)
[20:09:15.115] Timer tick, asking Buildbucket for the build status
[20:09:15.322] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:15.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:234:0) after 1m0s
[20:10:15.393] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:234:0)
[20:10:15.393] Timer tick, asking Buildbucket for the build status
[20:10:15.491] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:15.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:235:0) after 1m0s
[20:11:15.560] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:235:0)
[20:11:15.560] Timer tick, asking Buildbucket for the build status
[20:11:15.747] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:15.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:236:0) after 1m0s
[20:12:15.788] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:236:0)
[20:12:15.788] Timer tick, asking Buildbucket for the build status
[20:12:15.921] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:237:0) after 1m0s
[20:13:15.948] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:237:0)
[20:13:15.948] Timer tick, asking Buildbucket for the build status
[20:13:16.030] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:16.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:238:0) after 1m0s
[20:14:16.088] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:238:0)
[20:14:16.088] Timer tick, asking Buildbucket for the build status
[20:14:16.246] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:16.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:239:0) after 1m0s
[20:15:16.284] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:239:0)
[20:15:16.284] Timer tick, asking Buildbucket for the build status
[20:15:16.357] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:16.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:240:0) after 1m0s
[20:16:16.403] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:240:0)
[20:16:16.403] Timer tick, asking Buildbucket for the build status
[20:16:16.498] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:16.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:241:0) after 1m0s
[20:17:16.544] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:241:0)
[20:17:16.544] Timer tick, asking Buildbucket for the build status
[20:17:16.636] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:16.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:242:0) after 1m0s
[20:18:16.797] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:242:0)
[20:18:16.797] Timer tick, asking Buildbucket for the build status
[20:18:16.899] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:16.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:243:0) after 1m0s
[20:19:16.997] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:243:0)
[20:19:16.997] Timer tick, asking Buildbucket for the build status
[20:19:17.088] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:17.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:244:0) after 1m0s
[20:20:17.119] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:244:0)
[20:20:17.119] Timer tick, asking Buildbucket for the build status
[20:20:17.179] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:17.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:245:0) after 1m0s
[20:21:17.276] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:245:0)
[20:21:17.276] Timer tick, asking Buildbucket for the build status
[20:21:17.362] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:17.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:246:0) after 1m0s
[20:22:17.437] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:246:0)
[20:22:17.437] Timer tick, asking Buildbucket for the build status
[20:22:17.864] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:17.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:247:0) after 1m0s
[20:23:17.882] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:247:0)
[20:23:17.882] Timer tick, asking Buildbucket for the build status
[20:23:17.956] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:17.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:248:0) after 1m0s
[20:24:18.018] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:248:0)
[20:24:18.018] Timer tick, asking Buildbucket for the build status
[20:24:18.146] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:249:0) after 1m0s
[20:25:18.300] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:249:0)
[20:25:18.300] Timer tick, asking Buildbucket for the build status
[20:25:18.385] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:18.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:250:0) after 1m0s
[20:26:18.433] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:250:0)
[20:26:18.433] Timer tick, asking Buildbucket for the build status
[20:26:18.901] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:18.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:251:0) after 1m0s
[20:27:19.218] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:251:0)
[20:27:19.218] Timer tick, asking Buildbucket for the build status
[20:27:19.307] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:19.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:252:0) after 1m0s
[20:28:19.416] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:252:0)
[20:28:19.416] Timer tick, asking Buildbucket for the build status
[20:28:19.484] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:19.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:253:0) after 1m0s
[20:29:19.535] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:253:0)
[20:29:19.535] Timer tick, asking Buildbucket for the build status
[20:29:19.745] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:19.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:254:0) after 1m0s
[20:30:21.431] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:254:0)
[20:30:21.431] Timer tick, asking Buildbucket for the build status
[20:30:21.742] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:21.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:255:0) after 1m0s
[20:31:21.856] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:255:0)
[20:31:21.856] Timer tick, asking Buildbucket for the build status
[20:31:21.942] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:21.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:256:0) after 1m0s
[20:32:21.983] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:256:0)
[20:32:21.983] Timer tick, asking Buildbucket for the build status
[20:32:22.092] Build 8862915887739583760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:22.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:257:0) after 1m0s
[20:32:57.420] Received PubSub notification, asking Buildbucket for the build status
[20:32:57.483] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:22.110] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:257:0)
[20:33:22.110] Timer tick, asking Buildbucket for the build status
[20:33:22.191] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:22.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:259:0) after 1m0s
[20:34:22.213] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:259:0)
[20:34:22.213] Timer tick, asking Buildbucket for the build status
[20:34:22.325] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:22.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:260:0) after 1m0s
[20:35:22.322] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:260:0)
[20:35:22.322] Timer tick, asking Buildbucket for the build status
[20:35:22.385] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:22.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:261:0) after 1m0s
[20:36:22.380] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:261:0)
[20:36:22.380] Timer tick, asking Buildbucket for the build status
[20:36:22.548] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:22.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:262:0) after 1m0s
[20:37:22.608] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:262:0)
[20:37:22.608] Timer tick, asking Buildbucket for the build status
[20:37:22.990] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:22.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:263:0) after 1m0s
[20:38:23.020] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:263:0)
[20:38:23.020] Timer tick, asking Buildbucket for the build status
[20:38:23.079] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:23.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:264:0) after 1m0s
[20:39:23.348] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:264:0)
[20:39:23.348] Timer tick, asking Buildbucket for the build status
[20:39:23.554] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:23.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:265:0) after 1m0s
[20:40:23.599] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:265:0)
[20:40:23.599] Timer tick, asking Buildbucket for the build status
[20:40:23.659] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:23.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:266:0) after 1m0s
[20:41:23.688] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:266:0)
[20:41:23.688] Timer tick, asking Buildbucket for the build status
[20:41:23.745] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:23.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:267:0) after 1m0s
[20:42:23.785] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:267:0)
[20:42:23.785] Timer tick, asking Buildbucket for the build status
[20:42:25.007] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:25.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:268:0) after 1m0s
[20:43:25.068] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:268:0)
[20:43:25.068] Timer tick, asking Buildbucket for the build status
[20:43:25.133] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:25.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:269:0) after 1m0s
[20:44:25.167] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:269:0)
[20:44:25.167] Timer tick, asking Buildbucket for the build status
[20:44:25.241] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:25.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:270:0) after 1m0s
[20:45:25.247] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:270:0)
[20:45:25.247] Timer tick, asking Buildbucket for the build status
[20:45:25.314] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:25.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:271:0) after 1m0s
[20:46:25.472] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:271:0)
[20:46:25.472] Timer tick, asking Buildbucket for the build status
[20:46:25.535] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:25.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:272:0) after 1m0s
[20:47:25.568] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:272:0)
[20:47:25.568] Timer tick, asking Buildbucket for the build status
[20:47:26.407] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:26.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:273:0) after 1m0s
[20:48:26.488] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:273:0)
[20:48:26.488] Timer tick, asking Buildbucket for the build status
[20:48:26.541] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:26.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:274:0) after 1m0s
[20:49:26.611] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:274:0)
[20:49:26.611] Timer tick, asking Buildbucket for the build status
[20:49:26.687] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:26.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:275:0) after 1m0s
[20:50:26.722] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:275:0)
[20:50:26.722] Timer tick, asking Buildbucket for the build status
[20:50:26.780] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:26.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:276:0) after 1m0s
[20:51:26.815] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:276:0)
[20:51:26.815] Timer tick, asking Buildbucket for the build status
[20:51:26.872] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:26.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:277:0) after 1m0s
[20:52:26.939] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:277:0)
[20:52:26.939] Timer tick, asking Buildbucket for the build status
[20:52:27.064] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:27.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:278:0) after 1m0s
[20:53:27.133] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:278:0)
[20:53:27.133] Timer tick, asking Buildbucket for the build status
[20:53:27.247] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:27.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:279:0) after 1m0s
[20:54:27.285] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:279:0)
[20:54:27.285] Timer tick, asking Buildbucket for the build status
[20:54:27.382] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:27.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:280:0) after 1m0s
[20:55:27.421] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:280:0)
[20:55:27.421] Timer tick, asking Buildbucket for the build status
[20:55:27.519] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:27.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:281:0) after 1m0s
[20:56:27.649] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:281:0)
[20:56:27.649] Timer tick, asking Buildbucket for the build status
[20:56:27.803] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:27.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:282:0) after 1m0s
[20:57:27.939] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:282:0)
[20:57:27.939] Timer tick, asking Buildbucket for the build status
[20:57:28.550] Build 8862915887739583760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:28.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028345950388268032:283:0) after 1m0s
[20:57:31.109] Received PubSub notification, asking Buildbucket for the build status
[20:57:31.205] Build 8862915887739583760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:57:31.206] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606078642145244",
"created_by": "project:chromium",
"created_ts": "1606061771601155",
"id": "8862915887739583760",
"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\": \"054bf78bd1a68aa63eaa5884e6f40bab4a82e10b\", \"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-tvz8\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1777, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"054bf78bd1a68aa63eaa5884e6f40bab4a82e10b\", \"got_revision_cp\": \"refs/heads/master@{#830057}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"805e8b5987e5fd07adbe998f0c21f84cb20468b8\", \"got_v8_revision_cp\": \"refs/heads/8.9.32@{#1}\", \"got_webrtc_revision\": \"d96634781e537685496ce6e207bf41b4a98de492\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32661}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#830057}_without_patch\": {\"upload_trace_processor\": \"751cd163b0d56d15285001d26d08364c052ff0e1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1bdf55b197d439c94705ddfba40ad846e2fdb8dd164b64a485766434889345a8_v2\", \"builder_48ce158d992f85c54a400240cc3d77408bb96a2369de806c235fde7d7ef64068_v2\", \"builder_572c7d4336ecb7e9d9870c0b7d73eb5c4ec9b5267736155cf1f0727554d722db_v2\", \"builder_6b755bbaffc280fb83e7e303317e4888b2acb597c551cb7db892c262f1cf5030_v2\", \"builder_7e7f4ebc5094421a46baff10228f22baf4d4d757ab94366d4bf23e3f4dc4e562_v2\", \"builder_9fe9814ce14bb8ceec490c2f73b354cfd72877294131c83e8f28b19a7d4650fc_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-tvz8\"], \"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\": [\"5637-4d8b832\"], \"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": "1606077176771634",
"status": "COMPLETED",
"status_changed_ts": "1606078650670712",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1777",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9028345950388268032",
"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/8862915887739583760/+/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:50098f916a853910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606078650675239",
"url": "https://ci.chromium.org/b/8862915887739583760",
"utcnow_ts": "1606078651193420"
}
}
[20:57:31.206] Invocation finished in 4h41m21.513839868s with status SUCCEEDED