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

• cron:v1:4802 (5 years ago)

[22:39:49.446] New invocation is queued and will start shortly
[22:39:50.544] Starting the invocation (attempt 1)
[22:39:50.583] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:39:50.583] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:39:50.583] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9028865394246280816",
  "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:9028865394246280816",
    "scheduler_job_id:chromium/win-upload-perfetto",
    "user_agent:luci-scheduler"
  ]
}
[22:39:51.385] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1605566390669653",
    "id": "8863435332295797136",
    "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": "1605566391093807",
    "tags": [
      "build_address:luci.chromium.ci/win-upload-perfetto/1756",
      "builder:win-upload-perfetto",
      "scheduler_invocation_id:9028865394246280816",
      "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/8863435332295797136/+/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": "1605566391093995",
    "url": "https://ci.chromium.org/b/8863435332295797136",
    "utcnow_ts": "1605566391339138"
  }
}
[22:39:51.385] Task URL: https://ci.chromium.org/b/8863435332295797136
[22:39:51.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:2:0) after 1m0s
[22:40:51.451] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:2:0)
[22:40:51.451] Timer tick, asking Buildbucket for the build status
[22:40:51.974] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:51.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:3:0) after 1m0s
[22:41:52.071] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:3:0)
[22:41:52.071] Timer tick, asking Buildbucket for the build status
[22:41:52.183] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:52.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:4:0) after 1m0s
[22:42:52.247] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:4:0)
[22:42:52.247] Timer tick, asking Buildbucket for the build status
[22:42:52.341] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:52.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:5:0) after 1m0s
[22:43:52.320] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:5:0)
[22:43:52.320] Timer tick, asking Buildbucket for the build status
[22:43:52.406] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:52.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:6:0) after 1m0s
[22:44:52.578] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:6:0)
[22:44:52.578] Timer tick, asking Buildbucket for the build status
[22:44:52.837] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:52.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:7:0) after 1m0s
[22:45:53.024] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:7:0)
[22:45:53.024] Timer tick, asking Buildbucket for the build status
[22:45:53.127] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:53.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:8:0) after 1m0s
[22:46:53.203] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:8:0)
[22:46:53.203] Timer tick, asking Buildbucket for the build status
[22:46:53.508] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:53.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:9:0) after 1m0s
[22:47:53.773] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:9:0)
[22:47:53.773] Timer tick, asking Buildbucket for the build status
[22:47:53.859] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:53.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:10:0) after 1m0s
[22:48:53.954] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:10:0)
[22:48:53.954] Timer tick, asking Buildbucket for the build status
[22:48:54.019] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:54.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:11:0) after 1m0s
[22:49:54.108] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:11:0)
[22:49:54.108] Timer tick, asking Buildbucket for the build status
[22:49:54.264] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:54.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:12:0) after 1m0s
[22:50:54.316] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:12:0)
[22:50:54.316] Timer tick, asking Buildbucket for the build status
[22:50:54.385] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:54.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:13:0) after 1m0s
[22:51:54.490] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:13:0)
[22:51:54.490] Timer tick, asking Buildbucket for the build status
[22:51:54.841] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:54.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:14:0) after 1m0s
[22:52:55.025] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:14:0)
[22:52:55.025] Timer tick, asking Buildbucket for the build status
[22:52:55.136] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:55.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:15:0) after 1m0s
[22:53:55.173] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:15:0)
[22:53:55.173] Timer tick, asking Buildbucket for the build status
[22:53:55.249] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:55.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:16:0) after 1m0s
[22:54:55.277] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:16:0)
[22:54:55.277] Timer tick, asking Buildbucket for the build status
[22:54:55.369] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:55.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:17:0) after 1m0s
[22:55:55.418] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:17:0)
[22:55:55.418] Timer tick, asking Buildbucket for the build status
[22:55:55.493] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:55.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:18:0) after 1m0s
[22:56:55.561] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:18:0)
[22:56:55.561] Timer tick, asking Buildbucket for the build status
[22:56:56.004] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:56.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:19:0) after 1m0s
[22:57:56.072] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:19:0)
[22:57:56.072] Timer tick, asking Buildbucket for the build status
[22:57:56.328] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:56.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:20:0) after 1m0s
[22:58:56.354] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:20:0)
[22:58:56.354] Timer tick, asking Buildbucket for the build status
[22:58:56.446] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:56.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:21:0) after 1m0s
[22:59:56.541] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:21:0)
[22:59:56.541] Timer tick, asking Buildbucket for the build status
[22:59:56.648] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:56.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:22:0) after 1m0s
[23:00:56.680] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:22:0)
[23:00:56.680] Timer tick, asking Buildbucket for the build status
[23:00:56.793] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:56.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:23:0) after 1m0s
[23:01:56.825] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:23:0)
[23:01:56.825] Timer tick, asking Buildbucket for the build status
[23:01:57.055] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:57.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:24:0) after 1m0s
[23:02:57.117] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:24:0)
[23:02:57.117] Timer tick, asking Buildbucket for the build status
[23:02:57.215] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:57.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:25:0) after 1m0s
[23:03:58.525] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:25:0)
[23:03:58.525] Timer tick, asking Buildbucket for the build status
[23:03:58.616] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:58.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:26:0) after 1m0s
[23:04:58.693] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:26:0)
[23:04:58.693] Timer tick, asking Buildbucket for the build status
[23:04:58.809] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:58.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:27:0) after 1m0s
[23:05:58.886] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:27:0)
[23:05:58.886] Timer tick, asking Buildbucket for the build status
[23:05:59.054] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:59.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:28:0) after 1m0s
[23:06:59.077] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:28:0)
[23:06:59.077] Timer tick, asking Buildbucket for the build status
[23:06:59.218] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:59.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:29:0) after 1m0s
[23:07:59.273] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:29:0)
[23:07:59.273] Timer tick, asking Buildbucket for the build status
[23:07:59.346] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:59.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:30:0) after 1m0s
[23:08:59.383] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:30:0)
[23:08:59.383] Timer tick, asking Buildbucket for the build status
[23:08:59.534] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:59.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:31:0) after 1m0s
[23:09:59.620] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:31:0)
[23:09:59.620] Timer tick, asking Buildbucket for the build status
[23:09:59.747] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:59.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:32:0) after 1m0s
[23:10:59.861] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:32:0)
[23:10:59.861] Timer tick, asking Buildbucket for the build status
[23:10:59.979] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:59.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:33:0) after 1m0s
[23:12:00.079] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:33:0)
[23:12:00.079] Timer tick, asking Buildbucket for the build status
[23:12:00.272] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:00.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:34:0) after 1m0s
[23:13:00.378] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:34:0)
[23:13:00.378] Timer tick, asking Buildbucket for the build status
[23:13:00.578] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:00.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:35:0) after 1m0s
[23:14:00.613] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:35:0)
[23:14:00.613] Timer tick, asking Buildbucket for the build status
[23:14:00.697] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:00.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:36:0) after 1m0s
[23:15:00.837] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:36:0)
[23:15:00.837] Timer tick, asking Buildbucket for the build status
[23:15:00.978] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:00.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:37:0) after 1m0s
[23:16:01.051] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:37:0)
[23:16:01.051] Timer tick, asking Buildbucket for the build status
[23:16:01.151] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:01.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:38:0) after 1m0s
[23:17:01.248] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:38:0)
[23:17:01.248] Timer tick, asking Buildbucket for the build status
[23:17:01.385] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:01.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:39:0) after 1m0s
[23:18:01.484] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:39:0)
[23:18:01.484] Timer tick, asking Buildbucket for the build status
[23:18:01.675] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:01.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:40:0) after 1m0s
[23:19:01.735] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:40:0)
[23:19:01.735] Timer tick, asking Buildbucket for the build status
[23:19:01.841] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:41:0) after 1m0s
[23:20:01.984] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:41:0)
[23:20:01.984] Timer tick, asking Buildbucket for the build status
[23:20:02.287] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:42:0) after 1m0s
[23:21:02.344] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:42:0)
[23:21:02.344] Timer tick, asking Buildbucket for the build status
[23:21:03.380] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:03.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:43:0) after 1m0s
[23:22:03.438] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:43:0)
[23:22:03.439] Timer tick, asking Buildbucket for the build status
[23:22:03.547] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:03.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:44:0) after 1m0s
[23:23:03.692] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:44:0)
[23:23:03.692] Timer tick, asking Buildbucket for the build status
[23:23:03.830] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:03.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:45:0) after 1m0s
[23:24:03.989] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:45:0)
[23:24:03.989] Timer tick, asking Buildbucket for the build status
[23:24:04.090] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:04.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:46:0) after 1m0s
[23:25:04.311] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:46:0)
[23:25:04.311] Timer tick, asking Buildbucket for the build status
[23:25:04.523] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:04.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:47:0) after 1m0s
[23:26:04.701] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:47:0)
[23:26:04.701] Timer tick, asking Buildbucket for the build status
[23:26:04.838] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:04.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:48:0) after 1m0s
[23:27:05.029] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:48:0)
[23:27:05.029] Timer tick, asking Buildbucket for the build status
[23:27:05.306] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:05.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:49:0) after 1m0s
[23:28:05.358] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:49:0)
[23:28:05.358] Timer tick, asking Buildbucket for the build status
[23:28:05.475] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:05.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:50:0) after 1m0s
[23:29:05.495] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:50:0)
[23:29:05.495] Timer tick, asking Buildbucket for the build status
[23:29:05.676] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:05.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:51:0) after 1m0s
[23:30:05.676] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:51:0)
[23:30:05.676] Timer tick, asking Buildbucket for the build status
[23:30:06.115] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:52:0) after 1m0s
[23:31:06.159] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:52:0)
[23:31:06.159] Timer tick, asking Buildbucket for the build status
[23:31:06.253] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:06.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:53:0) after 1m0s
[23:32:06.298] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:53:0)
[23:32:06.298] Timer tick, asking Buildbucket for the build status
[23:32:06.382] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:06.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:54:0) after 1m0s
[23:33:06.417] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:54:0)
[23:33:06.417] Timer tick, asking Buildbucket for the build status
[23:33:06.511] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:06.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:55:0) after 1m0s
[23:34:06.609] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:55:0)
[23:34:06.609] Timer tick, asking Buildbucket for the build status
[23:34:06.694] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:06.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:56:0) after 1m0s
[23:35:06.833] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:56:0)
[23:35:06.833] Timer tick, asking Buildbucket for the build status
[23:35:06.981] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:06.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:57:0) after 1m0s
[23:36:07.017] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:57:0)
[23:36:07.017] Timer tick, asking Buildbucket for the build status
[23:36:07.113] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:07.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:58:0) after 1m0s
[23:37:07.144] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:58:0)
[23:37:07.144] Timer tick, asking Buildbucket for the build status
[23:37:07.237] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:07.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:59:0) after 1m0s
[23:38:07.328] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:59:0)
[23:38:07.328] Timer tick, asking Buildbucket for the build status
[23:38:07.631] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:07.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:60:0) after 1m0s
[23:39:07.770] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:60:0)
[23:39:07.770] Timer tick, asking Buildbucket for the build status
[23:39:08.160] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:08.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:61:0) after 1m0s
[23:40:08.221] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:61:0)
[23:40:08.221] Timer tick, asking Buildbucket for the build status
[23:40:08.319] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:08.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:62:0) after 1m0s
[23:41:08.478] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:62:0)
[23:41:08.478] Timer tick, asking Buildbucket for the build status
[23:41:09.634] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:09.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:63:0) after 1m0s
[23:42:09.673] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:63:0)
[23:42:09.673] Timer tick, asking Buildbucket for the build status
[23:42:09.762] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:09.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:64:0) after 1m0s
[23:43:09.807] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:64:0)
[23:43:09.807] Timer tick, asking Buildbucket for the build status
[23:43:10.096] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:10.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:65:0) after 1m0s
[23:44:10.137] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:65:0)
[23:44:10.137] Timer tick, asking Buildbucket for the build status
[23:44:10.211] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:10.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:66:0) after 1m0s
[23:45:10.236] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:66:0)
[23:45:10.236] Timer tick, asking Buildbucket for the build status
[23:45:10.353] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:10.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:67:0) after 1m0s
[23:46:10.373] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:67:0)
[23:46:10.373] Timer tick, asking Buildbucket for the build status
[23:46:10.480] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:10.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:68:0) after 1m0s
[23:47:10.552] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:68:0)
[23:47:10.552] Timer tick, asking Buildbucket for the build status
[23:47:10.618] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:10.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:69:0) after 1m0s
[23:48:10.652] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:69:0)
[23:48:10.652] Timer tick, asking Buildbucket for the build status
[23:48:10.877] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:70:0) after 1m0s
[23:49:11.094] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:70:0)
[23:49:11.094] Timer tick, asking Buildbucket for the build status
[23:49:11.638] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:11.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:71:0) after 1m0s
[23:50:11.685] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:71:0)
[23:50:11.685] Timer tick, asking Buildbucket for the build status
[23:50:11.789] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:11.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:72:0) after 1m0s
[23:51:11.785] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:72:0)
[23:51:11.785] Timer tick, asking Buildbucket for the build status
[23:51:12.063] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:73:0) after 1m0s
[23:52:12.143] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:73:0)
[23:52:12.143] Timer tick, asking Buildbucket for the build status
[23:52:12.218] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:12.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:74:0) after 1m0s
[23:53:12.725] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:74:0)
[23:53:12.725] Timer tick, asking Buildbucket for the build status
[23:53:12.789] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:75:0) after 1m0s
[23:54:12.924] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:75:0)
[23:54:12.924] Timer tick, asking Buildbucket for the build status
[23:54:13.000] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:13.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:76:0) after 1m0s
[23:55:13.169] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:76:0)
[23:55:13.169] Timer tick, asking Buildbucket for the build status
[23:55:13.399] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:13.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:77:0) after 1m0s
[23:56:13.492] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:77:0)
[23:56:13.492] Timer tick, asking Buildbucket for the build status
[23:56:13.585] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:13.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:78:0) after 1m0s
[23:57:13.609] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:78:0)
[23:57:13.609] Timer tick, asking Buildbucket for the build status
[23:57:13.685] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:13.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:79:0) after 1m0s
[23:58:13.741] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:79:0)
[23:58:13.741] Timer tick, asking Buildbucket for the build status
[23:58:13.828] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:13.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:80:0) after 1m0s
[23:59:13.874] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:80:0)
[23:59:13.874] Timer tick, asking Buildbucket for the build status
[23:59:13.980] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:13.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:81:0) after 1m0s
[00:00:14.084] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:81:0)
[00:00:14.084] Timer tick, asking Buildbucket for the build status
[00:00:14.213] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:14.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:82:0) after 1m0s
[00:01:14.411] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:82:0)
[00:01:14.411] Timer tick, asking Buildbucket for the build status
[00:01:14.516] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:14.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:83:0) after 1m0s
[00:02:14.754] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:83:0)
[00:02:14.754] Timer tick, asking Buildbucket for the build status
[00:02:14.849] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:14.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:84:0) after 1m0s
[00:03:15.070] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:84:0)
[00:03:15.070] Timer tick, asking Buildbucket for the build status
[00:03:15.158] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:15.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:85:0) after 1m0s
[00:04:15.247] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:85:0)
[00:04:15.247] Timer tick, asking Buildbucket for the build status
[00:04:15.407] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:15.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:86:0) after 1m0s
[00:05:15.495] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:86:0)
[00:05:15.495] Timer tick, asking Buildbucket for the build status
[00:05:15.649] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:15.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:87:0) after 1m0s
[00:06:15.765] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:87:0)
[00:06:15.765] Timer tick, asking Buildbucket for the build status
[00:06:16.132] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:16.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:88:0) after 1m0s
[00:07:16.269] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:88:0)
[00:07:16.269] Timer tick, asking Buildbucket for the build status
[00:07:16.367] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:89:0) after 1m0s
[00:08:16.426] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:89:0)
[00:08:16.427] Timer tick, asking Buildbucket for the build status
[00:08:16.770] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:16.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:90:0) after 1m0s
[00:09:16.798] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:90:0)
[00:09:16.798] Timer tick, asking Buildbucket for the build status
[00:09:16.885] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:16.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:91:0) after 1m0s
[00:10:16.959] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:91:0)
[00:10:16.959] Timer tick, asking Buildbucket for the build status
[00:10:17.058] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:17.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:92:0) after 1m0s
[00:11:17.042] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:92:0)
[00:11:17.042] Timer tick, asking Buildbucket for the build status
[00:11:17.309] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:17.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:93:0) after 1m0s
[00:12:17.292] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:93:0)
[00:12:17.292] Timer tick, asking Buildbucket for the build status
[00:12:17.364] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:17.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:94:0) after 1m0s
[00:13:17.403] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:94:0)
[00:13:17.403] Timer tick, asking Buildbucket for the build status
[00:13:17.691] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:17.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:95:0) after 1m0s
[00:14:17.697] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:95:0)
[00:14:17.697] Timer tick, asking Buildbucket for the build status
[00:14:17.923] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:17.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:96:0) after 1m0s
[00:15:17.959] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:96:0)
[00:15:17.959] Timer tick, asking Buildbucket for the build status
[00:15:18.157] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:18.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:97:0) after 1m0s
[00:16:18.178] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:97:0)
[00:16:18.178] Timer tick, asking Buildbucket for the build status
[00:16:18.360] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:18.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:98:0) after 1m0s
[00:17:18.451] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:98:0)
[00:17:18.451] Timer tick, asking Buildbucket for the build status
[00:17:18.552] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:18.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:99:0) after 1m0s
[00:18:18.594] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:99:0)
[00:18:18.594] Timer tick, asking Buildbucket for the build status
[00:18:18.811] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:18.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:100:0) after 1m0s
[00:19:18.807] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:100:0)
[00:19:18.807] Timer tick, asking Buildbucket for the build status
[00:19:18.891] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:18.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:101:0) after 1m0s
[00:20:18.892] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:101:0)
[00:20:18.892] Timer tick, asking Buildbucket for the build status
[00:20:18.991] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:18.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:102:0) after 1m0s
[00:21:19.032] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:102:0)
[00:21:19.032] Timer tick, asking Buildbucket for the build status
[00:21:19.110] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:19.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:103:0) after 1m0s
[00:22:19.274] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:103:0)
[00:22:19.274] Timer tick, asking Buildbucket for the build status
[00:22:19.377] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:19.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:104:0) after 1m0s
[00:23:19.578] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:104:0)
[00:23:19.578] Timer tick, asking Buildbucket for the build status
[00:23:20.125] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:20.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:105:0) after 1m0s
[00:24:20.287] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:105:0)
[00:24:20.287] Timer tick, asking Buildbucket for the build status
[00:24:20.373] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:20.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:106:0) after 1m0s
[00:25:20.469] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:106:0)
[00:25:20.469] Timer tick, asking Buildbucket for the build status
[00:25:21.042] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:21.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:107:0) after 1m0s
[00:26:21.054] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:107:0)
[00:26:21.054] Timer tick, asking Buildbucket for the build status
[00:26:21.281] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:21.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:108:0) after 1m0s
[00:27:21.304] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:108:0)
[00:27:21.304] Timer tick, asking Buildbucket for the build status
[00:27:21.629] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:21.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:109:0) after 1m0s
[00:28:21.625] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:109:0)
[00:28:21.625] Timer tick, asking Buildbucket for the build status
[00:28:21.741] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:21.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:110:0) after 1m0s
[00:29:21.833] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:110:0)
[00:29:21.833] Timer tick, asking Buildbucket for the build status
[00:29:21.923] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:21.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:111:0) after 1m0s
[00:30:21.956] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:111:0)
[00:30:21.956] Timer tick, asking Buildbucket for the build status
[00:30:22.112] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:22.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:112:0) after 1m0s
[00:31:22.120] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:112:0)
[00:31:22.120] Timer tick, asking Buildbucket for the build status
[00:31:22.358] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:22.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:113:0) after 1m0s
[00:32:22.426] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:113:0)
[00:32:22.426] Timer tick, asking Buildbucket for the build status
[00:32:22.509] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:22.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:114:0) after 1m0s
[00:33:22.486] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:114:0)
[00:33:22.486] Timer tick, asking Buildbucket for the build status
[00:33:22.579] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:22.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:115:0) after 1m0s
[00:34:22.656] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:115:0)
[00:34:22.656] Timer tick, asking Buildbucket for the build status
[00:34:22.750] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:116:0) after 1m0s
[00:35:22.824] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:116:0)
[00:35:22.824] Timer tick, asking Buildbucket for the build status
[00:35:23.186] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:23.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:117:0) after 1m0s
[00:36:23.184] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:117:0)
[00:36:23.184] Timer tick, asking Buildbucket for the build status
[00:36:23.428] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:23.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:118:0) after 1m0s
[00:37:23.483] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:118:0)
[00:37:23.483] Timer tick, asking Buildbucket for the build status
[00:37:23.563] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:23.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:119:0) after 1m0s
[00:38:23.609] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:119:0)
[00:38:23.609] Timer tick, asking Buildbucket for the build status
[00:38:23.816] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:23.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:120:0) after 1m0s
[00:39:23.842] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:120:0)
[00:39:23.842] Timer tick, asking Buildbucket for the build status
[00:39:23.942] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:23.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:121:0) after 1m0s
[00:40:23.967] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:121:0)
[00:40:23.967] Timer tick, asking Buildbucket for the build status
[00:40:24.082] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:24.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:122:0) after 1m0s
[00:41:24.097] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:122:0)
[00:41:24.097] Timer tick, asking Buildbucket for the build status
[00:41:24.192] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:24.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:123:0) after 1m0s
[00:42:24.271] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:123:0)
[00:42:24.271] Timer tick, asking Buildbucket for the build status
[00:42:24.406] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:24.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:124:0) after 1m0s
[00:43:24.504] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:124:0)
[00:43:24.504] Timer tick, asking Buildbucket for the build status
[00:43:24.807] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:24.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:125:0) after 1m0s
[00:44:24.846] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:125:0)
[00:44:24.846] Timer tick, asking Buildbucket for the build status
[00:44:24.949] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:24.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:126:0) after 1m0s
[00:45:24.943] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:126:0)
[00:45:24.943] Timer tick, asking Buildbucket for the build status
[00:45:25.046] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:25.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:127:0) after 1m0s
[00:46:25.124] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:127:0)
[00:46:25.124] Timer tick, asking Buildbucket for the build status
[00:46:25.200] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:25.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:128:0) after 1m0s
[00:47:25.289] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:128:0)
[00:47:25.289] Timer tick, asking Buildbucket for the build status
[00:47:25.561] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:25.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:129:0) after 1m0s
[00:48:25.544] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:129:0)
[00:48:25.544] Timer tick, asking Buildbucket for the build status
[00:48:25.653] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:25.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:130:0) after 1m0s
[00:49:25.791] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:130:0)
[00:49:25.791] Timer tick, asking Buildbucket for the build status
[00:49:25.867] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:25.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:131:0) after 1m0s
[00:50:25.898] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:131:0)
[00:50:25.898] Timer tick, asking Buildbucket for the build status
[00:50:26.001] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:26.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:132:0) after 1m0s
[00:51:25.990] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:132:0)
[00:51:25.990] Timer tick, asking Buildbucket for the build status
[00:51:26.058] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:26.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:133:0) after 1m0s
[00:52:26.190] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:133:0)
[00:52:26.190] Timer tick, asking Buildbucket for the build status
[00:52:26.347] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:26.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:134:0) after 1m0s
[00:53:26.387] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:134:0)
[00:53:26.387] Timer tick, asking Buildbucket for the build status
[00:53:26.511] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:26.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:135:0) after 1m0s
[00:54:26.555] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:135:0)
[00:54:26.555] Timer tick, asking Buildbucket for the build status
[00:54:26.629] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:26.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:136:0) after 1m0s
[00:55:26.669] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:136:0)
[00:55:26.669] Timer tick, asking Buildbucket for the build status
[00:55:26.769] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:26.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:137:0) after 1m0s
[00:56:26.792] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:137:0)
[00:56:26.792] Timer tick, asking Buildbucket for the build status
[00:56:26.864] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:26.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:138:0) after 1m0s
[00:57:26.934] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:138:0)
[00:57:26.934] Timer tick, asking Buildbucket for the build status
[00:57:27.014] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:27.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:139:0) after 1m0s
[00:58:27.034] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:139:0)
[00:58:27.034] Timer tick, asking Buildbucket for the build status
[00:58:27.113] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:27.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:140:0) after 1m0s
[00:59:27.117] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:140:0)
[00:59:27.117] Timer tick, asking Buildbucket for the build status
[00:59:27.271] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:27.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:141:0) after 1m0s
[01:00:27.438] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:141:0)
[01:00:27.438] Timer tick, asking Buildbucket for the build status
[01:00:27.658] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:27.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:142:0) after 1m0s
[01:01:27.718] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:142:0)
[01:01:27.718] Timer tick, asking Buildbucket for the build status
[01:01:27.786] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:27.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:143:0) after 1m0s
[01:02:27.823] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:143:0)
[01:02:27.823] Timer tick, asking Buildbucket for the build status
[01:02:27.902] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:144:0) after 1m0s
[01:03:27.953] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:144:0)
[01:03:27.953] Timer tick, asking Buildbucket for the build status
[01:03:28.060] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:145:0) after 1m0s
[01:04:28.164] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:145:0)
[01:04:28.164] Timer tick, asking Buildbucket for the build status
[01:04:28.349] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:28.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:146:0) after 1m0s
[01:05:28.442] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:146:0)
[01:05:28.442] Timer tick, asking Buildbucket for the build status
[01:05:28.567] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:28.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:147:0) after 1m0s
[01:06:28.615] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:147:0)
[01:06:28.615] Timer tick, asking Buildbucket for the build status
[01:06:28.693] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:28.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:148:0) after 1m0s
[01:07:28.735] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:148:0)
[01:07:28.735] Timer tick, asking Buildbucket for the build status
[01:07:28.825] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:28.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:149:0) after 1m0s
[01:08:28.909] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:149:0)
[01:08:28.909] Timer tick, asking Buildbucket for the build status
[01:08:28.997] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:28.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:150:0) after 1m0s
[01:09:29.189] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:150:0)
[01:09:29.189] Timer tick, asking Buildbucket for the build status
[01:09:29.499] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:29.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:151:0) after 1m0s
[01:10:29.558] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:151:0)
[01:10:29.558] Timer tick, asking Buildbucket for the build status
[01:10:29.880] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:152:0) after 1m0s
[01:11:29.864] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:152:0)
[01:11:29.864] Timer tick, asking Buildbucket for the build status
[01:11:29.952] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:29.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:153:0) after 1m0s
[01:12:29.993] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:153:0)
[01:12:29.993] Timer tick, asking Buildbucket for the build status
[01:12:30.084] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:30.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:154:0) after 1m0s
[01:13:30.201] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:154:0)
[01:13:30.201] Timer tick, asking Buildbucket for the build status
[01:13:30.285] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:30.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:155:0) after 1m0s
[01:14:30.317] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:155:0)
[01:14:30.317] Timer tick, asking Buildbucket for the build status
[01:14:30.550] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:30.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:156:0) after 1m0s
[01:15:30.581] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:156:0)
[01:15:30.581] Timer tick, asking Buildbucket for the build status
[01:15:30.843] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:30.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:157:0) after 1m0s
[01:16:30.857] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:157:0)
[01:16:30.857] Timer tick, asking Buildbucket for the build status
[01:16:31.015] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:31.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:158:0) after 1m0s
[01:17:31.119] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:158:0)
[01:17:31.119] Timer tick, asking Buildbucket for the build status
[01:17:31.237] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:31.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:159:0) after 1m0s
[01:18:31.320] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:159:0)
[01:18:31.320] Timer tick, asking Buildbucket for the build status
[01:18:31.443] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:31.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:160:0) after 1m0s
[01:19:31.501] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:160:0)
[01:19:31.501] Timer tick, asking Buildbucket for the build status
[01:19:31.738] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:31.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:161:0) after 1m0s
[01:20:31.767] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:161:0)
[01:20:31.767] Timer tick, asking Buildbucket for the build status
[01:20:32.027] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:32.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:162:0) after 1m0s
[01:21:32.107] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:162:0)
[01:21:32.107] Timer tick, asking Buildbucket for the build status
[01:21:32.293] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:32.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:163:0) after 1m0s
[01:22:32.336] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:163:0)
[01:22:32.336] Timer tick, asking Buildbucket for the build status
[01:22:32.413] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:32.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:164:0) after 1m0s
[01:23:32.502] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:164:0)
[01:23:32.502] Timer tick, asking Buildbucket for the build status
[01:23:32.585] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:32.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:165:0) after 1m0s
[01:24:32.715] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:165:0)
[01:24:32.715] Timer tick, asking Buildbucket for the build status
[01:24:32.785] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:32.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:166:0) after 1m0s
[01:25:32.822] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:166:0)
[01:25:32.822] Timer tick, asking Buildbucket for the build status
[01:25:32.933] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:32.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:167:0) after 1m0s
[01:26:33.029] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:167:0)
[01:26:33.029] Timer tick, asking Buildbucket for the build status
[01:26:33.121] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:33.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:168:0) after 1m0s
[01:27:33.288] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:168:0)
[01:27:33.288] Timer tick, asking Buildbucket for the build status
[01:27:33.362] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:169:0) after 1m0s
[01:28:33.417] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:169:0)
[01:28:33.417] Timer tick, asking Buildbucket for the build status
[01:28:33.527] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:170:0) after 1m0s
[01:29:33.607] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:170:0)
[01:29:33.607] Timer tick, asking Buildbucket for the build status
[01:29:33.931] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:33.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:171:0) after 1m0s
[01:30:33.940] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:171:0)
[01:30:33.940] Timer tick, asking Buildbucket for the build status
[01:30:34.036] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:34.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:172:0) after 1m0s
[01:31:34.077] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:172:0)
[01:31:34.077] Timer tick, asking Buildbucket for the build status
[01:31:34.158] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:34.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:173:0) after 1m0s
[01:32:34.224] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:173:0)
[01:32:34.224] Timer tick, asking Buildbucket for the build status
[01:32:34.537] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:34.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:174:0) after 1m0s
[01:33:34.545] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:174:0)
[01:33:34.545] Timer tick, asking Buildbucket for the build status
[01:33:34.799] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:34.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:175:0) after 1m0s
[01:34:34.910] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:175:0)
[01:34:34.910] Timer tick, asking Buildbucket for the build status
[01:34:35.086] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:35.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:176:0) after 1m0s
[01:35:35.302] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:176:0)
[01:35:35.302] Timer tick, asking Buildbucket for the build status
[01:35:35.417] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:35.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:177:0) after 1m0s
[01:36:35.471] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:177:0)
[01:36:35.471] Timer tick, asking Buildbucket for the build status
[01:36:35.544] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:35.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:178:0) after 1m0s
[01:37:35.619] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:178:0)
[01:37:35.619] Timer tick, asking Buildbucket for the build status
[01:37:35.702] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:35.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:179:0) after 1m0s
[01:38:35.752] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:179:0)
[01:38:35.752] Timer tick, asking Buildbucket for the build status
[01:38:35.855] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:35.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:180:0) after 1m0s
[01:39:35.880] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:180:0)
[01:39:35.880] Timer tick, asking Buildbucket for the build status
[01:39:36.032] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:36.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:181:0) after 1m0s
[01:40:36.063] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:181:0)
[01:40:36.063] Timer tick, asking Buildbucket for the build status
[01:40:36.279] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:36.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:182:0) after 1m0s
[01:41:36.347] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:182:0)
[01:41:36.347] Timer tick, asking Buildbucket for the build status
[01:41:36.462] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:36.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:183:0) after 1m0s
[01:42:36.561] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:183:0)
[01:42:36.561] Timer tick, asking Buildbucket for the build status
[01:42:36.625] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:36.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:184:0) after 1m0s
[01:43:36.841] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:184:0)
[01:43:36.841] Timer tick, asking Buildbucket for the build status
[01:43:36.916] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:36.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:185:0) after 1m0s
[01:44:37.030] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:185:0)
[01:44:37.030] Timer tick, asking Buildbucket for the build status
[01:44:37.183] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:37.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:186:0) after 1m0s
[01:45:37.295] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:186:0)
[01:45:37.296] Timer tick, asking Buildbucket for the build status
[01:45:37.544] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:37.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:187:0) after 1m0s
[01:46:37.584] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:187:0)
[01:46:37.584] Timer tick, asking Buildbucket for the build status
[01:46:37.742] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:37.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:188:0) after 1m0s
[01:47:37.810] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:188:0)
[01:47:37.810] Timer tick, asking Buildbucket for the build status
[01:47:37.976] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:37.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:189:0) after 1m0s
[01:48:38.039] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:189:0)
[01:48:38.039] Timer tick, asking Buildbucket for the build status
[01:48:38.318] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:190:0) after 1m0s
[01:49:38.401] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:190:0)
[01:49:38.401] Timer tick, asking Buildbucket for the build status
[01:49:38.473] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:38.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:191:0) after 1m0s
[01:50:38.531] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:191:0)
[01:50:38.531] Timer tick, asking Buildbucket for the build status
[01:50:38.845] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:192:0) after 1m0s
[01:51:38.878] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:192:0)
[01:51:38.878] Timer tick, asking Buildbucket for the build status
[01:51:38.995] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:38.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:193:0) after 1m0s
[01:52:39.028] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:193:0)
[01:52:39.028] Timer tick, asking Buildbucket for the build status
[01:52:39.165] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:39.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:194:0) after 1m0s
[01:53:39.197] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:194:0)
[01:53:39.197] Timer tick, asking Buildbucket for the build status
[01:53:39.402] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:39.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:195:0) after 1m0s
[01:54:39.476] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:195:0)
[01:54:39.476] Timer tick, asking Buildbucket for the build status
[01:54:39.644] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:39.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:196:0) after 1m0s
[01:55:39.706] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:196:0)
[01:55:39.706] Timer tick, asking Buildbucket for the build status
[01:55:39.797] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:39.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:197:0) after 1m0s
[01:56:39.821] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:197:0)
[01:56:39.821] Timer tick, asking Buildbucket for the build status
[01:56:39.902] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:39.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:198:0) after 1m0s
[01:57:39.921] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:198:0)
[01:57:39.921] Timer tick, asking Buildbucket for the build status
[01:57:40.014] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:40.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:199:0) after 1m0s
[01:58:40.075] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:199:0)
[01:58:40.075] Timer tick, asking Buildbucket for the build status
[01:58:40.186] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:40.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:200:0) after 1m0s
[01:59:40.354] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:200:0)
[01:59:40.354] Timer tick, asking Buildbucket for the build status
[01:59:40.441] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:40.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:201:0) after 1m0s
[02:00:40.546] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:201:0)
[02:00:40.546] Timer tick, asking Buildbucket for the build status
[02:00:40.664] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:40.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:202:0) after 1m0s
[02:01:40.816] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:202:0)
[02:01:40.816] Timer tick, asking Buildbucket for the build status
[02:01:40.972] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:40.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:203:0) after 1m0s
[02:02:41.041] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:203:0)
[02:02:41.041] Timer tick, asking Buildbucket for the build status
[02:02:41.211] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:204:0) after 1m0s
[02:03:41.347] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:204:0)
[02:03:41.347] Timer tick, asking Buildbucket for the build status
[02:03:41.456] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:41.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:205:0) after 1m0s
[02:04:41.626] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:205:0)
[02:04:41.626] Timer tick, asking Buildbucket for the build status
[02:04:41.726] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:41.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:206:0) after 1m0s
[02:05:41.757] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:206:0)
[02:05:41.757] Timer tick, asking Buildbucket for the build status
[02:05:41.870] Build 8863435332295797136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:41.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:207:0) after 1m0s
[02:05:51.277] Received PubSub notification, asking Buildbucket for the build status
[02:05:51.645] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:42.024] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:207:0)
[02:06:42.024] Timer tick, asking Buildbucket for the build status
[02:06:42.195] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:42.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:209:0) after 1m0s
[02:07:42.550] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:209:0)
[02:07:42.550] Timer tick, asking Buildbucket for the build status
[02:07:42.633] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:42.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:210:0) after 1m0s
[02:08:42.751] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:210:0)
[02:08:42.751] Timer tick, asking Buildbucket for the build status
[02:08:43.227] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:43.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:211:0) after 1m0s
[02:09:43.561] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:211:0)
[02:09:43.561] Timer tick, asking Buildbucket for the build status
[02:09:43.649] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:212:0) after 1m0s
[02:10:43.837] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:212:0)
[02:10:43.837] Timer tick, asking Buildbucket for the build status
[02:10:44.035] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:44.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:213:0) after 1m0s
[02:11:44.126] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:213:0)
[02:11:44.126] Timer tick, asking Buildbucket for the build status
[02:11:44.206] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:44.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:214:0) after 1m0s
[02:12:44.234] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:214:0)
[02:12:44.234] Timer tick, asking Buildbucket for the build status
[02:12:44.459] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:44.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:215:0) after 1m0s
[02:13:44.509] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:215:0)
[02:13:44.509] Timer tick, asking Buildbucket for the build status
[02:13:44.892] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:44.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:216:0) after 1m0s
[02:14:44.922] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:216:0)
[02:14:44.922] Timer tick, asking Buildbucket for the build status
[02:14:45.008] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:45.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:217:0) after 1m0s
[02:15:45.079] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:217:0)
[02:15:45.079] Timer tick, asking Buildbucket for the build status
[02:15:45.199] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:45.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:218:0) after 1m0s
[02:16:45.231] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:218:0)
[02:16:45.231] Timer tick, asking Buildbucket for the build status
[02:16:45.330] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:45.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:219:0) after 1m0s
[02:17:45.372] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:219:0)
[02:17:45.372] Timer tick, asking Buildbucket for the build status
[02:17:45.474] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:45.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:220:0) after 1m0s
[02:18:45.524] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:220:0)
[02:18:45.524] Timer tick, asking Buildbucket for the build status
[02:18:45.657] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:45.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:221:0) after 1m0s
[02:19:45.758] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:221:0)
[02:19:45.758] Timer tick, asking Buildbucket for the build status
[02:19:45.854] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:45.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:222:0) after 1m0s
[02:20:45.968] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:222:0)
[02:20:45.968] Timer tick, asking Buildbucket for the build status
[02:20:46.331] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:46.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:223:0) after 1m0s
[02:21:46.710] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:223:0)
[02:21:46.710] Timer tick, asking Buildbucket for the build status
[02:21:46.776] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:46.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:224:0) after 1m0s
[02:22:46.901] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:224:0)
[02:22:46.901] Timer tick, asking Buildbucket for the build status
[02:22:46.981] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:46.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:225:0) after 1m0s
[02:23:47.031] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:225:0)
[02:23:47.031] Timer tick, asking Buildbucket for the build status
[02:23:47.278] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:47.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:226:0) after 1m0s
[02:24:47.428] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:226:0)
[02:24:47.428] Timer tick, asking Buildbucket for the build status
[02:24:47.501] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:47.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:227:0) after 1m0s
[02:25:47.532] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:227:0)
[02:25:47.532] Timer tick, asking Buildbucket for the build status
[02:25:48.258] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:48.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:228:0) after 1m0s
[02:26:48.366] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:228:0)
[02:26:48.366] Timer tick, asking Buildbucket for the build status
[02:26:48.456] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:48.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:229:0) after 1m0s
[02:27:48.896] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:229:0)
[02:27:48.896] Timer tick, asking Buildbucket for the build status
[02:27:49.393] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:230:0) after 1m0s
[02:28:49.542] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:230:0)
[02:28:49.542] Timer tick, asking Buildbucket for the build status
[02:28:49.599] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:49.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:231:0) after 1m0s
[02:29:49.674] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:231:0)
[02:29:49.674] Timer tick, asking Buildbucket for the build status
[02:29:49.766] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:49.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:232:0) after 1m0s
[02:30:49.876] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:232:0)
[02:30:49.876] Timer tick, asking Buildbucket for the build status
[02:30:50.089] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:50.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:233:0) after 1m0s
[02:31:50.480] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:233:0)
[02:31:50.480] Timer tick, asking Buildbucket for the build status
[02:31:50.572] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:50.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:234:0) after 1m0s
[02:32:50.669] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:234:0)
[02:32:50.669] Timer tick, asking Buildbucket for the build status
[02:32:50.788] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:50.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:235:0) after 1m0s
[02:33:50.805] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:235:0)
[02:33:50.805] Timer tick, asking Buildbucket for the build status
[02:33:51.024] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:51.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:236:0) after 1m0s
[02:34:51.063] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:236:0)
[02:34:51.063] Timer tick, asking Buildbucket for the build status
[02:34:51.145] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:51.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:237:0) after 1m0s
[02:35:51.210] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:237:0)
[02:35:51.210] Timer tick, asking Buildbucket for the build status
[02:35:51.537] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:51.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:238:0) after 1m0s
[02:36:51.609] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:238:0)
[02:36:51.609] Timer tick, asking Buildbucket for the build status
[02:36:51.887] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:51.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:239:0) after 1m0s
[02:37:51.914] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:239:0)
[02:37:51.914] Timer tick, asking Buildbucket for the build status
[02:37:51.982] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:51.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:240:0) after 1m0s
[02:38:52.019] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:240:0)
[02:38:52.019] Timer tick, asking Buildbucket for the build status
[02:38:52.227] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:52.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:241:0) after 1m0s
[02:39:52.259] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:241:0)
[02:39:52.259] Timer tick, asking Buildbucket for the build status
[02:39:52.412] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:52.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:242:0) after 1m0s
[02:40:52.447] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:242:0)
[02:40:52.447] Timer tick, asking Buildbucket for the build status
[02:40:52.662] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:52.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:243:0) after 1m0s
[02:41:52.700] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:243:0)
[02:41:52.700] Timer tick, asking Buildbucket for the build status
[02:41:52.779] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:52.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:244:0) after 1m0s
[02:42:52.807] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:244:0)
[02:42:52.807] Timer tick, asking Buildbucket for the build status
[02:42:56.076] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:56.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:245:0) after 1m0s
[02:43:56.159] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:245:0)
[02:43:56.159] Timer tick, asking Buildbucket for the build status
[02:43:56.345] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:56.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:246:0) after 1m0s
[02:44:56.423] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:246:0)
[02:44:56.423] Timer tick, asking Buildbucket for the build status
[02:44:56.496] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:56.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:247:0) after 1m0s
[02:45:56.577] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:247:0)
[02:45:56.577] Timer tick, asking Buildbucket for the build status
[02:45:56.669] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:248:0) after 1m0s
[02:46:56.774] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:248:0)
[02:46:56.774] Timer tick, asking Buildbucket for the build status
[02:46:57.052] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:57.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:249:0) after 1m0s
[02:47:57.153] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:249:0)
[02:47:57.153] Timer tick, asking Buildbucket for the build status
[02:47:57.240] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:57.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:250:0) after 1m0s
[02:48:57.447] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:250:0)
[02:48:57.447] Timer tick, asking Buildbucket for the build status
[02:48:57.633] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:57.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:251:0) after 1m0s
[02:49:57.678] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:251:0)
[02:49:57.678] Timer tick, asking Buildbucket for the build status
[02:49:57.817] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:57.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:252:0) after 1m0s
[02:50:57.854] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:252:0)
[02:50:57.854] Timer tick, asking Buildbucket for the build status
[02:50:57.964] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:57.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:253:0) after 1m0s
[02:51:58.035] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:253:0)
[02:51:58.035] Timer tick, asking Buildbucket for the build status
[02:51:58.126] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:58.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:254:0) after 1m0s
[02:52:58.207] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:254:0)
[02:52:58.207] Timer tick, asking Buildbucket for the build status
[02:52:58.355] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:255:0) after 1m0s
[02:53:58.408] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:255:0)
[02:53:58.408] Timer tick, asking Buildbucket for the build status
[02:53:58.519] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:58.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:256:0) after 1m0s
[02:54:58.631] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:256:0)
[02:54:58.631] Timer tick, asking Buildbucket for the build status
[02:54:58.989] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:58.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:257:0) after 1m0s
[02:55:59.159] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:257:0)
[02:55:59.159] Timer tick, asking Buildbucket for the build status
[02:55:59.291] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:59.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:258:0) after 1m0s
[02:56:59.424] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:258:0)
[02:56:59.424] Timer tick, asking Buildbucket for the build status
[02:56:59.723] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:59.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:259:0) after 1m0s
[02:57:59.819] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:259:0)
[02:57:59.819] Timer tick, asking Buildbucket for the build status
[02:57:59.942] Build 8863435332295797136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:59.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9028865394246280816:260:0) after 1m0s
[02:58:26.946] Received PubSub notification, asking Buildbucket for the build status
[02:58:27.025] Build 8863435332295797136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:58:27.025] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1605581905721181",
    "created_by": "project:chromium",
    "created_ts": "1605566390669653",
    "id": "8863435332295797136",
    "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\": \"513535c08d9179483fea801e68a37b70f3d6ae34\", \"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-mxby\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"win-upload-perfetto\", \"buildnumber\": 1756, \"got_angle_revision\": \"620cb770e3dd506be78103e362cfdab96fd2dca4\", \"got_dawn_revision\": \"2c5b040b5c2aa9482c7dc6a8dcbc730db21d5222\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"513535c08d9179483fea801e68a37b70f3d6ae34\", \"got_revision_cp\": \"refs/heads/master@{#828040}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04515da400d5fbc22d852af1369c4d46bd54991e\", \"got_v8_revision\": \"89e3ceea54f63df2a3249732ca38597731342514\", \"got_v8_revision_cp\": \"refs/heads/8.9.3@{#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){#828040}_without_patch\": {\"upload_trace_processor\": \"27f015812a3b9b97f52f3fd28b94f05486ba740b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_50caedf96d092a2fa7deb66b1ab2e23d963d80586891ff4a59d00bee7305ac9e_v2\"], \"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-mxby\"], \"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\": [\"5632-2e614e1\"], \"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": "1605578749978020",
    "status": "COMPLETED",
    "status_changed_ts": "1605581906493458",
    "tags": [
      "build_address:luci.chromium.ci/win-upload-perfetto/1756",
      "builder:win-upload-perfetto",
      "scheduler_invocation_id:9028865394246280816",
      "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/8863435332295797136/+/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:4fec086cec720010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1605581906497275",
    "url": "https://ci.chromium.org/b/8863435332295797136",
    "utcnow_ts": "1605581907015547"
  }
}
[02:58:27.025] Invocation finished in 4h18m37.599379203s with status SUCCEEDED