[14:42:51.570] New invocation is queued and will start shortly
[14:42:52.982] Starting the invocation (attempt 1)
[14:42:53.016] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:42:53.016] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:42:53.016] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075371646023752448",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"74cf65e4adebd0afa7b15061e8a7799ebc6c342d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9075371646023752448",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"gitiles_ref:refs/heads/master"
]
}
[14:42:53.799] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561214573186672",
"id": "8909941583665528288",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"74cf65e4adebd0afa7b15061e8a7799ebc6c342d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561214573683768",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23827",
"builder:Deterministic Linux",
"buildset:commit/git/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075371646023752448",
"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/8909941583665528288/+/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": "1561214573683859",
"url": "https://ci.chromium.org/b/8909941583665528288",
"utcnow_ts": "1561214573791799"
}
}
[14:42:53.799] Task URL: https://ci.chromium.org/b/8909941583665528288
[14:42:53.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:2:0) after 1m0s
[14:42:56.780] Received PubSub notification, asking Buildbucket for the build status
[14:42:56.989] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:53.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:2:0)
[14:43:53.774] Timer tick, asking Buildbucket for the build status
[14:43:53.964] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:53.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:4:0) after 1m0s
[14:44:53.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:4:0)
[14:44:53.990] Timer tick, asking Buildbucket for the build status
[14:44:54.139] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:54.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:5:0) after 1m0s
[14:45:54.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:5:0)
[14:45:54.168] Timer tick, asking Buildbucket for the build status
[14:45:54.297] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:54.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:6:0) after 1m0s
[14:46:54.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:6:0)
[14:46:54.477] Timer tick, asking Buildbucket for the build status
[14:46:55.528] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:55.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:7:0) after 1m0s
[14:47:55.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:7:0)
[14:47:55.549] Timer tick, asking Buildbucket for the build status
[14:47:55.688] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:55.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:8:0) after 1m0s
[14:48:55.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:8:0)
[14:48:55.671] Timer tick, asking Buildbucket for the build status
[14:48:56.225] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:56.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:9:0) after 1m0s
[14:49:56.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:9:0)
[14:49:56.243] Timer tick, asking Buildbucket for the build status
[14:49:56.537] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:56.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:10:0) after 1m0s
[14:50:56.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:10:0)
[14:50:56.564] Timer tick, asking Buildbucket for the build status
[14:50:57.509] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:57.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:11:0) after 1m0s
[14:51:57.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:11:0)
[14:51:57.628] Timer tick, asking Buildbucket for the build status
[14:51:57.775] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:57.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:12:0) after 1m0s
[14:52:57.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:12:0)
[14:52:57.796] Timer tick, asking Buildbucket for the build status
[14:52:57.927] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:57.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:13:0) after 1m0s
[14:53:57.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:13:0)
[14:53:57.918] Timer tick, asking Buildbucket for the build status
[14:53:58.339] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:58.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:14:0) after 1m0s
[14:54:58.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:14:0)
[14:54:58.433] Timer tick, asking Buildbucket for the build status
[14:54:59.049] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:59.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:15:0) after 1m0s
[14:55:59.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:15:0)
[14:55:59.089] Timer tick, asking Buildbucket for the build status
[14:55:59.209] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:59.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:16:0) after 1m0s
[14:56:59.529] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:16:0)
[14:56:59.529] Timer tick, asking Buildbucket for the build status
[14:56:59.656] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:59.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:17:0) after 1m0s
[14:57:59.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:17:0)
[14:57:59.816] Timer tick, asking Buildbucket for the build status
[14:58:00.478] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:00.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:18:0) after 1m0s
[14:59:00.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:18:0)
[14:59:00.669] Timer tick, asking Buildbucket for the build status
[14:59:00.770] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:00.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:19:0) after 1m0s
[15:00:00.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:19:0)
[15:00:00.788] Timer tick, asking Buildbucket for the build status
[15:00:01.172] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:01.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:20:0) after 1m0s
[15:01:01.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:20:0)
[15:01:01.242] Timer tick, asking Buildbucket for the build status
[15:01:01.438] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:01.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:21:0) after 1m0s
[15:02:01.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:21:0)
[15:02:01.534] Timer tick, asking Buildbucket for the build status
[15:02:01.890] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:01.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:22:0) after 1m0s
[15:03:01.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:22:0)
[15:03:01.939] Timer tick, asking Buildbucket for the build status
[15:03:02.338] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:02.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:23:0) after 1m0s
[15:04:02.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:23:0)
[15:04:02.609] Timer tick, asking Buildbucket for the build status
[15:04:03.513] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:03.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:24:0) after 1m0s
[15:05:03.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:24:0)
[15:05:03.570] Timer tick, asking Buildbucket for the build status
[15:05:03.683] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:03.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:25:0) after 1m0s
[15:06:03.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:25:0)
[15:06:03.914] Timer tick, asking Buildbucket for the build status
[15:06:05.088] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:05.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:26:0) after 1m0s
[15:07:05.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:26:0)
[15:07:05.219] Timer tick, asking Buildbucket for the build status
[15:07:05.333] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:05.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:27:0) after 1m0s
[15:08:05.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:27:0)
[15:08:05.477] Timer tick, asking Buildbucket for the build status
[15:08:06.526] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:06.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:28:0) after 1m0s
[15:09:06.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:28:0)
[15:09:06.574] Timer tick, asking Buildbucket for the build status
[15:09:07.798] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:07.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:29:0) after 1m0s
[15:10:07.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:29:0)
[15:10:07.822] Timer tick, asking Buildbucket for the build status
[15:10:08.359] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:08.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:30:0) after 1m0s
[15:11:08.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:30:0)
[15:11:08.378] Timer tick, asking Buildbucket for the build status
[15:11:10.587] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:10.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:31:0) after 1m0s
[15:12:10.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:31:0)
[15:12:10.592] Timer tick, asking Buildbucket for the build status
[15:12:12.419] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:12.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:32:0) after 1m0s
[15:13:12.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:32:0)
[15:13:12.477] Timer tick, asking Buildbucket for the build status
[15:13:12.910] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:33:0) after 1m0s
[15:14:12.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:33:0)
[15:14:12.952] Timer tick, asking Buildbucket for the build status
[15:14:13.521] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:13.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:34:0) after 1m0s
[15:15:13.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:34:0)
[15:15:13.625] Timer tick, asking Buildbucket for the build status
[15:15:14.323] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:14.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:35:0) after 1m0s
[15:16:14.357] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:35:0)
[15:16:14.357] Timer tick, asking Buildbucket for the build status
[15:16:15.162] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:15.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:36:0) after 1m0s
[15:17:15.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:36:0)
[15:17:15.333] Timer tick, asking Buildbucket for the build status
[15:17:15.806] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:15.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:37:0) after 1m0s
[15:18:15.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:37:0)
[15:18:15.887] Timer tick, asking Buildbucket for the build status
[15:18:18.249] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:18.249] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:38:0) after 1m0s
[15:19:18.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:38:0)
[15:19:18.371] Timer tick, asking Buildbucket for the build status
[15:19:18.917] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:18.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:39:0) after 1m0s
[15:20:18.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:39:0)
[15:20:18.997] Timer tick, asking Buildbucket for the build status
[15:20:19.163] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:19.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:40:0) after 1m0s
[15:21:19.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:40:0)
[15:21:19.184] Timer tick, asking Buildbucket for the build status
[15:21:19.422] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:19.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:41:0) after 1m0s
[15:22:19.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:41:0)
[15:22:19.451] Timer tick, asking Buildbucket for the build status
[15:22:20.042] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:20.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:42:0) after 1m0s
[15:23:20.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:42:0)
[15:23:20.073] Timer tick, asking Buildbucket for the build status
[15:23:20.195] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:20.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:43:0) after 1m0s
[15:24:20.214] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:43:0)
[15:24:20.214] Timer tick, asking Buildbucket for the build status
[15:24:20.741] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:20.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:44:0) after 1m0s
[15:25:20.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:44:0)
[15:25:20.757] Timer tick, asking Buildbucket for the build status
[15:25:20.921] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:20.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:45:0) after 1m0s
[15:26:21.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:45:0)
[15:26:21.007] Timer tick, asking Buildbucket for the build status
[15:26:21.176] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:21.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:46:0) after 1m0s
[15:27:21.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:46:0)
[15:27:21.289] Timer tick, asking Buildbucket for the build status
[15:27:21.669] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:21.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:47:0) after 1m0s
[15:28:21.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:47:0)
[15:28:21.701] Timer tick, asking Buildbucket for the build status
[15:28:23.301] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:48:0) after 1m0s
[15:29:23.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:48:0)
[15:29:23.439] Timer tick, asking Buildbucket for the build status
[15:29:24.135] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:24.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:49:0) after 1m0s
[15:30:24.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:49:0)
[15:30:24.159] Timer tick, asking Buildbucket for the build status
[15:30:24.329] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:24.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:50:0) after 1m0s
[15:31:24.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:50:0)
[15:31:24.413] Timer tick, asking Buildbucket for the build status
[15:31:24.733] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:24.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:51:0) after 1m0s
[15:32:24.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:51:0)
[15:32:24.849] Timer tick, asking Buildbucket for the build status
[15:32:25.394] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:25.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:52:0) after 1m0s
[15:33:25.426] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:52:0)
[15:33:25.426] Timer tick, asking Buildbucket for the build status
[15:33:25.545] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:25.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:53:0) after 1m0s
[15:34:25.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:53:0)
[15:34:25.575] Timer tick, asking Buildbucket for the build status
[15:34:25.698] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:25.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:54:0) after 1m0s
[15:35:25.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:54:0)
[15:35:25.729] Timer tick, asking Buildbucket for the build status
[15:35:27.138] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:27.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:55:0) after 1m0s
[15:36:27.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:55:0)
[15:36:27.231] Timer tick, asking Buildbucket for the build status
[15:36:28.108] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:28.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:56:0) after 1m0s
[15:37:28.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:56:0)
[15:37:28.146] Timer tick, asking Buildbucket for the build status
[15:37:29.430] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:29.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:57:0) after 1m0s
[15:38:29.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:57:0)
[15:38:29.504] Timer tick, asking Buildbucket for the build status
[15:38:29.896] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:29.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:58:0) after 1m0s
[15:39:29.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:58:0)
[15:39:29.916] Timer tick, asking Buildbucket for the build status
[15:39:30.547] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:30.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:59:0) after 1m0s
[15:40:30.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:59:0)
[15:40:30.608] Timer tick, asking Buildbucket for the build status
[15:40:31.180] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:31.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:60:0) after 1m0s
[15:41:31.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:60:0)
[15:41:31.223] Timer tick, asking Buildbucket for the build status
[15:41:31.438] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:31.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:61:0) after 1m0s
[15:42:31.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:61:0)
[15:42:31.545] Timer tick, asking Buildbucket for the build status
[15:42:31.688] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:31.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:62:0) after 1m0s
[15:43:31.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:62:0)
[15:43:31.814] Timer tick, asking Buildbucket for the build status
[15:43:33.439] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:63:0) after 1m0s
[15:44:33.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:63:0)
[15:44:33.458] Timer tick, asking Buildbucket for the build status
[15:44:33.622] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:33.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:64:0) after 1m0s
[15:45:33.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:64:0)
[15:45:33.697] Timer tick, asking Buildbucket for the build status
[15:45:34.799] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:34.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:65:0) after 1m0s
[15:46:34.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:65:0)
[15:46:34.853] Timer tick, asking Buildbucket for the build status
[15:46:34.983] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:34.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:66:0) after 1m0s
[15:47:35.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:66:0)
[15:47:35.018] Timer tick, asking Buildbucket for the build status
[15:47:35.245] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:35.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:67:0) after 1m0s
[15:48:35.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:67:0)
[15:48:35.314] Timer tick, asking Buildbucket for the build status
[15:48:35.602] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:35.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:68:0) after 1m0s
[15:49:35.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:68:0)
[15:49:35.622] Timer tick, asking Buildbucket for the build status
[15:49:35.775] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:35.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:69:0) after 1m0s
[15:50:35.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:69:0)
[15:50:35.851] Timer tick, asking Buildbucket for the build status
[15:50:36.041] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:36.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:70:0) after 1m0s
[15:51:36.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:70:0)
[15:51:36.086] Timer tick, asking Buildbucket for the build status
[15:51:36.280] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:71:0) after 1m0s
[15:52:36.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:71:0)
[15:52:36.378] Timer tick, asking Buildbucket for the build status
[15:52:36.617] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:36.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:72:0) after 1m0s
[15:53:36.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:72:0)
[15:53:36.756] Timer tick, asking Buildbucket for the build status
[15:53:37.216] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:73:0) after 1m0s
[15:54:37.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:73:0)
[15:54:37.278] Timer tick, asking Buildbucket for the build status
[15:54:37.700] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:37.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:74:0) after 1m0s
[15:55:37.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:74:0)
[15:55:37.869] Timer tick, asking Buildbucket for the build status
[15:55:38.527] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:75:0) after 1m0s
[15:56:38.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:75:0)
[15:56:38.717] Timer tick, asking Buildbucket for the build status
[15:56:39.621] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:39.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:76:0) after 1m0s
[15:57:39.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:76:0)
[15:57:39.658] Timer tick, asking Buildbucket for the build status
[15:57:46.258] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:46.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:77:0) after 1m0s
[15:58:46.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:77:0)
[15:58:46.290] Timer tick, asking Buildbucket for the build status
[15:58:47.369] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:47.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:78:0) after 1m0s
[15:59:47.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:78:0)
[15:59:47.407] Timer tick, asking Buildbucket for the build status
[15:59:47.536] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:47.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:79:0) after 1m0s
[16:00:47.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:79:0)
[16:00:47.575] Timer tick, asking Buildbucket for the build status
[16:00:49.079] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:49.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:80:0) after 1m0s
[16:01:49.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:80:0)
[16:01:49.114] Timer tick, asking Buildbucket for the build status
[16:01:50.813] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:50.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:81:0) after 1m0s
[16:02:50.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:81:0)
[16:02:50.836] Timer tick, asking Buildbucket for the build status
[16:02:51.039] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:51.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:82:0) after 1m0s
[16:03:51.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:82:0)
[16:03:51.080] Timer tick, asking Buildbucket for the build status
[16:03:51.216] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:51.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:83:0) after 1m0s
[16:04:51.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:83:0)
[16:04:51.324] Timer tick, asking Buildbucket for the build status
[16:04:52.657] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:84:0) after 1m0s
[16:05:52.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:84:0)
[16:05:52.731] Timer tick, asking Buildbucket for the build status
[16:05:53.809] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:53.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:85:0) after 1m0s
[16:06:53.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:85:0)
[16:06:53.886] Timer tick, asking Buildbucket for the build status
[16:06:54.159] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:54.159] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:86:0) after 1m0s
[16:07:54.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:86:0)
[16:07:54.187] Timer tick, asking Buildbucket for the build status
[16:07:54.710] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:54.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:87:0) after 1m0s
[16:08:54.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:87:0)
[16:08:54.756] Timer tick, asking Buildbucket for the build status
[16:08:56.244] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:56.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:88:0) after 1m0s
[16:09:56.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:88:0)
[16:09:56.297] Timer tick, asking Buildbucket for the build status
[16:09:57.508] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:89:0) after 1m0s
[16:10:57.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:89:0)
[16:10:57.537] Timer tick, asking Buildbucket for the build status
[16:10:57.833] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:57.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:90:0) after 1m0s
[16:11:57.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:90:0)
[16:11:57.913] Timer tick, asking Buildbucket for the build status
[16:11:58.971] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:91:0) after 1m0s
[16:12:59.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:91:0)
[16:12:59.006] Timer tick, asking Buildbucket for the build status
[16:12:59.822] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:59.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:92:0) after 1m0s
[16:13:59.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:92:0)
[16:13:59.894] Timer tick, asking Buildbucket for the build status
[16:14:00.084] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:00.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:93:0) after 1m0s
[16:15:00.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:93:0)
[16:15:00.121] Timer tick, asking Buildbucket for the build status
[16:15:00.386] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:00.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:94:0) after 1m0s
[16:16:00.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:94:0)
[16:16:00.417] Timer tick, asking Buildbucket for the build status
[16:16:02.687] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:02.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:95:0) after 1m0s
[16:17:02.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:95:0)
[16:17:02.708] Timer tick, asking Buildbucket for the build status
[16:17:03.242] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:03.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:96:0) after 1m0s
[16:18:03.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:96:0)
[16:18:03.236] Timer tick, asking Buildbucket for the build status
[16:18:04.738] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:04.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:97:0) after 1m0s
[16:19:04.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:97:0)
[16:19:04.762] Timer tick, asking Buildbucket for the build status
[16:19:05.183] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:05.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:98:0) after 1m0s
[16:20:05.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:98:0)
[16:20:05.215] Timer tick, asking Buildbucket for the build status
[16:20:05.371] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:05.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:99:0) after 1m0s
[16:21:05.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:99:0)
[16:21:05.392] Timer tick, asking Buildbucket for the build status
[16:21:05.562] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:05.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:100:0) after 1m0s
[16:22:05.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:100:0)
[16:22:05.596] Timer tick, asking Buildbucket for the build status
[16:22:05.835] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:101:0) after 1m0s
[16:23:05.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:101:0)
[16:23:05.857] Timer tick, asking Buildbucket for the build status
[16:23:06.930] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:06.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:102:0) after 1m0s
[16:24:07.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:102:0)
[16:24:07.059] Timer tick, asking Buildbucket for the build status
[16:24:07.271] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:07.271] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:103:0) after 1m0s
[16:25:07.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:103:0)
[16:25:07.326] Timer tick, asking Buildbucket for the build status
[16:25:07.515] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:07.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:104:0) after 1m0s
[16:26:07.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:104:0)
[16:26:07.549] Timer tick, asking Buildbucket for the build status
[16:26:08.112] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:08.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:105:0) after 1m0s
[16:27:08.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:105:0)
[16:27:08.202] Timer tick, asking Buildbucket for the build status
[16:27:08.439] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:106:0) after 1m0s
[16:28:08.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:106:0)
[16:28:08.467] Timer tick, asking Buildbucket for the build status
[16:28:11.521] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:11.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:107:0) after 1m0s
[16:29:11.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:107:0)
[16:29:11.545] Timer tick, asking Buildbucket for the build status
[16:29:11.663] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:11.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:108:0) after 1m0s
[16:30:11.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:108:0)
[16:30:11.683] Timer tick, asking Buildbucket for the build status
[16:30:11.888] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:11.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:109:0) after 1m0s
[16:31:11.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:109:0)
[16:31:11.979] Timer tick, asking Buildbucket for the build status
[16:31:13.345] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:13.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:110:0) after 1m0s
[16:32:13.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:110:0)
[16:32:13.372] Timer tick, asking Buildbucket for the build status
[16:32:18.403] Build 8909941583665528288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:18.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075371646023752448:111:0) after 1m0s
[16:32:49.011] Received PubSub notification, asking Buildbucket for the build status
[16:32:49.778] Build 8909941583665528288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:32:49.778] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561221166598740",
"created_by": "project:chromium",
"created_ts": "1561214573186672",
"id": "8909941583665528288",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"74cf65e4adebd0afa7b15061e8a7799ebc6c342d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-trusty-8-9-3vwz\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23827, \"got_angle_revision\": \"dfd760055152076509c59b23e1604d83a7435688\", \"got_dawn_revision\": \"4ec2c1060e85678809c73bd9ee81120567b23dd8\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"74cf65e4adebd0afa7b15061e8a7799ebc6c342d\", \"got_revision_cp\": \"refs/heads/master@{#671539}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"f887b1751d2707b193466a974dd46e5023959cc4\", \"got_v8_revision_cp\": \"refs/heads/7.7.132@{#1}\", \"got_webrtc_revision\": \"abf7eba8658c6facda98210399bf88d0c5f72036\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28339}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"74cf65e4adebd0afa7b15061e8a7799ebc6c342d\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_360e090537af5d0e85670c6ae42c4dc4bbec8921cc650184022f9d46f257e3c4_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_b9f10e617e36b89b59cf2468f05559e0083126a9b3741fee04e133349127cbf2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-9-3vwz\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561214575187880",
"status": "COMPLETED",
"status_changed_ts": "1561221168205325",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23827",
"builder:Deterministic Linux",
"buildset:commit/git/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74cf65e4adebd0afa7b15061e8a7799ebc6c342d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075371646023752448",
"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/8909941583665528288/+/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:459875669a451510",
"user_agent:luci-scheduler"
],
"updated_ts": "1561221168210026",
"url": "https://ci.chromium.org/b/8909941583665528288",
"utcnow_ts": "1561221169770725"
}
}
[16:32:49.778] Invocation finished in 1h49m58.225016335s with status SUCCEEDED