[16:34:26.171] New invocation is queued and will start shortly
[16:34:28.812] Starting the invocation (attempt 1)
[16:34:28.878] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:34:28.878] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:34:28.878] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9038763451808949136",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3b8567d2154bd7b5dc329f226e5885b1f63e146b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9038763451808949136",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"gitiles_ref:refs/heads/master"
]
}
[16:34:29.781] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1596126868979822",
"id": "8873333388191445792",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b8567d2154bd7b5dc329f226e5885b1f63e146b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596126869572507",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/17999",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038763451808949136",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8873333388191445792/+/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": "1596126869572662",
"url": "https://ci.chromium.org/b/8873333388191445792",
"utcnow_ts": "1596126869769325"
}
}
[16:34:29.781] Task URL: https://ci.chromium.org/b/8873333388191445792
[16:34:29.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:2:0) after 1m0s
[16:34:34.695] Received PubSub notification, asking Buildbucket for the build status
[16:34:34.842] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:29.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:2:0)
[16:35:29.856] Timer tick, asking Buildbucket for the build status
[16:35:30.018] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:30.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:4:0) after 1m0s
[16:36:30.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:4:0)
[16:36:30.041] Timer tick, asking Buildbucket for the build status
[16:36:30.180] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:30.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:5:0) after 1m0s
[16:37:30.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:5:0)
[16:37:30.461] Timer tick, asking Buildbucket for the build status
[16:37:30.633] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:30.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:6:0) after 1m0s
[16:38:30.685] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:6:0)
[16:38:30.685] Timer tick, asking Buildbucket for the build status
[16:38:30.762] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:30.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:7:0) after 1m0s
[16:39:30.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:7:0)
[16:39:30.813] Timer tick, asking Buildbucket for the build status
[16:39:30.991] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:30.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:8:0) after 1m0s
[16:40:31.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:8:0)
[16:40:31.082] Timer tick, asking Buildbucket for the build status
[16:40:31.178] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:31.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:9:0) after 1m0s
[16:41:31.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:9:0)
[16:41:31.333] Timer tick, asking Buildbucket for the build status
[16:41:31.419] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:31.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:10:0) after 1m0s
[16:42:31.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:10:0)
[16:42:31.527] Timer tick, asking Buildbucket for the build status
[16:42:32.223] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:32.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:11:0) after 1m0s
[16:43:32.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:11:0)
[16:43:32.418] Timer tick, asking Buildbucket for the build status
[16:43:32.795] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:32.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:12:0) after 1m0s
[16:44:32.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:12:0)
[16:44:32.908] Timer tick, asking Buildbucket for the build status
[16:44:33.144] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:33.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:13:0) after 1m0s
[16:45:33.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:13:0)
[16:45:33.260] Timer tick, asking Buildbucket for the build status
[16:45:33.422] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:33.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:14:0) after 1m0s
[16:46:33.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:14:0)
[16:46:33.509] Timer tick, asking Buildbucket for the build status
[16:46:33.636] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:33.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:15:0) after 1m0s
[16:47:33.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:15:0)
[16:47:33.733] Timer tick, asking Buildbucket for the build status
[16:47:33.848] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:33.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:16:0) after 1m0s
[16:48:35.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:16:0)
[16:48:35.669] Timer tick, asking Buildbucket for the build status
[16:48:36.270] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:36.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:17:0) after 1m0s
[16:49:36.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:17:0)
[16:49:36.365] Timer tick, asking Buildbucket for the build status
[16:49:36.601] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:36.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:18:0) after 1m0s
[16:50:37.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:18:0)
[16:50:37.055] Timer tick, asking Buildbucket for the build status
[16:50:37.141] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:37.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:19:0) after 1m0s
[16:51:37.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:19:0)
[16:51:37.479] Timer tick, asking Buildbucket for the build status
[16:51:37.580] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:37.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:20:0) after 1m0s
[16:52:37.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:20:0)
[16:52:37.763] Timer tick, asking Buildbucket for the build status
[16:52:37.832] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:37.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:21:0) after 1m0s
[16:53:37.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:21:0)
[16:53:37.879] Timer tick, asking Buildbucket for the build status
[16:53:37.951] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:37.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:22:0) after 1m0s
[16:54:38.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:22:0)
[16:54:38.106] Timer tick, asking Buildbucket for the build status
[16:54:43.539] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:43.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:23:0) after 1m0s
[16:55:43.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:23:0)
[16:55:43.658] Timer tick, asking Buildbucket for the build status
[16:55:43.785] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:43.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:24:0) after 1m0s
[16:56:43.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:24:0)
[16:56:43.794] Timer tick, asking Buildbucket for the build status
[16:56:43.890] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:43.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:25:0) after 1m0s
[16:57:43.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:25:0)
[16:57:43.983] Timer tick, asking Buildbucket for the build status
[16:57:44.073] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:44.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:26:0) after 1m0s
[16:58:44.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:26:0)
[16:58:44.097] Timer tick, asking Buildbucket for the build status
[16:58:44.338] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:44.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:27:0) after 1m0s
[16:59:44.323] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:27:0)
[16:59:44.323] Timer tick, asking Buildbucket for the build status
[16:59:44.479] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:44.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:28:0) after 1m0s
[17:00:44.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:28:0)
[17:00:44.504] Timer tick, asking Buildbucket for the build status
[17:00:44.620] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:44.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:29:0) after 1m0s
[17:01:44.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:29:0)
[17:01:44.665] Timer tick, asking Buildbucket for the build status
[17:01:48.573] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:48.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:30:0) after 1m0s
[17:02:48.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:30:0)
[17:02:48.768] Timer tick, asking Buildbucket for the build status
[17:02:48.827] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:48.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:31:0) after 1m0s
[17:03:49.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:31:0)
[17:03:49.207] Timer tick, asking Buildbucket for the build status
[17:03:49.278] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:49.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:32:0) after 1m0s
[17:04:49.428] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:32:0)
[17:04:49.428] Timer tick, asking Buildbucket for the build status
[17:04:49.683] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:33:0) after 1m0s
[17:05:51.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:33:0)
[17:05:51.456] Timer tick, asking Buildbucket for the build status
[17:05:51.658] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:51.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:34:0) after 1m0s
[17:06:51.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:34:0)
[17:06:51.864] Timer tick, asking Buildbucket for the build status
[17:06:52.004] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:52.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:35:0) after 1m0s
[17:07:52.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:35:0)
[17:07:52.103] Timer tick, asking Buildbucket for the build status
[17:07:52.211] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:52.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:36:0) after 1m0s
[17:08:52.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:36:0)
[17:08:52.293] Timer tick, asking Buildbucket for the build status
[17:08:52.392] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:52.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:37:0) after 1m0s
[17:09:52.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:37:0)
[17:09:52.416] Timer tick, asking Buildbucket for the build status
[17:09:53.592] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:53.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:38:0) after 1m0s
[17:10:53.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:38:0)
[17:10:53.612] Timer tick, asking Buildbucket for the build status
[17:10:54.112] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:54.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:39:0) after 1m0s
[17:11:54.183] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:39:0)
[17:11:54.183] Timer tick, asking Buildbucket for the build status
[17:11:54.539] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:54.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:40:0) after 1m0s
[17:12:55.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:40:0)
[17:12:55.813] Timer tick, asking Buildbucket for the build status
[17:12:55.905] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:55.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:41:0) after 1m0s
[17:13:56.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:41:0)
[17:13:56.208] Timer tick, asking Buildbucket for the build status
[17:13:56.314] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:56.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:42:0) after 1m0s
[17:14:56.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:42:0)
[17:14:56.464] Timer tick, asking Buildbucket for the build status
[17:14:56.567] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:43:0) after 1m0s
[17:15:56.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:43:0)
[17:15:56.720] Timer tick, asking Buildbucket for the build status
[17:15:56.807] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:56.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:44:0) after 1m0s
[17:16:58.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:44:0)
[17:16:58.921] Timer tick, asking Buildbucket for the build status
[17:16:59.028] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:59.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:45:0) after 1m0s
[17:17:59.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:45:0)
[17:17:59.078] Timer tick, asking Buildbucket for the build status
[17:17:59.230] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:46:0) after 1m0s
[17:19:00.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:46:0)
[17:19:00.463] Timer tick, asking Buildbucket for the build status
[17:19:00.656] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:00.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:47:0) after 1m0s
[17:20:01.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:47:0)
[17:20:01.756] Timer tick, asking Buildbucket for the build status
[17:20:01.994] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:01.994] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:48:0) after 1m0s
[17:21:02.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:48:0)
[17:21:02.294] Timer tick, asking Buildbucket for the build status
[17:21:02.386] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:02.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:49:0) after 1m0s
[17:22:02.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:49:0)
[17:22:02.422] Timer tick, asking Buildbucket for the build status
[17:22:02.648] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:02.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:50:0) after 1m0s
[17:23:03.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:50:0)
[17:23:03.455] Timer tick, asking Buildbucket for the build status
[17:23:03.548] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:03.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:51:0) after 1m0s
[17:24:04.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:51:0)
[17:24:04.523] Timer tick, asking Buildbucket for the build status
[17:24:04.603] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:04.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:52:0) after 1m0s
[17:25:05.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:52:0)
[17:25:05.111] Timer tick, asking Buildbucket for the build status
[17:25:05.696] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:05.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:53:0) after 1m0s
[17:26:05.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:53:0)
[17:26:05.724] Timer tick, asking Buildbucket for the build status
[17:26:05.889] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:05.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:54:0) after 1m0s
[17:27:06.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:54:0)
[17:27:06.282] Timer tick, asking Buildbucket for the build status
[17:27:06.366] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:06.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:55:0) after 1m0s
[17:28:06.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:55:0)
[17:28:06.491] Timer tick, asking Buildbucket for the build status
[17:28:06.800] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:06.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:56:0) after 1m0s
[17:29:06.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:56:0)
[17:29:06.887] Timer tick, asking Buildbucket for the build status
[17:29:07.161] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:07.161] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:57:0) after 1m0s
[17:30:08.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:57:0)
[17:30:08.787] Timer tick, asking Buildbucket for the build status
[17:30:09.253] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:09.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:58:0) after 1m0s
[17:31:09.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:58:0)
[17:31:09.268] Timer tick, asking Buildbucket for the build status
[17:31:09.418] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:09.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:59:0) after 1m0s
[17:32:09.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:59:0)
[17:32:09.535] Timer tick, asking Buildbucket for the build status
[17:32:09.731] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:09.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:60:0) after 1m0s
[17:33:09.773] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:60:0)
[17:33:09.773] Timer tick, asking Buildbucket for the build status
[17:33:09.854] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:09.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:61:0) after 1m0s
[17:34:09.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:61:0)
[17:34:09.878] Timer tick, asking Buildbucket for the build status
[17:34:09.959] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:09.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:62:0) after 1m0s
[17:35:10.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:62:0)
[17:35:10.016] Timer tick, asking Buildbucket for the build status
[17:35:10.123] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:10.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:63:0) after 1m0s
[17:36:12.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:63:0)
[17:36:12.238] Timer tick, asking Buildbucket for the build status
[17:36:12.365] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:12.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:64:0) after 1m0s
[17:37:12.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:64:0)
[17:37:12.481] Timer tick, asking Buildbucket for the build status
[17:37:12.575] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:12.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:65:0) after 1m0s
[17:38:13.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:65:0)
[17:38:13.126] Timer tick, asking Buildbucket for the build status
[17:38:15.593] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:15.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:66:0) after 1m0s
[17:39:15.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:66:0)
[17:39:15.648] Timer tick, asking Buildbucket for the build status
[17:39:15.732] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:15.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:67:0) after 1m0s
[17:40:15.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:67:0)
[17:40:15.766] Timer tick, asking Buildbucket for the build status
[17:40:16.076] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:16.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:68:0) after 1m0s
[17:41:16.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:68:0)
[17:41:16.113] Timer tick, asking Buildbucket for the build status
[17:41:16.226] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:16.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:69:0) after 1m0s
[17:42:16.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:69:0)
[17:42:16.272] Timer tick, asking Buildbucket for the build status
[17:42:16.422] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:16.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:70:0) after 1m0s
[17:43:16.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:70:0)
[17:43:16.503] Timer tick, asking Buildbucket for the build status
[17:43:16.585] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:16.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:71:0) after 1m0s
[17:44:16.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:71:0)
[17:44:16.687] Timer tick, asking Buildbucket for the build status
[17:44:16.783] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:16.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:72:0) after 1m0s
[17:45:16.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:72:0)
[17:45:16.932] Timer tick, asking Buildbucket for the build status
[17:45:17.898] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:17.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:73:0) after 1m0s
[17:46:17.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:73:0)
[17:46:17.939] Timer tick, asking Buildbucket for the build status
[17:46:18.032] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:18.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:74:0) after 1m0s
[17:47:18.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:74:0)
[17:47:18.117] Timer tick, asking Buildbucket for the build status
[17:47:18.207] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:18.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:75:0) after 1m0s
[17:48:18.345] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:75:0)
[17:48:18.345] Timer tick, asking Buildbucket for the build status
[17:48:18.420] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:18.420] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:76:0) after 1m0s
[17:49:18.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:76:0)
[17:49:18.537] Timer tick, asking Buildbucket for the build status
[17:49:18.757] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:18.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:77:0) after 1m0s
[17:50:18.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:77:0)
[17:50:18.809] Timer tick, asking Buildbucket for the build status
[17:50:21.254] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:21.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:78:0) after 1m0s
[17:51:21.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:78:0)
[17:51:21.329] Timer tick, asking Buildbucket for the build status
[17:51:22.128] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:22.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:79:0) after 1m0s
[17:52:22.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:79:0)
[17:52:22.209] Timer tick, asking Buildbucket for the build status
[17:52:22.418] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:22.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:80:0) after 1m0s
[17:53:22.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:80:0)
[17:53:22.501] Timer tick, asking Buildbucket for the build status
[17:53:22.594] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:22.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:81:0) after 1m0s
[17:54:22.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:81:0)
[17:54:22.705] Timer tick, asking Buildbucket for the build status
[17:54:22.843] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:22.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:82:0) after 1m0s
[17:55:22.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:82:0)
[17:55:22.918] Timer tick, asking Buildbucket for the build status
[17:55:23.550] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:23.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:83:0) after 1m0s
[17:56:23.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:83:0)
[17:56:23.627] Timer tick, asking Buildbucket for the build status
[17:56:23.711] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:23.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:84:0) after 1m0s
[17:57:23.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:84:0)
[17:57:23.739] Timer tick, asking Buildbucket for the build status
[17:57:23.978] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:23.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:85:0) after 1m0s
[17:58:24.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:85:0)
[17:58:24.099] Timer tick, asking Buildbucket for the build status
[17:58:24.202] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:24.202] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:86:0) after 1m0s
[17:59:24.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:86:0)
[17:59:24.271] Timer tick, asking Buildbucket for the build status
[17:59:24.421] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:24.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:87:0) after 1m0s
[18:00:24.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:87:0)
[18:00:24.528] Timer tick, asking Buildbucket for the build status
[18:00:24.781] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:24.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:88:0) after 1m0s
[18:01:24.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:88:0)
[18:01:24.967] Timer tick, asking Buildbucket for the build status
[18:01:25.073] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:25.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:89:0) after 1m0s
[18:02:25.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:89:0)
[18:02:25.079] Timer tick, asking Buildbucket for the build status
[18:02:25.490] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:25.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:90:0) after 1m0s
[18:03:25.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:90:0)
[18:03:25.549] Timer tick, asking Buildbucket for the build status
[18:03:25.761] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:25.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:91:0) after 1m0s
[18:04:25.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:91:0)
[18:04:25.827] Timer tick, asking Buildbucket for the build status
[18:04:26.024] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:26.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:92:0) after 1m0s
[18:05:26.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:92:0)
[18:05:26.051] Timer tick, asking Buildbucket for the build status
[18:05:26.240] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:26.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:93:0) after 1m0s
[18:06:26.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:93:0)
[18:06:26.280] Timer tick, asking Buildbucket for the build status
[18:06:26.677] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:26.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:94:0) after 1m0s
[18:07:26.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:94:0)
[18:07:26.683] Timer tick, asking Buildbucket for the build status
[18:07:26.826] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:26.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:95:0) after 1m0s
[18:08:26.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:95:0)
[18:08:26.854] Timer tick, asking Buildbucket for the build status
[18:08:27.176] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:27.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:96:0) after 1m0s
[18:09:27.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:96:0)
[18:09:27.202] Timer tick, asking Buildbucket for the build status
[18:09:27.292] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:27.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:97:0) after 1m0s
[18:10:27.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:97:0)
[18:10:27.368] Timer tick, asking Buildbucket for the build status
[18:10:27.556] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:27.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:98:0) after 1m0s
[18:11:27.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:98:0)
[18:11:27.625] Timer tick, asking Buildbucket for the build status
[18:11:27.856] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:27.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:99:0) after 1m0s
[18:12:27.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:99:0)
[18:12:27.856] Timer tick, asking Buildbucket for the build status
[18:12:28.028] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:28.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:100:0) after 1m0s
[18:13:28.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:100:0)
[18:13:28.213] Timer tick, asking Buildbucket for the build status
[18:13:28.285] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:28.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:101:0) after 1m0s
[18:14:28.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:101:0)
[18:14:28.315] Timer tick, asking Buildbucket for the build status
[18:14:28.437] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:28.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:102:0) after 1m0s
[18:15:28.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:102:0)
[18:15:28.518] Timer tick, asking Buildbucket for the build status
[18:15:28.732] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:28.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:103:0) after 1m0s
[18:16:28.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:103:0)
[18:16:28.849] Timer tick, asking Buildbucket for the build status
[18:16:30.647] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:30.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:104:0) after 1m0s
[18:17:30.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:104:0)
[18:17:30.749] Timer tick, asking Buildbucket for the build status
[18:17:31.002] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:31.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:105:0) after 1m0s
[18:18:31.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:105:0)
[18:18:31.092] Timer tick, asking Buildbucket for the build status
[18:18:31.869] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:31.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:106:0) after 1m0s
[18:19:31.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:106:0)
[18:19:31.996] Timer tick, asking Buildbucket for the build status
[18:19:32.076] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:32.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:107:0) after 1m0s
[18:20:32.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:107:0)
[18:20:32.264] Timer tick, asking Buildbucket for the build status
[18:20:32.831] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:32.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:108:0) after 1m0s
[18:21:32.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:108:0)
[18:21:32.932] Timer tick, asking Buildbucket for the build status
[18:21:33.086] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:33.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:109:0) after 1m0s
[18:22:33.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:109:0)
[18:22:33.145] Timer tick, asking Buildbucket for the build status
[18:22:33.331] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:33.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:110:0) after 1m0s
[18:23:33.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:110:0)
[18:23:33.430] Timer tick, asking Buildbucket for the build status
[18:23:33.563] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:33.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:111:0) after 1m0s
[18:24:33.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:111:0)
[18:24:33.666] Timer tick, asking Buildbucket for the build status
[18:24:34.098] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:34.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:112:0) after 1m0s
[18:25:34.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:112:0)
[18:25:34.145] Timer tick, asking Buildbucket for the build status
[18:25:35.098] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:35.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:113:0) after 1m0s
[18:26:35.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:113:0)
[18:26:35.249] Timer tick, asking Buildbucket for the build status
[18:26:35.357] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:35.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:114:0) after 1m0s
[18:27:35.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:114:0)
[18:27:35.468] Timer tick, asking Buildbucket for the build status
[18:27:35.570] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:35.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:115:0) after 1m0s
[18:28:35.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:115:0)
[18:28:35.725] Timer tick, asking Buildbucket for the build status
[18:28:35.994] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:35.994] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:116:0) after 1m0s
[18:29:36.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:116:0)
[18:29:36.078] Timer tick, asking Buildbucket for the build status
[18:29:36.304] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:36.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:117:0) after 1m0s
[18:30:36.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:117:0)
[18:30:36.318] Timer tick, asking Buildbucket for the build status
[18:30:42.354] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:42.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:118:0) after 1m0s
[18:31:43.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:118:0)
[18:31:43.005] Timer tick, asking Buildbucket for the build status
[18:31:43.203] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:43.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:119:0) after 1m0s
[18:32:44.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:119:0)
[18:32:44.833] Timer tick, asking Buildbucket for the build status
[18:32:45.052] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:45.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:120:0) after 1m0s
[18:33:45.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:120:0)
[18:33:45.116] Timer tick, asking Buildbucket for the build status
[18:33:45.190] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:45.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:121:0) after 1m0s
[18:34:45.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:121:0)
[18:34:45.247] Timer tick, asking Buildbucket for the build status
[18:34:45.450] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:45.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:122:0) after 1m0s
[18:35:45.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:122:0)
[18:35:45.561] Timer tick, asking Buildbucket for the build status
[18:35:45.755] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:45.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:123:0) after 1m0s
[18:36:46.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:123:0)
[18:36:46.004] Timer tick, asking Buildbucket for the build status
[18:36:46.172] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:46.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:124:0) after 1m0s
[18:37:46.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:124:0)
[18:37:46.314] Timer tick, asking Buildbucket for the build status
[18:37:46.473] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:46.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:125:0) after 1m0s
[18:38:46.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:125:0)
[18:38:46.501] Timer tick, asking Buildbucket for the build status
[18:38:47.025] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:47.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:126:0) after 1m0s
[18:39:47.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:126:0)
[18:39:47.087] Timer tick, asking Buildbucket for the build status
[18:39:47.550] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:47.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:127:0) after 1m0s
[18:40:47.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:127:0)
[18:40:47.630] Timer tick, asking Buildbucket for the build status
[18:40:47.927] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:47.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:128:0) after 1m0s
[18:41:48.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:128:0)
[18:41:48.028] Timer tick, asking Buildbucket for the build status
[18:41:48.433] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:48.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:129:0) after 1m0s
[18:42:48.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:129:0)
[18:42:48.547] Timer tick, asking Buildbucket for the build status
[18:42:48.685] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:48.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:130:0) after 1m0s
[18:43:48.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:130:0)
[18:43:48.792] Timer tick, asking Buildbucket for the build status
[18:43:49.132] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:49.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:131:0) after 1m0s
[18:44:49.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:131:0)
[18:44:49.176] Timer tick, asking Buildbucket for the build status
[18:44:49.335] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:49.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:132:0) after 1m0s
[18:45:49.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:132:0)
[18:45:49.444] Timer tick, asking Buildbucket for the build status
[18:45:49.563] Build 8873333388191445792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:49.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9038763451808949136:133:0) after 1m0s
[18:46:11.002] Received PubSub notification, asking Buildbucket for the build status
[18:46:11.428] Build 8873333388191445792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:46:11.428] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1596134769925687",
"created_by": "project:chromium",
"created_ts": "1596126868979822",
"id": "8873333388191445792",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b8567d2154bd7b5dc329f226e5885b1f63e146b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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-32-15-9t9r\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 17999, \"got_angle_revision\": \"8138cbbd875a6aa9b7daa4a4e6d2b83aecf9b310\", \"got_dawn_revision\": \"38ba51ce7ad82a4b4935ca5e71ea1570e2dd9ca3\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"3b8567d2154bd7b5dc329f226e5885b1f63e146b\", \"got_revision_cp\": \"refs/heads/master@{#793209}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"08a3cc4cfbaab73a59899d83ba82ab373f61cc87\", \"got_v8_revision\": \"78a8b5cff3beee6e5228d64098c745e8435b71b6\", \"got_v8_revision_cp\": \"refs/heads/8.6.281@{#1}\", \"got_webrtc_revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31810}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b8567d2154bd7b5dc329f226e5885b1f63e146b\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-15-9t9r\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1596126873378752",
"status": "COMPLETED",
"status_changed_ts": "1596134770543070",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/17999",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8567d2154bd7b5dc329f226e5885b1f63e146b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038763451808949136",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8873333388191445792/+/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:4db964c1b3e40c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1596134770548124",
"url": "https://ci.chromium.org/b/8873333388191445792",
"utcnow_ts": "1596134771391213"
}
}
[18:46:11.428] Invocation finished in 2h11m45.281997475s with status SUCCEEDED