[00:27:46.589] New invocation is queued and will start shortly
[00:27:49.047] Starting the invocation (attempt 1)
[00:27:49.184] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:27:49.184] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:27:49.184] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067543507131648896",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fd43bf7dd29611e8704ce06f9269037b06acedf8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9067543507131648896",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"gitiles_ref:refs/heads/master"
]
}
[00:27:50.077] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568680069492111",
"id": "8902113443410943168",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd43bf7dd29611e8704ce06f9269037b06acedf8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568680069896784",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14737",
"builder:Windows deterministic",
"buildset:commit/git/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067543507131648896",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8902113443410943168/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1568680069896934",
"url": "https://ci.chromium.org/b/8902113443410943168",
"utcnow_ts": "1568680070068939"
}
}
[00:27:50.077] Task URL: https://ci.chromium.org/b/8902113443410943168
[00:27:50.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:2:0) after 1m0s
[00:28:06.868] Received PubSub notification, asking Buildbucket for the build status
[00:28:08.015] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:50.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:2:0)
[00:28:50.129] Timer tick, asking Buildbucket for the build status
[00:28:50.700] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:50.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:4:0) after 1m0s
[00:29:50.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:4:0)
[00:29:50.835] Timer tick, asking Buildbucket for the build status
[00:29:51.822] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:51.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:5:0) after 1m0s
[00:30:51.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:5:0)
[00:30:51.907] Timer tick, asking Buildbucket for the build status
[00:30:57.717] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:57.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:6:0) after 1m0s
[00:31:57.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:6:0)
[00:31:57.843] Timer tick, asking Buildbucket for the build status
[00:31:58.502] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:58.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:7:0) after 1m0s
[00:32:58.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:7:0)
[00:32:58.566] Timer tick, asking Buildbucket for the build status
[00:32:58.798] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:58.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:8:0) after 1m0s
[00:33:58.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:8:0)
[00:33:58.843] Timer tick, asking Buildbucket for the build status
[00:33:59.453] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:9:0) after 1m0s
[00:35:01.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:9:0)
[00:35:01.010] Timer tick, asking Buildbucket for the build status
[00:35:01.242] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:01.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:10:0) after 1m0s
[00:36:01.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:10:0)
[00:36:01.274] Timer tick, asking Buildbucket for the build status
[00:36:06.902] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:06.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:11:0) after 1m0s
[00:37:07.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:11:0)
[00:37:07.120] Timer tick, asking Buildbucket for the build status
[00:37:07.808] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:07.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:12:0) after 1m0s
[00:38:07.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:12:0)
[00:38:07.938] Timer tick, asking Buildbucket for the build status
[00:38:09.997] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:09.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:13:0) after 1m0s
[00:39:10.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:13:0)
[00:39:10.136] Timer tick, asking Buildbucket for the build status
[00:39:11.253] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:11.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:14:0) after 1m0s
[00:40:11.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:14:0)
[00:40:11.303] Timer tick, asking Buildbucket for the build status
[00:40:11.668] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:11.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:15:0) after 1m0s
[00:41:11.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:15:0)
[00:41:11.703] Timer tick, asking Buildbucket for the build status
[00:41:12.701] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:12.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:16:0) after 1m0s
[00:42:12.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:16:0)
[00:42:12.932] Timer tick, asking Buildbucket for the build status
[00:42:14.215] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:14.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:17:0) after 1m0s
[00:43:14.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:17:0)
[00:43:14.290] Timer tick, asking Buildbucket for the build status
[00:43:15.046] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:18:0) after 1m0s
[00:44:15.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:18:0)
[00:44:15.086] Timer tick, asking Buildbucket for the build status
[00:44:15.425] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:15.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:19:0) after 1m0s
[00:45:15.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:19:0)
[00:45:15.453] Timer tick, asking Buildbucket for the build status
[00:45:16.813] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:16.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:20:0) after 1m0s
[00:46:17.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:20:0)
[00:46:17.716] Timer tick, asking Buildbucket for the build status
[00:46:17.949] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:17.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:21:0) after 1m0s
[00:47:18.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:21:0)
[00:47:18.343] Timer tick, asking Buildbucket for the build status
[00:47:18.895] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:18.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:22:0) after 1m0s
[00:48:19.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:22:0)
[00:48:19.396] Timer tick, asking Buildbucket for the build status
[00:48:19.674] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:19.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:23:0) after 1m0s
[00:49:19.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:23:0)
[00:49:19.701] Timer tick, asking Buildbucket for the build status
[00:49:20.114] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:20.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:24:0) after 1m0s
[00:50:20.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:24:0)
[00:50:20.441] Timer tick, asking Buildbucket for the build status
[00:50:24.245] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:24.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:25:0) after 1m0s
[00:51:24.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:25:0)
[00:51:24.336] Timer tick, asking Buildbucket for the build status
[00:51:26.936] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:26.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:26:0) after 1m0s
[00:52:27.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:26:0)
[00:52:27.024] Timer tick, asking Buildbucket for the build status
[00:52:27.816] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:27.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:27:0) after 1m0s
[00:53:27.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:27:0)
[00:53:27.883] Timer tick, asking Buildbucket for the build status
[00:53:28.113] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:28:0) after 1m0s
[00:54:28.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:28:0)
[00:54:28.102] Timer tick, asking Buildbucket for the build status
[00:54:30.335] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:30.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:29:0) after 1m0s
[00:55:30.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:29:0)
[00:55:30.470] Timer tick, asking Buildbucket for the build status
[00:55:32.448] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:32.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:30:0) after 1m0s
[00:56:32.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:30:0)
[00:56:32.634] Timer tick, asking Buildbucket for the build status
[00:56:32.870] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:32.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:31:0) after 1m0s
[00:57:32.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:31:0)
[00:57:32.941] Timer tick, asking Buildbucket for the build status
[00:57:33.274] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:33.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:32:0) after 1m0s
[00:58:33.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:32:0)
[00:58:33.306] Timer tick, asking Buildbucket for the build status
[00:58:34.108] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:34.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:33:0) after 1m0s
[00:59:34.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:33:0)
[00:59:34.251] Timer tick, asking Buildbucket for the build status
[00:59:35.064] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:35.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:34:0) after 1m0s
[01:00:35.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:34:0)
[01:00:35.134] Timer tick, asking Buildbucket for the build status
[01:00:35.412] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:35.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:35:0) after 1m0s
[01:01:35.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:35:0)
[01:01:35.563] Timer tick, asking Buildbucket for the build status
[01:01:38.473] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:38.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:36:0) after 1m0s
[01:02:38.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:36:0)
[01:02:38.590] Timer tick, asking Buildbucket for the build status
[01:02:41.366] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:41.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:37:0) after 1m0s
[01:03:41.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:37:0)
[01:03:41.428] Timer tick, asking Buildbucket for the build status
[01:03:45.115] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:45.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:38:0) after 1m0s
[01:04:45.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:38:0)
[01:04:45.148] Timer tick, asking Buildbucket for the build status
[01:04:46.196] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:39:0) after 1m0s
[01:05:46.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:39:0)
[01:05:46.256] Timer tick, asking Buildbucket for the build status
[01:05:49.557] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:49.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:40:0) after 1m0s
[01:06:49.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:40:0)
[01:06:49.585] Timer tick, asking Buildbucket for the build status
[01:06:49.903] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:49.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:41:0) after 1m0s
[01:07:49.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:41:0)
[01:07:49.947] Timer tick, asking Buildbucket for the build status
[01:07:50.208] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:50.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:42:0) after 1m0s
[01:08:50.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:42:0)
[01:08:50.319] Timer tick, asking Buildbucket for the build status
[01:08:50.653] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:50.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:43:0) after 1m0s
[01:09:50.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:43:0)
[01:09:50.770] Timer tick, asking Buildbucket for the build status
[01:09:50.959] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:50.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:44:0) after 1m0s
[01:10:51.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:44:0)
[01:10:51.219] Timer tick, asking Buildbucket for the build status
[01:10:53.365] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:53.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:45:0) after 1m0s
[01:11:53.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:45:0)
[01:11:53.511] Timer tick, asking Buildbucket for the build status
[01:11:53.913] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:53.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:46:0) after 1m0s
[01:12:54.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:46:0)
[01:12:54.141] Timer tick, asking Buildbucket for the build status
[01:12:55.360] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:47:0) after 1m0s
[01:13:55.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:47:0)
[01:13:55.506] Timer tick, asking Buildbucket for the build status
[01:13:56.026] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:56.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:48:0) after 1m0s
[01:14:56.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:48:0)
[01:14:56.106] Timer tick, asking Buildbucket for the build status
[01:14:56.390] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:56.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:49:0) after 1m0s
[01:15:56.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:49:0)
[01:15:56.460] Timer tick, asking Buildbucket for the build status
[01:15:57.284] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:50:0) after 1m0s
[01:16:57.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:50:0)
[01:16:57.374] Timer tick, asking Buildbucket for the build status
[01:16:57.675] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:51:0) after 1m0s
[01:17:57.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:51:0)
[01:17:57.752] Timer tick, asking Buildbucket for the build status
[01:17:57.970] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:57.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:52:0) after 1m0s
[01:18:58.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:52:0)
[01:18:58.084] Timer tick, asking Buildbucket for the build status
[01:18:58.309] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:58.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:53:0) after 1m0s
[01:19:58.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:53:0)
[01:19:58.388] Timer tick, asking Buildbucket for the build status
[01:19:59.243] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:59.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:54:0) after 1m0s
[01:20:59.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:54:0)
[01:20:59.317] Timer tick, asking Buildbucket for the build status
[01:21:04.847] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:04.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:55:0) after 1m0s
[01:22:04.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:55:0)
[01:22:04.885] Timer tick, asking Buildbucket for the build status
[01:22:07.175] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:07.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:56:0) after 1m0s
[01:23:07.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:56:0)
[01:23:07.195] Timer tick, asking Buildbucket for the build status
[01:23:07.795] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:07.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:57:0) after 1m0s
[01:24:07.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:57:0)
[01:24:07.933] Timer tick, asking Buildbucket for the build status
[01:24:10.745] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:58:0) after 1m0s
[01:25:10.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:58:0)
[01:25:10.817] Timer tick, asking Buildbucket for the build status
[01:25:12.507] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:12.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:59:0) after 1m0s
[01:26:12.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:59:0)
[01:26:12.537] Timer tick, asking Buildbucket for the build status
[01:26:13.835] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:13.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:60:0) after 1m0s
[01:27:13.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:60:0)
[01:27:13.864] Timer tick, asking Buildbucket for the build status
[01:27:14.320] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:14.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:61:0) after 1m0s
[01:28:14.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:61:0)
[01:28:14.410] Timer tick, asking Buildbucket for the build status
[01:28:15.153] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:15.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:62:0) after 1m0s
[01:29:15.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:62:0)
[01:29:15.188] Timer tick, asking Buildbucket for the build status
[01:29:15.505] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:15.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:63:0) after 1m0s
[01:30:15.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:63:0)
[01:30:15.693] Timer tick, asking Buildbucket for the build status
[01:30:15.975] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:15.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:64:0) after 1m0s
[01:31:16.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:64:0)
[01:31:16.117] Timer tick, asking Buildbucket for the build status
[01:31:16.387] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:16.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:65:0) after 1m0s
[01:32:16.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:65:0)
[01:32:16.433] Timer tick, asking Buildbucket for the build status
[01:32:17.132] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:66:0) after 1m0s
[01:33:17.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:66:0)
[01:33:17.175] Timer tick, asking Buildbucket for the build status
[01:33:17.623] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:17.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:67:0) after 1m0s
[01:34:18.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:67:0)
[01:34:18.461] Timer tick, asking Buildbucket for the build status
[01:34:19.113] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:19.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:68:0) after 1m0s
[01:35:19.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:68:0)
[01:35:19.196] Timer tick, asking Buildbucket for the build status
[01:35:20.957] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:20.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:69:0) after 1m0s
[01:36:21.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:69:0)
[01:36:21.132] Timer tick, asking Buildbucket for the build status
[01:36:22.119] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:22.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:70:0) after 1m0s
[01:37:22.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:70:0)
[01:37:22.301] Timer tick, asking Buildbucket for the build status
[01:37:22.913] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:22.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:71:0) after 1m0s
[01:38:22.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:71:0)
[01:38:22.958] Timer tick, asking Buildbucket for the build status
[01:38:23.194] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:23.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:72:0) after 1m0s
[01:39:23.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:72:0)
[01:39:23.294] Timer tick, asking Buildbucket for the build status
[01:39:24.229] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:73:0) after 1m0s
[01:40:24.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:73:0)
[01:40:24.330] Timer tick, asking Buildbucket for the build status
[01:40:25.018] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:74:0) after 1m0s
[01:41:25.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:74:0)
[01:41:25.027] Timer tick, asking Buildbucket for the build status
[01:41:27.807] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:27.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:75:0) after 1m0s
[01:42:27.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:75:0)
[01:42:27.868] Timer tick, asking Buildbucket for the build status
[01:42:28.366] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:28.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:76:0) after 1m0s
[01:43:28.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:76:0)
[01:43:28.423] Timer tick, asking Buildbucket for the build status
[01:43:28.584] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:28.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:77:0) after 1m0s
[01:44:28.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:77:0)
[01:44:28.628] Timer tick, asking Buildbucket for the build status
[01:44:30.136] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:78:0) after 1m0s
[01:45:30.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:78:0)
[01:45:30.149] Timer tick, asking Buildbucket for the build status
[01:45:30.433] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:30.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:79:0) after 1m0s
[01:46:30.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:79:0)
[01:46:30.586] Timer tick, asking Buildbucket for the build status
[01:46:30.755] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:30.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:80:0) after 1m0s
[01:47:30.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:80:0)
[01:47:30.801] Timer tick, asking Buildbucket for the build status
[01:47:31.174] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:31.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:81:0) after 1m0s
[01:48:31.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:81:0)
[01:48:31.279] Timer tick, asking Buildbucket for the build status
[01:48:31.513] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:31.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:82:0) after 1m0s
[01:49:31.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:82:0)
[01:49:31.548] Timer tick, asking Buildbucket for the build status
[01:49:31.983] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:31.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:83:0) after 1m0s
[01:50:32.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:83:0)
[01:50:32.026] Timer tick, asking Buildbucket for the build status
[01:50:33.710] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:33.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:84:0) after 1m0s
[01:51:33.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:84:0)
[01:51:33.794] Timer tick, asking Buildbucket for the build status
[01:51:34.140] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:34.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:85:0) after 1m0s
[01:52:34.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:85:0)
[01:52:34.247] Timer tick, asking Buildbucket for the build status
[01:52:34.654] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:34.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:86:0) after 1m0s
[01:53:34.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:86:0)
[01:53:34.760] Timer tick, asking Buildbucket for the build status
[01:53:35.073] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:87:0) after 1m0s
[01:54:35.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:87:0)
[01:54:35.400] Timer tick, asking Buildbucket for the build status
[01:54:35.649] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:35.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:88:0) after 1m0s
[01:55:35.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:88:0)
[01:55:35.740] Timer tick, asking Buildbucket for the build status
[01:55:36.637] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:36.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:89:0) after 1m0s
[01:56:36.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:89:0)
[01:56:36.703] Timer tick, asking Buildbucket for the build status
[01:56:37.628] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:37.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:90:0) after 1m0s
[01:57:37.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:90:0)
[01:57:37.680] Timer tick, asking Buildbucket for the build status
[01:57:38.596] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:91:0) after 1m0s
[01:58:38.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:91:0)
[01:58:38.647] Timer tick, asking Buildbucket for the build status
[01:58:39.629] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:39.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:92:0) after 1m0s
[01:59:39.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:92:0)
[01:59:39.662] Timer tick, asking Buildbucket for the build status
[01:59:40.288] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:40.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:93:0) after 1m0s
[02:00:40.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:93:0)
[02:00:40.337] Timer tick, asking Buildbucket for the build status
[02:00:41.598] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:41.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:94:0) after 1m0s
[02:01:41.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:94:0)
[02:01:41.616] Timer tick, asking Buildbucket for the build status
[02:01:43.078] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:43.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:95:0) after 1m0s
[02:02:43.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:95:0)
[02:02:43.134] Timer tick, asking Buildbucket for the build status
[02:02:43.331] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:43.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:96:0) after 1m0s
[02:03:43.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:96:0)
[02:03:43.369] Timer tick, asking Buildbucket for the build status
[02:03:43.545] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:43.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:97:0) after 1m0s
[02:04:43.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:97:0)
[02:04:43.583] Timer tick, asking Buildbucket for the build status
[02:04:43.790] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:43.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:98:0) after 1m0s
[02:05:43.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:98:0)
[02:05:43.817] Timer tick, asking Buildbucket for the build status
[02:05:44.110] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:44.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:99:0) after 1m0s
[02:06:44.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:99:0)
[02:06:44.116] Timer tick, asking Buildbucket for the build status
[02:06:44.289] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:100:0) after 1m0s
[02:07:44.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:100:0)
[02:07:44.359] Timer tick, asking Buildbucket for the build status
[02:07:44.525] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:44.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:101:0) after 1m0s
[02:08:44.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:101:0)
[02:08:44.562] Timer tick, asking Buildbucket for the build status
[02:08:44.793] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:44.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:102:0) after 1m0s
[02:09:45.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:102:0)
[02:09:45.003] Timer tick, asking Buildbucket for the build status
[02:09:45.266] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:45.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:103:0) after 1m0s
[02:10:45.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:103:0)
[02:10:45.428] Timer tick, asking Buildbucket for the build status
[02:10:45.652] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:45.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:104:0) after 1m0s
[02:11:45.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:104:0)
[02:11:45.745] Timer tick, asking Buildbucket for the build status
[02:11:46.147] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:46.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:105:0) after 1m0s
[02:12:46.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:105:0)
[02:12:46.319] Timer tick, asking Buildbucket for the build status
[02:12:46.665] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:46.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:106:0) after 1m0s
[02:13:46.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:106:0)
[02:13:46.930] Timer tick, asking Buildbucket for the build status
[02:13:49.455] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:49.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:107:0) after 1m0s
[02:14:49.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:107:0)
[02:14:49.536] Timer tick, asking Buildbucket for the build status
[02:14:49.703] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:49.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:108:0) after 1m0s
[02:15:49.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:108:0)
[02:15:49.826] Timer tick, asking Buildbucket for the build status
[02:15:50.306] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:50.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:109:0) after 1m0s
[02:16:50.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:109:0)
[02:16:50.411] Timer tick, asking Buildbucket for the build status
[02:16:50.911] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:50.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:110:0) after 1m0s
[02:17:50.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:110:0)
[02:17:50.997] Timer tick, asking Buildbucket for the build status
[02:17:51.226] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:111:0) after 1m0s
[02:18:51.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:111:0)
[02:18:51.261] Timer tick, asking Buildbucket for the build status
[02:18:51.534] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:51.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:112:0) after 1m0s
[02:19:51.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:112:0)
[02:19:51.604] Timer tick, asking Buildbucket for the build status
[02:19:51.858] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:51.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:113:0) after 1m0s
[02:20:51.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:113:0)
[02:20:51.972] Timer tick, asking Buildbucket for the build status
[02:20:52.736] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:52.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:114:0) after 1m0s
[02:21:52.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:114:0)
[02:21:52.820] Timer tick, asking Buildbucket for the build status
[02:21:52.979] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:52.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:115:0) after 1m0s
[02:22:53.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:115:0)
[02:22:53.013] Timer tick, asking Buildbucket for the build status
[02:22:53.238] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:53.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:116:0) after 1m0s
[02:23:53.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:116:0)
[02:23:53.348] Timer tick, asking Buildbucket for the build status
[02:23:53.523] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:53.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:117:0) after 1m0s
[02:24:53.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:117:0)
[02:24:53.638] Timer tick, asking Buildbucket for the build status
[02:24:53.807] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:53.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:118:0) after 1m0s
[02:25:53.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:118:0)
[02:25:53.928] Timer tick, asking Buildbucket for the build status
[02:25:57.124] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:57.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:119:0) after 1m0s
[02:26:57.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:119:0)
[02:26:57.160] Timer tick, asking Buildbucket for the build status
[02:26:57.637] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:120:0) after 1m0s
[02:27:57.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:120:0)
[02:27:57.672] Timer tick, asking Buildbucket for the build status
[02:27:57.860] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:57.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:121:0) after 1m0s
[02:28:57.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:121:0)
[02:28:57.937] Timer tick, asking Buildbucket for the build status
[02:28:58.356] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:58.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:122:0) after 1m0s
[02:29:58.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:122:0)
[02:29:58.416] Timer tick, asking Buildbucket for the build status
[02:29:58.964] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:58.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:123:0) after 1m0s
[02:30:58.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:123:0)
[02:30:58.984] Timer tick, asking Buildbucket for the build status
[02:30:59.478] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:59.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:124:0) after 1m0s
[02:31:59.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:124:0)
[02:31:59.487] Timer tick, asking Buildbucket for the build status
[02:31:59.663] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:59.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:125:0) after 1m0s
[02:32:59.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:125:0)
[02:32:59.740] Timer tick, asking Buildbucket for the build status
[02:33:01.797] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:01.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:126:0) after 1m0s
[02:34:01.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:126:0)
[02:34:01.831] Timer tick, asking Buildbucket for the build status
[02:34:02.054] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:02.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:127:0) after 1m0s
[02:35:02.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:127:0)
[02:35:02.096] Timer tick, asking Buildbucket for the build status
[02:35:02.328] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:02.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:128:0) after 1m0s
[02:36:02.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:128:0)
[02:36:02.387] Timer tick, asking Buildbucket for the build status
[02:36:03.108] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:03.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:129:0) after 1m0s
[02:37:03.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:129:0)
[02:37:03.145] Timer tick, asking Buildbucket for the build status
[02:37:03.712] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:03.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:130:0) after 1m0s
[02:38:03.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:130:0)
[02:38:03.810] Timer tick, asking Buildbucket for the build status
[02:38:04.002] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:04.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:131:0) after 1m0s
[02:39:04.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:131:0)
[02:39:04.034] Timer tick, asking Buildbucket for the build status
[02:39:04.445] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:04.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:132:0) after 1m0s
[02:40:04.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:132:0)
[02:40:04.523] Timer tick, asking Buildbucket for the build status
[02:40:04.952] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:04.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:133:0) after 1m0s
[02:41:04.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:133:0)
[02:41:04.991] Timer tick, asking Buildbucket for the build status
[02:41:06.565] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:06.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:134:0) after 1m0s
[02:42:06.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:134:0)
[02:42:06.581] Timer tick, asking Buildbucket for the build status
[02:42:07.896] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:07.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:135:0) after 1m0s
[02:43:08.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:135:0)
[02:43:08.186] Timer tick, asking Buildbucket for the build status
[02:43:08.392] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:136:0) after 1m0s
[02:44:08.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:136:0)
[02:44:08.476] Timer tick, asking Buildbucket for the build status
[02:44:08.956] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:08.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:137:0) after 1m0s
[02:45:09.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:137:0)
[02:45:09.004] Timer tick, asking Buildbucket for the build status
[02:45:11.046] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:11.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:138:0) after 1m0s
[02:46:11.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:138:0)
[02:46:11.610] Timer tick, asking Buildbucket for the build status
[02:46:12.311] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:12.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:139:0) after 1m0s
[02:47:12.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:139:0)
[02:47:12.419] Timer tick, asking Buildbucket for the build status
[02:47:12.637] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:12.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:140:0) after 1m0s
[02:48:12.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:140:0)
[02:48:12.709] Timer tick, asking Buildbucket for the build status
[02:48:13.083] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:141:0) after 1m0s
[02:49:13.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:141:0)
[02:49:13.120] Timer tick, asking Buildbucket for the build status
[02:49:13.425] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:13.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:142:0) after 1m0s
[02:50:13.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:142:0)
[02:50:13.435] Timer tick, asking Buildbucket for the build status
[02:50:14.168] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:143:0) after 1m0s
[02:51:14.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:143:0)
[02:51:14.258] Timer tick, asking Buildbucket for the build status
[02:51:14.419] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:14.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:144:0) after 1m0s
[02:52:14.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:144:0)
[02:52:14.461] Timer tick, asking Buildbucket for the build status
[02:52:15.518] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:15.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:145:0) after 1m0s
[02:53:15.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:145:0)
[02:53:15.755] Timer tick, asking Buildbucket for the build status
[02:53:15.972] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:15.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:146:0) after 1m0s
[02:54:16.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:146:0)
[02:54:16.124] Timer tick, asking Buildbucket for the build status
[02:54:16.415] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:147:0) after 1m0s
[02:55:16.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:147:0)
[02:55:16.474] Timer tick, asking Buildbucket for the build status
[02:55:16.958] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:148:0) after 1m0s
[02:56:17.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:148:0)
[02:56:17.014] Timer tick, asking Buildbucket for the build status
[02:56:17.654] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:17.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:149:0) after 1m0s
[02:57:17.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:149:0)
[02:57:17.728] Timer tick, asking Buildbucket for the build status
[02:57:17.931] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:17.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:150:0) after 1m0s
[02:58:17.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:150:0)
[02:58:17.985] Timer tick, asking Buildbucket for the build status
[02:58:18.156] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:18.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:151:0) after 1m0s
[02:59:18.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:151:0)
[02:59:18.233] Timer tick, asking Buildbucket for the build status
[02:59:18.716] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:18.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:152:0) after 1m0s
[03:00:18.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:152:0)
[03:00:18.836] Timer tick, asking Buildbucket for the build status
[03:00:19.456] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:19.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:153:0) after 1m0s
[03:01:19.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:153:0)
[03:01:19.563] Timer tick, asking Buildbucket for the build status
[03:01:19.753] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:19.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:154:0) after 1m0s
[03:02:19.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:154:0)
[03:02:19.858] Timer tick, asking Buildbucket for the build status
[03:02:20.113] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:20.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:155:0) after 1m0s
[03:03:20.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:155:0)
[03:03:20.192] Timer tick, asking Buildbucket for the build status
[03:03:20.895] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:20.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:156:0) after 1m0s
[03:04:20.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:156:0)
[03:04:20.944] Timer tick, asking Buildbucket for the build status
[03:04:21.838] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:21.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:157:0) after 1m0s
[03:05:21.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:157:0)
[03:05:21.936] Timer tick, asking Buildbucket for the build status
[03:05:22.155] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:158:0) after 1m0s
[03:06:22.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:158:0)
[03:06:22.190] Timer tick, asking Buildbucket for the build status
[03:06:22.823] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:22.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:159:0) after 1m0s
[03:07:22.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:159:0)
[03:07:22.885] Timer tick, asking Buildbucket for the build status
[03:07:23.190] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:23.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:160:0) after 1m0s
[03:08:23.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:160:0)
[03:08:23.260] Timer tick, asking Buildbucket for the build status
[03:08:23.415] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:23.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:161:0) after 1m0s
[03:09:23.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:161:0)
[03:09:23.476] Timer tick, asking Buildbucket for the build status
[03:09:24.614] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:24.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:162:0) after 1m0s
[03:10:24.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:162:0)
[03:10:24.662] Timer tick, asking Buildbucket for the build status
[03:10:24.933] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:24.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:163:0) after 1m0s
[03:11:25.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:163:0)
[03:11:25.042] Timer tick, asking Buildbucket for the build status
[03:11:25.294] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:25.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:164:0) after 1m0s
[03:12:25.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:164:0)
[03:12:25.372] Timer tick, asking Buildbucket for the build status
[03:12:26.227] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:26.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:165:0) after 1m0s
[03:13:26.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:165:0)
[03:13:26.339] Timer tick, asking Buildbucket for the build status
[03:13:26.770] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:26.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:166:0) after 1m0s
[03:14:26.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:166:0)
[03:14:26.811] Timer tick, asking Buildbucket for the build status
[03:14:26.986] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:167:0) after 1m0s
[03:15:27.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:167:0)
[03:15:27.100] Timer tick, asking Buildbucket for the build status
[03:15:28.164] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:28.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:168:0) after 1m0s
[03:16:28.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:168:0)
[03:16:28.256] Timer tick, asking Buildbucket for the build status
[03:16:28.434] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:28.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:169:0) after 1m0s
[03:17:28.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:169:0)
[03:17:28.477] Timer tick, asking Buildbucket for the build status
[03:17:28.726] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:28.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:170:0) after 1m0s
[03:18:28.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:170:0)
[03:18:28.805] Timer tick, asking Buildbucket for the build status
[03:18:29.346] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:29.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:171:0) after 1m0s
[03:19:29.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:171:0)
[03:19:29.406] Timer tick, asking Buildbucket for the build status
[03:19:29.652] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:172:0) after 1m0s
[03:20:29.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:172:0)
[03:20:29.718] Timer tick, asking Buildbucket for the build status
[03:20:30.330] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:173:0) after 1m0s
[03:21:30.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:173:0)
[03:21:30.443] Timer tick, asking Buildbucket for the build status
[03:21:30.805] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:30.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:174:0) after 1m0s
[03:22:30.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:174:0)
[03:22:30.900] Timer tick, asking Buildbucket for the build status
[03:22:31.088] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:175:0) after 1m0s
[03:23:31.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:175:0)
[03:23:31.158] Timer tick, asking Buildbucket for the build status
[03:23:31.363] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:31.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:176:0) after 1m0s
[03:24:31.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:176:0)
[03:24:31.414] Timer tick, asking Buildbucket for the build status
[03:24:33.007] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:33.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:177:0) after 1m0s
[03:25:33.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:177:0)
[03:25:33.038] Timer tick, asking Buildbucket for the build status
[03:25:33.305] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:33.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:178:0) after 1m0s
[03:26:33.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:178:0)
[03:26:33.342] Timer tick, asking Buildbucket for the build status
[03:26:33.720] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:33.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:179:0) after 1m0s
[03:27:33.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:179:0)
[03:27:33.756] Timer tick, asking Buildbucket for the build status
[03:27:33.892] Build 8902113443410943168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:33.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067543507131648896:180:0) after 1m0s
[03:27:45.591] Received PubSub notification, asking Buildbucket for the build status
[03:27:45.753] Build 8902113443410943168: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:27:45.753] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568690864508193",
"created_by": "project:chromium",
"created_ts": "1568680069492111",
"id": "8902113443410943168",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd43bf7dd29611e8704ce06f9269037b06acedf8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-y5mg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14737, \"got_angle_revision\": \"b5560486ad224ec6de8a54e2f2a7e638bed17fe1\", \"got_dawn_revision\": \"785ec66b66a3577e4f17306a10ab30b7f92c49ae\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"fd43bf7dd29611e8704ce06f9269037b06acedf8\", \"got_revision_cp\": \"refs/heads/master@{#697016}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7720ac9d21ceeaa24715da66d11c0437010fbdee\", \"got_v8_revision_cp\": \"refs/heads/7.9.50@{#1}\", \"got_webrtc_revision\": \"3d1647412c08f589b03aed641a3cca5f0b05555d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29200}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd43bf7dd29611e8704ce06f9269037b06acedf8\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-y5mg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4436-e523514\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1568680085430735",
"status": "COMPLETED",
"status_changed_ts": "1568690864887749",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14737",
"builder:Windows deterministic",
"buildset:commit/git/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd43bf7dd29611e8704ce06f9269037b06acedf8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067543507131648896",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8902113443410943168/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:47556ff777a62010",
"user_agent:luci-scheduler"
],
"updated_ts": "1568690864928977",
"url": "https://ci.chromium.org/b/8902113443410943168",
"utcnow_ts": "1568690865739404"
}
}
[03:27:45.753] Invocation finished in 2h59m59.193160738s with status SUCCEEDED