[23:31:24.153] New invocation is queued and will start shortly
[23:31:25.374] Starting the invocation (attempt 1)
[23:31:25.431] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:31:25.431] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:31:25.431] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070355559821075600",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ac8a0221dd0dcefbd11cbfb881b3024dd45a1737\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9070355559821075600",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"gitiles_ref:refs/heads/master"
]
}
[23:31:26.222] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565998285597783",
"id": "8904925497639677296",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ac8a0221dd0dcefbd11cbfb881b3024dd45a1737\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565998286008495",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14442",
"builder:Windows deterministic",
"buildset:commit/git/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070355559821075600",
"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/8904925497639677296/+/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": "1565998286008725",
"url": "https://ci.chromium.org/b/8904925497639677296",
"utcnow_ts": "1565998286206997"
}
}
[23:31:26.222] Task URL: https://ci.chromium.org/b/8904925497639677296
[23:31:26.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:2:0) after 1m0s
[23:31:30.137] Received PubSub notification, asking Buildbucket for the build status
[23:31:30.711] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:26.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:2:0)
[23:32:26.305] Timer tick, asking Buildbucket for the build status
[23:32:27.654] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:27.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:4:0) after 1m0s
[23:33:27.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:4:0)
[23:33:27.719] Timer tick, asking Buildbucket for the build status
[23:33:27.870] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:27.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:5:0) after 1m0s
[23:34:27.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:5:0)
[23:34:27.948] Timer tick, asking Buildbucket for the build status
[23:34:28.805] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:28.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:6:0) after 1m0s
[23:35:28.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:6:0)
[23:35:28.896] Timer tick, asking Buildbucket for the build status
[23:35:29.245] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:29.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:7:0) after 1m0s
[23:36:29.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:7:0)
[23:36:29.276] Timer tick, asking Buildbucket for the build status
[23:36:29.631] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:29.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:8:0) after 1m0s
[23:37:29.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:8:0)
[23:37:29.658] Timer tick, asking Buildbucket for the build status
[23:37:29.869] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:29.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:9:0) after 1m0s
[23:38:29.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:9:0)
[23:38:29.897] Timer tick, asking Buildbucket for the build status
[23:38:30.299] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:30.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:10:0) after 1m0s
[23:39:30.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:10:0)
[23:39:30.332] Timer tick, asking Buildbucket for the build status
[23:39:30.506] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:30.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:11:0) after 1m0s
[23:40:30.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:11:0)
[23:40:30.535] Timer tick, asking Buildbucket for the build status
[23:40:30.837] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:30.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:12:0) after 1m0s
[23:41:30.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:12:0)
[23:41:30.893] Timer tick, asking Buildbucket for the build status
[23:41:31.067] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:31.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:13:0) after 1m0s
[23:42:31.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:13:0)
[23:42:31.096] Timer tick, asking Buildbucket for the build status
[23:42:31.635] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:31.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:14:0) after 1m0s
[23:43:31.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:14:0)
[23:43:31.665] Timer tick, asking Buildbucket for the build status
[23:43:32.891] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:32.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:15:0) after 1m0s
[23:44:32.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:15:0)
[23:44:32.951] Timer tick, asking Buildbucket for the build status
[23:44:33.652] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:33.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:16:0) after 1m0s
[23:45:33.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:16:0)
[23:45:33.797] Timer tick, asking Buildbucket for the build status
[23:45:33.994] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:17:0) after 1m0s
[23:46:34.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:17:0)
[23:46:34.070] Timer tick, asking Buildbucket for the build status
[23:46:34.227] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:34.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:18:0) after 1m0s
[23:47:34.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:18:0)
[23:47:34.260] Timer tick, asking Buildbucket for the build status
[23:47:34.386] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:34.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:19:0) after 1m0s
[23:48:34.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:19:0)
[23:48:34.444] Timer tick, asking Buildbucket for the build status
[23:48:34.618] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:34.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:20:0) after 1m0s
[23:49:34.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:20:0)
[23:49:34.908] Timer tick, asking Buildbucket for the build status
[23:49:37.568] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:37.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:21:0) after 1m0s
[23:50:37.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:21:0)
[23:50:37.649] Timer tick, asking Buildbucket for the build status
[23:50:38.212] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:38.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:22:0) after 1m0s
[23:51:38.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:22:0)
[23:51:38.270] Timer tick, asking Buildbucket for the build status
[23:51:38.399] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:38.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:23:0) after 1m0s
[23:52:38.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:23:0)
[23:52:38.606] Timer tick, asking Buildbucket for the build status
[23:52:39.193] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:39.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:24:0) after 1m0s
[23:53:39.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:24:0)
[23:53:39.201] Timer tick, asking Buildbucket for the build status
[23:53:39.362] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:39.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:25:0) after 1m0s
[23:54:39.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:25:0)
[23:54:39.421] Timer tick, asking Buildbucket for the build status
[23:54:39.646] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:39.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:26:0) after 1m0s
[23:55:39.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:26:0)
[23:55:39.688] Timer tick, asking Buildbucket for the build status
[23:55:39.908] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:39.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:27:0) after 1m0s
[23:56:40.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:27:0)
[23:56:40.048] Timer tick, asking Buildbucket for the build status
[23:56:40.736] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:40.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:28:0) after 1m0s
[23:57:40.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:28:0)
[23:57:40.827] Timer tick, asking Buildbucket for the build status
[23:57:41.130] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:41.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:29:0) after 1m0s
[23:58:41.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:29:0)
[23:58:41.189] Timer tick, asking Buildbucket for the build status
[23:58:41.387] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:41.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:30:0) after 1m0s
[23:59:41.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:30:0)
[23:59:41.472] Timer tick, asking Buildbucket for the build status
[23:59:41.813] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:41.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:31:0) after 1m0s
[00:00:42.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:31:0)
[00:00:42.023] Timer tick, asking Buildbucket for the build status
[00:00:42.271] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:42.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:32:0) after 1m0s
[00:01:42.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:32:0)
[00:01:42.372] Timer tick, asking Buildbucket for the build status
[00:01:42.976] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:42.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:33:0) after 1m0s
[00:02:43.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:33:0)
[00:02:43.092] Timer tick, asking Buildbucket for the build status
[00:02:45.277] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:45.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:34:0) after 1m0s
[00:03:45.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:34:0)
[00:03:45.386] Timer tick, asking Buildbucket for the build status
[00:03:45.745] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:45.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:35:0) after 1m0s
[00:04:45.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:35:0)
[00:04:45.832] Timer tick, asking Buildbucket for the build status
[00:04:46.087] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:36:0) after 1m0s
[00:05:46.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:36:0)
[00:05:46.140] Timer tick, asking Buildbucket for the build status
[00:05:46.299] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:46.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:37:0) after 1m0s
[00:06:46.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:37:0)
[00:06:46.480] Timer tick, asking Buildbucket for the build status
[00:06:46.713] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:38:0) after 1m0s
[00:07:46.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:38:0)
[00:07:46.839] Timer tick, asking Buildbucket for the build status
[00:07:48.841] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:48.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:39:0) after 1m0s
[00:08:48.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:39:0)
[00:08:48.897] Timer tick, asking Buildbucket for the build status
[00:08:49.513] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:49.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:40:0) after 1m0s
[00:09:49.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:40:0)
[00:09:49.658] Timer tick, asking Buildbucket for the build status
[00:09:49.787] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:41:0) after 1m0s
[00:10:49.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:41:0)
[00:10:49.926] Timer tick, asking Buildbucket for the build status
[00:10:50.436] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:50.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:42:0) after 1m0s
[00:11:50.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:42:0)
[00:11:50.554] Timer tick, asking Buildbucket for the build status
[00:11:52.200] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:52.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:43:0) after 1m0s
[00:12:52.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:43:0)
[00:12:52.284] Timer tick, asking Buildbucket for the build status
[00:12:52.683] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:52.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:44:0) after 1m0s
[00:13:52.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:44:0)
[00:13:52.737] Timer tick, asking Buildbucket for the build status
[00:13:52.934] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:52.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:45:0) after 1m0s
[00:14:53.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:45:0)
[00:14:53.074] Timer tick, asking Buildbucket for the build status
[00:14:53.851] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:53.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:46:0) after 1m0s
[00:15:53.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:46:0)
[00:15:53.933] Timer tick, asking Buildbucket for the build status
[00:15:54.316] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:54.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:47:0) after 1m0s
[00:16:54.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:47:0)
[00:16:54.505] Timer tick, asking Buildbucket for the build status
[00:16:54.680] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:54.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:48:0) after 1m0s
[00:17:54.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:48:0)
[00:17:54.833] Timer tick, asking Buildbucket for the build status
[00:17:55.836] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:55.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:49:0) after 1m0s
[00:18:56.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:49:0)
[00:18:56.007] Timer tick, asking Buildbucket for the build status
[00:18:56.235] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:56.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:50:0) after 1m0s
[00:19:56.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:50:0)
[00:19:56.259] Timer tick, asking Buildbucket for the build status
[00:19:57.719] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:57.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:51:0) after 1m0s
[00:20:57.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:51:0)
[00:20:57.812] Timer tick, asking Buildbucket for the build status
[00:20:58.038] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:58.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:52:0) after 1m0s
[00:21:58.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:52:0)
[00:21:58.075] Timer tick, asking Buildbucket for the build status
[00:21:58.407] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:58.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:53:0) after 1m0s
[00:22:58.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:53:0)
[00:22:58.542] Timer tick, asking Buildbucket for the build status
[00:22:58.794] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:58.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:54:0) after 1m0s
[00:23:58.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:54:0)
[00:23:58.878] Timer tick, asking Buildbucket for the build status
[00:23:59.059] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:59.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:55:0) after 1m0s
[00:24:59.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:55:0)
[00:24:59.145] Timer tick, asking Buildbucket for the build status
[00:24:59.999] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:59.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:56:0) after 1m0s
[00:26:00.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:56:0)
[00:26:00.046] Timer tick, asking Buildbucket for the build status
[00:26:00.460] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:00.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:57:0) after 1m0s
[00:27:00.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:57:0)
[00:27:00.553] Timer tick, asking Buildbucket for the build status
[00:27:00.749] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:00.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:58:0) after 1m0s
[00:28:00.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:58:0)
[00:28:00.872] Timer tick, asking Buildbucket for the build status
[00:28:01.186] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:01.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:59:0) after 1m0s
[00:29:01.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:59:0)
[00:29:01.273] Timer tick, asking Buildbucket for the build status
[00:29:01.447] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:01.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:60:0) after 1m0s
[00:30:01.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:60:0)
[00:30:01.523] Timer tick, asking Buildbucket for the build status
[00:30:01.874] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:01.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:61:0) after 1m0s
[00:31:01.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:61:0)
[00:31:01.959] Timer tick, asking Buildbucket for the build status
[00:31:02.373] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:02.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:62:0) after 1m0s
[00:32:02.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:62:0)
[00:32:02.443] Timer tick, asking Buildbucket for the build status
[00:32:03.153] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:03.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:63:0) after 1m0s
[00:33:03.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:63:0)
[00:33:03.265] Timer tick, asking Buildbucket for the build status
[00:33:03.736] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:03.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:64:0) after 1m0s
[00:34:03.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:64:0)
[00:34:03.796] Timer tick, asking Buildbucket for the build status
[00:34:06.208] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:06.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:65:0) after 1m0s
[00:35:06.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:65:0)
[00:35:06.336] Timer tick, asking Buildbucket for the build status
[00:35:06.655] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:06.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:66:0) after 1m0s
[00:36:06.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:66:0)
[00:36:06.724] Timer tick, asking Buildbucket for the build status
[00:36:07.040] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:07.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:67:0) after 1m0s
[00:37:07.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:67:0)
[00:37:07.125] Timer tick, asking Buildbucket for the build status
[00:37:07.352] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:07.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:68:0) after 1m0s
[00:38:07.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:68:0)
[00:38:07.430] Timer tick, asking Buildbucket for the build status
[00:38:08.270] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:08.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:69:0) after 1m0s
[00:39:08.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:69:0)
[00:39:08.299] Timer tick, asking Buildbucket for the build status
[00:39:08.493] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:70:0) after 1m0s
[00:40:08.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:70:0)
[00:40:08.757] Timer tick, asking Buildbucket for the build status
[00:40:08.918] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:08.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:71:0) after 1m0s
[00:41:09.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:71:0)
[00:41:09.067] Timer tick, asking Buildbucket for the build status
[00:41:09.356] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:09.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:72:0) after 1m0s
[00:42:09.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:72:0)
[00:42:09.471] Timer tick, asking Buildbucket for the build status
[00:42:10.043] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:10.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:73:0) after 1m0s
[00:43:10.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:73:0)
[00:43:10.181] Timer tick, asking Buildbucket for the build status
[00:43:10.453] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:10.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:74:0) after 1m0s
[00:44:10.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:74:0)
[00:44:10.498] Timer tick, asking Buildbucket for the build status
[00:44:10.660] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:10.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:75:0) after 1m0s
[00:45:10.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:75:0)
[00:45:10.719] Timer tick, asking Buildbucket for the build status
[00:45:11.112] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:11.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:76:0) after 1m0s
[00:46:11.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:76:0)
[00:46:11.135] Timer tick, asking Buildbucket for the build status
[00:46:12.103] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:12.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:77:0) after 1m0s
[00:47:12.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:77:0)
[00:47:12.343] Timer tick, asking Buildbucket for the build status
[00:47:12.976] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:12.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:78:0) after 1m0s
[00:48:13.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:78:0)
[00:48:13.108] Timer tick, asking Buildbucket for the build status
[00:48:13.679] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:13.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:79:0) after 1m0s
[00:49:13.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:79:0)
[00:49:13.700] Timer tick, asking Buildbucket for the build status
[00:49:13.905] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:13.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:80:0) after 1m0s
[00:50:14.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:80:0)
[00:50:14.036] Timer tick, asking Buildbucket for the build status
[00:50:14.399] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:14.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:81:0) after 1m0s
[00:51:14.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:81:0)
[00:51:14.454] Timer tick, asking Buildbucket for the build status
[00:51:14.981] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:14.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:82:0) after 1m0s
[00:52:15.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:82:0)
[00:52:15.011] Timer tick, asking Buildbucket for the build status
[00:52:15.360] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:15.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:83:0) after 1m0s
[00:53:15.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:83:0)
[00:53:15.422] Timer tick, asking Buildbucket for the build status
[00:53:15.962] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:15.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:84:0) after 1m0s
[00:54:16.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:84:0)
[00:54:16.022] Timer tick, asking Buildbucket for the build status
[00:54:16.552] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:16.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:85:0) after 1m0s
[00:55:16.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:85:0)
[00:55:16.625] Timer tick, asking Buildbucket for the build status
[00:55:17.106] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:17.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:86:0) after 1m0s
[00:56:17.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:86:0)
[00:56:17.140] Timer tick, asking Buildbucket for the build status
[00:56:17.304] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:17.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:87:0) after 1m0s
[00:57:17.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:87:0)
[00:57:17.391] Timer tick, asking Buildbucket for the build status
[00:57:17.555] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:17.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:88:0) after 1m0s
[00:58:17.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:88:0)
[00:58:17.584] Timer tick, asking Buildbucket for the build status
[00:58:18.013] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:18.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:89:0) after 1m0s
[00:59:18.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:89:0)
[00:59:18.140] Timer tick, asking Buildbucket for the build status
[00:59:18.542] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:18.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:90:0) after 1m0s
[01:00:18.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:90:0)
[01:00:18.594] Timer tick, asking Buildbucket for the build status
[01:00:20.092] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:20.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:91:0) after 1m0s
[01:01:20.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:91:0)
[01:01:20.261] Timer tick, asking Buildbucket for the build status
[01:01:20.673] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:20.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:92:0) after 1m0s
[01:02:20.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:92:0)
[01:02:20.785] Timer tick, asking Buildbucket for the build status
[01:02:21.146] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:21.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:93:0) after 1m0s
[01:03:21.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:93:0)
[01:03:21.185] Timer tick, asking Buildbucket for the build status
[01:03:21.411] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:21.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:94:0) after 1m0s
[01:04:21.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:94:0)
[01:04:21.447] Timer tick, asking Buildbucket for the build status
[01:04:21.989] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:21.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:95:0) after 1m0s
[01:05:22.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:95:0)
[01:05:22.048] Timer tick, asking Buildbucket for the build status
[01:05:22.793] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:22.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:96:0) after 1m0s
[01:06:22.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:96:0)
[01:06:22.874] Timer tick, asking Buildbucket for the build status
[01:06:23.173] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:23.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:97:0) after 1m0s
[01:07:23.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:97:0)
[01:07:23.206] Timer tick, asking Buildbucket for the build status
[01:07:23.546] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:23.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:98:0) after 1m0s
[01:08:23.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:98:0)
[01:08:23.582] Timer tick, asking Buildbucket for the build status
[01:08:24.154] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:24.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:99:0) after 1m0s
[01:09:24.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:99:0)
[01:09:24.276] Timer tick, asking Buildbucket for the build status
[01:09:24.800] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:100:0) after 1m0s
[01:10:24.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:100:0)
[01:10:24.950] Timer tick, asking Buildbucket for the build status
[01:10:25.454] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:25.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:101:0) after 1m0s
[01:11:25.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:101:0)
[01:11:25.482] Timer tick, asking Buildbucket for the build status
[01:11:25.796] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:25.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:102:0) after 1m0s
[01:12:25.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:102:0)
[01:12:25.828] Timer tick, asking Buildbucket for the build status
[01:12:25.978] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:25.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:103:0) after 1m0s
[01:13:26.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:103:0)
[01:13:26.067] Timer tick, asking Buildbucket for the build status
[01:13:28.740] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:28.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:104:0) after 1m0s
[01:14:28.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:104:0)
[01:14:28.835] Timer tick, asking Buildbucket for the build status
[01:14:28.958] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:28.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:105:0) after 1m0s
[01:15:29.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:105:0)
[01:15:29.003] Timer tick, asking Buildbucket for the build status
[01:15:29.209] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:106:0) after 1m0s
[01:16:29.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:106:0)
[01:16:29.247] Timer tick, asking Buildbucket for the build status
[01:16:29.482] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:29.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:107:0) after 1m0s
[01:17:29.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:107:0)
[01:17:29.543] Timer tick, asking Buildbucket for the build status
[01:17:30.165] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:30.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:108:0) after 1m0s
[01:18:30.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:108:0)
[01:18:30.288] Timer tick, asking Buildbucket for the build status
[01:18:31.937] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:31.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:109:0) after 1m0s
[01:19:31.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:109:0)
[01:19:31.975] Timer tick, asking Buildbucket for the build status
[01:19:32.326] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:110:0) after 1m0s
[01:20:32.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:110:0)
[01:20:32.358] Timer tick, asking Buildbucket for the build status
[01:20:33.355] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:33.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:111:0) after 1m0s
[01:21:33.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:111:0)
[01:21:33.518] Timer tick, asking Buildbucket for the build status
[01:21:33.680] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:33.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:112:0) after 1m0s
[01:22:33.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:112:0)
[01:22:33.743] Timer tick, asking Buildbucket for the build status
[01:22:34.002] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:34.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:113:0) after 1m0s
[01:23:34.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:113:0)
[01:23:34.048] Timer tick, asking Buildbucket for the build status
[01:23:37.044] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:37.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:114:0) after 1m0s
[01:24:37.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:114:0)
[01:24:37.123] Timer tick, asking Buildbucket for the build status
[01:24:38.685] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:115:0) after 1m0s
[01:25:38.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:115:0)
[01:25:38.757] Timer tick, asking Buildbucket for the build status
[01:25:39.981] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:39.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:116:0) after 1m0s
[01:26:40.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:116:0)
[01:26:40.115] Timer tick, asking Buildbucket for the build status
[01:26:42.727] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:42.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:117:0) after 1m0s
[01:27:42.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:117:0)
[01:27:42.900] Timer tick, asking Buildbucket for the build status
[01:27:45.650] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:45.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:118:0) after 1m0s
[01:28:45.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:118:0)
[01:28:45.727] Timer tick, asking Buildbucket for the build status
[01:28:47.325] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:47.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:119:0) after 1m0s
[01:29:47.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:119:0)
[01:29:47.363] Timer tick, asking Buildbucket for the build status
[01:29:47.645] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:47.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:120:0) after 1m0s
[01:30:47.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:120:0)
[01:30:47.930] Timer tick, asking Buildbucket for the build status
[01:30:50.899] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:50.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:121:0) after 1m0s
[01:31:50.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:121:0)
[01:31:50.951] Timer tick, asking Buildbucket for the build status
[01:31:52.854] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:52.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:122:0) after 1m0s
[01:32:52.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:122:0)
[01:32:52.894] Timer tick, asking Buildbucket for the build status
[01:32:54.270] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:123:0) after 1m0s
[01:33:54.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:123:0)
[01:33:54.336] Timer tick, asking Buildbucket for the build status
[01:33:54.854] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:54.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:124:0) after 1m0s
[01:34:54.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:124:0)
[01:34:54.900] Timer tick, asking Buildbucket for the build status
[01:34:55.563] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:125:0) after 1m0s
[01:35:55.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:125:0)
[01:35:55.588] Timer tick, asking Buildbucket for the build status
[01:35:55.809] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:126:0) after 1m0s
[01:36:55.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:126:0)
[01:36:55.849] Timer tick, asking Buildbucket for the build status
[01:36:56.331] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:56.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:127:0) after 1m0s
[01:37:56.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:127:0)
[01:37:56.430] Timer tick, asking Buildbucket for the build status
[01:37:58.281] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:58.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:128:0) after 1m0s
[01:38:58.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:128:0)
[01:38:58.313] Timer tick, asking Buildbucket for the build status
[01:38:59.330] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:59.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:129:0) after 1m0s
[01:39:59.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:129:0)
[01:39:59.359] Timer tick, asking Buildbucket for the build status
[01:40:01.317] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:01.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:130:0) after 1m0s
[01:41:01.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:130:0)
[01:41:01.323] Timer tick, asking Buildbucket for the build status
[01:41:01.568] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:01.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:131:0) after 1m0s
[01:42:01.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:131:0)
[01:42:01.598] Timer tick, asking Buildbucket for the build status
[01:42:02.350] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:02.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:132:0) after 1m0s
[01:43:02.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:132:0)
[01:43:02.404] Timer tick, asking Buildbucket for the build status
[01:43:03.825] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:03.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:133:0) after 1m0s
[01:44:03.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:133:0)
[01:44:03.856] Timer tick, asking Buildbucket for the build status
[01:44:04.146] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:04.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:134:0) after 1m0s
[01:45:04.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:134:0)
[01:45:04.406] Timer tick, asking Buildbucket for the build status
[01:45:04.837] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:04.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:135:0) after 1m0s
[01:46:04.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:135:0)
[01:46:04.868] Timer tick, asking Buildbucket for the build status
[01:46:05.185] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:05.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:136:0) after 1m0s
[01:47:05.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:136:0)
[01:47:05.236] Timer tick, asking Buildbucket for the build status
[01:47:05.407] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:05.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:137:0) after 1m0s
[01:48:05.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:137:0)
[01:48:05.482] Timer tick, asking Buildbucket for the build status
[01:48:05.806] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:05.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:138:0) after 1m0s
[01:49:05.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:138:0)
[01:49:05.874] Timer tick, asking Buildbucket for the build status
[01:49:06.102] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:06.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:139:0) after 1m0s
[01:50:06.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:139:0)
[01:50:06.142] Timer tick, asking Buildbucket for the build status
[01:50:06.357] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:140:0) after 1m0s
[01:51:06.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:140:0)
[01:51:06.487] Timer tick, asking Buildbucket for the build status
[01:51:06.728] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:141:0) after 1m0s
[01:52:06.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:141:0)
[01:52:06.829] Timer tick, asking Buildbucket for the build status
[01:52:07.024] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:07.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:142:0) after 1m0s
[01:53:07.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:142:0)
[01:53:07.112] Timer tick, asking Buildbucket for the build status
[01:53:07.619] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:07.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:143:0) after 1m0s
[01:54:07.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:143:0)
[01:54:07.655] Timer tick, asking Buildbucket for the build status
[01:54:08.222] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:144:0) after 1m0s
[01:55:08.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:144:0)
[01:55:08.367] Timer tick, asking Buildbucket for the build status
[01:55:08.611] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:145:0) after 1m0s
[01:56:08.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:145:0)
[01:56:08.650] Timer tick, asking Buildbucket for the build status
[01:56:09.496] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:09.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:146:0) after 1m0s
[01:57:09.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:146:0)
[01:57:09.546] Timer tick, asking Buildbucket for the build status
[01:57:10.747] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:10.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:147:0) after 1m0s
[01:58:10.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:147:0)
[01:58:10.787] Timer tick, asking Buildbucket for the build status
[01:58:11.216] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:11.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:148:0) after 1m0s
[01:59:11.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:148:0)
[01:59:11.282] Timer tick, asking Buildbucket for the build status
[01:59:12.115] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:12.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:149:0) after 1m0s
[02:00:12.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:149:0)
[02:00:12.204] Timer tick, asking Buildbucket for the build status
[02:00:13.515] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:13.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:150:0) after 1m0s
[02:01:13.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:150:0)
[02:01:13.629] Timer tick, asking Buildbucket for the build status
[02:01:14.113] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:14.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:151:0) after 1m0s
[02:02:14.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:151:0)
[02:02:14.207] Timer tick, asking Buildbucket for the build status
[02:02:14.427] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:14.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:152:0) after 1m0s
[02:03:14.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:152:0)
[02:03:14.516] Timer tick, asking Buildbucket for the build status
[02:03:14.655] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:14.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:153:0) after 1m0s
[02:04:14.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:153:0)
[02:04:14.780] Timer tick, asking Buildbucket for the build status
[02:04:15.443] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:15.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:154:0) after 1m0s
[02:05:15.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:154:0)
[02:05:15.429] Timer tick, asking Buildbucket for the build status
[02:05:15.575] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:155:0) after 1m0s
[02:06:15.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:155:0)
[02:06:15.695] Timer tick, asking Buildbucket for the build status
[02:06:15.964] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:15.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:156:0) after 1m0s
[02:07:16.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:156:0)
[02:07:16.045] Timer tick, asking Buildbucket for the build status
[02:07:17.214] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:17.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:157:0) after 1m0s
[02:08:17.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:157:0)
[02:08:17.308] Timer tick, asking Buildbucket for the build status
[02:08:17.580] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:17.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:158:0) after 1m0s
[02:09:17.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:158:0)
[02:09:17.674] Timer tick, asking Buildbucket for the build status
[02:09:17.895] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:17.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:159:0) after 1m0s
[02:10:17.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:159:0)
[02:10:17.972] Timer tick, asking Buildbucket for the build status
[02:10:18.299] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:18.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:160:0) after 1m0s
[02:11:18.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:160:0)
[02:11:18.339] Timer tick, asking Buildbucket for the build status
[02:11:18.612] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:18.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:161:0) after 1m0s
[02:12:18.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:161:0)
[02:12:18.663] Timer tick, asking Buildbucket for the build status
[02:12:18.995] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:18.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:162:0) after 1m0s
[02:13:19.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:162:0)
[02:13:19.064] Timer tick, asking Buildbucket for the build status
[02:13:22.497] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:22.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:163:0) after 1m0s
[02:14:22.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:163:0)
[02:14:22.609] Timer tick, asking Buildbucket for the build status
[02:14:22.814] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:22.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:164:0) after 1m0s
[02:15:22.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:164:0)
[02:15:22.916] Timer tick, asking Buildbucket for the build status
[02:15:23.098] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:23.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:165:0) after 1m0s
[02:16:23.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:165:0)
[02:16:23.192] Timer tick, asking Buildbucket for the build status
[02:16:23.374] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:23.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:166:0) after 1m0s
[02:17:23.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:166:0)
[02:17:23.376] Timer tick, asking Buildbucket for the build status
[02:17:23.900] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:23.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:167:0) after 1m0s
[02:18:23.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:167:0)
[02:18:23.976] Timer tick, asking Buildbucket for the build status
[02:18:24.529] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:24.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:168:0) after 1m0s
[02:19:24.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:168:0)
[02:19:24.597] Timer tick, asking Buildbucket for the build status
[02:19:25.014] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:25.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:169:0) after 1m0s
[02:20:25.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:169:0)
[02:20:25.199] Timer tick, asking Buildbucket for the build status
[02:20:25.351] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:25.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:170:0) after 1m0s
[02:21:25.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:170:0)
[02:21:25.523] Timer tick, asking Buildbucket for the build status
[02:21:25.828] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:25.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:171:0) after 1m0s
[02:22:25.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:171:0)
[02:22:25.852] Timer tick, asking Buildbucket for the build status
[02:22:26.024] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:26.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:172:0) after 1m0s
[02:23:26.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:172:0)
[02:23:26.336] Timer tick, asking Buildbucket for the build status
[02:23:28.518] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:28.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:173:0) after 1m0s
[02:24:28.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:173:0)
[02:24:28.581] Timer tick, asking Buildbucket for the build status
[02:24:29.629] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:29.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:174:0) after 1m0s
[02:25:29.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:174:0)
[02:25:29.678] Timer tick, asking Buildbucket for the build status
[02:25:30.127] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:30.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:175:0) after 1m0s
[02:26:30.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:175:0)
[02:26:30.171] Timer tick, asking Buildbucket for the build status
[02:26:30.883] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:30.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:176:0) after 1m0s
[02:27:30.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:176:0)
[02:27:30.954] Timer tick, asking Buildbucket for the build status
[02:27:32.983] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:32.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:177:0) after 1m0s
[02:28:33.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:177:0)
[02:28:33.085] Timer tick, asking Buildbucket for the build status
[02:28:33.881] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:33.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:178:0) after 1m0s
[02:29:33.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:178:0)
[02:29:33.920] Timer tick, asking Buildbucket for the build status
[02:29:34.840] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:34.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:179:0) after 1m0s
[02:30:35.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:179:0)
[02:30:35.077] Timer tick, asking Buildbucket for the build status
[02:30:35.214] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:35.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:180:0) after 1m0s
[02:31:35.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:180:0)
[02:31:35.251] Timer tick, asking Buildbucket for the build status
[02:31:36.048] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:36.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:181:0) after 1m0s
[02:32:36.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:181:0)
[02:32:36.332] Timer tick, asking Buildbucket for the build status
[02:32:36.612] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:36.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:182:0) after 1m0s
[02:33:36.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:182:0)
[02:33:36.696] Timer tick, asking Buildbucket for the build status
[02:33:38.358] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:38.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:183:0) after 1m0s
[02:34:38.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:183:0)
[02:34:38.527] Timer tick, asking Buildbucket for the build status
[02:34:38.870] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:38.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:184:0) after 1m0s
[02:35:38.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:184:0)
[02:35:38.943] Timer tick, asking Buildbucket for the build status
[02:35:39.514] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:39.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:185:0) after 1m0s
[02:36:39.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:185:0)
[02:36:39.608] Timer tick, asking Buildbucket for the build status
[02:36:40.006] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:186:0) after 1m0s
[02:37:40.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:186:0)
[02:37:40.109] Timer tick, asking Buildbucket for the build status
[02:37:40.328] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:187:0) after 1m0s
[02:38:40.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:187:0)
[02:38:40.365] Timer tick, asking Buildbucket for the build status
[02:38:40.524] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:188:0) after 1m0s
[02:39:40.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:188:0)
[02:39:40.570] Timer tick, asking Buildbucket for the build status
[02:39:40.722] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:40.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:189:0) after 1m0s
[02:40:40.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:189:0)
[02:40:40.880] Timer tick, asking Buildbucket for the build status
[02:40:41.578] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:190:0) after 1m0s
[02:41:41.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:190:0)
[02:41:41.649] Timer tick, asking Buildbucket for the build status
[02:41:42.637] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:42.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:191:0) after 1m0s
[02:42:42.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:191:0)
[02:42:42.670] Timer tick, asking Buildbucket for the build status
[02:42:43.338] Build 8904925497639677296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070355559821075600:192:0) after 1m0s
[02:42:47.394] Received PubSub notification, asking Buildbucket for the build status
[02:42:47.512] Build 8904925497639677296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:42:47.512] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566009766398798",
"created_by": "project:chromium",
"created_ts": "1565998285597783",
"id": "8904925497639677296",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ac8a0221dd0dcefbd11cbfb881b3024dd45a1737\"}}",
"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-q2vi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14442, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_dawn_revision\": \"786f76574a7face893b369e0dcca60b7bc9fd1a8\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"ac8a0221dd0dcefbd11cbfb881b3024dd45a1737\", \"got_revision_cp\": \"refs/heads/master@{#687878}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ac8a0221dd0dcefbd11cbfb881b3024dd45a1737\"}, \"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-q2vi\"], \"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\": [\"4397-8786906\"], \"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": "1565998288295292",
"status": "COMPLETED",
"status_changed_ts": "1566009766814175",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14442",
"builder:Windows deterministic",
"buildset:commit/git/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac8a0221dd0dcefbd11cbfb881b3024dd45a1737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070355559821075600",
"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/8904925497639677296/+/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:46b5970e8666f110",
"user_agent:luci-scheduler"
],
"updated_ts": "1566009766822384",
"url": "https://ci.chromium.org/b/8904925497639677296",
"utcnow_ts": "1566009767504940"
}
}
[02:42:47.512] Invocation finished in 3h11m23.377456364s with status SUCCEEDED