Status: SUCCEEDED
Triggered by: -
Duration: 1 hour
Actions:

Definition (rev 4c3247f4ed8a00ea6dc37d6edf987ff8d0e003c5)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "Windows deterministic"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/chromium/src.git",
  "revision": "8715348f87461e9102ed5c28faed7a72c9a8e3f3"
}

Incoming tags

  • buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3
  • buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[04:12:04.512] New invocation is queued and will start shortly
[04:12:05.601] Starting the invocation (attempt 1)
[04:12:05.638] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:12:05.638] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:12:05.638] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9094074306625050656",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8715348f87461e9102ed5c28faed7a72c9a8e3f3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9094074306625050656",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
    "gitiles_ref:refs/heads/master"
  ]
}
[04:12:07.225] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1543378325800285",
    "id": "8928644244604582784",
    "lease_expiration_ts": "1543497126884666",
    "lease_key": "707530661",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8715348f87461e9102ed5c28faed7a72c9a8e3f3\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1543378327090346",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/10878",
      "builder:Windows deterministic",
      "buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094074306625050656",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10878",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8928644244604582784",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8928644244604582784/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows-10",
      "swarming_tag:pool:luci.chromium.ci",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9094074306625050656",
      "swarming_tag:scheduler_job_id:chromium/Windows deterministic",
      "swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:914243eb1439b4edf9491de814a79e7b008b0928",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:417155dc31854210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1543378327090512",
    "url": "https://ci.chromium.org/b/8928644244604582784",
    "utcnow_ts": "1543378327200122"
  }
}
[04:12:07.225] Task URL: https://ci.chromium.org/b/8928644244604582784
[04:12:07.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:2:0) after 1m0s
[04:12:07.573] Received PubSub notification, asking Buildbucket for the build status
[04:12:07.622] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:07.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:2:0)
[04:13:07.293] Timer tick, asking Buildbucket for the build status
[04:13:07.429] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:07.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:4:0) after 1m0s
[04:14:07.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:4:0)
[04:14:07.448] Timer tick, asking Buildbucket for the build status
[04:14:07.529] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:07.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:5:0) after 1m0s
[04:15:07.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:5:0)
[04:15:07.547] Timer tick, asking Buildbucket for the build status
[04:15:07.647] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:07.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:6:0) after 1m0s
[04:16:07.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:6:0)
[04:16:07.667] Timer tick, asking Buildbucket for the build status
[04:16:07.838] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:07.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:7:0) after 1m0s
[04:17:07.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:7:0)
[04:17:07.859] Timer tick, asking Buildbucket for the build status
[04:17:08.020] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:08.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:8:0) after 1m0s
[04:18:08.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:8:0)
[04:18:08.040] Timer tick, asking Buildbucket for the build status
[04:18:08.083] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:08.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:9:0) after 1m0s
[04:19:08.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:9:0)
[04:19:08.117] Timer tick, asking Buildbucket for the build status
[04:19:08.357] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:08.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:10:0) after 1m0s
[04:20:08.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:10:0)
[04:20:08.382] Timer tick, asking Buildbucket for the build status
[04:20:08.439] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:11:0) after 1m0s
[04:21:08.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:11:0)
[04:21:08.461] Timer tick, asking Buildbucket for the build status
[04:21:08.558] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:08.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:12:0) after 1m0s
[04:22:08.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:12:0)
[04:22:08.595] Timer tick, asking Buildbucket for the build status
[04:22:08.656] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:08.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:13:0) after 1m0s
[04:23:08.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:13:0)
[04:23:08.678] Timer tick, asking Buildbucket for the build status
[04:23:08.818] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:14:0) after 1m0s
[04:24:08.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:14:0)
[04:24:08.843] Timer tick, asking Buildbucket for the build status
[04:24:08.915] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:08.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:15:0) after 1m0s
[04:25:08.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:15:0)
[04:25:08.980] Timer tick, asking Buildbucket for the build status
[04:25:09.076] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:09.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:16:0) after 1m0s
[04:26:09.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:16:0)
[04:26:09.156] Timer tick, asking Buildbucket for the build status
[04:26:09.320] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:09.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:17:0) after 1m0s
[04:27:09.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:17:0)
[04:27:09.359] Timer tick, asking Buildbucket for the build status
[04:27:09.439] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:09.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:18:0) after 1m0s
[04:28:09.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:18:0)
[04:28:09.459] Timer tick, asking Buildbucket for the build status
[04:28:09.543] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:09.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:19:0) after 1m0s
[04:29:09.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:19:0)
[04:29:09.563] Timer tick, asking Buildbucket for the build status
[04:29:09.670] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:09.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:20:0) after 1m0s
[04:30:09.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:20:0)
[04:30:09.691] Timer tick, asking Buildbucket for the build status
[04:30:09.811] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:09.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:21:0) after 1m0s
[04:31:09.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:21:0)
[04:31:09.829] Timer tick, asking Buildbucket for the build status
[04:31:09.933] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:09.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:22:0) after 1m0s
[04:32:09.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:22:0)
[04:32:09.953] Timer tick, asking Buildbucket for the build status
[04:32:10.126] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:10.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:23:0) after 1m0s
[04:33:10.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:23:0)
[04:33:10.159] Timer tick, asking Buildbucket for the build status
[04:33:10.324] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:10.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:24:0) after 1m0s
[04:34:10.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:24:0)
[04:34:10.468] Timer tick, asking Buildbucket for the build status
[04:34:10.525] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:10.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:25:0) after 1m0s
[04:35:10.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:25:0)
[04:35:10.546] Timer tick, asking Buildbucket for the build status
[04:35:10.651] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:10.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:26:0) after 1m0s
[04:36:10.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:26:0)
[04:36:10.684] Timer tick, asking Buildbucket for the build status
[04:36:10.770] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:10.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:27:0) after 1m0s
[04:37:10.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:27:0)
[04:37:10.792] Timer tick, asking Buildbucket for the build status
[04:37:11.014] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:11.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:28:0) after 1m0s
[04:38:11.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:28:0)
[04:38:11.065] Timer tick, asking Buildbucket for the build status
[04:38:11.117] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:11.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:29:0) after 1m0s
[04:39:11.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:29:0)
[04:39:11.139] Timer tick, asking Buildbucket for the build status
[04:39:11.336] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:11.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:30:0) after 1m0s
[04:40:11.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:30:0)
[04:40:11.373] Timer tick, asking Buildbucket for the build status
[04:40:11.428] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:11.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:31:0) after 1m0s
[04:41:11.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:31:0)
[04:41:11.453] Timer tick, asking Buildbucket for the build status
[04:41:11.516] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:32:0) after 1m0s
[04:42:11.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:32:0)
[04:42:11.539] Timer tick, asking Buildbucket for the build status
[04:42:11.760] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:11.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:33:0) after 1m0s
[04:43:11.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:33:0)
[04:43:11.793] Timer tick, asking Buildbucket for the build status
[04:43:11.851] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:11.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:34:0) after 1m0s
[04:44:11.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:34:0)
[04:44:11.872] Timer tick, asking Buildbucket for the build status
[04:44:11.957] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:11.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:35:0) after 1m0s
[04:45:11.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:35:0)
[04:45:11.977] Timer tick, asking Buildbucket for the build status
[04:45:12.066] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:12.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:36:0) after 1m0s
[04:46:12.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:36:0)
[04:46:12.086] Timer tick, asking Buildbucket for the build status
[04:46:12.164] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:37:0) after 1m0s
[04:47:12.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:37:0)
[04:47:12.182] Timer tick, asking Buildbucket for the build status
[04:47:12.249] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:38:0) after 1m0s
[04:48:12.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:38:0)
[04:48:12.280] Timer tick, asking Buildbucket for the build status
[04:48:12.344] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:12.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:39:0) after 1m0s
[04:49:12.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:39:0)
[04:49:12.372] Timer tick, asking Buildbucket for the build status
[04:49:12.454] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:12.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:40:0) after 1m0s
[04:50:12.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:40:0)
[04:50:12.578] Timer tick, asking Buildbucket for the build status
[04:50:12.712] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:12.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:41:0) after 1m0s
[04:51:12.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:41:0)
[04:51:12.757] Timer tick, asking Buildbucket for the build status
[04:51:12.836] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:42:0) after 1m0s
[04:52:12.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:42:0)
[04:52:12.856] Timer tick, asking Buildbucket for the build status
[04:52:12.909] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:12.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:43:0) after 1m0s
[04:53:12.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:43:0)
[04:53:12.942] Timer tick, asking Buildbucket for the build status
[04:53:13.016] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:13.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:44:0) after 1m0s
[04:54:13.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:44:0)
[04:54:13.051] Timer tick, asking Buildbucket for the build status
[04:54:13.166] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:13.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:45:0) after 1m0s
[04:55:13.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:45:0)
[04:55:13.189] Timer tick, asking Buildbucket for the build status
[04:55:13.316] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:13.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:46:0) after 1m0s
[04:56:13.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:46:0)
[04:56:13.341] Timer tick, asking Buildbucket for the build status
[04:56:13.405] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:47:0) after 1m0s
[04:57:13.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:47:0)
[04:57:13.427] Timer tick, asking Buildbucket for the build status
[04:57:13.503] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:13.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:48:0) after 1m0s
[04:58:13.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:48:0)
[04:58:13.522] Timer tick, asking Buildbucket for the build status
[04:58:13.635] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:13.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:49:0) after 1m0s
[04:59:13.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:49:0)
[04:59:13.656] Timer tick, asking Buildbucket for the build status
[04:59:13.709] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:13.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:50:0) after 1m0s
[05:00:13.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:50:0)
[05:00:13.728] Timer tick, asking Buildbucket for the build status
[05:00:13.795] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:13.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:51:0) after 1m0s
[05:01:13.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:51:0)
[05:01:13.858] Timer tick, asking Buildbucket for the build status
[05:01:13.940] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:52:0) after 1m0s
[05:02:13.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:52:0)
[05:02:13.961] Timer tick, asking Buildbucket for the build status
[05:02:14.032] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:14.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:53:0) after 1m0s
[05:03:14.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:53:0)
[05:03:14.145] Timer tick, asking Buildbucket for the build status
[05:03:14.227] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:54:0) after 1m0s
[05:04:14.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:54:0)
[05:04:14.248] Timer tick, asking Buildbucket for the build status
[05:04:14.322] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:14.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:55:0) after 1m0s
[05:05:14.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:55:0)
[05:05:14.474] Timer tick, asking Buildbucket for the build status
[05:05:14.571] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:56:0) after 1m0s
[05:06:14.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:56:0)
[05:06:14.593] Timer tick, asking Buildbucket for the build status
[05:06:14.708] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:57:0) after 1m0s
[05:07:14.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:57:0)
[05:07:14.726] Timer tick, asking Buildbucket for the build status
[05:07:14.801] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:14.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:58:0) after 1m0s
[05:08:14.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:58:0)
[05:08:14.849] Timer tick, asking Buildbucket for the build status
[05:08:14.923] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:14.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:59:0) after 1m0s
[05:09:14.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:59:0)
[05:09:14.954] Timer tick, asking Buildbucket for the build status
[05:09:15.124] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:15.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:60:0) after 1m0s
[05:10:15.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:60:0)
[05:10:15.172] Timer tick, asking Buildbucket for the build status
[05:10:15.213] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:15.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:61:0) after 1m0s
[05:11:15.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:61:0)
[05:11:15.237] Timer tick, asking Buildbucket for the build status
[05:11:15.466] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:15.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:62:0) after 1m0s
[05:12:15.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:62:0)
[05:12:15.499] Timer tick, asking Buildbucket for the build status
[05:12:15.617] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:15.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:63:0) after 1m0s
[05:13:15.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:63:0)
[05:13:15.647] Timer tick, asking Buildbucket for the build status
[05:13:15.846] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:15.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:64:0) after 1m0s
[05:14:15.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:64:0)
[05:14:15.866] Timer tick, asking Buildbucket for the build status
[05:14:15.989] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:15.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:65:0) after 1m0s
[05:15:16.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:65:0)
[05:15:16.063] Timer tick, asking Buildbucket for the build status
[05:15:16.319] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:16.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:66:0) after 1m0s
[05:16:16.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:66:0)
[05:16:16.422] Timer tick, asking Buildbucket for the build status
[05:16:16.556] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:67:0) after 1m0s
[05:17:16.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:67:0)
[05:17:16.579] Timer tick, asking Buildbucket for the build status
[05:17:16.663] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:16.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:68:0) after 1m0s
[05:18:16.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:68:0)
[05:18:16.689] Timer tick, asking Buildbucket for the build status
[05:18:16.778] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:16.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:69:0) after 1m0s
[05:19:16.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:69:0)
[05:19:16.802] Timer tick, asking Buildbucket for the build status
[05:19:16.870] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:16.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:70:0) after 1m0s
[05:20:16.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:70:0)
[05:20:16.900] Timer tick, asking Buildbucket for the build status
[05:20:16.961] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:16.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:71:0) after 1m0s
[05:21:17.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:71:0)
[05:21:17.009] Timer tick, asking Buildbucket for the build status
[05:21:17.082] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:17.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:72:0) after 1m0s
[05:22:17.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:72:0)
[05:22:17.189] Timer tick, asking Buildbucket for the build status
[05:22:17.268] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:17.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:73:0) after 1m0s
[05:23:17.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:73:0)
[05:23:17.373] Timer tick, asking Buildbucket for the build status
[05:23:17.438] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:17.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:74:0) after 1m0s
[05:24:17.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:74:0)
[05:24:17.461] Timer tick, asking Buildbucket for the build status
[05:24:17.537] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:17.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:75:0) after 1m0s
[05:25:17.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:75:0)
[05:25:17.577] Timer tick, asking Buildbucket for the build status
[05:25:17.627] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:17.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:76:0) after 1m0s
[05:26:17.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:76:0)
[05:26:17.651] Timer tick, asking Buildbucket for the build status
[05:26:17.712] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:17.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:77:0) after 1m0s
[05:27:17.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:77:0)
[05:27:17.734] Timer tick, asking Buildbucket for the build status
[05:27:17.771] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:17.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:78:0) after 1m0s
[05:28:17.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:78:0)
[05:28:17.815] Timer tick, asking Buildbucket for the build status
[05:28:17.878] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:17.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:79:0) after 1m0s
[05:29:17.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:79:0)
[05:29:17.972] Timer tick, asking Buildbucket for the build status
[05:29:18.046] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:18.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:80:0) after 1m0s
[05:30:18.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:80:0)
[05:30:18.073] Timer tick, asking Buildbucket for the build status
[05:30:18.158] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:18.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:81:0) after 1m0s
[05:31:18.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:81:0)
[05:31:18.202] Timer tick, asking Buildbucket for the build status
[05:31:18.293] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:18.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:82:0) after 1m0s
[05:32:18.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:82:0)
[05:32:18.402] Timer tick, asking Buildbucket for the build status
[05:32:18.489] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:18.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:83:0) after 1m0s
[05:33:18.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:83:0)
[05:33:18.511] Timer tick, asking Buildbucket for the build status
[05:33:18.594] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:18.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:84:0) after 1m0s
[05:34:18.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:84:0)
[05:34:18.618] Timer tick, asking Buildbucket for the build status
[05:34:18.723] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:18.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:85:0) after 1m0s
[05:35:18.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:85:0)
[05:35:18.745] Timer tick, asking Buildbucket for the build status
[05:35:18.809] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:86:0) after 1m0s
[05:36:18.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:86:0)
[05:36:18.844] Timer tick, asking Buildbucket for the build status
[05:36:18.910] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:87:0) after 1m0s
[05:37:18.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:87:0)
[05:37:18.943] Timer tick, asking Buildbucket for the build status
[05:37:19.011] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:19.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:88:0) after 1m0s
[05:38:19.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:88:0)
[05:38:19.035] Timer tick, asking Buildbucket for the build status
[05:38:19.077] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:89:0) after 1m0s
[05:39:19.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:89:0)
[05:39:19.103] Timer tick, asking Buildbucket for the build status
[05:39:19.174] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:90:0) after 1m0s
[05:40:19.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:90:0)
[05:40:19.222] Timer tick, asking Buildbucket for the build status
[05:40:19.283] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:19.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:91:0) after 1m0s
[05:41:19.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:91:0)
[05:41:19.306] Timer tick, asking Buildbucket for the build status
[05:41:19.397] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:19.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:92:0) after 1m0s
[05:42:19.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:92:0)
[05:42:19.636] Timer tick, asking Buildbucket for the build status
[05:42:19.757] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:19.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:93:0) after 1m0s
[05:43:19.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:93:0)
[05:43:19.879] Timer tick, asking Buildbucket for the build status
[05:43:19.917] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:19.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:94:0) after 1m0s
[05:44:20.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:94:0)
[05:44:20.140] Timer tick, asking Buildbucket for the build status
[05:44:20.423] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:20.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:95:0) after 1m0s
[05:45:20.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:95:0)
[05:45:20.522] Timer tick, asking Buildbucket for the build status
[05:45:20.603] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:96:0) after 1m0s
[05:46:20.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:96:0)
[05:46:20.654] Timer tick, asking Buildbucket for the build status
[05:46:20.702] Build 8928644244604582784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:20.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9094074306625050656:97:0) after 1m0s
[05:47:06.630] Received PubSub notification, asking Buildbucket for the build status
[05:47:06.677] Build 8928644244604582784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:47:06.677] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1543384014607953",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1543378325800285",
    "id": "8928644244604582784",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8715348f87461e9102ed5c28faed7a72c9a8e3f3\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"id\": [\"swarm2173-c4\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3885-d07efe8\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"f701a90597fc85979319447c0cd44c3b52201c78\", \"got_swarming_client_revision\": \"157bec8a25cc4ebd6a16052510d08b05b6102aad\", \"got_revision\": \"8715348f87461e9102ed5c28faed7a72c9a8e3f3\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"cf714a81c86e56827563e20c1b2750e674aec322\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25801}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#611555}\", \"branch\": \"refs/heads/master\", \"revision\": \"8715348f87461e9102ed5c28faed7a72c9a8e3f3\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"59cfd35438753acd69859e8a2f98f6490e68d6a0\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"3b7c9d099b0da0e70ebe9a0d73cfa644ee1c4901\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1543378325800285, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9094074306625050656\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8928644244604582784\"}}, \"got_v8_revision\": \"ab168019ec9085b4e6c0c1e4fee8f3b763682eaf\", \"got_v8_revision_cp\": \"refs/heads/7.2.486@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10878, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"04161ec8d7c781e4498c699254c69ba0dd959fde\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1543378326989306",
    "status": "COMPLETED",
    "status_changed_ts": "1543384025956716",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/10878",
      "builder:Windows deterministic",
      "buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094074306625050656",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Windows-10",
      "swarming_dimension:pool:luci.chromium.ci",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10878",
      "swarming_tag:buildbucket_bucket:chromium/ci",
      "swarming_tag:buildbucket_build_id:8928644244604582784",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8715348f87461e9102ed5c28faed7a72c9a8e3f3",
      "swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8928644244604582784/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows-10",
      "swarming_tag:pool:luci.chromium.ci",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9094074306625050656",
      "swarming_tag:scheduler_job_id:chromium/Windows deterministic",
      "swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:914243eb1439b4edf9491de814a79e7b008b0928",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:417155dc31854210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1543384025958185",
    "url": "https://ci.chromium.org/b/8928644244604582784",
    "utcnow_ts": "1543384026665196"
  }
}
[05:47:06.677] Invocation finished in 1h35m2.188404012s with status SUCCEEDED