[07:04:17.051] New invocation is queued and will start shortly
[07:04:18.586] Starting the invocation (attempt 1)
[07:04:18.653] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:04:18.654] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:04:18.654] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017690229490032192",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"96b6fd517163ca5d48185df79fa8ac1032622b72\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9017690229490032192",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96b6fd517163ca5d48185df79fa8ac1032622b72",
"gitiles_ref:refs/heads/master"
]
}
[07:04:19.339] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616223858806805",
"id": "8852260166986773056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96b6fd517163ca5d48185df79fa8ac1032622b72\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616223859211894",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/30497",
"builder:Deterministic Linux",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96b6fd517163ca5d48185df79fa8ac1032622b72",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017690229490032192",
"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/8852260166986773056/+/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": "1616223859212055",
"url": "https://ci.chromium.org/b/8852260166986773056",
"utcnow_ts": "1616223859333717"
}
}
[07:04:19.339] Task URL: https://ci.chromium.org/b/8852260166986773056
[07:04:19.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:2:0) after 1m0s
[07:05:19.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:2:0)
[07:05:19.659] Timer tick, asking Buildbucket for the build status
[07:05:19.782] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:3:0) after 1m0s
[07:06:19.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:3:0)
[07:06:19.902] Build status: SCHEDULED
[07:06:19.902] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:4:0) after 5m52s
[07:12:12.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:4:0)
[07:12:12.065] Timer tick, asking Buildbucket for the build status
[07:12:12.279] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:12.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:5:0) after 1m0s
[07:13:12.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:5:0)
[07:13:12.324] Build status: SCHEDULED
[07:13:12.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:6:0) after 7m20s
[07:20:32.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:6:0)
[07:20:32.363] Build status: SCHEDULED
[07:20:32.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:7:0) after 9m43s
[07:30:15.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:7:0)
[07:30:15.592] Timer tick, asking Buildbucket for the build status
[07:30:15.717] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:15.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:8:0) after 1m0s
[07:31:16.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:8:0)
[07:31:16.088] Build status: SCHEDULED
[07:31:16.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:9:0) after 4m37s
[07:35:53.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:9:0)
[07:35:53.514] Timer tick, asking Buildbucket for the build status
[07:35:53.652] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:53.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:10:0) after 1m0s
[07:36:53.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:10:0)
[07:36:53.781] Timer tick, asking Buildbucket for the build status
[07:36:53.897] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:53.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:11:0) after 1m0s
[07:37:53.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:11:0)
[07:37:53.903] Timer tick, asking Buildbucket for the build status
[07:37:53.961] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:53.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:12:0) after 1m0s
[07:38:54.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:12:0)
[07:38:54.058] Build status: SCHEDULED
[07:38:54.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:13:0) after 2m37s
[07:41:31.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:13:0)
[07:41:31.222] Timer tick, asking Buildbucket for the build status
[07:41:31.333] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:31.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:14:0) after 1m0s
[07:42:31.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:14:0)
[07:42:31.308] Timer tick, asking Buildbucket for the build status
[07:42:31.374] Build 8852260166986773056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:31.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:15:0) after 1m0s
[07:43:19.526] Received PubSub notification, asking Buildbucket for the build status
[07:43:19.552] Build status: STARTED
[07:43:31.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:15:0)
[07:43:31.542] Build status: STARTED
[07:43:31.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:17:0) after 8m16s
[07:51:47.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:17:0)
[07:51:47.569] Timer tick, asking Buildbucket for the build status
[07:51:47.667] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:47.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:18:0) after 1m0s
[07:52:47.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:18:0)
[07:52:47.698] Timer tick, asking Buildbucket for the build status
[07:52:47.784] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:47.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:19:0) after 1m0s
[07:53:47.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:19:0)
[07:53:47.829] Build status: STARTED
[07:53:47.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:20:0) after 6m39s
[08:00:26.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:20:0)
[08:00:26.884] Build status: STARTED
[08:00:26.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:21:0) after 3m16s
[08:03:43.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:21:0)
[08:03:43.285] Build status: STARTED
[08:03:43.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:22:0) after 8m29s
[08:12:12.270] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:22:0)
[08:12:12.294] Build status: STARTED
[08:12:12.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:23:0) after 1m8s
[08:13:20.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:23:0)
[08:13:20.326] Build status: STARTED
[08:13:20.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:24:0) after 8m59s
[08:22:19.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:24:0)
[08:22:19.334] Timer tick, asking Buildbucket for the build status
[08:22:19.581] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:19.581] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:25:0) after 1m0s
[08:23:19.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:25:0)
[08:23:19.558] Timer tick, asking Buildbucket for the build status
[08:23:19.619] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:19.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:26:0) after 1m0s
[08:24:19.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:26:0)
[08:24:19.730] Timer tick, asking Buildbucket for the build status
[08:24:20.037] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:20.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:27:0) after 1m0s
[08:25:20.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:27:0)
[08:25:20.072] Timer tick, asking Buildbucket for the build status
[08:25:20.305] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:20.305] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:28:0) after 1m0s
[08:26:20.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:28:0)
[08:26:20.357] Build status: STARTED
[08:26:20.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:29:0) after 9m8s
[08:35:28.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:29:0)
[08:35:28.410] Build status: STARTED
[08:35:28.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:30:0) after 7m3s
[08:42:31.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:30:0)
[08:42:31.427] Timer tick, asking Buildbucket for the build status
[08:42:31.686] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:31.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:31:0) after 1m0s
[08:43:31.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:31:0)
[08:43:31.738] Build status: STARTED
[08:43:31.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:32:0) after 6m12s
[08:49:43.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:32:0)
[08:49:43.827] Build status: STARTED
[08:49:43.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:33:0) after 8m2s
[08:57:45.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:33:0)
[08:57:45.897] Timer tick, asking Buildbucket for the build status
[08:57:45.982] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:45.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:34:0) after 1m0s
[08:58:46.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:34:0)
[08:58:46.001] Timer tick, asking Buildbucket for the build status
[08:58:46.064] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:46.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:35:0) after 1m0s
[08:59:46.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:35:0)
[08:59:46.271] Timer tick, asking Buildbucket for the build status
[08:59:46.360] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:46.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:36:0) after 1m0s
[09:00:46.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:36:0)
[09:00:46.539] Build status: STARTED
[09:00:46.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:37:0) after 9m52s
[09:10:38.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:37:0)
[09:10:38.592] Build status: STARTED
[09:10:38.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:38:0) after 6m43s
[09:17:21.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:38:0)
[09:17:21.671] Build status: STARTED
[09:17:21.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:39:0) after 1m23s
[09:18:44.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:39:0)
[09:18:44.690] Timer tick, asking Buildbucket for the build status
[09:18:44.990] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:44.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:40:0) after 1m0s
[09:19:45.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:40:0)
[09:19:45.040] Build status: STARTED
[09:19:45.040] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:41:0) after 1m39s
[09:21:24.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:41:0)
[09:21:24.087] Build status: STARTED
[09:21:24.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:42:0) after 9m2s
[09:30:26.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:42:0)
[09:30:26.131] Timer tick, asking Buildbucket for the build status
[09:30:26.229] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:43:0) after 1m0s
[09:31:26.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:43:0)
[09:31:26.392] Build status: STARTED
[09:31:26.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:44:0) after 1m21s
[09:32:47.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:44:0)
[09:32:47.437] Build status: STARTED
[09:32:47.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:45:0) after 9m52s
[09:42:39.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:45:0)
[09:42:39.535] Build status: STARTED
[09:42:39.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:46:0) after 6m32s
[09:49:11.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:46:0)
[09:49:11.752] Timer tick, asking Buildbucket for the build status
[09:49:12.057] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:12.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:47:0) after 1m0s
[09:50:12.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:47:0)
[09:50:12.186] Timer tick, asking Buildbucket for the build status
[09:50:12.303] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:12.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:48:0) after 1m0s
[09:51:12.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:48:0)
[09:51:12.326] Timer tick, asking Buildbucket for the build status
[09:51:12.413] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:12.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:49:0) after 1m0s
[09:52:12.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:49:0)
[09:52:12.448] Timer tick, asking Buildbucket for the build status
[09:52:12.638] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:12.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:50:0) after 1m0s
[09:53:12.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:50:0)
[09:53:12.703] Build status: STARTED
[09:53:12.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:51:0) after 9m9s
[10:02:21.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:51:0)
[10:02:21.728] Timer tick, asking Buildbucket for the build status
[10:02:21.842] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:21.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:52:0) after 1m0s
[10:03:21.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:52:0)
[10:03:21.975] Timer tick, asking Buildbucket for the build status
[10:03:22.065] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:22.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:53:0) after 1m0s
[10:04:22.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:53:0)
[10:04:22.245] Build status: STARTED
[10:04:22.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:54:0) after 5m40s
[10:10:02.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:54:0)
[10:10:02.271] Timer tick, asking Buildbucket for the build status
[10:10:02.357] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:02.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:55:0) after 1m0s
[10:11:02.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:55:0)
[10:11:02.475] Timer tick, asking Buildbucket for the build status
[10:11:02.543] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:02.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:56:0) after 1m0s
[10:12:02.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:56:0)
[10:12:02.578] Timer tick, asking Buildbucket for the build status
[10:12:02.692] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:02.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:57:0) after 1m0s
[10:13:02.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:57:0)
[10:13:02.738] Build status: STARTED
[10:13:02.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:58:0) after 9m37s
[10:22:39.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:58:0)
[10:22:39.780] Build status: STARTED
[10:22:39.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:59:0) after 1m30s
[10:24:09.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:59:0)
[10:24:09.930] Build status: STARTED
[10:24:09.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:60:0) after 1m50s
[10:25:59.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:60:0)
[10:26:00.019] Build status: STARTED
[10:26:00.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:61:0) after 3m40s
[10:29:40.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:61:0)
[10:29:40.097] Timer tick, asking Buildbucket for the build status
[10:29:40.393] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:40.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:62:0) after 1m0s
[10:30:40.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:62:0)
[10:30:40.413] Timer tick, asking Buildbucket for the build status
[10:30:40.639] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:40.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:63:0) after 1m0s
[10:31:40.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:63:0)
[10:31:40.670] Timer tick, asking Buildbucket for the build status
[10:31:40.739] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:40.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:64:0) after 1m0s
[10:32:40.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:64:0)
[10:32:40.795] Build status: STARTED
[10:32:40.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:65:0) after 9m38s
[10:42:18.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:65:0)
[10:42:18.861] Timer tick, asking Buildbucket for the build status
[10:42:18.951] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:18.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:66:0) after 1m0s
[10:43:18.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:66:0)
[10:43:19.251] Build status: STARTED
[10:43:19.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:67:0) after 4m26s
[10:47:45.308] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:67:0)
[10:47:45.333] Build status: STARTED
[10:47:45.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:68:0) after 9m1s
[10:56:46.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:68:0)
[10:56:46.468] Timer tick, asking Buildbucket for the build status
[10:56:46.606] Build 8852260166986773056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:46.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:69:0) after 1m0s
[10:57:46.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:69:0)
[10:57:46.685] Build status: STARTED
[10:57:46.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:70:0) after 4m42s
[11:02:28.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:70:0)
[11:02:28.959] Build status: STARTED
[11:02:28.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9017690229490032192:71:0) after 2m11s
[11:02:31.615] Received PubSub notification, asking Buildbucket for the build status
[11:02:32.500] Build 8852260166986773056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:02:32.500] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616238150841104",
"created_by": "project:chromium",
"created_ts": "1616223858806805",
"id": "8852260166986773056",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96b6fd517163ca5d48185df79fa8ac1032622b72\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-43-1ok7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 30497, \"got_angle_revision\": \"d5bc8a27abec7e86ea555f816e6dfa3947a2ffa5\", \"got_dawn_revision\": \"853b5d765e715fc11ea28c1d3754e48d38c283b1\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"96b6fd517163ca5d48185df79fa8ac1032622b72\", \"got_revision_cp\": \"refs/heads/master@{#864938}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"66377e9eee38ae5d2bec601ec40a6e7e792169bf\", \"got_v8_revision_cp\": \"refs/heads/9.1.169@{#1}\", \"got_webrtc_revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33510}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"96b6fd517163ca5d48185df79fa8ac1032622b72\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_53a369b6e7b3f2409540d71b27a68c8bcf1cb73633e70dba0b4b8b173a0aec5e_v2\", \"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_7b27d20986eac2bbcc1513665f8799c69dbe398236c21423fd80a70475184e3c_v2\", \"builder_7ddc1ece4c938056809d45345930c5d8ea6799936d2255389af4f16219f397ac_v2\", \"builder_fbb3d50a702ddd064319c35d96f4b89f6e7a29ba4c11145a49be75e11fea82c5_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-43-1ok7\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616226198098214",
"status": "COMPLETED",
"status_changed_ts": "1616238151210380",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/30497",
"builder:Deterministic Linux",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96b6fd517163ca5d48185df79fa8ac1032622b72",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017690229490032192",
"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/8852260166986773056/+/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:5267447c177c2610",
"user_agent:luci-scheduler"
],
"updated_ts": "1616238151215062",
"url": "https://ci.chromium.org/b/8852260166986773056",
"utcnow_ts": "1616238152403198"
}
}
[11:02:32.500] Invocation finished in 3h58m15.46496142s with status SUCCEEDED