[18:39:36.502] New invocation is queued and will start shortly
[18:39:37.590] Starting the invocation (attempt 1)
[18:39:37.635] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:39:37.635] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:39:37.635] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027521552812890080",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027521552812890080",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"gitiles_ref:refs/heads/master"
]
}
[18:39:39.311] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606847977820507",
"id": "8862091490767933424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606847979006797",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43348",
"builder:linux-chromeos-rel",
"buildset:commit/git/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027521552812890080",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862091490767933424/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1606847979006979",
"url": "https://ci.chromium.org/b/8862091490767933424",
"utcnow_ts": "1606847979279524"
}
}
[18:39:39.311] Task URL: https://ci.chromium.org/b/8862091490767933424
[18:39:39.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:2:0) after 1m0s
[18:39:41.243] Received PubSub notification, asking Buildbucket for the build status
[18:39:41.312] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:39.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:2:0)
[18:40:39.631] Timer tick, asking Buildbucket for the build status
[18:40:39.816] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:39.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:4:0) after 1m0s
[18:41:40.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:4:0)
[18:41:40.031] Timer tick, asking Buildbucket for the build status
[18:41:41.022] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:5:0) after 1m0s
[18:42:41.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:5:0)
[18:42:41.231] Timer tick, asking Buildbucket for the build status
[18:42:41.379] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:41.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:6:0) after 1m0s
[18:43:41.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:6:0)
[18:43:41.588] Timer tick, asking Buildbucket for the build status
[18:43:41.764] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:41.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:7:0) after 1m0s
[18:44:41.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:7:0)
[18:44:41.997] Timer tick, asking Buildbucket for the build status
[18:44:42.362] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:42.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:8:0) after 1m0s
[18:45:42.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:8:0)
[18:45:42.570] Timer tick, asking Buildbucket for the build status
[18:45:42.720] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:42.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:9:0) after 1m0s
[18:46:42.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:9:0)
[18:46:42.846] Timer tick, asking Buildbucket for the build status
[18:46:42.953] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:42.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:10:0) after 1m0s
[18:47:43.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:10:0)
[18:47:43.074] Timer tick, asking Buildbucket for the build status
[18:47:43.127] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:43.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:11:0) after 1m0s
[18:48:43.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:11:0)
[18:48:43.144] Timer tick, asking Buildbucket for the build status
[18:48:43.748] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:43.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:12:0) after 1m0s
[18:49:43.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:12:0)
[18:49:43.801] Timer tick, asking Buildbucket for the build status
[18:49:44.671] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:44.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:13:0) after 1m0s
[18:50:44.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:13:0)
[18:50:44.762] Timer tick, asking Buildbucket for the build status
[18:50:45.028] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:45.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:14:0) after 1m0s
[18:51:45.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:14:0)
[18:51:45.049] Timer tick, asking Buildbucket for the build status
[18:51:45.153] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:45.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:15:0) after 1m0s
[18:52:45.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:15:0)
[18:52:45.213] Timer tick, asking Buildbucket for the build status
[18:52:45.407] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:45.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:16:0) after 1m0s
[18:53:45.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:16:0)
[18:53:45.441] Timer tick, asking Buildbucket for the build status
[18:53:45.505] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:45.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:17:0) after 1m0s
[18:54:45.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:17:0)
[18:54:45.611] Timer tick, asking Buildbucket for the build status
[18:54:45.744] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:45.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:18:0) after 1m0s
[18:55:45.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:18:0)
[18:55:45.771] Timer tick, asking Buildbucket for the build status
[18:55:45.839] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:45.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:19:0) after 1m0s
[18:56:45.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:19:0)
[18:56:45.941] Timer tick, asking Buildbucket for the build status
[18:56:46.007] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:46.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:20:0) after 1m0s
[18:57:46.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:20:0)
[18:57:46.139] Timer tick, asking Buildbucket for the build status
[18:57:46.204] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:46.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:21:0) after 1m0s
[18:58:46.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:21:0)
[18:58:46.287] Timer tick, asking Buildbucket for the build status
[18:58:46.608] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:46.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:22:0) after 1m0s
[18:59:46.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:22:0)
[18:59:46.667] Timer tick, asking Buildbucket for the build status
[18:59:46.987] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:46.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:23:0) after 1m0s
[19:00:47.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:23:0)
[19:00:47.036] Timer tick, asking Buildbucket for the build status
[19:00:47.204] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:47.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:24:0) after 1m0s
[19:01:47.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:24:0)
[19:01:47.262] Timer tick, asking Buildbucket for the build status
[19:01:47.672] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:47.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:25:0) after 1m0s
[19:02:47.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:25:0)
[19:02:47.764] Timer tick, asking Buildbucket for the build status
[19:02:47.838] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:47.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:26:0) after 1m0s
[19:03:47.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:26:0)
[19:03:47.998] Timer tick, asking Buildbucket for the build status
[19:03:48.106] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:48.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:27:0) after 1m0s
[19:04:48.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:27:0)
[19:04:48.297] Timer tick, asking Buildbucket for the build status
[19:04:48.535] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:28:0) after 1m0s
[19:05:48.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:28:0)
[19:05:48.652] Timer tick, asking Buildbucket for the build status
[19:05:48.902] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:29:0) after 1m0s
[19:06:49.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:29:0)
[19:06:49.009] Timer tick, asking Buildbucket for the build status
[19:06:49.118] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:30:0) after 1m0s
[19:07:49.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:30:0)
[19:07:49.127] Timer tick, asking Buildbucket for the build status
[19:07:49.655] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:49.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:31:0) after 1m0s
[19:08:49.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:31:0)
[19:08:49.822] Timer tick, asking Buildbucket for the build status
[19:08:49.939] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:49.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:32:0) after 1m0s
[19:09:50.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:32:0)
[19:09:50.005] Timer tick, asking Buildbucket for the build status
[19:09:50.891] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:50.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:33:0) after 1m0s
[19:10:50.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:33:0)
[19:10:50.903] Timer tick, asking Buildbucket for the build status
[19:10:51.041] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:51.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:34:0) after 1m0s
[19:11:51.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:34:0)
[19:11:51.122] Timer tick, asking Buildbucket for the build status
[19:11:51.187] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:35:0) after 1m0s
[19:12:51.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:35:0)
[19:12:51.218] Timer tick, asking Buildbucket for the build status
[19:12:51.292] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:51.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:36:0) after 1m0s
[19:13:51.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:36:0)
[19:13:51.314] Timer tick, asking Buildbucket for the build status
[19:13:51.424] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:51.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:37:0) after 1m0s
[19:14:51.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:37:0)
[19:14:51.486] Timer tick, asking Buildbucket for the build status
[19:14:51.720] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:51.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:38:0) after 1m0s
[19:15:51.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:38:0)
[19:15:51.824] Timer tick, asking Buildbucket for the build status
[19:15:51.897] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:51.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:39:0) after 1m0s
[19:16:52.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:39:0)
[19:16:52.075] Timer tick, asking Buildbucket for the build status
[19:16:52.454] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:52.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:40:0) after 1m0s
[19:17:52.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:40:0)
[19:17:52.482] Timer tick, asking Buildbucket for the build status
[19:17:52.657] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:41:0) after 1m0s
[19:18:52.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:41:0)
[19:18:52.802] Timer tick, asking Buildbucket for the build status
[19:18:53.077] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:53.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:42:0) after 1m0s
[19:19:53.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:42:0)
[19:19:53.213] Timer tick, asking Buildbucket for the build status
[19:19:53.341] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:53.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:43:0) after 1m0s
[19:20:53.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:43:0)
[19:20:53.482] Timer tick, asking Buildbucket for the build status
[19:20:53.708] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:44:0) after 1m0s
[19:21:53.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:44:0)
[19:21:53.757] Timer tick, asking Buildbucket for the build status
[19:21:54.086] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:54.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:45:0) after 1m0s
[19:22:54.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:45:0)
[19:22:54.186] Timer tick, asking Buildbucket for the build status
[19:22:54.935] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:54.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:46:0) after 1m0s
[19:23:55.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:46:0)
[19:23:55.122] Timer tick, asking Buildbucket for the build status
[19:23:55.242] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:55.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:47:0) after 1m0s
[19:24:55.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:47:0)
[19:24:55.357] Timer tick, asking Buildbucket for the build status
[19:24:55.490] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:55.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:48:0) after 1m0s
[19:25:55.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:48:0)
[19:25:55.577] Timer tick, asking Buildbucket for the build status
[19:25:56.936] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:56.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:49:0) after 1m0s
[19:26:57.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:49:0)
[19:26:57.007] Timer tick, asking Buildbucket for the build status
[19:26:57.142] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:57.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:50:0) after 1m0s
[19:27:57.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:50:0)
[19:27:57.163] Timer tick, asking Buildbucket for the build status
[19:27:57.342] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:57.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:51:0) after 1m0s
[19:28:57.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:51:0)
[19:28:57.398] Timer tick, asking Buildbucket for the build status
[19:28:57.591] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:57.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:52:0) after 1m0s
[19:29:57.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:52:0)
[19:29:57.719] Timer tick, asking Buildbucket for the build status
[19:29:57.862] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:57.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:53:0) after 1m0s
[19:30:57.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:53:0)
[19:30:57.964] Timer tick, asking Buildbucket for the build status
[19:30:58.380] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:58.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:54:0) after 1m0s
[19:31:58.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:54:0)
[19:31:58.419] Timer tick, asking Buildbucket for the build status
[19:31:58.574] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:58.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:55:0) after 1m0s
[19:32:58.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:55:0)
[19:32:58.730] Timer tick, asking Buildbucket for the build status
[19:32:59.441] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:59.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:56:0) after 1m0s
[19:33:59.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:56:0)
[19:33:59.470] Timer tick, asking Buildbucket for the build status
[19:33:59.801] Build 8862091490767933424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:59.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027521552812890080:57:0) after 1m0s
[19:34:35.692] Received PubSub notification, asking Buildbucket for the build status
[19:34:35.935] Build 8862091490767933424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:34:35.935] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606851272336549",
"created_by": "project:chromium",
"created_ts": "1606847977820507",
"id": "8862091490767933424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\", \"project\": \"chromium/src\"}], \"$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-158-dnw9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43348, \"got_angle_revision\": \"df873e5fa6d33d5d402cf90dc6106e6812bc71f7\", \"got_dawn_revision\": \"a6a7e46e54518bd730caf47ef4d4a01ff81f9123\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\", \"got_revision_cp\": \"refs/heads/master@{#832433}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"bfb211914759cc5deffbe9419cd1c2cae0573488\", \"got_v8_revision\": \"4f7b9247f5edfccbe90dfa8ced02893e7fd38d23\", \"got_v8_revision_cp\": \"refs/heads/8.9.72@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8\", \"swarm_hashes_refs/heads/master(at){#832433}_without_patch\": {\"absl_hardening_tests\": \"e79ea0b0c20ccd340d88165da1b6649ca89bc02b\", \"accessibility_unittests\": \"01cf81310cf778f64ac2b5fe780f442f3384a557\", \"angle_unittests\": \"2aca586b0ac1b0e41a7d3e6be6d77a7d8b611bbf\", \"app_list_unittests\": \"792d46ebf8ff356d6475926fa6651d2876da55e2\", \"app_shell_unittests\": \"b8fc41b8911b4642962955de5461cd99f490f9f6\", \"ash_unittests\": \"faf3e558ef0ee91225b592c49a91c10ea26caaae\", \"aura_unittests\": \"d725c0472cd02c660815e4bb9cd876098c1a6e43\", \"base_unittests\": \"14eec3fea492eea535271f60587650a63f6cef59\", \"base_util_unittests\": \"017e126f0080ea79b94e63159983c53de7755b88\", \"blink_common_unittests\": \"44c2d6f53f27bfdb6c7321c3c5d6cf6abd454da5\", \"blink_fuzzer_unittests\": \"3bf255a7cfe3e2d2cb2085bf46227c41ea9c644b\", \"blink_heap_unittests\": \"219ccbaa78b2308e912f202e5c13533693e90fe6\", \"blink_platform_unittests\": \"3ca2bbd82c4b0a9ecfa00f7913f70429fb05c773\", \"blink_unittests\": \"43f2e05131da328e6c584eccebec661564d970a2\", \"boringssl_crypto_tests\": \"b6851291bace290e45488ad0140a61b2da85fd75\", \"boringssl_ssl_tests\": \"097fef1d28f361e5f76f261a9b87972a3b815dbc\", \"browser_tests\": \"627322b25e52130d4b8449f30dafa164171f4b60\", \"capture_unittests\": \"743ebc15f342b2321a01f973086c27e259cdd6b7\", \"cast_unittests\": \"573494e75d03e5c039178a38ae1900a7c638ebf7\", \"cc_unittests\": \"6abda5f0af81ac581e6448bb491ce213967036af\", \"chrome_app_unittests\": \"64b8564b0e951d7653b42a0718fcc88c59207b20\", \"chromedriver_unittests\": \"71aa14af6a8765d2a28a00c03650071caba52ae6\", \"chromeos_components_unittests\": \"551522af8438d5ce09dd74271114ae55bd4567f3\", \"chromeos_unittests\": \"04dfa17ccdf368359ba3c06358fe68c3bcb9e39b\", \"components_browsertests\": \"cb016bd0d282c4f16e26efeb33056b4bbd1d3705\", \"components_unittests\": \"558369ae97c32e3c0cc8c8dd93120c4208229775\", \"compositor_unittests\": \"7cc90b6a79f2163bd5d81944435a01531ec51c6b\", \"content_browsertests\": \"091e24dab1d9a95530c1dd1d36d27f7ebbe54e05\", \"content_unittests\": \"2828ebb8f8167fa06ad4961c35865ec01c03c16e\", \"crashpad_tests\": \"fb38007e0211a1c40a94ef5764ada852feff1347\", \"crypto_unittests\": \"f54c8ebe04a8ec198dc7edd326d90aeef694d5d8\", \"dbus_unittests\": \"ab79ed6274630b6481f36c5b5df24058882b994e\", \"device_unittests\": \"300be82f5c1a9a930388691075192d2d2f871b88\", \"display_unittests\": \"2fed6b27bd1763145d7cae07624fc29dca7bae60\", \"events_unittests\": \"6f117758e0e95ee14c64c4fe7b713843fe8a42fc\", \"exo_unittests\": \"e65a2a859a9ef3b08d85afc38592f5831cbb3974\", \"extensions_browsertests\": \"f542c6ad0640c4133788460ae54dd9a9d5e877e3\", \"extensions_unittests\": \"45f1b23f3ae62627e2cdcd554cd6ca7cf5ad84f0\", \"filesystem_service_unittests\": \"0ab7e5f58b5c2c201609e55f93f338a437ccfabf\", \"gcm_unit_tests\": \"68de14fc657c167ee6f065662dcc9d957bfef81e\", \"gfx_unittests\": \"8ec4c74509a0b28ef52999a9cb574a0a71c91ac2\", \"gin_unittests\": \"56b22d506dc5d100c20c849598e4f46b498aa88b\", \"gl_unittests_ozone\": \"ecd15922e0c1a58818d6ba88b94268671af57a85\", \"google_apis_unittests\": \"d183dd1c3d21e03769f4212c9ac3f0af3d7b569b\", \"gpu_unittests\": \"6efdb4e5be6b4a98b96de642fc68c3a6c2e654b7\", \"gwp_asan_unittests\": \"b2ac7a3a0c6c7fd2dfa16338153ecd69647b4867\", \"interactive_ui_tests\": \"1e0ada3ea41a55872b63c939fa7a4679cd9d30bf\", \"ipc_tests\": \"a0e0c25968902c042d0f49ab3a2de2ebfc4fa4a0\", \"jingle_unittests\": \"881d800d919765f71573b18b2f41c8bfa457d182\", \"keyboard_unittests\": \"b6f2d3b7887ac505d692a54122bd5f03ae9bfe6d\", \"latency_unittests\": \"7e47e0ae22b3764679b63bc3fa81a681965bb995\", \"libjingle_xmpp_unittests\": \"fb1d5eaf8366bc6b32198723c823c966f5b721e9\", \"liburlpattern_unittests\": \"d7a45c96bd4c3cd508d8825aed10c7d378754c41\", \"media_blink_unittests\": \"0f183bb0243200eb8031443c4c02826e563e18e7\", \"media_unittests\": \"14899cfeb114a6ed37330f852eefa69b07b529e5\", \"message_center_unittests\": \"ad305d6de3f250aac7a3b23f9d2d53fa17d363cb\", \"midi_unittests\": \"50c101a4d94096c8f6b607cf012e97d7ccff3e38\", \"mojo_core_unittests\": \"c3b7e4a97a8e21e2e418079c111163ddd0bf5e92\", \"mojo_unittests\": \"4b9b198588f4797b6c38f336774d471bf3a60b20\", \"nacl_helper_nonsfi_unittests\": \"657daf53cb960a672794fd555ba2720b9a532306\", \"nacl_loader_unittests\": \"1053f1cb051d223b469da7ba3ef2780d18ead797\", \"native_theme_unittests\": \"30352703afc9c47bf90a76e2acf51e480808b745\", \"net_unittests\": \"a2a559a9af6694ae788bafdb9dae0a86020c7c8c\", \"ozone_gl_unittests\": \"788a01e314f2ac0beefde70f80007fbbbf4384ff\", \"ozone_unittests\": \"38d4684d542fa78f6fe3b882be978cb06fae39a0\", \"ozone_x11_unittests\": \"2ef382512b468b750c10630e268f60f3c296608c\", \"pdf_unittests\": \"a52629c37176042d864a1c943cf765865fe5777a\", \"perfetto_unittests\": \"22ef647c16eecbb8362a44e4b908965e5029df9c\", \"ppapi_unittests\": \"041825db0b2de9e9f6008c29b53b5d324bfd43da\", \"printing_unittests\": \"d027dc8fe309ab9c14b3ee323a27e5284795162f\", \"remoting_unittests\": \"01b5ca7e1edc964f389973d3b9c9fd4bd480013e\", \"sandbox_linux_unittests\": \"edeffc80db65de798a71e8c1840712ad6e72b93f\", \"service_manager_unittests\": \"0321ee692de41da32ee2e98926595638888ca6d4\", \"services_unittests\": \"659d4bddd1a158ac8a5b6008bd7b172d3b6b95a0\", \"shell_dialogs_unittests\": \"6087a34d11aef08494270aec6f905c1467806970\", \"skia_unittests\": \"9fce2c8304e7631b781180d0123b38e51ddd8697\", \"snapshot_unittests\": \"20dbf36d8a92e1786ed6b7d0899f60710bc0fd53\", \"sql_unittests\": \"8a04f6e8c4fc5f988b3c67b51a1b2a23ee673023\", \"storage_unittests\": \"1c409f0a80e8452f37942cb3c324f3ce74bc3c5e\", \"sync_integration_tests\": \"7b61257c64d5232b237df1067f68a7fa858d41a0\", \"traffic_annotation_auditor_unittests\": \"1d64866b3a9b99744a606e0b234f3a5475000a5e\", \"ui_base_unittests\": \"781d2906b21f8eb405ddf51ab797590d5a126f3f\", \"ui_chromeos_unittests\": \"246e04f8d112ae733b810c55643a7e509d0fa40d\", \"ui_touch_selection_unittests\": \"f6af1f0b805d4acaa9d1acbcc55c74f7bd3a9b09\", \"unit_tests\": \"d17e87b35fc4216cb25c61a4d0d10f1a826befa1\", \"url_unittests\": \"f63912285a271d287c13037137de61666e8f7cea\", \"usage_time_limit_unittests\": \"2950b9992611b9dac89590dba22c5d190850dd2b\", \"views_unittests\": \"d75a59a4bed845b3c3048ddbdb09359e28751370\", \"viz_unittests\": \"9b446b872b4b33d1419b5809ebf07b280f7bc33c\", \"wayland_client_perftests\": \"49ef6b473ecac28f86f09c19cbb19ebe662c44d5\", \"wm_unittests\": \"96d43d3814447bddc3476446cb685c7000f808e3\", \"wtf_unittests\": \"d767c1bf9910ab3173e773240c53b0da7bdd109f\", \"zlib_unittests\": \"70535177c193077b144b30d9e3bd79984b032954\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6887d226fea03ae8e203d0a1d4c9e197b929dd99abf2bafb38063e06e39bc1ba_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_79ddf9721ca7b7ce79374811fb2c516b44ee31d85deee669f4d7a1736cefaf3b_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_b13f895f2fa532c56bcd54736f154d6ea330771f795358111cd0095a10831ab4_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_c18d585c17603559d8d68e3de2c6e12032537b56b99cb619aa84174b37006d15_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-central1-b-8-158-dnw9\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606847980344659",
"status": "COMPLETED",
"status_changed_ts": "1606851274253142",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43348",
"builder:linux-chromeos-rel",
"buildset:commit/git/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ecf738d661b3e8633c438c7cb865d6f2b7a1d2a8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027521552812890080",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862091490767933424/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:50386be74e103910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606851274258202",
"url": "https://ci.chromium.org/b/8862091490767933424",
"utcnow_ts": "1606851275905827"
}
}
[19:34:35.935] Invocation finished in 54m59.449285672s with status SUCCEEDED