[19:19:52.866] New invocation is queued and will start shortly
[19:19:54.356] Starting the invocation (attempt 1)
[19:19:54.415] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:19:54.415] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:19:54.415] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052886169677865024",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"564afbae2b1ad9cb8235382b0d8502d1c085b6ae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9052886169677865024",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"gitiles_ref:refs/heads/master"
]
}
[19:19:55.787] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582658394620022",
"id": "8887456107161447856",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"564afbae2b1ad9cb8235382b0d8502d1c085b6ae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582658395328058",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26955",
"builder:Deterministic Linux",
"buildset:commit/git/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052886169677865024",
"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/8887456107161447856/+/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": "1582658395328173",
"url": "https://ci.chromium.org/b/8887456107161447856",
"utcnow_ts": "1582658395765415"
}
}
[19:19:55.787] Task URL: https://ci.chromium.org/b/8887456107161447856
[19:19:55.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:2:0) after 1m0s
[19:20:55.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:2:0)
[19:20:55.809] Timer tick, asking Buildbucket for the build status
[19:20:55.923] Build 8887456107161447856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:55.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:3:0) after 1m0s
[19:21:56.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:3:0)
[19:21:56.045] Timer tick, asking Buildbucket for the build status
[19:21:56.186] Build 8887456107161447856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:56.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:4:0) after 1m0s
[19:22:56.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:4:0)
[19:22:56.230] Timer tick, asking Buildbucket for the build status
[19:22:56.323] Build 8887456107161447856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:56.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:5:0) after 1m0s
[19:23:07.510] Received PubSub notification, asking Buildbucket for the build status
[19:23:07.696] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:56.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:5:0)
[19:23:56.348] Timer tick, asking Buildbucket for the build status
[19:23:56.450] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:56.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:7:0) after 1m0s
[19:24:56.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:7:0)
[19:24:56.549] Timer tick, asking Buildbucket for the build status
[19:24:56.758] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:8:0) after 1m0s
[19:25:56.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:8:0)
[19:25:56.816] Timer tick, asking Buildbucket for the build status
[19:25:57.046] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:57.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:9:0) after 1m0s
[19:26:57.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:9:0)
[19:26:57.076] Timer tick, asking Buildbucket for the build status
[19:26:57.212] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:57.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:10:0) after 1m0s
[19:27:57.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:10:0)
[19:27:57.208] Timer tick, asking Buildbucket for the build status
[19:27:57.405] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:57.405] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:11:0) after 1m0s
[19:28:57.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:11:0)
[19:28:57.399] Timer tick, asking Buildbucket for the build status
[19:28:57.493] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:57.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:12:0) after 1m0s
[19:29:57.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:12:0)
[19:29:57.517] Timer tick, asking Buildbucket for the build status
[19:29:57.713] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:57.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:13:0) after 1m0s
[19:30:57.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:13:0)
[19:30:57.764] Timer tick, asking Buildbucket for the build status
[19:30:58.133] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:58.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:14:0) after 1m0s
[19:31:58.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:14:0)
[19:31:58.138] Timer tick, asking Buildbucket for the build status
[19:31:58.272] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:58.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:15:0) after 1m0s
[19:32:58.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:15:0)
[19:32:58.381] Timer tick, asking Buildbucket for the build status
[19:32:58.511] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:58.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:16:0) after 1m0s
[19:33:58.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:16:0)
[19:33:58.589] Timer tick, asking Buildbucket for the build status
[19:33:58.717] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:58.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:17:0) after 1m0s
[19:34:58.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:17:0)
[19:34:58.757] Timer tick, asking Buildbucket for the build status
[19:34:58.860] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:58.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:18:0) after 1m0s
[19:35:58.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:18:0)
[19:35:58.919] Timer tick, asking Buildbucket for the build status
[19:35:59.223] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:59.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:19:0) after 1m0s
[19:36:59.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:19:0)
[19:36:59.230] Timer tick, asking Buildbucket for the build status
[19:36:59.434] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:59.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:20:0) after 1m0s
[19:37:59.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:20:0)
[19:37:59.499] Timer tick, asking Buildbucket for the build status
[19:37:59.593] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:59.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:21:0) after 1m0s
[19:38:59.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:21:0)
[19:38:59.739] Timer tick, asking Buildbucket for the build status
[19:38:59.857] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:59.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:22:0) after 1m0s
[19:39:59.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:22:0)
[19:39:59.972] Timer tick, asking Buildbucket for the build status
[19:40:00.287] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:00.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:23:0) after 1m0s
[19:41:00.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:23:0)
[19:41:00.286] Timer tick, asking Buildbucket for the build status
[19:41:00.408] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:00.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:24:0) after 1m0s
[19:42:00.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:24:0)
[19:42:00.582] Timer tick, asking Buildbucket for the build status
[19:42:00.706] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:00.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:25:0) after 1m0s
[19:43:00.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:25:0)
[19:43:00.766] Timer tick, asking Buildbucket for the build status
[19:43:00.859] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:00.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:26:0) after 1m0s
[19:44:00.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:26:0)
[19:44:00.933] Timer tick, asking Buildbucket for the build status
[19:44:01.053] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:01.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:27:0) after 1m0s
[19:45:01.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:27:0)
[19:45:01.111] Timer tick, asking Buildbucket for the build status
[19:45:01.244] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:01.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:28:0) after 1m0s
[19:46:01.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:28:0)
[19:46:01.261] Timer tick, asking Buildbucket for the build status
[19:46:01.474] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:01.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:29:0) after 1m0s
[19:47:01.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:29:0)
[19:47:01.564] Timer tick, asking Buildbucket for the build status
[19:47:01.761] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:01.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:30:0) after 1m0s
[19:48:01.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:30:0)
[19:48:01.786] Timer tick, asking Buildbucket for the build status
[19:48:01.905] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:31:0) after 1m0s
[19:49:01.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:31:0)
[19:49:01.972] Timer tick, asking Buildbucket for the build status
[19:49:02.233] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:02.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:32:0) after 1m0s
[19:50:02.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:32:0)
[19:50:02.393] Timer tick, asking Buildbucket for the build status
[19:50:02.505] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:02.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:33:0) after 1m0s
[19:51:02.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:33:0)
[19:51:02.566] Timer tick, asking Buildbucket for the build status
[19:51:02.654] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:02.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:34:0) after 1m0s
[19:52:02.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:34:0)
[19:52:02.680] Timer tick, asking Buildbucket for the build status
[19:52:02.937] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:02.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:35:0) after 1m0s
[19:53:03.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:35:0)
[19:53:03.042] Timer tick, asking Buildbucket for the build status
[19:53:03.150] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:03.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:36:0) after 1m0s
[19:54:03.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:36:0)
[19:54:03.208] Timer tick, asking Buildbucket for the build status
[19:54:03.338] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:03.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:37:0) after 1m0s
[19:55:03.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:37:0)
[19:55:03.387] Timer tick, asking Buildbucket for the build status
[19:55:03.668] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:38:0) after 1m0s
[19:56:03.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:38:0)
[19:56:03.653] Timer tick, asking Buildbucket for the build status
[19:56:03.822] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:39:0) after 1m0s
[19:57:03.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:39:0)
[19:57:03.844] Timer tick, asking Buildbucket for the build status
[19:57:04.007] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:04.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:40:0) after 1m0s
[19:58:04.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:40:0)
[19:58:04.055] Timer tick, asking Buildbucket for the build status
[19:58:04.301] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:04.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:41:0) after 1m0s
[19:59:04.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:41:0)
[19:59:04.340] Timer tick, asking Buildbucket for the build status
[19:59:04.475] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:04.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:42:0) after 1m0s
[20:00:04.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:42:0)
[20:00:04.561] Timer tick, asking Buildbucket for the build status
[20:00:04.837] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:04.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:43:0) after 1m0s
[20:01:04.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:43:0)
[20:01:04.817] Timer tick, asking Buildbucket for the build status
[20:01:04.918] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:04.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:44:0) after 1m0s
[20:02:04.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:44:0)
[20:02:04.971] Timer tick, asking Buildbucket for the build status
[20:02:05.101] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:05.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:45:0) after 1m0s
[20:03:05.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:45:0)
[20:03:05.122] Timer tick, asking Buildbucket for the build status
[20:03:05.228] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:05.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:46:0) after 1m0s
[20:04:05.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:46:0)
[20:04:05.265] Timer tick, asking Buildbucket for the build status
[20:04:05.372] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:05.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:47:0) after 1m0s
[20:05:05.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:47:0)
[20:05:05.435] Timer tick, asking Buildbucket for the build status
[20:05:05.596] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:05.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:48:0) after 1m0s
[20:06:05.686] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:48:0)
[20:06:05.686] Timer tick, asking Buildbucket for the build status
[20:06:05.797] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:05.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:49:0) after 1m0s
[20:07:06.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:49:0)
[20:07:06.207] Timer tick, asking Buildbucket for the build status
[20:07:06.319] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:06.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:50:0) after 1m0s
[20:08:06.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:50:0)
[20:08:06.406] Timer tick, asking Buildbucket for the build status
[20:08:06.575] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:06.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:51:0) after 1m0s
[20:09:06.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:51:0)
[20:09:06.707] Timer tick, asking Buildbucket for the build status
[20:09:06.931] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:06.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:52:0) after 1m0s
[20:10:06.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:52:0)
[20:10:06.953] Timer tick, asking Buildbucket for the build status
[20:10:07.066] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:07.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:53:0) after 1m0s
[20:11:07.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:53:0)
[20:11:07.113] Timer tick, asking Buildbucket for the build status
[20:11:07.234] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:07.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:54:0) after 1m0s
[20:12:07.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:54:0)
[20:12:07.281] Timer tick, asking Buildbucket for the build status
[20:12:07.409] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:07.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:55:0) after 1m0s
[20:13:07.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:55:0)
[20:13:07.462] Timer tick, asking Buildbucket for the build status
[20:13:07.577] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:07.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:56:0) after 1m0s
[20:14:07.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:56:0)
[20:14:07.731] Timer tick, asking Buildbucket for the build status
[20:14:07.907] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:07.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:57:0) after 1m0s
[20:15:08.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:57:0)
[20:15:08.103] Timer tick, asking Buildbucket for the build status
[20:15:08.385] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:08.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:58:0) after 1m0s
[20:16:08.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:58:0)
[20:16:08.465] Timer tick, asking Buildbucket for the build status
[20:16:08.625] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:08.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:59:0) after 1m0s
[20:17:08.623] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:59:0)
[20:17:08.623] Timer tick, asking Buildbucket for the build status
[20:17:08.739] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:08.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:60:0) after 1m0s
[20:18:08.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:60:0)
[20:18:08.781] Timer tick, asking Buildbucket for the build status
[20:18:09.260] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:09.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:61:0) after 1m0s
[20:19:09.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:61:0)
[20:19:09.291] Timer tick, asking Buildbucket for the build status
[20:19:09.679] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:09.679] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:62:0) after 1m0s
[20:20:09.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:62:0)
[20:20:09.750] Timer tick, asking Buildbucket for the build status
[20:20:10.634] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:10.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:63:0) after 1m0s
[20:21:10.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:63:0)
[20:21:10.739] Timer tick, asking Buildbucket for the build status
[20:21:11.030] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:11.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:64:0) after 1m0s
[20:22:11.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:64:0)
[20:22:11.174] Timer tick, asking Buildbucket for the build status
[20:22:11.479] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:11.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:65:0) after 1m0s
[20:23:11.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:65:0)
[20:23:11.542] Timer tick, asking Buildbucket for the build status
[20:23:11.764] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:11.764] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:66:0) after 1m0s
[20:24:11.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:66:0)
[20:24:11.788] Timer tick, asking Buildbucket for the build status
[20:24:12.543] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:67:0) after 1m0s
[20:25:12.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:67:0)
[20:25:12.627] Timer tick, asking Buildbucket for the build status
[20:25:12.873] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:12.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:68:0) after 1m0s
[20:26:12.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:68:0)
[20:26:12.867] Timer tick, asking Buildbucket for the build status
[20:26:13.209] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:13.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:69:0) after 1m0s
[20:27:13.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:69:0)
[20:27:13.244] Timer tick, asking Buildbucket for the build status
[20:27:13.590] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:13.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:70:0) after 1m0s
[20:28:13.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:70:0)
[20:28:13.687] Timer tick, asking Buildbucket for the build status
[20:28:13.757] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:13.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:71:0) after 1m0s
[20:29:13.773] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:71:0)
[20:29:13.773] Timer tick, asking Buildbucket for the build status
[20:29:14.002] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:14.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:72:0) after 1m0s
[20:30:14.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:72:0)
[20:30:14.117] Timer tick, asking Buildbucket for the build status
[20:30:14.288] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:14.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:73:0) after 1m0s
[20:31:14.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:73:0)
[20:31:14.437] Timer tick, asking Buildbucket for the build status
[20:31:14.600] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:74:0) after 1m0s
[20:32:14.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:74:0)
[20:32:14.831] Timer tick, asking Buildbucket for the build status
[20:32:14.893] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:14.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:75:0) after 1m0s
[20:33:15.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:75:0)
[20:33:15.079] Timer tick, asking Buildbucket for the build status
[20:33:15.193] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:15.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:76:0) after 1m0s
[20:34:15.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:76:0)
[20:34:15.257] Timer tick, asking Buildbucket for the build status
[20:34:15.396] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:15.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:77:0) after 1m0s
[20:35:15.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:77:0)
[20:35:15.536] Timer tick, asking Buildbucket for the build status
[20:35:15.622] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:15.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:78:0) after 1m0s
[20:36:15.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:78:0)
[20:36:15.736] Timer tick, asking Buildbucket for the build status
[20:36:15.821] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:15.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:79:0) after 1m0s
[20:37:15.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:79:0)
[20:37:15.969] Timer tick, asking Buildbucket for the build status
[20:37:16.210] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:16.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:80:0) after 1m0s
[20:38:16.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:80:0)
[20:38:16.324] Timer tick, asking Buildbucket for the build status
[20:38:16.449] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:16.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:81:0) after 1m0s
[20:39:16.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:81:0)
[20:39:16.527] Timer tick, asking Buildbucket for the build status
[20:39:16.592] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:16.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:82:0) after 1m0s
[20:40:16.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:82:0)
[20:40:16.649] Timer tick, asking Buildbucket for the build status
[20:40:16.858] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:16.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:83:0) after 1m0s
[20:41:16.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:83:0)
[20:41:16.922] Timer tick, asking Buildbucket for the build status
[20:41:17.078] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:17.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:84:0) after 1m0s
[20:42:17.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:84:0)
[20:42:17.201] Timer tick, asking Buildbucket for the build status
[20:42:17.448] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:17.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:85:0) after 1m0s
[20:43:17.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:85:0)
[20:43:17.475] Timer tick, asking Buildbucket for the build status
[20:43:17.619] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:17.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:86:0) after 1m0s
[20:44:17.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:86:0)
[20:44:17.654] Timer tick, asking Buildbucket for the build status
[20:44:17.953] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:17.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:87:0) after 1m0s
[20:45:18.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:87:0)
[20:45:18.427] Timer tick, asking Buildbucket for the build status
[20:45:18.603] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:18.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:88:0) after 1m0s
[20:46:18.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:88:0)
[20:46:18.724] Timer tick, asking Buildbucket for the build status
[20:46:19.092] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:19.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:89:0) after 1m0s
[20:47:19.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:89:0)
[20:47:19.350] Timer tick, asking Buildbucket for the build status
[20:47:19.460] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:19.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:90:0) after 1m0s
[20:48:19.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:90:0)
[20:48:19.475] Timer tick, asking Buildbucket for the build status
[20:48:19.611] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:19.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:91:0) after 1m0s
[20:49:19.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:91:0)
[20:49:19.661] Timer tick, asking Buildbucket for the build status
[20:49:19.753] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:19.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:92:0) after 1m0s
[20:50:19.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:92:0)
[20:50:19.920] Timer tick, asking Buildbucket for the build status
[20:50:20.423] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:20.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:93:0) after 1m0s
[20:51:20.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:93:0)
[20:51:20.547] Timer tick, asking Buildbucket for the build status
[20:51:20.645] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:20.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:94:0) after 1m0s
[20:52:20.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:94:0)
[20:52:20.725] Timer tick, asking Buildbucket for the build status
[20:52:20.864] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:20.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:95:0) after 1m0s
[20:53:21.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:95:0)
[20:53:21.034] Timer tick, asking Buildbucket for the build status
[20:53:21.387] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:21.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:96:0) after 1m0s
[20:54:21.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:96:0)
[20:54:21.547] Timer tick, asking Buildbucket for the build status
[20:54:21.718] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:21.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:97:0) after 1m0s
[20:55:21.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:97:0)
[20:55:21.903] Timer tick, asking Buildbucket for the build status
[20:55:22.341] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:22.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:98:0) after 1m0s
[20:56:22.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:98:0)
[20:56:22.451] Timer tick, asking Buildbucket for the build status
[20:56:22.858] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:22.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:99:0) after 1m0s
[20:57:23.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:99:0)
[20:57:23.032] Timer tick, asking Buildbucket for the build status
[20:57:23.177] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:23.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:100:0) after 1m0s
[20:58:23.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:100:0)
[20:58:23.258] Timer tick, asking Buildbucket for the build status
[20:58:23.378] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:23.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:101:0) after 1m0s
[20:59:23.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:101:0)
[20:59:23.502] Timer tick, asking Buildbucket for the build status
[20:59:23.622] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:23.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:102:0) after 1m0s
[21:00:23.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:102:0)
[21:00:23.777] Timer tick, asking Buildbucket for the build status
[21:00:23.875] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:23.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:103:0) after 1m0s
[21:01:23.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:103:0)
[21:01:23.910] Timer tick, asking Buildbucket for the build status
[21:01:24.221] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:24.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:104:0) after 1m0s
[21:02:24.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:104:0)
[21:02:24.332] Timer tick, asking Buildbucket for the build status
[21:02:24.474] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:105:0) after 1m0s
[21:03:24.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:105:0)
[21:03:24.508] Timer tick, asking Buildbucket for the build status
[21:03:25.010] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:25.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:106:0) after 1m0s
[21:04:25.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:106:0)
[21:04:25.121] Timer tick, asking Buildbucket for the build status
[21:04:25.260] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:25.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:107:0) after 1m0s
[21:05:25.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:107:0)
[21:05:25.319] Timer tick, asking Buildbucket for the build status
[21:05:25.391] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:25.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:108:0) after 1m0s
[21:06:25.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:108:0)
[21:06:25.458] Timer tick, asking Buildbucket for the build status
[21:06:25.570] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:25.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:109:0) after 1m0s
[21:07:25.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:109:0)
[21:07:25.575] Timer tick, asking Buildbucket for the build status
[21:07:25.740] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:25.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:110:0) after 1m0s
[21:08:25.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:110:0)
[21:08:25.794] Timer tick, asking Buildbucket for the build status
[21:08:26.068] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:26.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:111:0) after 1m0s
[21:09:26.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:111:0)
[21:09:26.195] Timer tick, asking Buildbucket for the build status
[21:09:26.315] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:26.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:112:0) after 1m0s
[21:10:26.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:112:0)
[21:10:26.329] Timer tick, asking Buildbucket for the build status
[21:10:26.404] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:26.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:113:0) after 1m0s
[21:11:26.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:113:0)
[21:11:26.573] Timer tick, asking Buildbucket for the build status
[21:11:26.940] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:26.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:114:0) after 1m0s
[21:12:27.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:114:0)
[21:12:27.046] Timer tick, asking Buildbucket for the build status
[21:12:27.254] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:115:0) after 1m0s
[21:13:27.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:115:0)
[21:13:27.402] Timer tick, asking Buildbucket for the build status
[21:13:27.859] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:27.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:116:0) after 1m0s
[21:14:27.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:116:0)
[21:14:27.952] Timer tick, asking Buildbucket for the build status
[21:14:28.156] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:28.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:117:0) after 1m0s
[21:15:28.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:117:0)
[21:15:28.256] Timer tick, asking Buildbucket for the build status
[21:15:28.479] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:28.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:118:0) after 1m0s
[21:16:28.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:118:0)
[21:16:28.559] Timer tick, asking Buildbucket for the build status
[21:16:28.644] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:28.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:119:0) after 1m0s
[21:17:28.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:119:0)
[21:17:28.817] Timer tick, asking Buildbucket for the build status
[21:17:28.975] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:28.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:120:0) after 1m0s
[21:18:29.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:120:0)
[21:18:29.008] Timer tick, asking Buildbucket for the build status
[21:18:29.074] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:29.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:121:0) after 1m0s
[21:19:29.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:121:0)
[21:19:29.181] Timer tick, asking Buildbucket for the build status
[21:19:29.286] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:29.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:122:0) after 1m0s
[21:20:29.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:122:0)
[21:20:29.317] Timer tick, asking Buildbucket for the build status
[21:20:29.591] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:29.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:123:0) after 1m0s
[21:21:29.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:123:0)
[21:21:29.657] Timer tick, asking Buildbucket for the build status
[21:21:29.799] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:29.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:124:0) after 1m0s
[21:22:29.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:124:0)
[21:22:29.878] Timer tick, asking Buildbucket for the build status
[21:22:30.265] Build 8887456107161447856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:30.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9052886169677865024:125:0) after 1m0s
[21:23:17.466] Received PubSub notification, asking Buildbucket for the build status
[21:23:17.636] Build 8887456107161447856: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:23:17.636] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582665796967146",
"created_by": "project:chromium",
"created_ts": "1582658394620022",
"failure_reason": "BUILD_FAILURE",
"id": "8887456107161447856",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"564afbae2b1ad9cb8235382b0d8502d1c085b6ae\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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-central1-b-8-94-hi7s\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26955, \"got_angle_revision\": \"b185002d559b22e404f0c1a9c218fab874e4ee45\", \"got_dawn_revision\": \"6c1d646ee9d4120dcdf344b3fee01f3fdf79390c\", \"got_nacl_revision\": \"530e1f0dae34020864c81e5cd52be54d9c656690\", \"got_revision\": \"564afbae2b1ad9cb8235382b0d8502d1c085b6ae\", \"got_revision_cp\": \"refs/heads/master@{#744340}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"c1e60dcf11656073f763938609b66da32d0a4630\", \"got_v8_revision\": \"57083a22efbe63d75af8adb979583fa3aa0ff0d4\", \"got_v8_revision_cp\": \"refs/heads/8.2.173@{#1}\", \"got_webrtc_revision\": \"0165d5c32c87b70ba6d12aeb4ef2eb87b03e0245\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30609}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"564afbae2b1ad9cb8235382b0d8502d1c085b6ae\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_eae3a4dc277b4e2282e9fce002ae6861b5ee5509389502cf3acc9366ec79a2d3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-94-hi7s\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582658586509424",
"status": "COMPLETED",
"status_changed_ts": "1582658587115916",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26955",
"builder:Deterministic Linux",
"buildset:commit/git/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/564afbae2b1ad9cb8235382b0d8502d1c085b6ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052886169677865024",
"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/8887456107161447856/+/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:4a969c273abe5910",
"user_agent:luci-scheduler"
],
"updated_ts": "1582665797154122",
"url": "https://ci.chromium.org/b/8887456107161447856",
"utcnow_ts": "1582665797627305"
}
}
[21:23:17.636] Invocation finished in 2h3m24.800467786s with status FAILED