buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "win-upload-perfetto"
>

• cron:v1:4841 (5 years ago)

[18:33:40.124] New invocation is queued and will start shortly
[18:33:41.262] Starting the invocation (attempt 1)
[18:33:41.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:41.307] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:41.307] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9028518493137736816",
  "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:9028518493137736816",
    "scheduler_job_id:chromium/win-upload-perfetto",
    "user_agent:luci-scheduler"
  ]
}
[18:33:42.025] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1605897221403003",
    "id": "8863088431128851232",
    "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": "1605897221867406",
    "tags": [
      "build_address:luci.chromium.ci/win-upload-perfetto/1769",
      "builder:win-upload-perfetto",
      "scheduler_invocation_id:9028518493137736816",
      "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/8863088431128851232/+/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": "1605897221867550",
    "url": "https://ci.chromium.org/b/8863088431128851232",
    "utcnow_ts": "1605897222016706"
  }
}
[18:33:42.025] Task URL: https://ci.chromium.org/b/8863088431128851232
[18:33:42.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:2:0) after 1m0s
[18:34:42.088] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:2:0)
[18:34:42.088] Timer tick, asking Buildbucket for the build status
[18:34:42.255] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:42.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:3:0) after 1m0s
[18:35:42.287] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:3:0)
[18:35:42.287] Timer tick, asking Buildbucket for the build status
[18:35:42.830] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:42.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:4:0) after 1m0s
[18:36:42.979] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:4:0)
[18:36:42.979] Timer tick, asking Buildbucket for the build status
[18:36:43.053] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:43.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:5:0) after 1m0s
[18:37:43.146] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:5:0)
[18:37:43.146] Timer tick, asking Buildbucket for the build status
[18:37:43.396] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:43.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:6:0) after 1m0s
[18:38:43.511] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:6:0)
[18:38:43.511] Timer tick, asking Buildbucket for the build status
[18:38:43.960] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:7:0) after 1m0s
[18:39:44.028] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:7:0)
[18:39:44.028] Timer tick, asking Buildbucket for the build status
[18:39:44.267] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:44.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:8:0) after 1m0s
[18:40:44.287] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:8:0)
[18:40:44.287] Timer tick, asking Buildbucket for the build status
[18:40:46.412] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:46.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:9:0) after 1m0s
[18:41:46.521] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:9:0)
[18:41:46.521] Timer tick, asking Buildbucket for the build status
[18:41:46.595] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:46.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:10:0) after 1m0s
[18:42:46.638] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:10:0)
[18:42:46.638] Timer tick, asking Buildbucket for the build status
[18:42:46.723] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:46.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:11:0) after 1m0s
[18:43:46.717] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:11:0)
[18:43:46.717] Timer tick, asking Buildbucket for the build status
[18:43:47.825] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:47.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:12:0) after 1m0s
[18:44:47.868] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:12:0)
[18:44:47.868] Timer tick, asking Buildbucket for the build status
[18:44:47.941] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:13:0) after 1m0s
[18:45:48.003] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:13:0)
[18:45:48.003] Timer tick, asking Buildbucket for the build status
[18:45:48.248] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:48.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:14:0) after 1m0s
[18:46:48.232] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:14:0)
[18:46:48.232] Timer tick, asking Buildbucket for the build status
[18:46:48.617] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:48.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:15:0) after 1m0s
[18:47:48.686] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:15:0)
[18:47:48.686] Timer tick, asking Buildbucket for the build status
[18:47:49.031] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:49.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:16:0) after 1m0s
[18:48:49.103] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:16:0)
[18:48:49.103] Timer tick, asking Buildbucket for the build status
[18:48:49.299] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:49.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:17:0) after 1m0s
[18:49:49.328] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:17:0)
[18:49:49.328] Timer tick, asking Buildbucket for the build status
[18:49:49.419] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:49.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:18:0) after 1m0s
[18:50:49.401] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:18:0)
[18:50:49.401] Timer tick, asking Buildbucket for the build status
[18:50:50.828] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:50.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:19:0) after 1m0s
[18:51:50.880] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:19:0)
[18:51:50.880] Timer tick, asking Buildbucket for the build status
[18:51:50.965] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:50.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:20:0) after 1m0s
[18:52:51.011] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:20:0)
[18:52:51.011] Timer tick, asking Buildbucket for the build status
[18:52:51.083] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:51.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:21:0) after 1m0s
[18:53:51.102] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:21:0)
[18:53:51.102] Timer tick, asking Buildbucket for the build status
[18:53:51.278] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:51.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:22:0) after 1m0s
[18:54:51.342] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:22:0)
[18:54:51.342] Timer tick, asking Buildbucket for the build status
[18:54:51.584] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:51.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:23:0) after 1m0s
[18:55:51.650] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:23:0)
[18:55:51.651] Timer tick, asking Buildbucket for the build status
[18:55:51.788] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:51.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:24:0) after 1m0s
[18:56:51.808] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:24:0)
[18:56:51.808] Timer tick, asking Buildbucket for the build status
[18:56:51.896] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:51.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:25:0) after 1m0s
[18:57:51.917] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:25:0)
[18:57:51.917] Timer tick, asking Buildbucket for the build status
[18:57:51.983] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:51.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:26:0) after 1m0s
[18:58:51.994] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:26:0)
[18:58:51.994] Timer tick, asking Buildbucket for the build status
[18:58:52.115] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:52.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:27:0) after 1m0s
[18:59:52.163] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:27:0)
[18:59:52.163] Timer tick, asking Buildbucket for the build status
[18:59:52.265] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:52.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:28:0) after 1m0s
[19:00:52.364] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:28:0)
[19:00:52.364] Timer tick, asking Buildbucket for the build status
[19:00:52.491] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:52.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:29:0) after 1m0s
[19:01:52.603] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:29:0)
[19:01:52.603] Timer tick, asking Buildbucket for the build status
[19:01:52.748] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:30:0) after 1m0s
[19:02:52.861] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:30:0)
[19:02:52.861] Timer tick, asking Buildbucket for the build status
[19:02:52.962] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:52.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:31:0) after 1m0s
[19:03:53.014] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:31:0)
[19:03:53.014] Timer tick, asking Buildbucket for the build status
[19:03:53.173] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:53.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:32:0) after 1m0s
[19:04:53.315] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:32:0)
[19:04:53.315] Timer tick, asking Buildbucket for the build status
[19:04:53.511] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:53.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:33:0) after 1m0s
[19:05:53.736] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:33:0)
[19:05:53.736] Timer tick, asking Buildbucket for the build status
[19:05:53.883] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:53.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:34:0) after 1m0s
[19:06:54.257] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:34:0)
[19:06:54.257] Timer tick, asking Buildbucket for the build status
[19:06:54.401] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:54.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:35:0) after 1m0s
[19:07:54.724] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:35:0)
[19:07:54.724] Timer tick, asking Buildbucket for the build status
[19:07:54.802] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:54.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:36:0) after 1m0s
[19:08:55.006] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:36:0)
[19:08:55.006] Timer tick, asking Buildbucket for the build status
[19:08:55.129] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:55.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:37:0) after 1m0s
[19:09:55.301] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:37:0)
[19:09:55.301] Timer tick, asking Buildbucket for the build status
[19:09:55.386] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:55.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:38:0) after 1m0s
[19:10:55.450] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:38:0)
[19:10:55.450] Timer tick, asking Buildbucket for the build status
[19:10:56.511] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:56.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:39:0) after 1m0s
[19:11:56.715] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:39:0)
[19:11:56.715] Timer tick, asking Buildbucket for the build status
[19:11:56.798] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:56.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:40:0) after 1m0s
[19:12:56.894] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:40:0)
[19:12:56.894] Timer tick, asking Buildbucket for the build status
[19:12:56.983] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:56.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:41:0) after 1m0s
[19:13:57.074] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:41:0)
[19:13:57.074] Timer tick, asking Buildbucket for the build status
[19:13:57.225] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:57.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:42:0) after 1m0s
[19:14:57.288] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:42:0)
[19:14:57.288] Timer tick, asking Buildbucket for the build status
[19:14:57.375] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:57.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:43:0) after 1m0s
[19:15:57.421] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:43:0)
[19:15:57.421] Timer tick, asking Buildbucket for the build status
[19:15:57.751] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:57.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:44:0) after 1m0s
[19:16:57.821] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:44:0)
[19:16:57.821] Timer tick, asking Buildbucket for the build status
[19:16:57.926] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:57.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:45:0) after 1m0s
[19:17:58.068] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:45:0)
[19:17:58.068] Timer tick, asking Buildbucket for the build status
[19:17:58.418] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:58.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:46:0) after 1m0s
[19:18:58.483] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:46:0)
[19:18:58.483] Timer tick, asking Buildbucket for the build status
[19:18:58.715] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:58.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:47:0) after 1m0s
[19:19:58.771] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:47:0)
[19:19:58.771] Timer tick, asking Buildbucket for the build status
[19:19:58.997] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:58.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:48:0) after 1m0s
[19:20:59.034] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:48:0)
[19:20:59.034] Timer tick, asking Buildbucket for the build status
[19:20:59.134] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:59.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:49:0) after 1m0s
[19:21:59.193] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:49:0)
[19:21:59.193] Timer tick, asking Buildbucket for the build status
[19:21:59.510] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:59.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:50:0) after 1m0s
[19:22:59.786] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:50:0)
[19:22:59.786] Timer tick, asking Buildbucket for the build status
[19:22:59.868] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:59.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:51:0) after 1m0s
[19:23:59.947] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:51:0)
[19:23:59.947] Timer tick, asking Buildbucket for the build status
[19:24:00.222] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:00.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:52:0) after 1m0s
[19:25:01.097] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:52:0)
[19:25:01.097] Timer tick, asking Buildbucket for the build status
[19:25:01.186] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:01.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:53:0) after 1m0s
[19:26:01.373] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:53:0)
[19:26:01.373] Timer tick, asking Buildbucket for the build status
[19:26:01.445] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:01.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:54:0) after 1m0s
[19:27:01.470] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:54:0)
[19:27:01.470] Timer tick, asking Buildbucket for the build status
[19:27:01.733] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:01.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:55:0) after 1m0s
[19:28:04.085] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:55:0)
[19:28:04.086] Timer tick, asking Buildbucket for the build status
[19:28:06.035] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:56:0) after 1m0s
[19:29:06.078] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:56:0)
[19:29:06.078] Timer tick, asking Buildbucket for the build status
[19:29:06.174] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:06.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:57:0) after 1m0s
[19:30:06.244] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:57:0)
[19:30:06.244] Timer tick, asking Buildbucket for the build status
[19:30:06.345] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:06.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:58:0) after 1m0s
[19:31:06.889] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:58:0)
[19:31:06.889] Timer tick, asking Buildbucket for the build status
[19:31:06.972] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:59:0) after 1m0s
[19:32:07.516] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:59:0)
[19:32:07.516] Timer tick, asking Buildbucket for the build status
[19:32:07.626] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:07.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:60:0) after 1m0s
[19:33:07.867] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:60:0)
[19:33:07.867] Timer tick, asking Buildbucket for the build status
[19:33:07.939] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:07.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:61:0) after 1m0s
[19:34:07.968] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:61:0)
[19:34:07.968] Timer tick, asking Buildbucket for the build status
[19:34:08.205] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:08.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:62:0) after 1m0s
[19:35:08.305] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:62:0)
[19:35:08.305] Timer tick, asking Buildbucket for the build status
[19:35:08.362] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:08.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:63:0) after 1m0s
[19:36:08.577] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:63:0)
[19:36:08.577] Timer tick, asking Buildbucket for the build status
[19:36:08.650] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:08.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:64:0) after 1m0s
[19:37:09.026] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:64:0)
[19:37:09.026] Timer tick, asking Buildbucket for the build status
[19:37:09.115] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:09.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:65:0) after 1m0s
[19:38:09.405] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:65:0)
[19:38:09.405] Timer tick, asking Buildbucket for the build status
[19:38:09.489] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:09.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:66:0) after 1m0s
[19:39:09.737] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:66:0)
[19:39:09.737] Timer tick, asking Buildbucket for the build status
[19:39:09.873] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:09.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:67:0) after 1m0s
[19:40:10.015] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:67:0)
[19:40:10.015] Timer tick, asking Buildbucket for the build status
[19:40:10.093] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:10.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:68:0) after 1m0s
[19:41:10.214] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:68:0)
[19:41:10.215] Timer tick, asking Buildbucket for the build status
[19:41:10.297] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:69:0) after 1m0s
[19:42:10.315] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:69:0)
[19:42:10.315] Timer tick, asking Buildbucket for the build status
[19:42:10.394] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:10.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:70:0) after 1m0s
[19:43:10.439] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:70:0)
[19:43:10.439] Timer tick, asking Buildbucket for the build status
[19:43:10.719] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:10.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:71:0) after 1m0s
[19:44:10.938] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:71:0)
[19:44:10.938] Timer tick, asking Buildbucket for the build status
[19:44:11.083] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:11.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:72:0) after 1m0s
[19:45:11.143] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:72:0)
[19:45:11.143] Timer tick, asking Buildbucket for the build status
[19:45:11.904] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:73:0) after 1m0s
[19:46:11.960] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:73:0)
[19:46:11.960] Timer tick, asking Buildbucket for the build status
[19:46:12.080] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:12.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:74:0) after 1m0s
[19:47:12.132] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:74:0)
[19:47:12.132] Timer tick, asking Buildbucket for the build status
[19:47:12.487] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:12.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:75:0) after 1m0s
[19:48:12.560] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:75:0)
[19:48:12.560] Timer tick, asking Buildbucket for the build status
[19:48:12.635] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:12.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:76:0) after 1m0s
[19:49:12.693] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:76:0)
[19:49:12.693] Timer tick, asking Buildbucket for the build status
[19:49:12.801] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:12.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:77:0) after 1m0s
[19:50:12.787] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:77:0)
[19:50:12.787] Timer tick, asking Buildbucket for the build status
[19:50:12.888] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:12.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:78:0) after 1m0s
[19:51:13.015] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:78:0)
[19:51:13.015] Timer tick, asking Buildbucket for the build status
[19:51:13.097] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:13.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:79:0) after 1m0s
[19:52:13.111] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:79:0)
[19:52:13.111] Timer tick, asking Buildbucket for the build status
[19:52:13.188] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:13.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:80:0) after 1m0s
[19:53:13.272] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:80:0)
[19:53:13.272] Timer tick, asking Buildbucket for the build status
[19:53:13.351] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:13.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:81:0) after 1m0s
[19:54:13.699] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:81:0)
[19:54:13.700] Timer tick, asking Buildbucket for the build status
[19:54:13.814] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:13.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:82:0) after 1m0s
[19:55:13.921] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:82:0)
[19:55:13.921] Timer tick, asking Buildbucket for the build status
[19:55:14.003] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:14.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:83:0) after 1m0s
[19:56:14.054] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:83:0)
[19:56:14.054] Timer tick, asking Buildbucket for the build status
[19:56:14.134] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:84:0) after 1m0s
[19:57:14.235] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:84:0)
[19:57:14.235] Timer tick, asking Buildbucket for the build status
[19:57:14.612] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:14.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:85:0) after 1m0s
[19:58:14.666] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:85:0)
[19:58:14.666] Timer tick, asking Buildbucket for the build status
[19:58:14.736] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:14.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:86:0) after 1m0s
[19:59:14.922] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:86:0)
[19:59:14.922] Timer tick, asking Buildbucket for the build status
[19:59:15.042] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:15.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:87:0) after 1m0s
[20:00:15.195] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:87:0)
[20:00:15.195] Timer tick, asking Buildbucket for the build status
[20:00:15.293] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:15.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:88:0) after 1m0s
[20:01:15.362] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:88:0)
[20:01:15.362] Timer tick, asking Buildbucket for the build status
[20:01:15.524] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:15.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:89:0) after 1m0s
[20:02:15.603] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:89:0)
[20:02:15.603] Timer tick, asking Buildbucket for the build status
[20:02:15.759] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:15.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:90:0) after 1m0s
[20:03:15.849] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:90:0)
[20:03:15.849] Timer tick, asking Buildbucket for the build status
[20:03:15.921] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:91:0) after 1m0s
[20:04:15.951] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:91:0)
[20:04:15.951] Timer tick, asking Buildbucket for the build status
[20:04:16.170] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:16.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:92:0) after 1m0s
[20:05:16.275] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:92:0)
[20:05:16.275] Timer tick, asking Buildbucket for the build status
[20:05:16.743] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:16.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:93:0) after 1m0s
[20:06:16.773] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:93:0)
[20:06:16.773] Timer tick, asking Buildbucket for the build status
[20:06:17.144] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:17.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:94:0) after 1m0s
[20:07:17.136] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:94:0)
[20:07:17.136] Timer tick, asking Buildbucket for the build status
[20:07:17.387] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:17.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:95:0) after 1m0s
[20:08:17.454] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:95:0)
[20:08:17.454] Timer tick, asking Buildbucket for the build status
[20:08:17.570] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:17.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:96:0) after 1m0s
[20:09:17.612] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:96:0)
[20:09:17.612] Timer tick, asking Buildbucket for the build status
[20:09:17.726] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:17.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:97:0) after 1m0s
[20:10:17.788] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:97:0)
[20:10:17.788] Timer tick, asking Buildbucket for the build status
[20:10:17.864] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:17.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:98:0) after 1m0s
[20:11:17.937] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:98:0)
[20:11:17.937] Timer tick, asking Buildbucket for the build status
[20:11:18.036] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:18.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:99:0) after 1m0s
[20:12:18.141] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:99:0)
[20:12:18.141] Timer tick, asking Buildbucket for the build status
[20:12:18.246] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:18.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:100:0) after 1m0s
[20:13:18.271] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:100:0)
[20:13:18.271] Timer tick, asking Buildbucket for the build status
[20:13:18.437] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:18.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:101:0) after 1m0s
[20:14:18.519] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:101:0)
[20:14:18.519] Timer tick, asking Buildbucket for the build status
[20:14:19.170] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:19.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:102:0) after 1m0s
[20:15:19.171] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:102:0)
[20:15:19.171] Timer tick, asking Buildbucket for the build status
[20:15:29.384] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:29.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:103:0) after 1m0s
[20:16:29.436] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:103:0)
[20:16:29.436] Timer tick, asking Buildbucket for the build status
[20:16:29.590] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:29.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:104:0) after 1m0s
[20:17:29.627] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:104:0)
[20:17:29.627] Timer tick, asking Buildbucket for the build status
[20:17:29.746] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:29.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:105:0) after 1m0s
[20:18:29.771] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:105:0)
[20:18:29.771] Timer tick, asking Buildbucket for the build status
[20:18:29.939] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:29.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:106:0) after 1m0s
[20:19:30.022] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:106:0)
[20:19:30.022] Timer tick, asking Buildbucket for the build status
[20:19:30.189] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:30.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:107:0) after 1m0s
[20:20:30.297] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:107:0)
[20:20:30.297] Timer tick, asking Buildbucket for the build status
[20:20:30.390] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:30.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:108:0) after 1m0s
[20:21:30.495] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:108:0)
[20:21:30.495] Timer tick, asking Buildbucket for the build status
[20:21:30.588] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:109:0) after 1m0s
[20:22:30.657] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:109:0)
[20:22:30.657] Timer tick, asking Buildbucket for the build status
[20:22:30.729] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:30.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:110:0) after 1m0s
[20:23:30.734] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:110:0)
[20:23:30.734] Timer tick, asking Buildbucket for the build status
[20:23:30.820] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:30.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:111:0) after 1m0s
[20:24:30.851] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:111:0)
[20:24:30.851] Timer tick, asking Buildbucket for the build status
[20:24:31.018] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:31.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:112:0) after 1m0s
[20:25:31.064] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:112:0)
[20:25:31.064] Timer tick, asking Buildbucket for the build status
[20:25:31.186] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:31.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:113:0) after 1m0s
[20:26:31.240] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:113:0)
[20:26:31.240] Timer tick, asking Buildbucket for the build status
[20:26:32.082] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:32.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:114:0) after 1m0s
[20:27:32.094] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:114:0)
[20:27:32.094] Timer tick, asking Buildbucket for the build status
[20:27:32.458] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:32.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:115:0) after 1m0s
[20:28:32.556] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:115:0)
[20:28:32.556] Timer tick, asking Buildbucket for the build status
[20:28:32.631] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:32.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:116:0) after 1m0s
[20:29:32.681] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:116:0)
[20:29:32.681] Timer tick, asking Buildbucket for the build status
[20:29:32.782] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:117:0) after 1m0s
[20:30:32.844] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:117:0)
[20:30:32.844] Timer tick, asking Buildbucket for the build status
[20:30:33.207] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:33.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:118:0) after 1m0s
[20:31:33.261] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:118:0)
[20:31:33.261] Timer tick, asking Buildbucket for the build status
[20:31:33.336] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:33.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:119:0) after 1m0s
[20:32:33.341] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:119:0)
[20:32:33.341] Timer tick, asking Buildbucket for the build status
[20:32:33.452] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:33.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:120:0) after 1m0s
[20:33:33.497] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:120:0)
[20:33:33.497] Timer tick, asking Buildbucket for the build status
[20:33:33.746] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:33.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:121:0) after 1m0s
[20:34:33.755] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:121:0)
[20:34:33.755] Timer tick, asking Buildbucket for the build status
[20:34:33.853] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:33.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:122:0) after 1m0s
[20:35:33.879] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:122:0)
[20:35:33.879] Timer tick, asking Buildbucket for the build status
[20:35:33.969] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:33.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:123:0) after 1m0s
[20:36:33.992] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:123:0)
[20:36:33.992] Timer tick, asking Buildbucket for the build status
[20:36:34.067] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:124:0) after 1m0s
[20:37:34.095] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:124:0)
[20:37:34.095] Timer tick, asking Buildbucket for the build status
[20:37:34.240] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:34.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:125:0) after 1m0s
[20:38:34.318] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:125:0)
[20:38:34.318] Timer tick, asking Buildbucket for the build status
[20:38:34.395] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:34.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:126:0) after 1m0s
[20:39:34.439] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:126:0)
[20:39:34.439] Timer tick, asking Buildbucket for the build status
[20:39:34.531] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:34.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:127:0) after 1m0s
[20:40:34.601] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:127:0)
[20:40:34.601] Timer tick, asking Buildbucket for the build status
[20:40:34.668] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:34.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:128:0) after 1m0s
[20:41:34.776] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:128:0)
[20:41:34.776] Timer tick, asking Buildbucket for the build status
[20:41:34.859] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:129:0) after 1m0s
[20:42:34.947] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:129:0)
[20:42:34.947] Timer tick, asking Buildbucket for the build status
[20:42:35.163] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:35.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:130:0) after 1m0s
[20:43:35.274] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:130:0)
[20:43:35.275] Timer tick, asking Buildbucket for the build status
[20:43:35.495] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:35.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:131:0) after 1m0s
[20:44:35.628] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:131:0)
[20:44:35.628] Timer tick, asking Buildbucket for the build status
[20:44:36.844] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:36.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:132:0) after 1m0s
[20:45:36.954] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:132:0)
[20:45:36.954] Timer tick, asking Buildbucket for the build status
[20:45:37.121] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:37.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:133:0) after 1m0s
[20:46:37.194] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:133:0)
[20:46:37.194] Timer tick, asking Buildbucket for the build status
[20:46:38.013] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:38.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:134:0) after 1m0s
[20:47:38.075] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:134:0)
[20:47:38.075] Timer tick, asking Buildbucket for the build status
[20:47:38.226] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:38.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:135:0) after 1m0s
[20:48:38.240] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:135:0)
[20:48:38.240] Timer tick, asking Buildbucket for the build status
[20:48:38.487] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:136:0) after 1m0s
[20:49:38.501] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:136:0)
[20:49:38.501] Timer tick, asking Buildbucket for the build status
[20:49:40.848] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:40.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:137:0) after 1m0s
[20:50:40.881] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:137:0)
[20:50:40.881] Timer tick, asking Buildbucket for the build status
[20:50:40.957] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:40.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:138:0) after 1m0s
[20:51:40.981] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:138:0)
[20:51:40.981] Timer tick, asking Buildbucket for the build status
[20:51:41.067] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:41.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:139:0) after 1m0s
[20:52:41.129] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:139:0)
[20:52:41.129] Timer tick, asking Buildbucket for the build status
[20:52:41.216] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:41.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:140:0) after 1m0s
[20:53:41.237] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:140:0)
[20:53:41.237] Timer tick, asking Buildbucket for the build status
[20:53:42.322] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:42.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:141:0) after 1m0s
[20:54:42.368] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:141:0)
[20:54:42.368] Timer tick, asking Buildbucket for the build status
[20:54:42.459] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:42.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:142:0) after 1m0s
[20:55:42.508] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:142:0)
[20:55:42.508] Timer tick, asking Buildbucket for the build status
[20:55:42.584] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:42.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:143:0) after 1m0s
[20:56:42.595] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:143:0)
[20:56:42.595] Timer tick, asking Buildbucket for the build status
[20:56:43.768] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:43.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:144:0) after 1m0s
[20:57:43.821] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:144:0)
[20:57:43.821] Timer tick, asking Buildbucket for the build status
[20:57:44.139] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:44.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:145:0) after 1m0s
[20:58:44.173] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:145:0)
[20:58:44.173] Timer tick, asking Buildbucket for the build status
[20:58:44.270] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:44.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:146:0) after 1m0s
[20:59:44.298] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:146:0)
[20:59:44.298] Timer tick, asking Buildbucket for the build status
[20:59:44.398] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:44.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:147:0) after 1m0s
[21:00:44.482] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:147:0)
[21:00:44.482] Timer tick, asking Buildbucket for the build status
[21:00:44.750] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:44.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:148:0) after 1m0s
[21:01:44.769] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:148:0)
[21:01:44.769] Timer tick, asking Buildbucket for the build status
[21:01:44.858] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:44.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:149:0) after 1m0s
[21:02:44.990] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:149:0)
[21:02:44.990] Timer tick, asking Buildbucket for the build status
[21:02:45.102] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:45.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:150:0) after 1m0s
[21:03:45.161] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:150:0)
[21:03:45.161] Timer tick, asking Buildbucket for the build status
[21:03:45.312] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:45.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:151:0) after 1m0s
[21:04:45.360] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:151:0)
[21:04:45.360] Timer tick, asking Buildbucket for the build status
[21:04:45.550] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:45.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:152:0) after 1m0s
[21:05:45.611] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:152:0)
[21:05:45.611] Timer tick, asking Buildbucket for the build status
[21:05:45.692] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:45.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:153:0) after 1m0s
[21:06:45.702] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:153:0)
[21:06:45.702] Timer tick, asking Buildbucket for the build status
[21:06:46.013] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:46.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:154:0) after 1m0s
[21:07:46.120] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:154:0)
[21:07:46.120] Timer tick, asking Buildbucket for the build status
[21:07:46.333] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:46.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:155:0) after 1m0s
[21:08:46.389] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:155:0)
[21:08:46.389] Timer tick, asking Buildbucket for the build status
[21:08:46.474] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:46.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:156:0) after 1m0s
[21:09:46.522] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:156:0)
[21:09:46.522] Timer tick, asking Buildbucket for the build status
[21:09:46.711] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:46.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:157:0) after 1m0s
[21:10:46.725] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:157:0)
[21:10:46.725] Timer tick, asking Buildbucket for the build status
[21:10:46.829] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:46.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:158:0) after 1m0s
[21:11:46.858] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:158:0)
[21:11:46.858] Timer tick, asking Buildbucket for the build status
[21:11:46.955] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:46.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:159:0) after 1m0s
[21:12:47.004] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:159:0)
[21:12:47.004] Timer tick, asking Buildbucket for the build status
[21:12:47.094] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:47.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:160:0) after 1m0s
[21:13:47.125] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:160:0)
[21:13:47.125] Timer tick, asking Buildbucket for the build status
[21:13:47.203] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:47.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:161:0) after 1m0s
[21:14:47.310] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:161:0)
[21:14:47.310] Timer tick, asking Buildbucket for the build status
[21:14:47.423] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:47.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:162:0) after 1m0s
[21:15:47.521] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:162:0)
[21:15:47.521] Timer tick, asking Buildbucket for the build status
[21:15:47.705] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:47.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:163:0) after 1m0s
[21:16:47.795] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:163:0)
[21:16:47.795] Timer tick, asking Buildbucket for the build status
[21:16:47.970] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:47.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:164:0) after 1m0s
[21:17:48.032] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:164:0)
[21:17:48.032] Timer tick, asking Buildbucket for the build status
[21:17:48.135] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:48.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:165:0) after 1m0s
[21:18:48.258] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:165:0)
[21:18:48.259] Timer tick, asking Buildbucket for the build status
[21:18:49.278] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:49.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:166:0) after 1m0s
[21:19:49.255] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:166:0)
[21:19:49.255] Timer tick, asking Buildbucket for the build status
[21:19:49.362] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:49.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:167:0) after 1m0s
[21:20:49.442] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:167:0)
[21:20:49.442] Timer tick, asking Buildbucket for the build status
[21:20:49.618] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:49.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:168:0) after 1m0s
[21:21:49.668] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:168:0)
[21:21:49.668] Timer tick, asking Buildbucket for the build status
[21:21:50.068] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:50.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:169:0) after 1m0s
[21:22:50.197] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:169:0)
[21:22:50.197] Timer tick, asking Buildbucket for the build status
[21:22:50.324] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:50.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:170:0) after 1m0s
[21:23:50.370] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:170:0)
[21:23:50.370] Timer tick, asking Buildbucket for the build status
[21:23:50.455] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:50.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:171:0) after 1m0s
[21:24:50.595] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:171:0)
[21:24:50.595] Timer tick, asking Buildbucket for the build status
[21:24:50.756] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:50.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:172:0) after 1m0s
[21:25:50.829] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:172:0)
[21:25:50.829] Timer tick, asking Buildbucket for the build status
[21:25:52.435] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:52.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:173:0) after 1m0s
[21:26:52.546] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:173:0)
[21:26:52.546] Timer tick, asking Buildbucket for the build status
[21:26:52.666] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:52.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:174:0) after 1m0s
[21:27:52.834] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:174:0)
[21:27:52.834] Timer tick, asking Buildbucket for the build status
[21:27:52.922] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:52.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:175:0) after 1m0s
[21:28:53.188] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:175:0)
[21:28:53.188] Timer tick, asking Buildbucket for the build status
[21:28:53.658] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:53.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:176:0) after 1m0s
[21:29:53.731] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:176:0)
[21:29:53.731] Timer tick, asking Buildbucket for the build status
[21:29:53.851] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:53.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:177:0) after 1m0s
[21:30:53.882] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:177:0)
[21:30:53.882] Timer tick, asking Buildbucket for the build status
[21:30:54.143] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:54.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:178:0) after 1m0s
[21:31:54.227] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:178:0)
[21:31:54.227] Timer tick, asking Buildbucket for the build status
[21:31:54.323] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:54.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:179:0) after 1m0s
[21:32:54.482] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:179:0)
[21:32:54.482] Timer tick, asking Buildbucket for the build status
[21:32:54.905] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:32:54.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:180:0) after 1m0s
[21:33:54.978] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:180:0)
[21:33:54.978] Timer tick, asking Buildbucket for the build status
[21:33:55.052] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:33:55.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:181:0) after 1m0s
[21:34:55.208] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:181:0)
[21:34:55.208] Timer tick, asking Buildbucket for the build status
[21:34:55.324] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:34:55.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:182:0) after 1m0s
[21:35:55.399] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:182:0)
[21:35:55.399] Timer tick, asking Buildbucket for the build status
[21:35:56.416] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:35:56.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:183:0) after 1m0s
[21:36:56.516] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:183:0)
[21:36:56.516] Timer tick, asking Buildbucket for the build status
[21:36:56.606] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:56.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:184:0) after 1m0s
[21:37:56.671] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:184:0)
[21:37:56.671] Timer tick, asking Buildbucket for the build status
[21:37:56.756] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:56.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:185:0) after 1m0s
[21:38:56.815] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:185:0)
[21:38:56.816] Timer tick, asking Buildbucket for the build status
[21:38:56.894] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:56.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:186:0) after 1m0s
[21:39:56.880] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:186:0)
[21:39:56.880] Timer tick, asking Buildbucket for the build status
[21:39:56.964] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:56.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:187:0) after 1m0s
[21:40:57.011] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:187:0)
[21:40:57.011] Timer tick, asking Buildbucket for the build status
[21:40:57.085] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:57.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:188:0) after 1m0s
[21:41:57.114] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:188:0)
[21:41:57.114] Timer tick, asking Buildbucket for the build status
[21:41:57.209] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:57.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:189:0) after 1m0s
[21:42:57.241] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:189:0)
[21:42:57.242] Timer tick, asking Buildbucket for the build status
[21:42:57.329] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:57.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:190:0) after 1m0s
[21:43:57.457] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:190:0)
[21:43:57.457] Timer tick, asking Buildbucket for the build status
[21:43:58.253] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:58.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:191:0) after 1m0s
[21:44:58.326] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:191:0)
[21:44:58.326] Timer tick, asking Buildbucket for the build status
[21:44:58.444] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:192:0) after 1m0s
[21:45:58.431] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:192:0)
[21:45:58.431] Timer tick, asking Buildbucket for the build status
[21:45:58.607] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:58.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:193:0) after 1m0s
[21:46:58.665] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:193:0)
[21:46:58.665] Timer tick, asking Buildbucket for the build status
[21:46:58.741] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:58.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:194:0) after 1m0s
[21:47:58.785] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:194:0)
[21:47:58.785] Timer tick, asking Buildbucket for the build status
[21:47:58.877] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:58.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:195:0) after 1m0s
[21:48:58.948] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:195:0)
[21:48:58.948] Timer tick, asking Buildbucket for the build status
[21:48:59.049] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:59.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:196:0) after 1m0s
[21:49:59.091] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:196:0)
[21:49:59.091] Timer tick, asking Buildbucket for the build status
[21:49:59.498] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:59.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:197:0) after 1m0s
[21:50:59.552] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:197:0)
[21:50:59.552] Timer tick, asking Buildbucket for the build status
[21:50:59.946] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:59.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:198:0) after 1m0s
[21:52:00.013] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:198:0)
[21:52:00.013] Timer tick, asking Buildbucket for the build status
[21:52:02.840] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:02.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:199:0) after 1m0s
[21:53:02.873] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:199:0)
[21:53:02.873] Timer tick, asking Buildbucket for the build status
[21:53:02.951] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:02.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:200:0) after 1m0s
[21:54:03.013] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:200:0)
[21:54:03.013] Timer tick, asking Buildbucket for the build status
[21:54:03.118] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:03.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:201:0) after 1m0s
[21:55:03.178] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:201:0)
[21:55:03.178] Timer tick, asking Buildbucket for the build status
[21:55:03.506] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:03.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:202:0) after 1m0s
[21:56:03.599] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:202:0)
[21:56:03.599] Timer tick, asking Buildbucket for the build status
[21:56:03.668] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:203:0) after 1m0s
[21:57:03.700] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:203:0)
[21:57:03.700] Timer tick, asking Buildbucket for the build status
[21:57:03.988] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:03.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:204:0) after 1m0s
[21:58:04.174] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:204:0)
[21:58:04.174] Timer tick, asking Buildbucket for the build status
[21:58:04.260] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:04.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:205:0) after 1m0s
[21:59:04.459] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:205:0)
[21:59:04.459] Timer tick, asking Buildbucket for the build status
[21:59:04.669] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:04.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:206:0) after 1m0s
[22:00:04.818] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:206:0)
[22:00:04.818] Timer tick, asking Buildbucket for the build status
[22:00:05.739] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:05.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:207:0) after 1m0s
[22:01:05.931] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:207:0)
[22:01:05.931] Timer tick, asking Buildbucket for the build status
[22:01:06.171] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:06.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:208:0) after 1m0s
[22:02:06.363] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:208:0)
[22:02:06.363] Timer tick, asking Buildbucket for the build status
[22:02:06.580] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:06.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:209:0) after 1m0s
[22:03:06.769] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:209:0)
[22:03:06.769] Timer tick, asking Buildbucket for the build status
[22:03:06.848] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:06.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:210:0) after 1m0s
[22:04:06.948] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:210:0)
[22:04:06.948] Timer tick, asking Buildbucket for the build status
[22:04:07.057] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:07.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:211:0) after 1m0s
[22:05:07.134] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:211:0)
[22:05:07.134] Timer tick, asking Buildbucket for the build status
[22:05:07.216] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:07.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:212:0) after 1m0s
[22:06:07.255] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:212:0)
[22:06:07.255] Timer tick, asking Buildbucket for the build status
[22:06:07.541] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:07.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:213:0) after 1m0s
[22:07:07.678] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:213:0)
[22:07:07.678] Timer tick, asking Buildbucket for the build status
[22:07:07.880] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:07.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:214:0) after 1m0s
[22:08:07.935] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:214:0)
[22:08:07.935] Timer tick, asking Buildbucket for the build status
[22:08:08.036] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:08.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:215:0) after 1m0s
[22:09:08.096] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:215:0)
[22:09:08.096] Timer tick, asking Buildbucket for the build status
[22:09:08.227] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:08.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:216:0) after 1m0s
[22:10:08.277] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:216:0)
[22:10:08.277] Timer tick, asking Buildbucket for the build status
[22:10:08.384] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:08.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:217:0) after 1m0s
[22:11:08.547] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:217:0)
[22:11:08.547] Timer tick, asking Buildbucket for the build status
[22:11:08.626] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:08.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:218:0) after 1m0s
[22:12:08.670] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:218:0)
[22:12:08.670] Timer tick, asking Buildbucket for the build status
[22:12:08.903] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:08.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:219:0) after 1m0s
[22:13:09.011] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:219:0)
[22:13:09.011] Timer tick, asking Buildbucket for the build status
[22:13:09.355] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:09.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:220:0) after 1m0s
[22:14:09.438] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:220:0)
[22:14:09.438] Timer tick, asking Buildbucket for the build status
[22:14:09.753] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:09.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:221:0) after 1m0s
[22:15:09.780] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:221:0)
[22:15:09.780] Timer tick, asking Buildbucket for the build status
[22:15:10.079] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:10.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:222:0) after 1m0s
[22:16:10.077] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:222:0)
[22:16:10.077] Timer tick, asking Buildbucket for the build status
[22:16:10.169] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:10.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:223:0) after 1m0s
[22:17:10.196] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:223:0)
[22:17:10.196] Timer tick, asking Buildbucket for the build status
[22:17:10.423] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:10.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:224:0) after 1m0s
[22:18:10.464] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:224:0)
[22:18:10.464] Timer tick, asking Buildbucket for the build status
[22:18:10.639] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:10.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:225:0) after 1m0s
[22:19:10.687] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:225:0)
[22:19:10.687] Timer tick, asking Buildbucket for the build status
[22:19:10.808] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:10.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:226:0) after 1m0s
[22:20:10.868] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:226:0)
[22:20:10.868] Timer tick, asking Buildbucket for the build status
[22:20:10.985] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:10.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:227:0) after 1m0s
[22:21:11.018] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:227:0)
[22:21:11.018] Timer tick, asking Buildbucket for the build status
[22:21:11.221] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:228:0) after 1m0s
[22:22:11.229] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:228:0)
[22:22:11.229] Timer tick, asking Buildbucket for the build status
[22:22:11.315] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:11.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:229:0) after 1m0s
[22:23:11.364] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:229:0)
[22:23:11.364] Timer tick, asking Buildbucket for the build status
[22:23:11.743] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:11.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:230:0) after 1m0s
[22:24:11.937] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:230:0)
[22:24:11.937] Timer tick, asking Buildbucket for the build status
[22:24:12.132] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:12.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:231:0) after 1m0s
[22:25:12.303] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:231:0)
[22:25:12.303] Timer tick, asking Buildbucket for the build status
[22:25:12.390] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:12.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:232:0) after 1m0s
[22:26:12.531] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:232:0)
[22:26:12.531] Timer tick, asking Buildbucket for the build status
[22:26:12.613] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:12.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:233:0) after 1m0s
[22:27:12.741] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:233:0)
[22:27:12.741] Timer tick, asking Buildbucket for the build status
[22:27:12.852] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:12.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:234:0) after 1m0s
[22:28:12.989] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:234:0)
[22:28:12.989] Timer tick, asking Buildbucket for the build status
[22:28:13.145] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:13.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:235:0) after 1m0s
[22:29:13.387] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:235:0)
[22:29:13.387] Timer tick, asking Buildbucket for the build status
[22:29:13.488] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:13.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:236:0) after 1m0s
[22:30:13.968] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:236:0)
[22:30:13.968] Timer tick, asking Buildbucket for the build status
[22:30:14.273] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:14.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:237:0) after 1m0s
[22:31:15.107] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:237:0)
[22:31:15.107] Timer tick, asking Buildbucket for the build status
[22:31:15.352] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:15.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:238:0) after 1m0s
[22:32:15.489] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:238:0)
[22:32:15.489] Timer tick, asking Buildbucket for the build status
[22:32:15.725] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:15.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:239:0) after 1m0s
[22:33:15.881] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:239:0)
[22:33:15.881] Timer tick, asking Buildbucket for the build status
[22:33:15.955] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:15.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:240:0) after 1m0s
[22:34:16.023] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:240:0)
[22:34:16.023] Timer tick, asking Buildbucket for the build status
[22:34:16.784] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:16.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:241:0) after 1m0s
[22:35:16.814] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:241:0)
[22:35:16.814] Timer tick, asking Buildbucket for the build status
[22:35:16.890] Build 8863088431128851232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:16.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:242:0) after 1m0s
[22:35:18.765] Received PubSub notification, asking Buildbucket for the build status
[22:35:18.844] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:17.220] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:242:0)
[22:36:17.220] Timer tick, asking Buildbucket for the build status
[22:36:17.760] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:17.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:244:0) after 1m0s
[22:37:17.871] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:244:0)
[22:37:17.871] Timer tick, asking Buildbucket for the build status
[22:37:22.117] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:22.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:245:0) after 1m0s
[22:38:22.508] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:245:0)
[22:38:22.508] Timer tick, asking Buildbucket for the build status
[22:38:22.577] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:22.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:246:0) after 1m0s
[22:39:22.917] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:246:0)
[22:39:22.917] Timer tick, asking Buildbucket for the build status
[22:39:23.028] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:23.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:247:0) after 1m0s
[22:40:23.254] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:247:0)
[22:40:23.254] Timer tick, asking Buildbucket for the build status
[22:40:23.311] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:248:0) after 1m0s
[22:41:23.472] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:248:0)
[22:41:23.472] Timer tick, asking Buildbucket for the build status
[22:41:23.554] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:23.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:249:0) after 1m0s
[22:42:23.788] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:249:0)
[22:42:23.788] Timer tick, asking Buildbucket for the build status
[22:42:23.844] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:23.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:250:0) after 1m0s
[22:43:23.933] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:250:0)
[22:43:23.933] Timer tick, asking Buildbucket for the build status
[22:43:24.063] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:24.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:251:0) after 1m0s
[22:44:24.176] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:251:0)
[22:44:24.176] Timer tick, asking Buildbucket for the build status
[22:44:24.442] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:24.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:252:0) after 1m0s
[22:45:24.472] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:252:0)
[22:45:24.472] Timer tick, asking Buildbucket for the build status
[22:45:24.578] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:24.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:253:0) after 1m0s
[22:46:24.657] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:253:0)
[22:46:24.657] Timer tick, asking Buildbucket for the build status
[22:46:24.715] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:24.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:254:0) after 1m0s
[22:47:24.759] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:254:0)
[22:47:24.759] Timer tick, asking Buildbucket for the build status
[22:47:24.848] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:24.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:255:0) after 1m0s
[22:48:24.878] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:255:0)
[22:48:24.878] Timer tick, asking Buildbucket for the build status
[22:48:24.980] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:24.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:256:0) after 1m0s
[22:49:25.059] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:256:0)
[22:49:25.059] Timer tick, asking Buildbucket for the build status
[22:49:25.289] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:25.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:257:0) after 1m0s
[22:50:25.349] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:257:0)
[22:50:25.349] Timer tick, asking Buildbucket for the build status
[22:50:26.917] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:26.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:258:0) after 1m0s
[22:51:26.956] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:258:0)
[22:51:26.956] Timer tick, asking Buildbucket for the build status
[22:51:28.840] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:28.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:259:0) after 1m0s
[22:52:28.915] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:259:0)
[22:52:28.915] Timer tick, asking Buildbucket for the build status
[22:52:28.977] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:28.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:260:0) after 1m0s
[22:53:29.016] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:260:0)
[22:53:29.016] Timer tick, asking Buildbucket for the build status
[22:53:29.102] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:29.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:261:0) after 1m0s
[22:54:29.241] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:261:0)
[22:54:29.241] Timer tick, asking Buildbucket for the build status
[22:54:29.374] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:29.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:262:0) after 1m0s
[22:55:29.374] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:262:0)
[22:55:29.374] Timer tick, asking Buildbucket for the build status
[22:55:29.480] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:29.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:263:0) after 1m0s
[22:56:29.534] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:263:0)
[22:56:29.534] Timer tick, asking Buildbucket for the build status
[22:56:29.627] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:29.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:264:0) after 1m0s
[22:57:29.743] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:264:0)
[22:57:29.743] Timer tick, asking Buildbucket for the build status
[22:57:30.034] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:30.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:265:0) after 1m0s
[22:58:30.133] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:265:0)
[22:58:30.133] Timer tick, asking Buildbucket for the build status
[22:58:30.277] Build 8863088431128851232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:30.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028518493137736816:266:0) after 1m0s
[22:59:22.826] Received PubSub notification, asking Buildbucket for the build status
[22:59:22.881] Build 8863088431128851232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:59:22.881] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1605913162031414",
    "created_by": "project:chromium",
    "created_ts": "1605897221403003",
    "id": "8863088431128851232",
    "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\": \"17a7e1ebebef5e2904f742c34b074331d40398d3\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-8-1-tvz8\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1769, \"got_angle_revision\": \"c4ca12e32e6aef9f5f8eb06c4b361264bec19f8d\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"17a7e1ebebef5e2904f742c34b074331d40398d3\", \"got_revision_cp\": \"refs/heads/master@{#829833}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"aeb3616301c8a2988ede07e4c34e8975da4d5fa0\", \"got_v8_revision\": \"8a682e08571d84f1d93ef73a07cfac7a089676c9\", \"got_v8_revision_cp\": \"refs/heads/8.9.28@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#829833}_without_patch\": {\"upload_trace_processor\": \"eed814529dde54eb3ca54af5b1f77aa6bb67a1ad\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1bdf55b197d439c94705ddfba40ad846e2fdb8dd164b64a485766434889345a8_v2\", \"builder_48ce158d992f85c54a400240cc3d77408bb96a2369de806c235fde7d7ef64068_v2\", \"builder_6b755bbaffc280fb83e7e303317e4888b2acb597c551cb7db892c262f1cf5030_v2\", \"builder_7e7f4ebc5094421a46baff10228f22baf4d4d757ab94366d4bf23e3f4dc4e562_v2\", \"builder_9fe9814ce14bb8ceec490c2f73b354cfd72877294131c83e8f28b19a7d4650fc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-8-1-tvz8\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1605911717617527",
    "status": "COMPLETED",
    "status_changed_ts": "1605913162556729",
    "tags": [
      "build_address:luci.chromium.ci/win-upload-perfetto/1769",
      "builder:win-upload-perfetto",
      "scheduler_invocation_id:9028518493137736816",
      "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/8863088431128851232/+/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:4fffc081cb421f10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1605913162565723",
    "url": "https://ci.chromium.org/b/8863088431128851232",
    "utcnow_ts": "1605913162873954"
  }
}
[22:59:22.881] Invocation finished in 4h25m42.77830892s with status SUCCEEDED