[19:32:44.172] New invocation is queued and will start shortly
[19:32:45.340] Starting the invocation (attempt 1)
[19:32:45.458] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:32:45.458] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:32:45.458] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062216848431800544",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ee438d7b3555a67c3372c8483207abef90b6dff8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9062216848431800544",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/ee438d7b3555a67c3372c8483207abef90b6dff8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ee438d7b3555a67c3372c8483207abef90b6dff8",
"gitiles_ref:refs/heads/master"
]
}
[19:32:47.333] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573759965926919",
"id": "8896786785927545056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ee438d7b3555a67c3372c8483207abef90b6dff8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573759966781833",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25692",
"builder:Deterministic Linux",
"buildset:commit/git/ee438d7b3555a67c3372c8483207abef90b6dff8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ee438d7b3555a67c3372c8483207abef90b6dff8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062216848431800544",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8896786785927545056/+/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": "1573759966782106",
"url": "https://ci.chromium.org/b/8896786785927545056",
"utcnow_ts": "1573759967317754"
}
}
[19:32:47.333] Task URL: https://ci.chromium.org/b/8896786785927545056
[19:32:47.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:2:0) after 1m0s
[19:33:47.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:2:0)
[19:33:47.375] Timer tick, asking Buildbucket for the build status
[19:33:47.764] Build 8896786785927545056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:47.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:3:0) after 1m0s
[19:34:48.039] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:3:0)
[19:34:48.039] Timer tick, asking Buildbucket for the build status
[19:34:48.369] Build 8896786785927545056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:48.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:4:0) after 1m0s
[19:35:48.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:4:0)
[19:35:48.926] Timer tick, asking Buildbucket for the build status
[19:35:49.171] Build 8896786785927545056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:49.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:5:0) after 1m0s
[19:36:13.843] Received PubSub notification, asking Buildbucket for the build status
[19:36:14.406] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:50.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:5:0)
[19:36:50.205] Timer tick, asking Buildbucket for the build status
[19:36:50.440] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:50.440] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:7:0) after 1m0s
[19:37:50.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:7:0)
[19:37:50.922] Timer tick, asking Buildbucket for the build status
[19:37:51.520] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:51.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:8:0) after 1m0s
[19:38:51.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:8:0)
[19:38:51.695] Timer tick, asking Buildbucket for the build status
[19:38:52.040] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:52.040] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:9:0) after 1m0s
[19:39:52.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:9:0)
[19:39:52.327] Timer tick, asking Buildbucket for the build status
[19:39:52.442] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:52.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:10:0) after 1m0s
[19:40:52.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:10:0)
[19:40:52.525] Timer tick, asking Buildbucket for the build status
[19:40:52.730] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:52.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:11:0) after 1m0s
[19:41:52.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:11:0)
[19:41:52.937] Timer tick, asking Buildbucket for the build status
[19:41:53.701] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:53.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:12:0) after 1m0s
[19:42:54.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:12:0)
[19:42:54.166] Timer tick, asking Buildbucket for the build status
[19:42:55.585] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:55.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:13:0) after 1m0s
[19:43:55.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:13:0)
[19:43:55.952] Timer tick, asking Buildbucket for the build status
[19:43:56.432] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:56.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:14:0) after 1m0s
[19:44:56.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:14:0)
[19:44:56.510] Timer tick, asking Buildbucket for the build status
[19:44:56.955] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:56.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:15:0) after 1m0s
[19:45:56.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:15:0)
[19:45:56.971] Timer tick, asking Buildbucket for the build status
[19:45:59.195] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:16:0) after 1m0s
[19:46:59.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:16:0)
[19:46:59.238] Timer tick, asking Buildbucket for the build status
[19:47:00.086] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:00.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:17:0) after 1m0s
[19:48:00.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:17:0)
[19:48:00.157] Timer tick, asking Buildbucket for the build status
[19:48:00.464] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:00.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:18:0) after 1m0s
[19:49:00.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:18:0)
[19:49:00.483] Timer tick, asking Buildbucket for the build status
[19:49:01.116] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:01.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:19:0) after 1m0s
[19:50:01.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:19:0)
[19:50:01.228] Timer tick, asking Buildbucket for the build status
[19:50:01.926] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:01.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:20:0) after 1m0s
[19:51:02.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:20:0)
[19:51:02.041] Timer tick, asking Buildbucket for the build status
[19:51:02.976] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:02.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:21:0) after 1m0s
[19:52:03.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:21:0)
[19:52:03.123] Timer tick, asking Buildbucket for the build status
[19:52:05.222] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:05.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:22:0) after 1m0s
[19:53:05.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:22:0)
[19:53:05.233] Timer tick, asking Buildbucket for the build status
[19:53:06.225] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:06.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:23:0) after 1m0s
[19:54:06.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:23:0)
[19:54:06.273] Timer tick, asking Buildbucket for the build status
[19:54:07.305] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:07.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:24:0) after 1m0s
[19:55:07.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:24:0)
[19:55:07.419] Timer tick, asking Buildbucket for the build status
[19:55:07.628] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:07.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:25:0) after 1m0s
[19:56:07.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:25:0)
[19:56:07.650] Timer tick, asking Buildbucket for the build status
[19:56:07.864] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:07.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:26:0) after 1m0s
[19:57:07.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:26:0)
[19:57:07.962] Timer tick, asking Buildbucket for the build status
[19:57:08.228] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:08.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:27:0) after 1m0s
[19:58:08.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:27:0)
[19:58:08.294] Timer tick, asking Buildbucket for the build status
[19:58:08.624] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:08.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:28:0) after 1m0s
[19:59:09.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:28:0)
[19:59:09.779] Timer tick, asking Buildbucket for the build status
[19:59:10.782] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:10.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:29:0) after 1m0s
[20:00:10.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:29:0)
[20:00:10.967] Timer tick, asking Buildbucket for the build status
[20:00:11.767] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:11.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:30:0) after 1m0s
[20:01:11.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:30:0)
[20:01:11.911] Timer tick, asking Buildbucket for the build status
[20:01:12.063] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:31:0) after 1m0s
[20:02:12.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:31:0)
[20:02:12.064] Timer tick, asking Buildbucket for the build status
[20:02:12.283] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:12.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:32:0) after 1m0s
[20:03:12.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:32:0)
[20:03:12.439] Timer tick, asking Buildbucket for the build status
[20:03:14.955] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:14.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:33:0) after 1m0s
[20:04:14.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:33:0)
[20:04:14.993] Timer tick, asking Buildbucket for the build status
[20:04:15.471] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:15.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:34:0) after 1m0s
[20:05:15.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:34:0)
[20:05:15.467] Timer tick, asking Buildbucket for the build status
[20:05:16.351] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:16.351] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:35:0) after 1m0s
[20:06:16.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:35:0)
[20:06:16.683] Timer tick, asking Buildbucket for the build status
[20:06:17.844] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:17.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:36:0) after 1m0s
[20:07:17.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:36:0)
[20:07:17.879] Timer tick, asking Buildbucket for the build status
[20:07:18.514] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:37:0) after 1m0s
[20:08:18.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:37:0)
[20:08:18.577] Timer tick, asking Buildbucket for the build status
[20:08:18.788] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:38:0) after 1m0s
[20:09:18.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:38:0)
[20:09:18.931] Timer tick, asking Buildbucket for the build status
[20:09:21.590] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:21.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:39:0) after 1m0s
[20:10:21.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:39:0)
[20:10:21.609] Timer tick, asking Buildbucket for the build status
[20:10:22.523] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:22.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:40:0) after 1m0s
[20:11:22.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:40:0)
[20:11:22.578] Timer tick, asking Buildbucket for the build status
[20:11:22.789] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:22.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:41:0) after 1m0s
[20:12:23.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:41:0)
[20:12:23.146] Timer tick, asking Buildbucket for the build status
[20:12:23.665] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:23.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:42:0) after 1m0s
[20:13:23.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:42:0)
[20:13:23.717] Timer tick, asking Buildbucket for the build status
[20:13:23.844] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:23.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:43:0) after 1m0s
[20:14:24.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:43:0)
[20:14:24.181] Timer tick, asking Buildbucket for the build status
[20:14:24.385] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:24.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:44:0) after 1m0s
[20:15:24.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:44:0)
[20:15:24.935] Timer tick, asking Buildbucket for the build status
[20:15:25.096] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:25.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:45:0) after 1m0s
[20:16:25.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:45:0)
[20:16:25.309] Timer tick, asking Buildbucket for the build status
[20:16:25.804] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:25.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:46:0) after 1m0s
[20:17:26.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:46:0)
[20:17:26.452] Timer tick, asking Buildbucket for the build status
[20:17:26.673] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:26.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:47:0) after 1m0s
[20:18:26.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:47:0)
[20:18:26.856] Timer tick, asking Buildbucket for the build status
[20:18:27.068] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:27.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:48:0) after 1m0s
[20:19:27.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:48:0)
[20:19:27.286] Timer tick, asking Buildbucket for the build status
[20:19:28.813] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:28.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:49:0) after 1m0s
[20:20:28.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:49:0)
[20:20:28.886] Timer tick, asking Buildbucket for the build status
[20:20:31.225] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:31.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:50:0) after 1m0s
[20:21:31.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:50:0)
[20:21:31.273] Timer tick, asking Buildbucket for the build status
[20:21:31.574] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:31.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:51:0) after 1m0s
[20:22:31.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:51:0)
[20:22:31.596] Timer tick, asking Buildbucket for the build status
[20:22:33.118] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:33.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:52:0) after 1m0s
[20:23:33.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:52:0)
[20:23:33.218] Timer tick, asking Buildbucket for the build status
[20:23:33.387] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:33.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:53:0) after 1m0s
[20:24:33.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:53:0)
[20:24:33.451] Timer tick, asking Buildbucket for the build status
[20:24:35.630] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:35.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:54:0) after 1m0s
[20:25:36.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:54:0)
[20:25:36.080] Timer tick, asking Buildbucket for the build status
[20:25:37.670] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:55:0) after 1m0s
[20:26:37.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:55:0)
[20:26:37.873] Timer tick, asking Buildbucket for the build status
[20:26:40.034] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:40.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:56:0) after 1m0s
[20:27:40.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:56:0)
[20:27:40.189] Timer tick, asking Buildbucket for the build status
[20:27:40.515] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:40.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:57:0) after 1m0s
[20:28:40.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:57:0)
[20:28:40.541] Timer tick, asking Buildbucket for the build status
[20:28:40.900] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:58:0) after 1m0s
[20:29:41.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:58:0)
[20:29:41.049] Timer tick, asking Buildbucket for the build status
[20:29:41.939] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:41.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:59:0) after 1m0s
[20:30:41.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:59:0)
[20:30:41.966] Timer tick, asking Buildbucket for the build status
[20:30:42.910] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:42.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:60:0) after 1m0s
[20:31:43.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:60:0)
[20:31:43.015] Timer tick, asking Buildbucket for the build status
[20:31:45.423] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:45.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:61:0) after 1m0s
[20:32:45.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:61:0)
[20:32:45.484] Timer tick, asking Buildbucket for the build status
[20:32:46.100] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:46.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:62:0) after 1m0s
[20:33:46.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:62:0)
[20:33:46.162] Timer tick, asking Buildbucket for the build status
[20:33:46.512] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:46.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:63:0) after 1m0s
[20:34:46.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:63:0)
[20:34:46.568] Timer tick, asking Buildbucket for the build status
[20:34:46.825] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:46.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:64:0) after 1m0s
[20:35:47.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:64:0)
[20:35:47.162] Timer tick, asking Buildbucket for the build status
[20:35:47.407] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:47.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:65:0) after 1m0s
[20:36:47.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:65:0)
[20:36:47.453] Timer tick, asking Buildbucket for the build status
[20:36:47.939] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:47.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:66:0) after 1m0s
[20:37:48.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:66:0)
[20:37:48.006] Timer tick, asking Buildbucket for the build status
[20:37:50.067] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:50.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:67:0) after 1m0s
[20:38:50.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:67:0)
[20:38:50.127] Timer tick, asking Buildbucket for the build status
[20:38:50.427] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:50.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:68:0) after 1m0s
[20:39:50.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:68:0)
[20:39:50.492] Timer tick, asking Buildbucket for the build status
[20:39:50.834] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:50.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:69:0) after 1m0s
[20:40:50.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:69:0)
[20:40:50.882] Timer tick, asking Buildbucket for the build status
[20:40:51.526] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:51.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:70:0) after 1m0s
[20:41:51.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:70:0)
[20:41:51.592] Timer tick, asking Buildbucket for the build status
[20:41:51.920] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:51.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:71:0) after 1m0s
[20:42:52.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:71:0)
[20:42:52.008] Timer tick, asking Buildbucket for the build status
[20:42:53.093] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:53.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:72:0) after 1m0s
[20:43:53.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:72:0)
[20:43:53.139] Timer tick, asking Buildbucket for the build status
[20:43:53.439] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:53.440] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:73:0) after 1m0s
[20:44:53.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:73:0)
[20:44:53.473] Timer tick, asking Buildbucket for the build status
[20:44:57.541] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:57.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:74:0) after 1m0s
[20:45:57.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:74:0)
[20:45:57.578] Timer tick, asking Buildbucket for the build status
[20:45:58.038] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:58.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:75:0) after 1m0s
[20:46:58.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:75:0)
[20:46:58.135] Timer tick, asking Buildbucket for the build status
[20:46:58.488] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:58.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:76:0) after 1m0s
[20:47:58.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:76:0)
[20:47:58.610] Timer tick, asking Buildbucket for the build status
[20:47:58.862] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:58.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:77:0) after 1m0s
[20:48:58.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:77:0)
[20:48:58.968] Timer tick, asking Buildbucket for the build status
[20:49:00.498] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:00.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:78:0) after 1m0s
[20:50:00.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:78:0)
[20:50:00.655] Timer tick, asking Buildbucket for the build status
[20:50:01.719] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:01.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:79:0) after 1m0s
[20:51:01.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:79:0)
[20:51:01.786] Timer tick, asking Buildbucket for the build status
[20:51:02.035] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:02.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:80:0) after 1m0s
[20:52:02.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:80:0)
[20:52:02.172] Timer tick, asking Buildbucket for the build status
[20:52:02.457] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:02.457] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:81:0) after 1m0s
[20:53:02.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:81:0)
[20:53:02.554] Timer tick, asking Buildbucket for the build status
[20:53:02.951] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:02.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:82:0) after 1m0s
[20:54:03.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:82:0)
[20:54:03.045] Timer tick, asking Buildbucket for the build status
[20:54:03.731] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:03.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:83:0) after 1m0s
[20:55:03.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:83:0)
[20:55:03.722] Timer tick, asking Buildbucket for the build status
[20:55:04.278] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:04.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:84:0) after 1m0s
[20:56:04.447] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:84:0)
[20:56:04.447] Timer tick, asking Buildbucket for the build status
[20:56:04.675] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:04.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:85:0) after 1m0s
[20:57:04.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:85:0)
[20:57:04.845] Timer tick, asking Buildbucket for the build status
[20:57:06.761] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:06.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:86:0) after 1m0s
[20:58:06.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:86:0)
[20:58:06.792] Timer tick, asking Buildbucket for the build status
[20:58:07.000] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:07.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:87:0) after 1m0s
[20:59:07.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:87:0)
[20:59:07.084] Timer tick, asking Buildbucket for the build status
[20:59:07.955] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:07.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:88:0) after 1m0s
[21:00:08.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:88:0)
[21:00:08.009] Timer tick, asking Buildbucket for the build status
[21:00:08.996] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:08.996] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:89:0) after 1m0s
[21:01:09.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:89:0)
[21:01:09.127] Timer tick, asking Buildbucket for the build status
[21:01:09.476] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:90:0) after 1m0s
[21:02:09.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:90:0)
[21:02:09.547] Timer tick, asking Buildbucket for the build status
[21:02:09.750] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:91:0) after 1m0s
[21:03:09.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:91:0)
[21:03:09.811] Timer tick, asking Buildbucket for the build status
[21:03:10.034] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:10.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:92:0) after 1m0s
[21:04:10.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:92:0)
[21:04:10.124] Timer tick, asking Buildbucket for the build status
[21:04:10.640] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:10.640] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:93:0) after 1m0s
[21:05:10.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:93:0)
[21:05:10.827] Timer tick, asking Buildbucket for the build status
[21:05:11.529] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:94:0) after 1m0s
[21:06:11.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:94:0)
[21:06:11.625] Timer tick, asking Buildbucket for the build status
[21:06:12.874] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:95:0) after 1m0s
[21:07:12.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:95:0)
[21:07:12.890] Timer tick, asking Buildbucket for the build status
[21:07:16.516] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:16.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:96:0) after 1m0s
[21:08:16.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:96:0)
[21:08:16.625] Timer tick, asking Buildbucket for the build status
[21:08:16.802] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:16.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:97:0) after 1m0s
[21:09:16.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:97:0)
[21:09:16.904] Timer tick, asking Buildbucket for the build status
[21:09:17.671] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:17.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:98:0) after 1m0s
[21:10:17.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:98:0)
[21:10:17.704] Timer tick, asking Buildbucket for the build status
[21:10:18.162] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:99:0) after 1m0s
[21:11:18.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:99:0)
[21:11:18.198] Timer tick, asking Buildbucket for the build status
[21:11:19.055] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:19.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:100:0) after 1m0s
[21:12:19.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:100:0)
[21:12:19.108] Timer tick, asking Buildbucket for the build status
[21:12:21.727] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:21.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:101:0) after 1m0s
[21:13:21.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:101:0)
[21:13:21.785] Timer tick, asking Buildbucket for the build status
[21:13:24.793] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:102:0) after 1m0s
[21:14:24.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:102:0)
[21:14:24.828] Timer tick, asking Buildbucket for the build status
[21:14:27.015] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:27.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:103:0) after 1m0s
[21:15:27.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:103:0)
[21:15:27.158] Timer tick, asking Buildbucket for the build status
[21:15:27.381] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:27.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:104:0) after 1m0s
[21:16:27.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:104:0)
[21:16:27.496] Timer tick, asking Buildbucket for the build status
[21:16:28.379] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:28.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:105:0) after 1m0s
[21:17:28.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:105:0)
[21:17:28.484] Timer tick, asking Buildbucket for the build status
[21:17:28.809] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:28.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:106:0) after 1m0s
[21:18:28.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:106:0)
[21:18:28.864] Timer tick, asking Buildbucket for the build status
[21:18:29.122] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:29.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:107:0) after 1m0s
[21:19:29.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:107:0)
[21:19:29.188] Timer tick, asking Buildbucket for the build status
[21:19:29.785] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:29.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:108:0) after 1m0s
[21:20:29.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:108:0)
[21:20:29.774] Timer tick, asking Buildbucket for the build status
[21:20:30.329] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:30.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:109:0) after 1m0s
[21:21:30.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:109:0)
[21:21:30.358] Timer tick, asking Buildbucket for the build status
[21:21:31.033] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:31.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:110:0) after 1m0s
[21:22:31.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:110:0)
[21:22:31.059] Timer tick, asking Buildbucket for the build status
[21:22:31.275] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:111:0) after 1m0s
[21:23:31.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:111:0)
[21:23:31.344] Timer tick, asking Buildbucket for the build status
[21:23:32.293] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:32.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:112:0) after 1m0s
[21:24:32.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:112:0)
[21:24:32.395] Timer tick, asking Buildbucket for the build status
[21:24:32.633] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:32.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:113:0) after 1m0s
[21:25:32.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:113:0)
[21:25:32.671] Timer tick, asking Buildbucket for the build status
[21:25:34.156] Build 8896786785927545056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:34.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9062216848431800544:114:0) after 1m0s
[21:26:23.304] Received PubSub notification, asking Buildbucket for the build status
[21:26:23.518] Build 8896786785927545056: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:26:23.518] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573766783022708",
"created_by": "project:chromium",
"created_ts": "1573759965926919",
"failure_reason": "BUILD_FAILURE",
"id": "8896786785927545056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ee438d7b3555a67c3372c8483207abef90b6dff8\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-88-8wm7\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25692, \"got_angle_revision\": \"6e687af2649d48aa66b020fab4057ac85191dd8b\", \"got_dawn_revision\": \"58dbfcae38f465b5f7963517b9d914190d304d19\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"ee438d7b3555a67c3372c8483207abef90b6dff8\", \"got_revision_cp\": \"refs/heads/master@{#715356}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"90df527f91c348d4af7948acefc1142f8b9468d0\", \"got_v8_revision\": \"5f43d8c38eebe19c8c1ac3fe6cc4e554a687e5bc\", \"got_v8_revision_cp\": \"refs/heads/8.0.262@{#1}\", \"got_webrtc_revision\": \"01294f0e298723dc9128fb6d45060f816f3034ac\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29798}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ee438d7b3555a67c3372c8483207abef90b6dff8\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_884aee959975e3ba239407d026a51b81c46e736b67f5763d1d4e447f2346535d_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-88-8wm7\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4628-14f2294\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573760172552316",
"status": "COMPLETED",
"status_changed_ts": "1573760173342969",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25692",
"builder:Deterministic Linux",
"buildset:commit/git/ee438d7b3555a67c3372c8483207abef90b6dff8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ee438d7b3555a67c3372c8483207abef90b6dff8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062216848431800544",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8896786785927545056/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:48843925b83d1810",
"user_agent:luci-scheduler"
],
"updated_ts": "1573766783090113",
"url": "https://ci.chromium.org/b/8896786785927545056",
"utcnow_ts": "1573766783507120"
}
}
[21:26:23.518] Invocation finished in 1h53m39.364501879s with status FAILED