[09:22:03.299] New invocation is queued and will start shortly
[09:22:04.563] Starting the invocation (attempt 1)
[09:22:04.596] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:22:04.596] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:22:04.596] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055822884558479648",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c747570d3ccffc199c837ee42be43b40790fb82e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9055822884558479648",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/c747570d3ccffc199c837ee42be43b40790fb82e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c747570d3ccffc199c837ee42be43b40790fb82e",
"gitiles_ref:refs/heads/master"
]
}
[09:22:06.153] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579857725190981",
"id": "8890392821908903952",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c747570d3ccffc199c837ee42be43b40790fb82e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579857725905597",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26572",
"builder:Deterministic Linux",
"buildset:commit/git/c747570d3ccffc199c837ee42be43b40790fb82e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c747570d3ccffc199c837ee42be43b40790fb82e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055822884558479648",
"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/8890392821908903952/+/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": "1579857725905765",
"url": "https://ci.chromium.org/b/8890392821908903952",
"utcnow_ts": "1579857726136849"
}
}
[09:22:06.153] Task URL: https://ci.chromium.org/b/8890392821908903952
[09:22:06.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:2:0) after 1m0s
[09:22:09.425] Received PubSub notification, asking Buildbucket for the build status
[09:22:09.713] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:06.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:2:0)
[09:23:06.275] Timer tick, asking Buildbucket for the build status
[09:23:07.829] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:07.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:4:0) after 1m0s
[09:24:07.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:4:0)
[09:24:07.907] Timer tick, asking Buildbucket for the build status
[09:24:08.224] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:08.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:5:0) after 1m0s
[09:25:08.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:5:0)
[09:25:08.275] Timer tick, asking Buildbucket for the build status
[09:25:08.754] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:08.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:6:0) after 1m0s
[09:26:08.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:6:0)
[09:26:08.801] Timer tick, asking Buildbucket for the build status
[09:26:08.991] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:08.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:7:0) after 1m0s
[09:27:09.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:7:0)
[09:27:09.052] Timer tick, asking Buildbucket for the build status
[09:27:09.269] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:09.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:8:0) after 1m0s
[09:28:09.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:8:0)
[09:28:09.276] Timer tick, asking Buildbucket for the build status
[09:28:09.535] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:09.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:9:0) after 1m0s
[09:29:09.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:9:0)
[09:29:09.580] Timer tick, asking Buildbucket for the build status
[09:29:10.078] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:10.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:10:0) after 1m0s
[09:30:10.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:10:0)
[09:30:10.146] Timer tick, asking Buildbucket for the build status
[09:30:10.406] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:10.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:11:0) after 1m0s
[09:31:10.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:11:0)
[09:31:10.661] Timer tick, asking Buildbucket for the build status
[09:31:11.541] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:11.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:12:0) after 1m0s
[09:32:11.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:12:0)
[09:32:11.516] Timer tick, asking Buildbucket for the build status
[09:32:11.987] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:11.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:13:0) after 1m0s
[09:33:12.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:13:0)
[09:33:12.031] Timer tick, asking Buildbucket for the build status
[09:33:12.728] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:12.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:14:0) after 1m0s
[09:34:12.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:14:0)
[09:34:12.744] Timer tick, asking Buildbucket for the build status
[09:34:12.999] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:12.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:15:0) after 1m0s
[09:35:13.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:15:0)
[09:35:13.058] Timer tick, asking Buildbucket for the build status
[09:35:13.916] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:13.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:16:0) after 1m0s
[09:36:13.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:16:0)
[09:36:13.972] Timer tick, asking Buildbucket for the build status
[09:36:14.533] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:14.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:17:0) after 1m0s
[09:37:14.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:17:0)
[09:37:14.510] Timer tick, asking Buildbucket for the build status
[09:37:14.709] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:14.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:18:0) after 1m0s
[09:38:14.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:18:0)
[09:38:14.725] Timer tick, asking Buildbucket for the build status
[09:38:14.872] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:19:0) after 1m0s
[09:39:14.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:19:0)
[09:39:14.904] Timer tick, asking Buildbucket for the build status
[09:39:15.270] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:15.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:20:0) after 1m0s
[09:40:15.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:20:0)
[09:40:15.333] Timer tick, asking Buildbucket for the build status
[09:40:15.921] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:21:0) after 1m0s
[09:41:15.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:21:0)
[09:41:15.953] Timer tick, asking Buildbucket for the build status
[09:41:16.203] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:16.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:22:0) after 1m0s
[09:42:16.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:22:0)
[09:42:16.291] Timer tick, asking Buildbucket for the build status
[09:42:16.636] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:16.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:23:0) after 1m0s
[09:43:16.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:23:0)
[09:43:16.700] Timer tick, asking Buildbucket for the build status
[09:43:16.862] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:16.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:24:0) after 1m0s
[09:44:16.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:24:0)
[09:44:16.958] Timer tick, asking Buildbucket for the build status
[09:44:17.416] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:17.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:25:0) after 1m0s
[09:45:17.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:25:0)
[09:45:17.455] Timer tick, asking Buildbucket for the build status
[09:45:18.983] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:18.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:26:0) after 1m0s
[09:46:19.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:26:0)
[09:46:19.230] Timer tick, asking Buildbucket for the build status
[09:46:19.482] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:27:0) after 1m0s
[09:47:19.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:27:0)
[09:47:19.581] Timer tick, asking Buildbucket for the build status
[09:47:19.932] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:19.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:28:0) after 1m0s
[09:48:19.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:28:0)
[09:48:19.997] Timer tick, asking Buildbucket for the build status
[09:48:20.270] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:20.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:29:0) after 1m0s
[09:49:20.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:29:0)
[09:49:20.337] Timer tick, asking Buildbucket for the build status
[09:49:22.216] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:22.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:30:0) after 1m0s
[09:50:22.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:30:0)
[09:50:22.344] Timer tick, asking Buildbucket for the build status
[09:50:22.605] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:22.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:31:0) after 1m0s
[09:51:22.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:31:0)
[09:51:22.666] Timer tick, asking Buildbucket for the build status
[09:51:22.887] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:22.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:32:0) after 1m0s
[09:52:22.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:32:0)
[09:52:22.926] Timer tick, asking Buildbucket for the build status
[09:52:23.160] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:23.160] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:33:0) after 1m0s
[09:53:23.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:33:0)
[09:53:23.213] Timer tick, asking Buildbucket for the build status
[09:53:23.556] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:23.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:34:0) after 1m0s
[09:54:23.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:34:0)
[09:54:23.573] Timer tick, asking Buildbucket for the build status
[09:54:24.141] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:24.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:35:0) after 1m0s
[09:55:24.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:35:0)
[09:55:24.197] Timer tick, asking Buildbucket for the build status
[09:55:24.916] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:24.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:36:0) after 1m0s
[09:56:24.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:36:0)
[09:56:24.994] Timer tick, asking Buildbucket for the build status
[09:56:25.397] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:25.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:37:0) after 1m0s
[09:57:25.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:37:0)
[09:57:25.489] Timer tick, asking Buildbucket for the build status
[09:57:25.940] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:25.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:38:0) after 1m0s
[09:58:26.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:38:0)
[09:58:26.113] Timer tick, asking Buildbucket for the build status
[09:58:26.530] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:26.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:39:0) after 1m0s
[09:59:26.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:39:0)
[09:59:26.620] Timer tick, asking Buildbucket for the build status
[09:59:27.281] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:27.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:40:0) after 1m0s
[10:00:27.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:40:0)
[10:00:27.419] Timer tick, asking Buildbucket for the build status
[10:00:27.629] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:27.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:41:0) after 1m0s
[10:01:27.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:41:0)
[10:01:27.818] Timer tick, asking Buildbucket for the build status
[10:01:28.040] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:28.040] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:42:0) after 1m0s
[10:02:28.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:42:0)
[10:02:28.333] Timer tick, asking Buildbucket for the build status
[10:02:29.049] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:29.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:43:0) after 1m0s
[10:03:29.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:43:0)
[10:03:29.239] Timer tick, asking Buildbucket for the build status
[10:03:29.575] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:29.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:44:0) after 1m0s
[10:04:29.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:44:0)
[10:04:29.579] Timer tick, asking Buildbucket for the build status
[10:04:29.727] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:45:0) after 1m0s
[10:05:29.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:45:0)
[10:05:29.805] Timer tick, asking Buildbucket for the build status
[10:05:29.999] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:29.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:46:0) after 1m0s
[10:06:30.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:46:0)
[10:06:30.014] Timer tick, asking Buildbucket for the build status
[10:06:30.442] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:30.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:47:0) after 1m0s
[10:07:30.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:47:0)
[10:07:30.498] Timer tick, asking Buildbucket for the build status
[10:07:30.743] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:30.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:48:0) after 1m0s
[10:08:30.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:48:0)
[10:08:30.728] Timer tick, asking Buildbucket for the build status
[10:08:30.903] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:30.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:49:0) after 1m0s
[10:09:31.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:49:0)
[10:09:31.088] Timer tick, asking Buildbucket for the build status
[10:09:31.566] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:31.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:50:0) after 1m0s
[10:10:31.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:50:0)
[10:10:31.655] Timer tick, asking Buildbucket for the build status
[10:10:32.263] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:32.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:51:0) after 1m0s
[10:11:32.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:51:0)
[10:11:32.339] Timer tick, asking Buildbucket for the build status
[10:11:32.531] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:32.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:52:0) after 1m0s
[10:12:32.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:52:0)
[10:12:32.589] Timer tick, asking Buildbucket for the build status
[10:12:32.784] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:32.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:53:0) after 1m0s
[10:13:32.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:53:0)
[10:13:32.858] Timer tick, asking Buildbucket for the build status
[10:13:33.072] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:33.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:54:0) after 1m0s
[10:14:33.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:54:0)
[10:14:33.139] Timer tick, asking Buildbucket for the build status
[10:14:33.611] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:33.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:55:0) after 1m0s
[10:15:33.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:55:0)
[10:15:33.671] Timer tick, asking Buildbucket for the build status
[10:15:34.102] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:34.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:56:0) after 1m0s
[10:16:34.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:56:0)
[10:16:34.122] Timer tick, asking Buildbucket for the build status
[10:16:34.272] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:34.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:57:0) after 1m0s
[10:17:34.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:57:0)
[10:17:34.346] Timer tick, asking Buildbucket for the build status
[10:17:34.548] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:34.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:58:0) after 1m0s
[10:18:34.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:58:0)
[10:18:34.652] Timer tick, asking Buildbucket for the build status
[10:18:34.879] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:34.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:59:0) after 1m0s
[10:19:34.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:59:0)
[10:19:34.965] Timer tick, asking Buildbucket for the build status
[10:19:35.392] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:35.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:60:0) after 1m0s
[10:20:35.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:60:0)
[10:20:35.416] Timer tick, asking Buildbucket for the build status
[10:20:36.720] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:36.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:61:0) after 1m0s
[10:21:36.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:61:0)
[10:21:36.823] Timer tick, asking Buildbucket for the build status
[10:21:37.447] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:37.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:62:0) after 1m0s
[10:22:37.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:62:0)
[10:22:37.549] Timer tick, asking Buildbucket for the build status
[10:22:38.182] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:38.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:63:0) after 1m0s
[10:23:38.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:63:0)
[10:23:38.262] Timer tick, asking Buildbucket for the build status
[10:23:38.467] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:38.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:64:0) after 1m0s
[10:24:38.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:64:0)
[10:24:38.603] Timer tick, asking Buildbucket for the build status
[10:24:38.801] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:38.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:65:0) after 1m0s
[10:25:38.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:65:0)
[10:25:38.916] Timer tick, asking Buildbucket for the build status
[10:25:39.562] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:39.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:66:0) after 1m0s
[10:26:39.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:66:0)
[10:26:39.641] Timer tick, asking Buildbucket for the build status
[10:26:39.801] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:39.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:67:0) after 1m0s
[10:27:39.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:67:0)
[10:27:39.854] Timer tick, asking Buildbucket for the build status
[10:27:40.047] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:40.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:68:0) after 1m0s
[10:28:40.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:68:0)
[10:28:40.078] Timer tick, asking Buildbucket for the build status
[10:28:40.510] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:40.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:69:0) after 1m0s
[10:29:40.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:69:0)
[10:29:40.597] Timer tick, asking Buildbucket for the build status
[10:29:40.875] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:70:0) after 1m0s
[10:30:40.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:70:0)
[10:30:40.947] Timer tick, asking Buildbucket for the build status
[10:30:42.507] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:42.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:71:0) after 1m0s
[10:31:42.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:71:0)
[10:31:42.537] Timer tick, asking Buildbucket for the build status
[10:31:42.883] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:42.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:72:0) after 1m0s
[10:32:43.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:72:0)
[10:32:43.012] Timer tick, asking Buildbucket for the build status
[10:32:43.291] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:43.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:73:0) after 1m0s
[10:33:43.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:73:0)
[10:33:43.344] Timer tick, asking Buildbucket for the build status
[10:33:44.123] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:44.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:74:0) after 1m0s
[10:34:44.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:74:0)
[10:34:44.223] Timer tick, asking Buildbucket for the build status
[10:34:44.468] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:44.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:75:0) after 1m0s
[10:35:44.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:75:0)
[10:35:44.541] Timer tick, asking Buildbucket for the build status
[10:35:44.744] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:44.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:76:0) after 1m0s
[10:36:44.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:76:0)
[10:36:44.806] Timer tick, asking Buildbucket for the build status
[10:36:45.338] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:45.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:77:0) after 1m0s
[10:37:45.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:77:0)
[10:37:45.640] Timer tick, asking Buildbucket for the build status
[10:37:45.853] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:45.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:78:0) after 1m0s
[10:38:46.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:78:0)
[10:38:46.206] Timer tick, asking Buildbucket for the build status
[10:38:48.177] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:48.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:79:0) after 1m0s
[10:39:48.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:79:0)
[10:39:48.395] Timer tick, asking Buildbucket for the build status
[10:39:48.569] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:48.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:80:0) after 1m0s
[10:40:48.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:80:0)
[10:40:48.567] Timer tick, asking Buildbucket for the build status
[10:40:48.780] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:48.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:81:0) after 1m0s
[10:41:48.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:81:0)
[10:41:48.875] Timer tick, asking Buildbucket for the build status
[10:41:49.494] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:49.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:82:0) after 1m0s
[10:42:49.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:82:0)
[10:42:49.576] Timer tick, asking Buildbucket for the build status
[10:42:49.771] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:49.771] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:83:0) after 1m0s
[10:43:49.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:83:0)
[10:43:49.973] Timer tick, asking Buildbucket for the build status
[10:43:50.135] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:50.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:84:0) after 1m0s
[10:44:50.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:84:0)
[10:44:50.181] Timer tick, asking Buildbucket for the build status
[10:44:50.312] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:50.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:85:0) after 1m0s
[10:45:50.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:85:0)
[10:45:50.548] Timer tick, asking Buildbucket for the build status
[10:45:50.737] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:50.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:86:0) after 1m0s
[10:46:50.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:86:0)
[10:46:50.991] Timer tick, asking Buildbucket for the build status
[10:46:51.158] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:51.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:87:0) after 1m0s
[10:47:51.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:87:0)
[10:47:51.250] Timer tick, asking Buildbucket for the build status
[10:47:51.710] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:51.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:88:0) after 1m0s
[10:48:51.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:88:0)
[10:48:51.744] Timer tick, asking Buildbucket for the build status
[10:48:52.177] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:52.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:89:0) after 1m0s
[10:49:52.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:89:0)
[10:49:52.202] Timer tick, asking Buildbucket for the build status
[10:49:52.461] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:52.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:90:0) after 1m0s
[10:50:52.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:90:0)
[10:50:52.488] Timer tick, asking Buildbucket for the build status
[10:50:52.873] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:52.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:91:0) after 1m0s
[10:51:52.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:91:0)
[10:51:52.890] Timer tick, asking Buildbucket for the build status
[10:51:53.343] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:53.343] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:92:0) after 1m0s
[10:52:53.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:92:0)
[10:52:53.366] Timer tick, asking Buildbucket for the build status
[10:52:53.728] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:53.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:93:0) after 1m0s
[10:53:53.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:93:0)
[10:53:53.769] Timer tick, asking Buildbucket for the build status
[10:53:54.054] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:54.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:94:0) after 1m0s
[10:54:54.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:94:0)
[10:54:54.146] Timer tick, asking Buildbucket for the build status
[10:54:54.419] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:54.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:95:0) after 1m0s
[10:55:54.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:95:0)
[10:55:54.520] Timer tick, asking Buildbucket for the build status
[10:55:54.717] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:54.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:96:0) after 1m0s
[10:56:54.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:96:0)
[10:56:54.738] Timer tick, asking Buildbucket for the build status
[10:56:55.165] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:97:0) after 1m0s
[10:57:55.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:97:0)
[10:57:55.247] Timer tick, asking Buildbucket for the build status
[10:57:57.967] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:57.967] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:98:0) after 1m0s
[10:58:58.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:98:0)
[10:58:58.027] Timer tick, asking Buildbucket for the build status
[10:58:58.272] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:58.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:99:0) after 1m0s
[10:59:58.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:99:0)
[10:59:58.349] Timer tick, asking Buildbucket for the build status
[10:59:58.731] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:58.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:100:0) after 1m0s
[11:00:58.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:100:0)
[11:00:58.870] Timer tick, asking Buildbucket for the build status
[11:01:00.142] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:00.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:101:0) after 1m0s
[11:02:00.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:101:0)
[11:02:00.165] Timer tick, asking Buildbucket for the build status
[11:02:00.555] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:00.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:102:0) after 1m0s
[11:03:00.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:102:0)
[11:03:00.601] Timer tick, asking Buildbucket for the build status
[11:03:02.382] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:02.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:103:0) after 1m0s
[11:04:02.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:103:0)
[11:04:02.408] Timer tick, asking Buildbucket for the build status
[11:04:02.658] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:02.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:104:0) after 1m0s
[11:05:02.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:104:0)
[11:05:02.688] Timer tick, asking Buildbucket for the build status
[11:05:04.258] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:04.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:105:0) after 1m0s
[11:06:04.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:105:0)
[11:06:04.293] Timer tick, asking Buildbucket for the build status
[11:06:04.497] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:04.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:106:0) after 1m0s
[11:07:04.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:106:0)
[11:07:04.775] Timer tick, asking Buildbucket for the build status
[11:07:05.167] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:05.167] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:107:0) after 1m0s
[11:08:05.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:107:0)
[11:08:05.236] Timer tick, asking Buildbucket for the build status
[11:08:05.652] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:05.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:108:0) after 1m0s
[11:09:05.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:108:0)
[11:09:05.679] Timer tick, asking Buildbucket for the build status
[11:09:05.906] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:05.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:109:0) after 1m0s
[11:10:05.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:109:0)
[11:10:05.898] Timer tick, asking Buildbucket for the build status
[11:10:06.486] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:06.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:110:0) after 1m0s
[11:11:06.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:110:0)
[11:11:06.524] Timer tick, asking Buildbucket for the build status
[11:11:06.820] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:06.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:111:0) after 1m0s
[11:12:06.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:111:0)
[11:12:06.864] Timer tick, asking Buildbucket for the build status
[11:12:07.029] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:07.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:112:0) after 1m0s
[11:13:07.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:112:0)
[11:13:07.116] Timer tick, asking Buildbucket for the build status
[11:13:07.302] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:07.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:113:0) after 1m0s
[11:14:07.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:113:0)
[11:14:07.347] Timer tick, asking Buildbucket for the build status
[11:14:07.906] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:114:0) after 1m0s
[11:15:07.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:114:0)
[11:15:07.968] Timer tick, asking Buildbucket for the build status
[11:15:08.187] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:08.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:115:0) after 1m0s
[11:16:08.211] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:115:0)
[11:16:08.211] Timer tick, asking Buildbucket for the build status
[11:16:09.003] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:116:0) after 1m0s
[11:17:09.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:116:0)
[11:17:09.071] Timer tick, asking Buildbucket for the build status
[11:17:09.603] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:09.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:117:0) after 1m0s
[11:18:09.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:117:0)
[11:18:09.631] Timer tick, asking Buildbucket for the build status
[11:18:10.163] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:118:0) after 1m0s
[11:19:10.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:118:0)
[11:19:10.167] Timer tick, asking Buildbucket for the build status
[11:19:10.500] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:10.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:119:0) after 1m0s
[11:20:10.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:119:0)
[11:20:10.524] Timer tick, asking Buildbucket for the build status
[11:20:10.786] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:10.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:120:0) after 1m0s
[11:21:10.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:120:0)
[11:21:10.826] Timer tick, asking Buildbucket for the build status
[11:21:11.010] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:11.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:121:0) after 1m0s
[11:22:11.030] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:121:0)
[11:22:11.030] Timer tick, asking Buildbucket for the build status
[11:22:11.232] Build 8890392821908903952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:11.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9055822884558479648:122:0) after 1m0s
[11:22:15.016] Received PubSub notification, asking Buildbucket for the build status
[11:22:15.368] Build 8890392821908903952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:22:15.368] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579864934065203",
"created_by": "project:chromium",
"created_ts": "1579857725190981",
"id": "8890392821908903952",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c747570d3ccffc199c837ee42be43b40790fb82e\"}}",
"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-us-central1-b-8-129-k9bo\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26572, \"got_angle_revision\": \"f3b4e6c3030f826d446fa8cb833fd7d49d21a37c\", \"got_dawn_revision\": \"d87e67684558fd46e15c382b78558fb13a091920\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"c747570d3ccffc199c837ee42be43b40790fb82e\", \"got_revision_cp\": \"refs/heads/master@{#734856}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5ef91b82cbedb4e262af2cb4fddaee7006de8818\", \"got_v8_revision\": \"a6d9d08d7c6ccb9d370342ff4a2423f711297550\", \"got_v8_revision_cp\": \"refs/heads/8.1.272@{#1}\", \"got_webrtc_revision\": \"760fd5249488a7a8698679a026b247423caa7cce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30366}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c747570d3ccffc199c837ee42be43b40790fb82e\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4f073cad989671df25347297d55a43b2baed7923c7c8febe8eed874750cd540a_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-129-k9bo\"], \"image\": [\"chrome-xenial-20011200-47b90f1b63b\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4792-2014df3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579857728101482",
"status": "COMPLETED",
"status_changed_ts": "1579864934384507",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26572",
"builder:Deterministic Linux",
"buildset:commit/git/c747570d3ccffc199c837ee42be43b40790fb82e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c747570d3ccffc199c837ee42be43b40790fb82e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055822884558479648",
"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/8890392821908903952/+/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:49efad5393083d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579864934455374",
"url": "https://ci.chromium.org/b/8890392821908903952",
"utcnow_ts": "1579864935360662"
}
}
[11:22:15.368] Invocation finished in 2h0m12.088848176s with status SUCCEEDED