[09:32:17.551] New invocation is queued and will start shortly
[09:32:18.685] Starting the invocation (attempt 1)
[09:32:18.719] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:32:18.719] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:32:18.719] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028371359648634704",
"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:9028371359648634704",
"scheduler_job_id:chromium/win-upload-perfetto",
"user_agent:luci-scheduler"
]
}
[09:32:19.822] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606037538801882",
"id": "8862941297672942800",
"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": "1606037539711306",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1776",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9028371359648634704",
"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/8862941297672942800/+/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": "1606037539711432",
"url": "https://ci.chromium.org/b/8862941297672942800",
"utcnow_ts": "1606037539813231"
}
}
[09:32:19.822] Task URL: https://ci.chromium.org/b/8862941297672942800
[09:32:19.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:2:0) after 1m0s
[09:33:19.892] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:2:0)
[09:33:19.892] Timer tick, asking Buildbucket for the build status
[09:33:19.974] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:19.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:3:0) after 1m0s
[09:34:20.061] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:3:0)
[09:34:20.061] Timer tick, asking Buildbucket for the build status
[09:34:20.137] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:20.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:4:0) after 1m0s
[09:35:20.137] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:4:0)
[09:35:20.137] Timer tick, asking Buildbucket for the build status
[09:35:20.210] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:20.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:5:0) after 1m0s
[09:36:20.239] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:5:0)
[09:36:20.239] Timer tick, asking Buildbucket for the build status
[09:36:20.310] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:20.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:6:0) after 1m0s
[09:37:25.007] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:6:0)
[09:37:25.007] Timer tick, asking Buildbucket for the build status
[09:37:25.346] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:25.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:7:0) after 1m0s
[09:38:25.425] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:7:0)
[09:38:25.425] Timer tick, asking Buildbucket for the build status
[09:38:25.490] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:25.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:8:0) after 1m0s
[09:39:25.499] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:8:0)
[09:39:25.499] Timer tick, asking Buildbucket for the build status
[09:39:25.635] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:9:0) after 1m0s
[09:40:25.638] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:9:0)
[09:40:25.638] Timer tick, asking Buildbucket for the build status
[09:40:25.709] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:25.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:10:0) after 1m0s
[09:41:25.702] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:10:0)
[09:41:25.702] Timer tick, asking Buildbucket for the build status
[09:41:25.842] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:25.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:11:0) after 1m0s
[09:42:25.894] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:11:0)
[09:42:25.894] Timer tick, asking Buildbucket for the build status
[09:42:26.127] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:26.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:12:0) after 1m0s
[09:43:26.170] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:12:0)
[09:43:26.170] Timer tick, asking Buildbucket for the build status
[09:43:26.272] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:26.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:13:0) after 1m0s
[09:44:26.294] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:13:0)
[09:44:26.294] Timer tick, asking Buildbucket for the build status
[09:44:26.515] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:26.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:14:0) after 1m0s
[09:45:26.540] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:14:0)
[09:45:26.540] Timer tick, asking Buildbucket for the build status
[09:45:26.618] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:26.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:15:0) after 1m0s
[09:46:26.635] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:15:0)
[09:46:26.635] Timer tick, asking Buildbucket for the build status
[09:46:26.893] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:26.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:16:0) after 1m0s
[09:47:26.949] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:16:0)
[09:47:26.949] Timer tick, asking Buildbucket for the build status
[09:47:27.237] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:27.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:17:0) after 1m0s
[09:48:27.290] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:17:0)
[09:48:27.290] Timer tick, asking Buildbucket for the build status
[09:48:27.370] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:27.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:18:0) after 1m0s
[09:49:27.494] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:18:0)
[09:49:27.494] Timer tick, asking Buildbucket for the build status
[09:49:27.701] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:27.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:19:0) after 1m0s
[09:50:27.719] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:19:0)
[09:50:27.719] Timer tick, asking Buildbucket for the build status
[09:50:27.805] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:20:0) after 1m0s
[09:51:27.826] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:20:0)
[09:51:27.826] Timer tick, asking Buildbucket for the build status
[09:51:27.952] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:27.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:21:0) after 1m0s
[09:52:28.041] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:21:0)
[09:52:28.041] Timer tick, asking Buildbucket for the build status
[09:52:28.172] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:28.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:22:0) after 1m0s
[09:53:28.187] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:22:0)
[09:53:28.187] Timer tick, asking Buildbucket for the build status
[09:53:28.269] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:23:0) after 1m0s
[09:54:28.382] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:23:0)
[09:54:28.382] Timer tick, asking Buildbucket for the build status
[09:54:28.480] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:28.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:24:0) after 1m0s
[09:55:28.498] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:24:0)
[09:55:28.498] Timer tick, asking Buildbucket for the build status
[09:55:28.588] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:25:0) after 1m0s
[09:56:28.615] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:25:0)
[09:56:28.615] Timer tick, asking Buildbucket for the build status
[09:56:28.684] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:28.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:26:0) after 1m0s
[09:57:28.703] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:26:0)
[09:57:28.703] Timer tick, asking Buildbucket for the build status
[09:57:30.637] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:30.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:27:0) after 1m0s
[09:58:30.693] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:27:0)
[09:58:30.693] Timer tick, asking Buildbucket for the build status
[09:58:30.775] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:30.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:28:0) after 1m0s
[09:59:30.799] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:28:0)
[09:59:30.799] Timer tick, asking Buildbucket for the build status
[09:59:30.879] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:30.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:29:0) after 1m0s
[10:00:31.002] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:29:0)
[10:00:31.002] Timer tick, asking Buildbucket for the build status
[10:00:31.089] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:31.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:30:0) after 1m0s
[10:01:31.133] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:30:0)
[10:01:31.133] Timer tick, asking Buildbucket for the build status
[10:01:31.206] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:31.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:31:0) after 1m0s
[10:02:31.228] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:31:0)
[10:02:31.228] Timer tick, asking Buildbucket for the build status
[10:02:31.337] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:31.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:32:0) after 1m0s
[10:03:31.351] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:32:0)
[10:03:31.351] Timer tick, asking Buildbucket for the build status
[10:03:31.565] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:31.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:33:0) after 1m0s
[10:04:31.588] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:33:0)
[10:04:31.588] Timer tick, asking Buildbucket for the build status
[10:04:31.669] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:34:0) after 1m0s
[10:05:31.692] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:34:0)
[10:05:31.692] Timer tick, asking Buildbucket for the build status
[10:05:31.761] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:31.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:35:0) after 1m0s
[10:06:31.780] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:35:0)
[10:06:31.780] Timer tick, asking Buildbucket for the build status
[10:06:31.855] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:31.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:36:0) after 1m0s
[10:07:31.912] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:36:0)
[10:07:31.912] Timer tick, asking Buildbucket for the build status
[10:07:32.118] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:32.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:37:0) after 1m0s
[10:08:32.157] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:37:0)
[10:08:32.157] Timer tick, asking Buildbucket for the build status
[10:08:32.234] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:32.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:38:0) after 1m0s
[10:09:32.288] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:38:0)
[10:09:32.288] Timer tick, asking Buildbucket for the build status
[10:09:32.358] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:39:0) after 1m0s
[10:10:32.392] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:39:0)
[10:10:32.392] Timer tick, asking Buildbucket for the build status
[10:10:32.477] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:32.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:40:0) after 1m0s
[10:11:32.518] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:40:0)
[10:11:32.518] Timer tick, asking Buildbucket for the build status
[10:11:32.586] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:32.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:41:0) after 1m0s
[10:12:32.608] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:41:0)
[10:12:32.608] Timer tick, asking Buildbucket for the build status
[10:12:33.002] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:33.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:42:0) after 1m0s
[10:13:33.023] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:42:0)
[10:13:33.023] Timer tick, asking Buildbucket for the build status
[10:13:33.090] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:33.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:43:0) after 1m0s
[10:14:33.096] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:43:0)
[10:14:33.096] Timer tick, asking Buildbucket for the build status
[10:14:33.183] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:33.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:44:0) after 1m0s
[10:15:33.201] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:44:0)
[10:15:33.201] Timer tick, asking Buildbucket for the build status
[10:15:33.281] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:33.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:45:0) after 1m0s
[10:16:33.302] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:45:0)
[10:16:33.302] Timer tick, asking Buildbucket for the build status
[10:16:33.562] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:46:0) after 1m0s
[10:17:33.585] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:46:0)
[10:17:33.585] Timer tick, asking Buildbucket for the build status
[10:17:33.913] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:33.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:47:0) after 1m0s
[10:18:33.934] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:47:0)
[10:18:33.934] Timer tick, asking Buildbucket for the build status
[10:18:34.024] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:34.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:48:0) after 1m0s
[10:19:34.045] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:48:0)
[10:19:34.045] Timer tick, asking Buildbucket for the build status
[10:19:34.157] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:34.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:49:0) after 1m0s
[10:20:34.176] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:49:0)
[10:20:34.176] Timer tick, asking Buildbucket for the build status
[10:20:34.268] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:34.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:50:0) after 1m0s
[10:21:34.303] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:50:0)
[10:21:34.303] Timer tick, asking Buildbucket for the build status
[10:21:34.525] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:34.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:51:0) after 1m0s
[10:22:34.596] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:51:0)
[10:22:34.596] Timer tick, asking Buildbucket for the build status
[10:22:34.709] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:34.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:52:0) after 1m0s
[10:23:34.779] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:52:0)
[10:23:34.779] Timer tick, asking Buildbucket for the build status
[10:23:34.858] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:53:0) after 1m0s
[10:24:34.948] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:53:0)
[10:24:34.948] Timer tick, asking Buildbucket for the build status
[10:24:35.017] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:35.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:54:0) after 1m0s
[10:25:35.073] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:54:0)
[10:25:35.073] Timer tick, asking Buildbucket for the build status
[10:25:35.155] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:35.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:55:0) after 1m0s
[10:26:35.265] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:55:0)
[10:26:35.265] Timer tick, asking Buildbucket for the build status
[10:26:35.344] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:35.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:56:0) after 1m0s
[10:27:35.369] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:56:0)
[10:27:35.369] Timer tick, asking Buildbucket for the build status
[10:27:35.785] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:35.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:57:0) after 1m0s
[10:28:35.829] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:57:0)
[10:28:35.829] Timer tick, asking Buildbucket for the build status
[10:28:35.890] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:35.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:58:0) after 1m0s
[10:29:35.939] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:58:0)
[10:29:35.939] Timer tick, asking Buildbucket for the build status
[10:29:36.013] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:59:0) after 1m0s
[10:30:36.021] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:59:0)
[10:30:36.021] Timer tick, asking Buildbucket for the build status
[10:30:36.102] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:36.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:60:0) after 1m0s
[10:31:36.144] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:60:0)
[10:31:36.144] Timer tick, asking Buildbucket for the build status
[10:31:36.323] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:36.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:61:0) after 1m0s
[10:32:36.439] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:61:0)
[10:32:36.439] Timer tick, asking Buildbucket for the build status
[10:32:37.820] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:37.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:62:0) after 1m0s
[10:33:37.979] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:62:0)
[10:33:37.979] Timer tick, asking Buildbucket for the build status
[10:33:38.065] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:33:38.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:63:0) after 1m0s
[10:34:38.136] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:63:0)
[10:34:38.136] Timer tick, asking Buildbucket for the build status
[10:34:38.231] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:34:38.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:64:0) after 1m0s
[10:35:38.286] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:64:0)
[10:35:38.286] Timer tick, asking Buildbucket for the build status
[10:35:38.371] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:35:38.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:65:0) after 1m0s
[10:36:38.390] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:65:0)
[10:36:38.390] Timer tick, asking Buildbucket for the build status
[10:36:38.464] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:36:38.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:66:0) after 1m0s
[10:37:38.554] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:66:0)
[10:37:38.554] Timer tick, asking Buildbucket for the build status
[10:37:39.100] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:37:39.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:67:0) after 1m0s
[10:38:39.111] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:67:0)
[10:38:39.111] Timer tick, asking Buildbucket for the build status
[10:38:39.180] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:38:39.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:68:0) after 1m0s
[10:39:39.204] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:68:0)
[10:39:39.204] Timer tick, asking Buildbucket for the build status
[10:39:39.302] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:39:39.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:69:0) after 1m0s
[10:40:39.336] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:69:0)
[10:40:39.336] Timer tick, asking Buildbucket for the build status
[10:40:39.397] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:40:39.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:70:0) after 1m0s
[10:41:39.456] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:70:0)
[10:41:39.456] Timer tick, asking Buildbucket for the build status
[10:41:39.574] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:41:39.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:71:0) after 1m0s
[10:42:39.682] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:71:0)
[10:42:39.682] Timer tick, asking Buildbucket for the build status
[10:42:39.773] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:42:39.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:72:0) after 1m0s
[10:43:39.847] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:72:0)
[10:43:39.847] Timer tick, asking Buildbucket for the build status
[10:43:39.928] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:43:39.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:73:0) after 1m0s
[10:44:41.136] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:73:0)
[10:44:41.136] Timer tick, asking Buildbucket for the build status
[10:44:41.446] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:44:41.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:74:0) after 1m0s
[10:45:41.590] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:74:0)
[10:45:41.590] Timer tick, asking Buildbucket for the build status
[10:45:41.686] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:45:41.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:75:0) after 1m0s
[10:46:41.805] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:75:0)
[10:46:41.805] Timer tick, asking Buildbucket for the build status
[10:46:41.882] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:46:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:76:0) after 1m0s
[10:47:41.969] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:76:0)
[10:47:41.969] Timer tick, asking Buildbucket for the build status
[10:47:42.119] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:47:42.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:77:0) after 1m0s
[10:48:42.995] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:77:0)
[10:48:42.995] Timer tick, asking Buildbucket for the build status
[10:48:43.068] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:48:43.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:78:0) after 1m0s
[10:49:43.304] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:78:0)
[10:49:43.304] Timer tick, asking Buildbucket for the build status
[10:49:43.384] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:49:43.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:79:0) after 1m0s
[10:50:43.476] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:79:0)
[10:50:43.476] Timer tick, asking Buildbucket for the build status
[10:50:43.714] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:50:43.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:80:0) after 1m0s
[10:51:43.915] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:80:0)
[10:51:43.915] Timer tick, asking Buildbucket for the build status
[10:51:43.999] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:51:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:81:0) after 1m0s
[10:52:44.022] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:81:0)
[10:52:44.022] Timer tick, asking Buildbucket for the build status
[10:52:44.298] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:52:44.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:82:0) after 1m0s
[10:53:44.371] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:82:0)
[10:53:44.371] Timer tick, asking Buildbucket for the build status
[10:53:44.452] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:53:44.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:83:0) after 1m0s
[10:54:44.482] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:83:0)
[10:54:44.482] Timer tick, asking Buildbucket for the build status
[10:54:44.563] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:54:44.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:84:0) after 1m0s
[10:55:44.603] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:84:0)
[10:55:44.603] Timer tick, asking Buildbucket for the build status
[10:55:44.678] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:55:44.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:85:0) after 1m0s
[10:56:44.946] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:85:0)
[10:56:44.946] Timer tick, asking Buildbucket for the build status
[10:56:45.021] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:56:45.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:86:0) after 1m0s
[10:57:45.101] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:86:0)
[10:57:45.101] Timer tick, asking Buildbucket for the build status
[10:57:45.188] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:57:45.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:87:0) after 1m0s
[10:58:45.343] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:87:0)
[10:58:45.343] Timer tick, asking Buildbucket for the build status
[10:58:45.423] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:58:45.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:88:0) after 1m0s
[10:59:45.447] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:88:0)
[10:59:45.447] Timer tick, asking Buildbucket for the build status
[10:59:45.516] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:45.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:89:0) after 1m0s
[11:00:45.718] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:89:0)
[11:00:45.718] Timer tick, asking Buildbucket for the build status
[11:00:45.796] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:00:45.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:90:0) after 1m0s
[11:01:46.022] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:90:0)
[11:01:46.022] Timer tick, asking Buildbucket for the build status
[11:01:46.108] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:01:46.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:91:0) after 1m0s
[11:02:46.297] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:91:0)
[11:02:46.298] Timer tick, asking Buildbucket for the build status
[11:02:46.500] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:02:46.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:92:0) after 1m0s
[11:03:46.528] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:92:0)
[11:03:46.528] Timer tick, asking Buildbucket for the build status
[11:03:46.627] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:03:46.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:93:0) after 1m0s
[11:04:46.735] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:93:0)
[11:04:46.735] Timer tick, asking Buildbucket for the build status
[11:04:46.951] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:04:46.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:94:0) after 1m0s
[11:05:47.082] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:94:0)
[11:05:47.082] Timer tick, asking Buildbucket for the build status
[11:05:47.160] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:05:47.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:95:0) after 1m0s
[11:06:47.254] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:95:0)
[11:06:47.254] Timer tick, asking Buildbucket for the build status
[11:06:47.350] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:06:47.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:96:0) after 1m0s
[11:07:47.453] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:96:0)
[11:07:47.453] Timer tick, asking Buildbucket for the build status
[11:07:47.585] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:07:47.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:97:0) after 1m0s
[11:08:47.688] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:97:0)
[11:08:47.688] Timer tick, asking Buildbucket for the build status
[11:08:47.746] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:08:47.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:98:0) after 1m0s
[11:09:47.860] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:98:0)
[11:09:47.860] Timer tick, asking Buildbucket for the build status
[11:09:47.942] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:09:47.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:99:0) after 1m0s
[11:10:48.092] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:99:0)
[11:10:48.092] Timer tick, asking Buildbucket for the build status
[11:10:48.185] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:48.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:100:0) after 1m0s
[11:11:48.216] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:100:0)
[11:11:48.216] Timer tick, asking Buildbucket for the build status
[11:11:48.338] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:48.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:101:0) after 1m0s
[11:12:48.421] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:101:0)
[11:12:48.421] Timer tick, asking Buildbucket for the build status
[11:12:48.738] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:12:48.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:102:0) after 1m0s
[11:13:48.815] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:102:0)
[11:13:48.815] Timer tick, asking Buildbucket for the build status
[11:13:48.893] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:13:48.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:103:0) after 1m0s
[11:14:48.990] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:103:0)
[11:14:48.990] Timer tick, asking Buildbucket for the build status
[11:14:49.085] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:14:49.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:104:0) after 1m0s
[11:15:49.201] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:104:0)
[11:15:49.201] Timer tick, asking Buildbucket for the build status
[11:15:49.438] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:15:49.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:105:0) after 1m0s
[11:16:49.593] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:105:0)
[11:16:49.593] Timer tick, asking Buildbucket for the build status
[11:16:49.877] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:16:49.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:106:0) after 1m0s
[11:17:49.904] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:106:0)
[11:17:49.904] Timer tick, asking Buildbucket for the build status
[11:17:51.134] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:51.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:107:0) after 1m0s
[11:18:51.278] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:107:0)
[11:18:51.278] Timer tick, asking Buildbucket for the build status
[11:18:51.438] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:18:51.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:108:0) after 1m0s
[11:19:51.477] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:108:0)
[11:19:51.477] Timer tick, asking Buildbucket for the build status
[11:19:51.550] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:19:51.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:109:0) after 1m0s
[11:20:51.685] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:109:0)
[11:20:51.685] Timer tick, asking Buildbucket for the build status
[11:20:51.805] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:20:51.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:110:0) after 1m0s
[11:21:51.909] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:110:0)
[11:21:51.909] Timer tick, asking Buildbucket for the build status
[11:21:51.985] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:21:51.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:111:0) after 1m0s
[11:22:52.199] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:111:0)
[11:22:52.199] Timer tick, asking Buildbucket for the build status
[11:22:52.650] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:22:52.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:112:0) after 1m0s
[11:23:52.737] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:112:0)
[11:23:52.737] Timer tick, asking Buildbucket for the build status
[11:23:52.807] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:23:52.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:113:0) after 1m0s
[11:24:52.924] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:113:0)
[11:24:52.924] Timer tick, asking Buildbucket for the build status
[11:24:53.124] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:24:53.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:114:0) after 1m0s
[11:25:53.283] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:114:0)
[11:25:53.283] Timer tick, asking Buildbucket for the build status
[11:25:53.370] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:25:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:115:0) after 1m0s
[11:26:53.398] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:115:0)
[11:26:53.398] Timer tick, asking Buildbucket for the build status
[11:26:53.483] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:26:53.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:116:0) after 1m0s
[11:27:53.564] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:116:0)
[11:27:53.564] Timer tick, asking Buildbucket for the build status
[11:27:53.672] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:27:53.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:117:0) after 1m0s
[11:28:53.693] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:117:0)
[11:28:53.693] Timer tick, asking Buildbucket for the build status
[11:28:53.766] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:28:53.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:118:0) after 1m0s
[11:29:53.802] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:118:0)
[11:29:53.802] Timer tick, asking Buildbucket for the build status
[11:29:53.881] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:29:53.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:119:0) after 1m0s
[11:30:53.904] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:119:0)
[11:30:53.904] Timer tick, asking Buildbucket for the build status
[11:30:53.983] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:30:53.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:120:0) after 1m0s
[11:31:54.011] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:120:0)
[11:31:54.011] Timer tick, asking Buildbucket for the build status
[11:31:54.077] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:31:54.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:121:0) after 1m0s
[11:32:54.076] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:121:0)
[11:32:54.076] Timer tick, asking Buildbucket for the build status
[11:32:55.139] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:32:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:122:0) after 1m0s
[11:33:55.254] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:122:0)
[11:33:55.254] Timer tick, asking Buildbucket for the build status
[11:33:55.428] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:33:55.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:123:0) after 1m0s
[11:34:55.451] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:123:0)
[11:34:55.452] Timer tick, asking Buildbucket for the build status
[11:34:55.644] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:55.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:124:0) after 1m0s
[11:35:55.669] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:124:0)
[11:35:55.669] Timer tick, asking Buildbucket for the build status
[11:35:55.745] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:125:0) after 1m0s
[11:36:55.761] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:125:0)
[11:36:55.761] Timer tick, asking Buildbucket for the build status
[11:36:55.967] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:55.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:126:0) after 1m0s
[11:37:56.026] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:126:0)
[11:37:56.026] Timer tick, asking Buildbucket for the build status
[11:37:56.126] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:56.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:127:0) after 1m0s
[11:38:56.154] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:127:0)
[11:38:56.154] Timer tick, asking Buildbucket for the build status
[11:38:56.221] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:56.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:128:0) after 1m0s
[11:39:56.244] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:128:0)
[11:39:56.244] Timer tick, asking Buildbucket for the build status
[11:39:56.645] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:39:56.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:129:0) after 1m0s
[11:40:56.689] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:129:0)
[11:40:56.689] Timer tick, asking Buildbucket for the build status
[11:40:56.760] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:56.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:130:0) after 1m0s
[11:41:56.772] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:130:0)
[11:41:56.772] Timer tick, asking Buildbucket for the build status
[11:41:56.843] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:56.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:131:0) after 1m0s
[11:42:56.864] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:131:0)
[11:42:56.864] Timer tick, asking Buildbucket for the build status
[11:42:56.952] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:56.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:132:0) after 1m0s
[11:43:56.976] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:132:0)
[11:43:56.976] Timer tick, asking Buildbucket for the build status
[11:43:57.067] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:57.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:133:0) after 1m0s
[11:44:57.092] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:133:0)
[11:44:57.092] Timer tick, asking Buildbucket for the build status
[11:44:57.185] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:57.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:134:0) after 1m0s
[11:45:57.206] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:134:0)
[11:45:57.206] Timer tick, asking Buildbucket for the build status
[11:45:57.265] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:57.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:135:0) after 1m0s
[11:46:57.287] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:135:0)
[11:46:57.287] Timer tick, asking Buildbucket for the build status
[11:46:57.629] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:57.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:136:0) after 1m0s
[11:47:57.652] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:136:0)
[11:47:57.652] Timer tick, asking Buildbucket for the build status
[11:47:57.927] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:47:57.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:137:0) after 1m0s
[11:48:58.074] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:137:0)
[11:48:58.074] Timer tick, asking Buildbucket for the build status
[11:48:58.156] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:48:58.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:138:0) after 1m0s
[11:49:58.270] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:138:0)
[11:49:58.270] Timer tick, asking Buildbucket for the build status
[11:49:58.355] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:49:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:139:0) after 1m0s
[11:50:58.376] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:139:0)
[11:50:58.376] Timer tick, asking Buildbucket for the build status
[11:50:58.440] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:50:58.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:140:0) after 1m0s
[11:51:58.495] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:140:0)
[11:51:58.495] Timer tick, asking Buildbucket for the build status
[11:51:58.568] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:51:58.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:141:0) after 1m0s
[11:52:58.639] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:141:0)
[11:52:58.639] Timer tick, asking Buildbucket for the build status
[11:52:58.743] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:52:58.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:142:0) after 1m0s
[11:53:58.879] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:142:0)
[11:53:58.879] Timer tick, asking Buildbucket for the build status
[11:53:58.978] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:53:58.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:143:0) after 1m0s
[11:54:59.079] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:143:0)
[11:54:59.079] Timer tick, asking Buildbucket for the build status
[11:54:59.146] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:54:59.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:144:0) after 1m0s
[11:55:59.344] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:144:0)
[11:55:59.344] Timer tick, asking Buildbucket for the build status
[11:55:59.453] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:55:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:145:0) after 1m0s
[11:56:59.495] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:145:0)
[11:56:59.495] Timer tick, asking Buildbucket for the build status
[11:56:59.558] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:56:59.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:146:0) after 1m0s
[11:57:59.581] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:146:0)
[11:57:59.581] Timer tick, asking Buildbucket for the build status
[11:57:59.678] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:57:59.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:147:0) after 1m0s
[11:58:59.787] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:147:0)
[11:58:59.787] Timer tick, asking Buildbucket for the build status
[11:58:59.859] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:58:59.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:148:0) after 1m0s
[11:59:59.984] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:148:0)
[11:59:59.984] Timer tick, asking Buildbucket for the build status
[12:00:00.186] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:00:00.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:149:0) after 1m0s
[12:01:00.480] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:149:0)
[12:01:00.480] Timer tick, asking Buildbucket for the build status
[12:01:00.560] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:01:00.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:150:0) after 1m0s
[12:02:00.908] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:150:0)
[12:02:00.909] Timer tick, asking Buildbucket for the build status
[12:02:01.065] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:02:01.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:151:0) after 1m0s
[12:03:01.332] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:151:0)
[12:03:01.332] Timer tick, asking Buildbucket for the build status
[12:03:01.482] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:03:01.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:152:0) after 1m0s
[12:04:01.545] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:152:0)
[12:04:01.545] Timer tick, asking Buildbucket for the build status
[12:04:01.640] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:04:01.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:153:0) after 1m0s
[12:05:01.748] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:153:0)
[12:05:01.748] Timer tick, asking Buildbucket for the build status
[12:05:01.835] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:05:01.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:154:0) after 1m0s
[12:06:01.865] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:154:0)
[12:06:01.865] Timer tick, asking Buildbucket for the build status
[12:06:01.938] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:06:01.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:155:0) after 1m0s
[12:07:01.962] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:155:0)
[12:07:01.962] Timer tick, asking Buildbucket for the build status
[12:07:02.157] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:07:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:156:0) after 1m0s
[12:08:02.201] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:156:0)
[12:08:02.201] Timer tick, asking Buildbucket for the build status
[12:08:02.450] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:08:02.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:157:0) after 1m0s
[12:09:02.604] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:157:0)
[12:09:02.604] Timer tick, asking Buildbucket for the build status
[12:09:02.814] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:09:02.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:158:0) after 1m0s
[12:10:02.887] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:158:0)
[12:10:02.887] Timer tick, asking Buildbucket for the build status
[12:10:02.971] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:10:02.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:159:0) after 1m0s
[12:11:03.077] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:159:0)
[12:11:03.077] Timer tick, asking Buildbucket for the build status
[12:11:03.233] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:11:03.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:160:0) after 1m0s
[12:12:03.302] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:160:0)
[12:12:03.302] Timer tick, asking Buildbucket for the build status
[12:12:03.712] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:12:03.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:161:0) after 1m0s
[12:13:03.734] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:161:0)
[12:13:03.734] Timer tick, asking Buildbucket for the build status
[12:13:03.921] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:13:03.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:162:0) after 1m0s
[12:14:03.947] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:162:0)
[12:14:03.947] Timer tick, asking Buildbucket for the build status
[12:14:04.029] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:14:04.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:163:0) after 1m0s
[12:15:04.058] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:163:0)
[12:15:04.058] Timer tick, asking Buildbucket for the build status
[12:15:04.345] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:15:04.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:164:0) after 1m0s
[12:16:04.380] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:164:0)
[12:16:04.380] Timer tick, asking Buildbucket for the build status
[12:16:04.502] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:16:04.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:165:0) after 1m0s
[12:17:04.477] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:165:0)
[12:17:04.477] Timer tick, asking Buildbucket for the build status
[12:17:04.560] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:04.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:166:0) after 1m0s
[12:18:04.584] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:166:0)
[12:18:04.584] Timer tick, asking Buildbucket for the build status
[12:18:04.672] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:04.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:167:0) after 1m0s
[12:19:04.712] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:167:0)
[12:19:04.712] Timer tick, asking Buildbucket for the build status
[12:19:04.995] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:19:04.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:168:0) after 1m0s
[12:20:05.027] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:168:0)
[12:20:05.027] Timer tick, asking Buildbucket for the build status
[12:20:05.093] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:20:05.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:169:0) after 1m0s
[12:21:05.257] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:169:0)
[12:21:05.257] Timer tick, asking Buildbucket for the build status
[12:21:05.337] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:21:05.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:170:0) after 1m0s
[12:22:05.412] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:170:0)
[12:22:05.412] Timer tick, asking Buildbucket for the build status
[12:22:05.710] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:22:05.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:171:0) after 1m0s
[12:23:05.743] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:171:0)
[12:23:05.743] Timer tick, asking Buildbucket for the build status
[12:23:06.128] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:23:06.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:172:0) after 1m0s
[12:24:06.212] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:172:0)
[12:24:06.212] Timer tick, asking Buildbucket for the build status
[12:24:06.297] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:24:06.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:173:0) after 1m0s
[12:25:06.438] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:173:0)
[12:25:06.438] Timer tick, asking Buildbucket for the build status
[12:25:06.512] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:06.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:174:0) after 1m0s
[12:26:06.644] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:174:0)
[12:26:06.644] Timer tick, asking Buildbucket for the build status
[12:26:06.911] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:26:06.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:175:0) after 1m0s
[12:27:06.953] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:175:0)
[12:27:06.953] Timer tick, asking Buildbucket for the build status
[12:27:07.035] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:27:07.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:176:0) after 1m0s
[12:28:07.138] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:176:0)
[12:28:07.138] Timer tick, asking Buildbucket for the build status
[12:28:07.285] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:28:07.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:177:0) after 1m0s
[12:29:07.386] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:177:0)
[12:29:07.386] Timer tick, asking Buildbucket for the build status
[12:29:07.595] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:29:07.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:178:0) after 1m0s
[12:30:07.675] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:178:0)
[12:30:07.675] Timer tick, asking Buildbucket for the build status
[12:30:07.752] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:30:07.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:179:0) after 1m0s
[12:31:07.791] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:179:0)
[12:31:07.791] Timer tick, asking Buildbucket for the build status
[12:31:07.932] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:31:07.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:180:0) after 1m0s
[12:32:08.000] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:180:0)
[12:32:08.000] Timer tick, asking Buildbucket for the build status
[12:32:08.079] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:32:08.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:181:0) after 1m0s
[12:33:08.134] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:181:0)
[12:33:08.134] Timer tick, asking Buildbucket for the build status
[12:33:08.246] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:33:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:182:0) after 1m0s
[12:34:08.273] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:182:0)
[12:34:08.273] Timer tick, asking Buildbucket for the build status
[12:34:08.373] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:34:08.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:183:0) after 1m0s
[12:35:08.412] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:183:0)
[12:35:08.412] Timer tick, asking Buildbucket for the build status
[12:35:08.513] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:35:08.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:184:0) after 1m0s
[12:36:08.538] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:184:0)
[12:36:08.538] Timer tick, asking Buildbucket for the build status
[12:36:08.622] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:36:08.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:185:0) after 1m0s
[12:37:08.754] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:185:0)
[12:37:08.754] Timer tick, asking Buildbucket for the build status
[12:37:08.834] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:37:08.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:186:0) after 1m0s
[12:38:08.907] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:186:0)
[12:38:08.907] Timer tick, asking Buildbucket for the build status
[12:38:09.012] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:09.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:187:0) after 1m0s
[12:39:09.087] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:187:0)
[12:39:09.087] Timer tick, asking Buildbucket for the build status
[12:39:09.153] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:09.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:188:0) after 1m0s
[12:40:09.244] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:188:0)
[12:40:09.244] Timer tick, asking Buildbucket for the build status
[12:40:09.316] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:09.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:189:0) after 1m0s
[12:41:09.391] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:189:0)
[12:41:09.391] Timer tick, asking Buildbucket for the build status
[12:41:09.477] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:09.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:190:0) after 1m0s
[12:42:09.561] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:190:0)
[12:42:09.561] Timer tick, asking Buildbucket for the build status
[12:42:09.638] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:09.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:191:0) after 1m0s
[12:43:09.715] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:191:0)
[12:43:09.715] Timer tick, asking Buildbucket for the build status
[12:43:09.803] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:09.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:192:0) after 1m0s
[12:44:10.009] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:192:0)
[12:44:10.009] Timer tick, asking Buildbucket for the build status
[12:44:10.088] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:10.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:193:0) after 1m0s
[12:45:10.229] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:193:0)
[12:45:10.229] Timer tick, asking Buildbucket for the build status
[12:45:10.322] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:45:10.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:194:0) after 1m0s
[12:46:10.510] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:194:0)
[12:46:10.510] Timer tick, asking Buildbucket for the build status
[12:46:10.578] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:46:10.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:195:0) after 1m0s
[12:47:10.759] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:195:0)
[12:47:10.759] Timer tick, asking Buildbucket for the build status
[12:47:11.036] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:47:11.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:196:0) after 1m0s
[12:48:11.160] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:196:0)
[12:48:11.160] Timer tick, asking Buildbucket for the build status
[12:48:11.351] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:48:11.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:197:0) after 1m0s
[12:49:11.427] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:197:0)
[12:49:11.427] Timer tick, asking Buildbucket for the build status
[12:49:11.546] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:49:11.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:198:0) after 1m0s
[12:50:11.630] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:198:0)
[12:50:11.631] Timer tick, asking Buildbucket for the build status
[12:50:11.813] Build 8862941297672942800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:50:11.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:199:0) after 1m0s
[12:50:42.146] Received PubSub notification, asking Buildbucket for the build status
[12:50:42.235] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:11.877] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:199:0)
[12:51:11.877] Timer tick, asking Buildbucket for the build status
[12:51:12.041] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:12.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:201:0) after 1m0s
[12:52:12.134] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:201:0)
[12:52:12.134] Timer tick, asking Buildbucket for the build status
[12:52:12.268] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:202:0) after 1m0s
[12:53:12.294] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:202:0)
[12:53:12.294] Timer tick, asking Buildbucket for the build status
[12:53:12.555] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:12.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:203:0) after 1m0s
[12:54:12.727] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:203:0)
[12:54:12.727] Timer tick, asking Buildbucket for the build status
[12:54:12.789] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:12.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:204:0) after 1m0s
[12:55:12.848] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:204:0)
[12:55:12.848] Timer tick, asking Buildbucket for the build status
[12:55:13.029] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:13.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:205:0) after 1m0s
[12:56:13.064] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:205:0)
[12:56:13.064] Timer tick, asking Buildbucket for the build status
[12:56:13.143] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:13.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:206:0) after 1m0s
[12:57:13.213] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:206:0)
[12:57:13.213] Timer tick, asking Buildbucket for the build status
[12:57:13.323] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:13.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:207:0) after 1m0s
[12:58:13.442] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:207:0)
[12:58:13.442] Timer tick, asking Buildbucket for the build status
[12:58:13.830] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:13.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:208:0) after 1m0s
[12:59:13.840] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:208:0)
[12:59:13.840] Timer tick, asking Buildbucket for the build status
[12:59:13.973] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:13.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:209:0) after 1m0s
[13:00:14.089] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:209:0)
[13:00:14.089] Timer tick, asking Buildbucket for the build status
[13:00:14.233] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:14.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:210:0) after 1m0s
[13:01:14.288] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:210:0)
[13:01:14.288] Timer tick, asking Buildbucket for the build status
[13:01:14.720] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:14.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:211:0) after 1m0s
[13:02:14.758] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:211:0)
[13:02:14.758] Timer tick, asking Buildbucket for the build status
[13:02:14.875] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:14.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:212:0) after 1m0s
[13:03:14.912] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:212:0)
[13:03:14.912] Timer tick, asking Buildbucket for the build status
[13:03:15.022] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:15.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:213:0) after 1m0s
[13:04:15.058] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:213:0)
[13:04:15.058] Timer tick, asking Buildbucket for the build status
[13:04:15.145] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:15.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:214:0) after 1m0s
[13:05:15.175] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:214:0)
[13:05:15.175] Timer tick, asking Buildbucket for the build status
[13:05:15.233] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:15.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:215:0) after 1m0s
[13:06:15.300] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:215:0)
[13:06:15.300] Timer tick, asking Buildbucket for the build status
[13:06:15.361] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:15.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:216:0) after 1m0s
[13:07:15.392] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:216:0)
[13:07:15.392] Timer tick, asking Buildbucket for the build status
[13:07:15.459] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:15.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:217:0) after 1m0s
[13:08:15.494] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:217:0)
[13:08:15.494] Timer tick, asking Buildbucket for the build status
[13:08:15.582] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:15.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:218:0) after 1m0s
[13:09:15.619] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:218:0)
[13:09:15.619] Timer tick, asking Buildbucket for the build status
[13:09:15.681] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:219:0) after 1m0s
[13:10:15.763] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:219:0)
[13:10:15.763] Timer tick, asking Buildbucket for the build status
[13:10:15.823] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:15.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:220:0) after 1m0s
[13:11:15.910] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:220:0)
[13:11:15.910] Timer tick, asking Buildbucket for the build status
[13:11:15.991] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:15.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:221:0) after 1m0s
[13:12:16.036] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:221:0)
[13:12:16.036] Timer tick, asking Buildbucket for the build status
[13:12:16.131] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:16.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:222:0) after 1m0s
[13:13:16.150] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:222:0)
[13:13:16.150] Timer tick, asking Buildbucket for the build status
[13:13:16.334] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:16.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:223:0) after 1m0s
[13:14:16.412] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:223:0)
[13:14:16.412] Timer tick, asking Buildbucket for the build status
[13:14:16.511] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:16.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:224:0) after 1m0s
[13:15:16.546] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:224:0)
[13:15:16.546] Timer tick, asking Buildbucket for the build status
[13:15:16.647] Build 8862941297672942800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028371359648634704:225:0) after 1m0s
[13:16:04.754] Received PubSub notification, asking Buildbucket for the build status
[13:16:05.530] Build 8862941297672942800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:16:05.530] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606050963830894",
"created_by": "project:chromium",
"created_ts": "1606037538801882",
"id": "8862941297672942800",
"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\": \"1fb5c9825be4e2271c4fef0e802f5d970b32f62f\", \"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-0-jln3\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1776, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"1fb5c9825be4e2271c4fef0e802f5d970b32f62f\", \"got_revision_cp\": \"refs/heads/master@{#830039}\", \"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\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#830039}_without_patch\": {\"upload_trace_processor\": \"ca857327183e897e48ae907fe3601f63aa732c63\"}}, \"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-0-jln3\"], \"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": "1606049441328127",
"status": "COMPLETED",
"status_changed_ts": "1606050964169698",
"tags": [
"build_address:luci.chromium.ci/win-upload-perfetto/1776",
"builder:win-upload-perfetto",
"scheduler_invocation_id:9028371359648634704",
"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/8862941297672942800/+/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:50081d94f227f210",
"user_agent:luci-scheduler"
],
"updated_ts": "1606050964173944",
"url": "https://ci.chromium.org/b/8862941297672942800",
"utcnow_ts": "1606050964832059"
}
}
[13:16:05.530] Invocation finished in 3h43m47.996967086s with status SUCCEEDED