Status: FAILED
Triggered by: -
Duration: 2 hours
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": "4437633bdfd4f28769a401afafc96a158c0ce6f2"
}

Incoming tags

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

Debug log (UTC)

[13:10:14.295] New invocation is queued and will start shortly
[13:10:15.466] Starting the invocation (attempt 1)
[13:10:15.498] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:10:15.498] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:10:15.499] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9107811187220384624",
  "parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4437633bdfd4f28769a401afafc96a158c0ce6f2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Windows deterministic",
    "scheduler_invocation_id:9107811187220384624",
    "scheduler_job_id:chromium/Windows deterministic",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2",
    "gitiles_ref:refs/heads/master"
  ]
}
[13:10:16.729] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1530277815611782",
    "id": "8942381125175926496",
    "lease_expiration_ts": "1530339016364043",
    "lease_key": "1709766893",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4437633bdfd4f28769a401afafc96a158c0ce6f2\"}}",
    "project": "chromium",
    "result_details_json": "null",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1530277816615128",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9314",
      "builder:Windows deterministic",
      "buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9107811187220384624",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "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/9314",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8942381125175926496",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "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/8942381125175926496/+/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:9107811187220384624",
      "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:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3e647bef6090c410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1530277816615215",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9314",
    "utcnow_ts": "1530277816716235"
  }
}
[13:10:16.729] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9314
[13:10:16.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:2:0) after 1m0s
[13:11:16.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:2:0)
[13:11:16.774] Timer tick, asking Buildbucket for the build status
[13:11:16.838] Build 8942381125175926496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:16.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:3:0) after 1m0s
[13:11:59.876] Received PubSub notification, asking Buildbucket for the build status
[13:11:59.918] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:16.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:3:0)
[13:12:16.946] Timer tick, asking Buildbucket for the build status
[13:12:16.981] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:16.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:5:0) after 1m0s
[13:13:17.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:5:0)
[13:13:17.104] Timer tick, asking Buildbucket for the build status
[13:13:17.162] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:17.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:6:0) after 1m0s
[13:14:17.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:6:0)
[13:14:17.182] Timer tick, asking Buildbucket for the build status
[13:14:17.505] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:17.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:7:0) after 1m0s
[13:15:17.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:7:0)
[13:15:17.662] Timer tick, asking Buildbucket for the build status
[13:15:17.729] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:17.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:8:0) after 1m0s
[13:16:17.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:8:0)
[13:16:17.793] Timer tick, asking Buildbucket for the build status
[13:16:18.987] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:18.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:9:0) after 1m0s
[13:17:19.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:9:0)
[13:17:19.067] Timer tick, asking Buildbucket for the build status
[13:17:19.206] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:10:0) after 1m0s
[13:18:19.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:10:0)
[13:18:19.223] Timer tick, asking Buildbucket for the build status
[13:18:19.275] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:19.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:11:0) after 1m0s
[13:19:19.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:11:0)
[13:19:19.356] Timer tick, asking Buildbucket for the build status
[13:19:19.522] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:19.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:12:0) after 1m0s
[13:20:19.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:12:0)
[13:20:19.539] Timer tick, asking Buildbucket for the build status
[13:20:19.722] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:19.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:13:0) after 1m0s
[13:21:19.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:13:0)
[13:21:19.862] Timer tick, asking Buildbucket for the build status
[13:21:19.983] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:19.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:14:0) after 1m0s
[13:22:20.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:14:0)
[13:22:20.007] Timer tick, asking Buildbucket for the build status
[13:22:20.313] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:20.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:15:0) after 1m0s
[13:23:20.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:15:0)
[13:23:20.332] Timer tick, asking Buildbucket for the build status
[13:23:20.450] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:20.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:16:0) after 1m0s
[13:24:20.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:16:0)
[13:24:20.466] Timer tick, asking Buildbucket for the build status
[13:24:20.812] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:20.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:17:0) after 1m0s
[13:25:20.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:17:0)
[13:25:20.833] Timer tick, asking Buildbucket for the build status
[13:25:20.896] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:20.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:18:0) after 1m0s
[13:26:20.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:18:0)
[13:26:20.952] Timer tick, asking Buildbucket for the build status
[13:26:21.184] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:19:0) after 1m0s
[13:27:21.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:19:0)
[13:27:21.203] Timer tick, asking Buildbucket for the build status
[13:27:21.345] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:21.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:20:0) after 1m0s
[13:28:21.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:20:0)
[13:28:21.365] Timer tick, asking Buildbucket for the build status
[13:28:21.529] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:21.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:21:0) after 1m0s
[13:29:21.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:21:0)
[13:29:21.547] Timer tick, asking Buildbucket for the build status
[13:29:21.616] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:21.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:22:0) after 1m0s
[13:30:21.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:22:0)
[13:30:21.730] Timer tick, asking Buildbucket for the build status
[13:30:21.796] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:21.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:23:0) after 1m0s
[13:31:21.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:23:0)
[13:31:21.814] Timer tick, asking Buildbucket for the build status
[13:31:21.871] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:21.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:24:0) after 1m0s
[13:32:21.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:24:0)
[13:32:21.913] Timer tick, asking Buildbucket for the build status
[13:32:21.973] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:21.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:25:0) after 1m0s
[13:33:22.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:25:0)
[13:33:22.021] Timer tick, asking Buildbucket for the build status
[13:33:22.055] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:22.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:26:0) after 1m0s
[13:34:22.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:26:0)
[13:34:22.154] Timer tick, asking Buildbucket for the build status
[13:34:22.238] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:22.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:27:0) after 1m0s
[13:35:22.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:27:0)
[13:35:22.303] Timer tick, asking Buildbucket for the build status
[13:35:22.545] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:22.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:28:0) after 1m0s
[13:36:22.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:28:0)
[13:36:22.640] Timer tick, asking Buildbucket for the build status
[13:36:22.758] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:22.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:29:0) after 1m0s
[13:37:22.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:29:0)
[13:37:22.787] Timer tick, asking Buildbucket for the build status
[13:37:22.863] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:22.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:30:0) after 1m0s
[13:38:22.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:30:0)
[13:38:22.904] Timer tick, asking Buildbucket for the build status
[13:38:23.010] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:23.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:31:0) after 1m0s
[13:39:23.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:31:0)
[13:39:23.029] Timer tick, asking Buildbucket for the build status
[13:39:23.084] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:32:0) after 1m0s
[13:40:23.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:32:0)
[13:40:23.103] Timer tick, asking Buildbucket for the build status
[13:40:23.168] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:23.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:33:0) after 1m0s
[13:41:23.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:33:0)
[13:41:23.194] Timer tick, asking Buildbucket for the build status
[13:41:23.242] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:23.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:34:0) after 1m0s
[13:42:23.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:34:0)
[13:42:23.261] Timer tick, asking Buildbucket for the build status
[13:42:24.320] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:24.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:35:0) after 1m0s
[13:43:24.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:35:0)
[13:43:24.338] Timer tick, asking Buildbucket for the build status
[13:43:24.454] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:24.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:36:0) after 1m0s
[13:44:24.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:36:0)
[13:44:24.534] Timer tick, asking Buildbucket for the build status
[13:44:24.597] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:24.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:37:0) after 1m0s
[13:45:24.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:37:0)
[13:45:24.622] Timer tick, asking Buildbucket for the build status
[13:45:24.680] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:24.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:38:0) after 1m0s
[13:46:24.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:38:0)
[13:46:24.699] Timer tick, asking Buildbucket for the build status
[13:46:24.849] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:24.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:39:0) after 1m0s
[13:47:24.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:39:0)
[13:47:24.874] Timer tick, asking Buildbucket for the build status
[13:47:24.929] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:24.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:40:0) after 1m0s
[13:48:24.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:40:0)
[13:48:24.950] Timer tick, asking Buildbucket for the build status
[13:48:25.088] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:25.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:41:0) after 1m0s
[13:49:25.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:41:0)
[13:49:25.109] Timer tick, asking Buildbucket for the build status
[13:49:25.163] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:25.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:42:0) after 1m0s
[13:50:25.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:42:0)
[13:50:25.193] Timer tick, asking Buildbucket for the build status
[13:50:25.246] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:25.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:43:0) after 1m0s
[13:51:25.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:43:0)
[13:51:25.273] Timer tick, asking Buildbucket for the build status
[13:51:25.453] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:25.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:44:0) after 1m0s
[13:52:25.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:44:0)
[13:52:25.483] Timer tick, asking Buildbucket for the build status
[13:52:25.531] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:45:0) after 1m0s
[13:53:25.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:45:0)
[13:53:25.552] Timer tick, asking Buildbucket for the build status
[13:53:25.619] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:25.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:46:0) after 1m0s
[13:54:25.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:46:0)
[13:54:25.640] Timer tick, asking Buildbucket for the build status
[13:54:25.710] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:25.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:47:0) after 1m0s
[13:55:25.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:47:0)
[13:55:25.748] Timer tick, asking Buildbucket for the build status
[13:55:25.812] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:25.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:48:0) after 1m0s
[13:56:25.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:48:0)
[13:56:25.832] Timer tick, asking Buildbucket for the build status
[13:56:25.898] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:25.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:49:0) after 1m0s
[13:57:25.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:49:0)
[13:57:25.923] Timer tick, asking Buildbucket for the build status
[13:57:25.979] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:25.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:50:0) after 1m0s
[13:58:26.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:50:0)
[13:58:26.021] Timer tick, asking Buildbucket for the build status
[13:58:26.071] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:26.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:51:0) after 1m0s
[13:59:26.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:51:0)
[13:59:26.132] Timer tick, asking Buildbucket for the build status
[13:59:26.182] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:26.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:52:0) after 1m0s
[14:00:26.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:52:0)
[14:00:26.203] Timer tick, asking Buildbucket for the build status
[14:00:26.241] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:26.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:53:0) after 1m0s
[14:01:26.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:53:0)
[14:01:26.264] Timer tick, asking Buildbucket for the build status
[14:01:26.348] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:26.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:54:0) after 1m0s
[14:02:26.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:54:0)
[14:02:26.390] Timer tick, asking Buildbucket for the build status
[14:02:26.456] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:26.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:55:0) after 1m0s
[14:03:26.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:55:0)
[14:03:26.478] Timer tick, asking Buildbucket for the build status
[14:03:26.628] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:26.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:56:0) after 1m0s
[14:04:26.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:56:0)
[14:04:26.652] Timer tick, asking Buildbucket for the build status
[14:04:26.710] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:26.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:57:0) after 1m0s
[14:05:26.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:57:0)
[14:05:26.729] Timer tick, asking Buildbucket for the build status
[14:05:26.796] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:58:0) after 1m0s
[14:06:26.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:58:0)
[14:06:26.827] Timer tick, asking Buildbucket for the build status
[14:06:26.883] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:59:0) after 1m0s
[14:07:26.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:59:0)
[14:07:26.903] Timer tick, asking Buildbucket for the build status
[14:07:27.120] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:27.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:60:0) after 1m0s
[14:08:27.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:60:0)
[14:08:27.157] Timer tick, asking Buildbucket for the build status
[14:08:27.617] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:27.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:61:0) after 1m0s
[14:09:27.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:61:0)
[14:09:27.637] Timer tick, asking Buildbucket for the build status
[14:09:27.694] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:27.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:62:0) after 1m0s
[14:10:27.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:62:0)
[14:10:27.727] Timer tick, asking Buildbucket for the build status
[14:10:27.794] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:27.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:63:0) after 1m0s
[14:11:27.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:63:0)
[14:11:27.820] Timer tick, asking Buildbucket for the build status
[14:11:27.883] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:27.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:64:0) after 1m0s
[14:12:27.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:64:0)
[14:12:27.910] Timer tick, asking Buildbucket for the build status
[14:12:28.271] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:28.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:65:0) after 1m0s
[14:13:28.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:65:0)
[14:13:28.306] Timer tick, asking Buildbucket for the build status
[14:13:28.499] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:28.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:66:0) after 1m0s
[14:14:28.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:66:0)
[14:14:28.534] Timer tick, asking Buildbucket for the build status
[14:14:28.589] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:28.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:67:0) after 1m0s
[14:15:28.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:67:0)
[14:15:28.610] Timer tick, asking Buildbucket for the build status
[14:15:28.700] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:28.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:68:0) after 1m0s
[14:16:28.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:68:0)
[14:16:28.721] Timer tick, asking Buildbucket for the build status
[14:16:28.759] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:28.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:69:0) after 1m0s
[14:17:28.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:69:0)
[14:17:28.784] Timer tick, asking Buildbucket for the build status
[14:17:28.860] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:28.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:70:0) after 1m0s
[14:18:28.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:70:0)
[14:18:28.886] Timer tick, asking Buildbucket for the build status
[14:18:28.938] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:28.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:71:0) after 1m0s
[14:19:28.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:71:0)
[14:19:28.960] Timer tick, asking Buildbucket for the build status
[14:19:28.998] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:28.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:72:0) after 1m0s
[14:20:29.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:72:0)
[14:20:29.114] Timer tick, asking Buildbucket for the build status
[14:20:29.370] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:29.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:73:0) after 1m0s
[14:21:29.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:73:0)
[14:21:29.388] Timer tick, asking Buildbucket for the build status
[14:21:29.454] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:29.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:74:0) after 1m0s
[14:22:29.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:74:0)
[14:22:29.549] Timer tick, asking Buildbucket for the build status
[14:22:29.745] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:75:0) after 1m0s
[14:23:29.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:75:0)
[14:23:29.769] Timer tick, asking Buildbucket for the build status
[14:23:29.871] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:76:0) after 1m0s
[14:24:29.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:76:0)
[14:24:29.897] Timer tick, asking Buildbucket for the build status
[14:24:29.933] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:29.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:77:0) after 1m0s
[14:25:30.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:77:0)
[14:25:30.027] Timer tick, asking Buildbucket for the build status
[14:25:30.224] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:30.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:78:0) after 1m0s
[14:26:30.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:78:0)
[14:26:30.244] Timer tick, asking Buildbucket for the build status
[14:26:30.358] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:30.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:79:0) after 1m0s
[14:27:30.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:79:0)
[14:27:30.378] Timer tick, asking Buildbucket for the build status
[14:27:30.910] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:30.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:80:0) after 1m0s
[14:28:30.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:80:0)
[14:28:30.929] Timer tick, asking Buildbucket for the build status
[14:28:30.984] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:30.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:81:0) after 1m0s
[14:29:31.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:81:0)
[14:29:31.013] Timer tick, asking Buildbucket for the build status
[14:29:31.169] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:82:0) after 1m0s
[14:30:31.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:82:0)
[14:30:31.204] Timer tick, asking Buildbucket for the build status
[14:30:31.259] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:31.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:83:0) after 1m0s
[14:31:31.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:83:0)
[14:31:31.321] Timer tick, asking Buildbucket for the build status
[14:31:31.399] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:31.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:84:0) after 1m0s
[14:32:31.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:84:0)
[14:32:31.422] Timer tick, asking Buildbucket for the build status
[14:32:31.475] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:85:0) after 1m0s
[14:33:31.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:85:0)
[14:33:31.501] Timer tick, asking Buildbucket for the build status
[14:33:31.566] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:31.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:86:0) after 1m0s
[14:34:31.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:86:0)
[14:34:31.589] Timer tick, asking Buildbucket for the build status
[14:34:31.640] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:31.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:87:0) after 1m0s
[14:35:31.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:87:0)
[14:35:31.859] Timer tick, asking Buildbucket for the build status
[14:35:31.931] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:31.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:88:0) after 1m0s
[14:36:31.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:88:0)
[14:36:31.953] Timer tick, asking Buildbucket for the build status
[14:36:32.186] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:32.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:89:0) after 1m0s
[14:37:32.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:89:0)
[14:37:32.214] Timer tick, asking Buildbucket for the build status
[14:37:32.329] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:90:0) after 1m0s
[14:38:32.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:90:0)
[14:38:32.348] Timer tick, asking Buildbucket for the build status
[14:38:32.476] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:32.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:91:0) after 1m0s
[14:39:32.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:91:0)
[14:39:32.496] Timer tick, asking Buildbucket for the build status
[14:39:32.653] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:32.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:92:0) after 1m0s
[14:40:32.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:92:0)
[14:40:32.676] Timer tick, asking Buildbucket for the build status
[14:40:32.821] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:32.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:93:0) after 1m0s
[14:41:32.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:93:0)
[14:41:32.913] Timer tick, asking Buildbucket for the build status
[14:41:33.098] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:33.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:94:0) after 1m0s
[14:42:33.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:94:0)
[14:42:33.135] Timer tick, asking Buildbucket for the build status
[14:42:33.166] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:33.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:95:0) after 1m0s
[14:43:33.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:95:0)
[14:43:33.186] Timer tick, asking Buildbucket for the build status
[14:43:33.299] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:33.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:96:0) after 1m0s
[14:44:33.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:96:0)
[14:44:33.322] Timer tick, asking Buildbucket for the build status
[14:44:33.433] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:33.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:97:0) after 1m0s
[14:45:33.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:97:0)
[14:45:33.453] Timer tick, asking Buildbucket for the build status
[14:45:33.504] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:33.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:98:0) after 1m0s
[14:46:33.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:98:0)
[14:46:33.526] Timer tick, asking Buildbucket for the build status
[14:46:33.611] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:33.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:99:0) after 1m0s
[14:47:34.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:99:0)
[14:47:34.235] Timer tick, asking Buildbucket for the build status
[14:47:34.393] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:34.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:100:0) after 1m0s
[14:48:34.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:100:0)
[14:48:34.425] Timer tick, asking Buildbucket for the build status
[14:48:34.705] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:34.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:101:0) after 1m0s
[14:49:34.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:101:0)
[14:49:34.727] Timer tick, asking Buildbucket for the build status
[14:49:34.788] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:34.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:102:0) after 1m0s
[14:50:34.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:102:0)
[14:50:34.857] Timer tick, asking Buildbucket for the build status
[14:50:34.913] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:34.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:103:0) after 1m0s
[14:51:34.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:103:0)
[14:51:34.937] Timer tick, asking Buildbucket for the build status
[14:51:35.113] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:35.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:104:0) after 1m0s
[14:52:35.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:104:0)
[14:52:35.145] Timer tick, asking Buildbucket for the build status
[14:52:35.192] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:35.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:105:0) after 1m0s
[14:53:35.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:105:0)
[14:53:35.217] Timer tick, asking Buildbucket for the build status
[14:53:35.272] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:35.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:106:0) after 1m0s
[14:54:35.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:106:0)
[14:54:35.329] Timer tick, asking Buildbucket for the build status
[14:54:35.529] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:35.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:107:0) after 1m0s
[14:55:35.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:107:0)
[14:55:35.557] Timer tick, asking Buildbucket for the build status
[14:55:35.630] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:35.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:108:0) after 1m0s
[14:56:35.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:108:0)
[14:56:35.652] Timer tick, asking Buildbucket for the build status
[14:56:35.969] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:35.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:109:0) after 1m0s
[14:57:35.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:109:0)
[14:57:35.992] Timer tick, asking Buildbucket for the build status
[14:57:36.032] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:36.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:110:0) after 1m0s
[14:58:36.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:110:0)
[14:58:36.082] Timer tick, asking Buildbucket for the build status
[14:58:36.325] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:36.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:111:0) after 1m0s
[14:59:36.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:111:0)
[14:59:36.350] Timer tick, asking Buildbucket for the build status
[14:59:36.412] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:36.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:112:0) after 1m0s
[15:00:36.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:112:0)
[15:00:36.443] Timer tick, asking Buildbucket for the build status
[15:00:36.482] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:36.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:113:0) after 1m0s
[15:01:36.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:113:0)
[15:01:36.505] Timer tick, asking Buildbucket for the build status
[15:01:36.577] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:36.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:114:0) after 1m0s
[15:02:36.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:114:0)
[15:02:36.626] Timer tick, asking Buildbucket for the build status
[15:02:36.731] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:36.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:115:0) after 1m0s
[15:03:36.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:115:0)
[15:03:36.799] Timer tick, asking Buildbucket for the build status
[15:03:36.869] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:36.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:116:0) after 1m0s
[15:04:36.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:116:0)
[15:04:36.891] Timer tick, asking Buildbucket for the build status
[15:04:36.958] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:36.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:117:0) after 1m0s
[15:05:36.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:117:0)
[15:05:36.987] Timer tick, asking Buildbucket for the build status
[15:05:37.039] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:37.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:118:0) after 1m0s
[15:06:37.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:118:0)
[15:06:37.059] Timer tick, asking Buildbucket for the build status
[15:06:37.131] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:37.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:119:0) after 1m0s
[15:07:37.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:119:0)
[15:07:37.156] Timer tick, asking Buildbucket for the build status
[15:07:37.219] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:37.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:120:0) after 1m0s
[15:08:37.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:120:0)
[15:08:37.240] Timer tick, asking Buildbucket for the build status
[15:08:37.398] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:37.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:121:0) after 1m0s
[15:09:37.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:121:0)
[15:09:37.531] Timer tick, asking Buildbucket for the build status
[15:09:37.582] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:37.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:122:0) after 1m0s
[15:10:37.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:122:0)
[15:10:37.602] Timer tick, asking Buildbucket for the build status
[15:10:37.685] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:37.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:123:0) after 1m0s
[15:11:37.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:123:0)
[15:11:37.713] Timer tick, asking Buildbucket for the build status
[15:11:37.783] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:37.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:124:0) after 1m0s
[15:12:37.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:124:0)
[15:12:37.825] Timer tick, asking Buildbucket for the build status
[15:12:37.883] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:37.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:125:0) after 1m0s
[15:13:38.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:125:0)
[15:13:38.018] Timer tick, asking Buildbucket for the build status
[15:13:38.076] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:126:0) after 1m0s
[15:14:38.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:126:0)
[15:14:38.102] Timer tick, asking Buildbucket for the build status
[15:14:38.191] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:38.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:127:0) after 1m0s
[15:15:38.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:127:0)
[15:15:38.278] Timer tick, asking Buildbucket for the build status
[15:15:38.487] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:128:0) after 1m0s
[15:16:38.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:128:0)
[15:16:38.534] Timer tick, asking Buildbucket for the build status
[15:16:38.571] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:38.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:129:0) after 1m0s
[15:17:38.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:129:0)
[15:17:38.657] Timer tick, asking Buildbucket for the build status
[15:17:38.713] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:38.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:130:0) after 1m0s
[15:18:38.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:130:0)
[15:18:38.742] Timer tick, asking Buildbucket for the build status
[15:18:38.811] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:38.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:131:0) after 1m0s
[15:19:38.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:131:0)
[15:19:38.832] Timer tick, asking Buildbucket for the build status
[15:19:38.983] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:38.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:132:0) after 1m0s
[15:20:39.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:132:0)
[15:20:39.010] Timer tick, asking Buildbucket for the build status
[15:20:39.105] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:133:0) after 1m0s
[15:21:39.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:133:0)
[15:21:39.127] Timer tick, asking Buildbucket for the build status
[15:21:39.175] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:39.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:134:0) after 1m0s
[15:22:39.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:134:0)
[15:22:39.197] Timer tick, asking Buildbucket for the build status
[15:22:39.279] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:135:0) after 1m0s
[15:23:39.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:135:0)
[15:23:39.315] Timer tick, asking Buildbucket for the build status
[15:23:39.486] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:39.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:136:0) after 1m0s
[15:24:39.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:136:0)
[15:24:39.510] Timer tick, asking Buildbucket for the build status
[15:24:39.572] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:137:0) after 1m0s
[15:25:39.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:137:0)
[15:25:39.595] Timer tick, asking Buildbucket for the build status
[15:25:39.676] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:39.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:138:0) after 1m0s
[15:26:39.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:138:0)
[15:26:39.704] Timer tick, asking Buildbucket for the build status
[15:26:39.762] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:39.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:139:0) after 1m0s
[15:27:39.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:139:0)
[15:27:39.833] Timer tick, asking Buildbucket for the build status
[15:27:39.945] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:39.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:140:0) after 1m0s
[15:28:39.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:140:0)
[15:28:39.979] Timer tick, asking Buildbucket for the build status
[15:28:40.136] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:40.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:141:0) after 1m0s
[15:29:40.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:141:0)
[15:29:40.161] Timer tick, asking Buildbucket for the build status
[15:29:40.223] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:142:0) after 1m0s
[15:30:40.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:142:0)
[15:30:40.247] Timer tick, asking Buildbucket for the build status
[15:30:40.332] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:40.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:143:0) after 1m0s
[15:31:40.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:143:0)
[15:31:40.359] Timer tick, asking Buildbucket for the build status
[15:31:40.631] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:40.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:144:0) after 1m0s
[15:32:40.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:144:0)
[15:32:40.656] Timer tick, asking Buildbucket for the build status
[15:32:40.718] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:40.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:145:0) after 1m0s
[15:33:40.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:145:0)
[15:33:40.741] Timer tick, asking Buildbucket for the build status
[15:33:40.803] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:40.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:146:0) after 1m0s
[15:34:40.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:146:0)
[15:34:40.841] Timer tick, asking Buildbucket for the build status
[15:34:40.909] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:40.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:147:0) after 1m0s
[15:35:40.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:147:0)
[15:35:40.929] Timer tick, asking Buildbucket for the build status
[15:35:40.962] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:40.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:148:0) after 1m0s
[15:36:40.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:148:0)
[15:36:40.988] Timer tick, asking Buildbucket for the build status
[15:36:41.046] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:149:0) after 1m0s
[15:37:41.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:149:0)
[15:37:41.073] Timer tick, asking Buildbucket for the build status
[15:37:41.131] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:41.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:150:0) after 1m0s
[15:38:41.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:150:0)
[15:38:41.218] Timer tick, asking Buildbucket for the build status
[15:38:41.346] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:151:0) after 1m0s
[15:39:41.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:151:0)
[15:39:41.378] Timer tick, asking Buildbucket for the build status
[15:39:41.464] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:41.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:152:0) after 1m0s
[15:40:41.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:152:0)
[15:40:41.486] Timer tick, asking Buildbucket for the build status
[15:40:41.535] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:41.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:153:0) after 1m0s
[15:41:41.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:153:0)
[15:41:41.563] Timer tick, asking Buildbucket for the build status
[15:41:41.751] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:41.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:154:0) after 1m0s
[15:42:41.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:154:0)
[15:42:41.780] Timer tick, asking Buildbucket for the build status
[15:42:41.854] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:41.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:155:0) after 1m0s
[15:43:41.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:155:0)
[15:43:41.877] Timer tick, asking Buildbucket for the build status
[15:43:41.907] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:41.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:156:0) after 1m0s
[15:44:41.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:156:0)
[15:44:41.945] Timer tick, asking Buildbucket for the build status
[15:44:42.078] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:42.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:157:0) after 1m0s
[15:45:42.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:157:0)
[15:45:42.099] Timer tick, asking Buildbucket for the build status
[15:45:42.198] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:42.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:158:0) after 1m0s
[15:46:42.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:158:0)
[15:46:42.219] Timer tick, asking Buildbucket for the build status
[15:46:42.276] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:42.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:159:0) after 1m0s
[15:47:42.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:159:0)
[15:47:42.357] Timer tick, asking Buildbucket for the build status
[15:47:42.425] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:42.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:160:0) after 1m0s
[15:48:42.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:160:0)
[15:48:42.467] Timer tick, asking Buildbucket for the build status
[15:48:42.528] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:42.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:161:0) after 1m0s
[15:49:42.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:161:0)
[15:49:42.663] Timer tick, asking Buildbucket for the build status
[15:49:42.722] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:42.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:162:0) after 1m0s
[15:50:42.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:162:0)
[15:50:42.748] Timer tick, asking Buildbucket for the build status
[15:50:42.895] Build 8942381125175926496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:42.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107811187220384624:163:0) after 1m0s
[15:51:01.974] Received PubSub notification, asking Buildbucket for the build status
[15:51:02.223] Build 8942381125175926496: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[15:51:02.223] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1530287459355313",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1530277815611782",
    "failure_reason": "INFRA_FAILURE",
    "id": "8942381125175926496",
    "parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4437633bdfd4f28769a401afafc96a158c0ce6f2\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\\nFailure Uncaught Exception\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\", \"bootstrapperCallStack\": [], \"type\": \"RECIPE_INFRA_FAILURE\"}, \"recipeResult\": {\"failure\": {\"exception\": {\"traceback\": [\"Traceback (most recent call last):\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\run.py\\\", line 287, in _new_run\", \"    recipe_result = recipe_script.run(api, self.properties, self.environ)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 108, in run\", \"    self.run_steps, properties, environ, self.PROPERTIES, api=api)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 636, in invoke_with_properties\", \"    arg_names, **additional_args)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 599, in _invoke_with_properties\", \"    return callable_obj(*props, **additional_args)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipes\\\\swarming/deterministic_build.py\\\", line 194, in RunSteps\", \"    str(api.chromium.output_dir).rstrip('\\\\\\\\/') + '.2')\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\recipe_api.py\\\", line 759, in _inner\", \"    return func(*a, **kw)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipe_modules\\\\isolate\\\\api.py\\\", line 350, in compare_build_artifacts\", \"    self.archive_differences(first_dir, second_dir, step_result.json.output)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\recipe_api.py\\\", line 759, in _inner\", \"    return func(*a, **kw)\", \"  File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipe_modules\\\\isolate\\\\api.py\\\", line 302, in archive_differences\", \"    diffs = list(itertools.chain.from_iterable(values.itervalues()))\", \"AttributeError: 'NoneType' object has no attribute 'itervalues'\"]}, \"humanReason\": \"Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8942381125175926496/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"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\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3675-21ffa58\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"030b88a205c9ce9a82d68798bfaa059fd55216cd\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"4437633bdfd4f28769a401afafc96a158c0ce6f2\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23779}\", \"$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@{#571450}\", \"branch\": \"refs/heads/master\", \"revision\": \"4437633bdfd4f28769a401afafc96a158c0ce6f2\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"c54f706993be073040441eaa5d60c9a4182b9399\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"fa5d84be414528212b9aaee23551c8dc1971ad38\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1530277815611782, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107811187220384624\", \"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\": \"8942381125175926496\"}}, \"got_v8_revision\": \"d3714bb851cd75866f115e60aeb3b9ff99bcbb6f\", \"got_v8_revision_cp\": \"refs/heads/6.9.237@{#2}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9314, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"9c9fd97928dd45a0d9738af90f7c03b082f1216f\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1530277918957794",
    "status": "COMPLETED",
    "status_changed_ts": "1530287461436869",
    "tags": [
      "build_address:luci.chromium.ci/Windows deterministic/9314",
      "builder:Windows deterministic",
      "buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9107811187220384624",
      "scheduler_job_id:chromium/Windows deterministic",
      "swarming_dimension:builder:Windows deterministic",
      "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/9314",
      "swarming_tag:buildbucket_bucket:luci.chromium.ci",
      "swarming_tag:buildbucket_build_id:8942381125175926496",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:builder:Windows deterministic",
      "swarming_tag:buildset:commit/git/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4437633bdfd4f28769a401afafc96a158c0ce6f2",
      "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/8942381125175926496/+/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:9107811187220384624",
      "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:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3e647bef6090c410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1530287461442286",
    "url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9314",
    "utcnow_ts": "1530287462114282"
  }
}
[15:51:02.223] Invocation finished in 2h40m47.944913561s with status FAILED