[22:57:44.258] New invocation is queued and will start shortly
[22:57:45.331] Starting the invocation (attempt 1)
[22:57:45.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:57:45.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:57:45.364] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021072928109672336",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"299ef4872a2446a9e4b2796c7954e406e7c93cb3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021072928109672336",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"gitiles_ref:refs/heads/master"
]
}
[22:57:45.904] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612997865470230",
"id": "8855642866174900880",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"299ef4872a2446a9e4b2796c7954e406e7c93cb3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612997865788583",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180470",
"builder:Linux Builder (dbg)",
"buildset:commit/git/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021072928109672336",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855642866174900880/+/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": "1612997865788704",
"url": "https://ci.chromium.org/b/8855642866174900880",
"utcnow_ts": "1612997865896280"
}
}
[22:57:45.904] Task URL: https://ci.chromium.org/b/8855642866174900880
[22:57:45.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:2:0) after 1m0s
[22:57:48.412] Received PubSub notification, asking Buildbucket for the build status
[22:57:48.566] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:45.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:2:0)
[22:58:45.949] Timer tick, asking Buildbucket for the build status
[22:58:46.023] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:4:0) after 1m0s
[22:59:46.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:4:0)
[22:59:46.045] Timer tick, asking Buildbucket for the build status
[22:59:46.196] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:5:0) after 1m0s
[23:00:46.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:5:0)
[23:00:46.280] Timer tick, asking Buildbucket for the build status
[23:00:46.389] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:46.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:6:0) after 1m0s
[23:01:46.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:6:0)
[23:01:46.406] Timer tick, asking Buildbucket for the build status
[23:01:46.637] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:46.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:7:0) after 1m0s
[23:02:46.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:7:0)
[23:02:46.686] Timer tick, asking Buildbucket for the build status
[23:02:46.762] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:46.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:8:0) after 1m0s
[23:03:46.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:8:0)
[23:03:46.860] Timer tick, asking Buildbucket for the build status
[23:03:46.994] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:46.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:9:0) after 1m0s
[23:04:47.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:9:0)
[23:04:47.096] Timer tick, asking Buildbucket for the build status
[23:04:47.174] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:47.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:10:0) after 1m0s
[23:05:47.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:10:0)
[23:05:47.280] Timer tick, asking Buildbucket for the build status
[23:05:47.429] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:47.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:11:0) after 1m0s
[23:06:47.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:11:0)
[23:06:47.541] Timer tick, asking Buildbucket for the build status
[23:06:47.745] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:47.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:12:0) after 1m0s
[23:07:47.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:12:0)
[23:07:47.846] Timer tick, asking Buildbucket for the build status
[23:07:48.106] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:48.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:13:0) after 1m0s
[23:08:48.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:13:0)
[23:08:48.238] Timer tick, asking Buildbucket for the build status
[23:08:48.513] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:48.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:14:0) after 1m0s
[23:09:48.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:14:0)
[23:09:48.549] Timer tick, asking Buildbucket for the build status
[23:09:48.737] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:48.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:15:0) after 1m0s
[23:10:48.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:15:0)
[23:10:48.782] Timer tick, asking Buildbucket for the build status
[23:10:48.874] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:48.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:16:0) after 1m0s
[23:11:48.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:16:0)
[23:11:48.922] Timer tick, asking Buildbucket for the build status
[23:11:50.374] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:50.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:17:0) after 1m0s
[23:12:50.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:17:0)
[23:12:50.429] Timer tick, asking Buildbucket for the build status
[23:12:50.521] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:18:0) after 1m0s
[23:13:50.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:18:0)
[23:13:50.541] Timer tick, asking Buildbucket for the build status
[23:13:50.713] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:50.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:19:0) after 1m0s
[23:14:50.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:19:0)
[23:14:50.775] Timer tick, asking Buildbucket for the build status
[23:14:50.912] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:50.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:20:0) after 1m0s
[23:15:50.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:20:0)
[23:15:50.986] Timer tick, asking Buildbucket for the build status
[23:15:51.064] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:51.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:21:0) after 1m0s
[23:16:51.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:21:0)
[23:16:51.098] Timer tick, asking Buildbucket for the build status
[23:16:51.240] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:51.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:22:0) after 1m0s
[23:17:51.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:22:0)
[23:17:51.264] Timer tick, asking Buildbucket for the build status
[23:17:51.369] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:51.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:23:0) after 1m0s
[23:18:51.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:23:0)
[23:18:51.379] Timer tick, asking Buildbucket for the build status
[23:18:51.694] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:51.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:24:0) after 1m0s
[23:19:51.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:24:0)
[23:19:51.700] Timer tick, asking Buildbucket for the build status
[23:19:51.794] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:51.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:25:0) after 1m0s
[23:20:51.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:25:0)
[23:20:51.853] Timer tick, asking Buildbucket for the build status
[23:20:52.124] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:52.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:26:0) after 1m0s
[23:21:52.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:26:0)
[23:21:52.183] Timer tick, asking Buildbucket for the build status
[23:21:52.425] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:27:0) after 1m0s
[23:22:52.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:27:0)
[23:22:52.479] Timer tick, asking Buildbucket for the build status
[23:22:52.587] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:52.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:28:0) after 1m0s
[23:23:52.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:28:0)
[23:23:52.664] Timer tick, asking Buildbucket for the build status
[23:23:52.840] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:52.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:29:0) after 1m0s
[23:24:52.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:29:0)
[23:24:52.955] Timer tick, asking Buildbucket for the build status
[23:24:53.050] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:53.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:30:0) after 1m0s
[23:25:53.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:30:0)
[23:25:53.125] Timer tick, asking Buildbucket for the build status
[23:25:53.529] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:53.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:31:0) after 1m0s
[23:26:53.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:31:0)
[23:26:53.573] Timer tick, asking Buildbucket for the build status
[23:26:53.670] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:53.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:32:0) after 1m0s
[23:27:53.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:32:0)
[23:27:53.712] Timer tick, asking Buildbucket for the build status
[23:27:53.839] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:53.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:33:0) after 1m0s
[23:28:53.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:33:0)
[23:28:53.850] Timer tick, asking Buildbucket for the build status
[23:28:53.920] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:53.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:34:0) after 1m0s
[23:29:54.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:34:0)
[23:29:54.003] Timer tick, asking Buildbucket for the build status
[23:29:54.475] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:54.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:35:0) after 1m0s
[23:30:54.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:35:0)
[23:30:54.496] Timer tick, asking Buildbucket for the build status
[23:30:54.587] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:54.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:36:0) after 1m0s
[23:31:54.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:36:0)
[23:31:54.580] Timer tick, asking Buildbucket for the build status
[23:31:54.800] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:54.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:37:0) after 1m0s
[23:32:54.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:37:0)
[23:32:54.909] Timer tick, asking Buildbucket for the build status
[23:32:55.018] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:55.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:38:0) after 1m0s
[23:33:55.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:38:0)
[23:33:55.060] Timer tick, asking Buildbucket for the build status
[23:33:55.144] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:55.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:39:0) after 1m0s
[23:34:55.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:39:0)
[23:34:55.182] Timer tick, asking Buildbucket for the build status
[23:34:55.278] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:55.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:40:0) after 1m0s
[23:35:55.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:40:0)
[23:35:55.262] Timer tick, asking Buildbucket for the build status
[23:35:55.347] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:55.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:41:0) after 1m0s
[23:36:55.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:41:0)
[23:36:55.390] Timer tick, asking Buildbucket for the build status
[23:36:55.496] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:55.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:42:0) after 1m0s
[23:37:55.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:42:0)
[23:37:55.527] Timer tick, asking Buildbucket for the build status
[23:37:55.612] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:55.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:43:0) after 1m0s
[23:38:55.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:43:0)
[23:38:55.660] Timer tick, asking Buildbucket for the build status
[23:38:55.744] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:55.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:44:0) after 1m0s
[23:39:55.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:44:0)
[23:39:55.784] Timer tick, asking Buildbucket for the build status
[23:39:55.963] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:55.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:45:0) after 1m0s
[23:40:56.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:45:0)
[23:40:56.046] Timer tick, asking Buildbucket for the build status
[23:40:56.402] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:56.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:46:0) after 1m0s
[23:41:56.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:46:0)
[23:41:56.450] Timer tick, asking Buildbucket for the build status
[23:41:56.718] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:56.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:47:0) after 1m0s
[23:42:56.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:47:0)
[23:42:56.722] Timer tick, asking Buildbucket for the build status
[23:42:56.875] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:56.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:48:0) after 1m0s
[23:43:56.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:48:0)
[23:43:56.851] Timer tick, asking Buildbucket for the build status
[23:43:56.925] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:49:0) after 1m0s
[23:44:56.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:49:0)
[23:44:56.982] Timer tick, asking Buildbucket for the build status
[23:44:57.217] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:57.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:50:0) after 1m0s
[23:45:57.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:50:0)
[23:45:57.274] Timer tick, asking Buildbucket for the build status
[23:45:57.384] Build 8855642866174900880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:57.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021072928109672336:51:0) after 1m0s
[23:46:32.461] Received PubSub notification, asking Buildbucket for the build status
[23:46:32.545] Build 8855642866174900880: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:46:32.545] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613000791678931",
"created_by": "project:chromium",
"created_ts": "1612997865470230",
"id": "8855642866174900880",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"299ef4872a2446a9e4b2796c7954e406e7c93cb3\"}}",
"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/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"299ef4872a2446a9e4b2796c7954e406e7c93cb3\", \"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-east1-d-8-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180470, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e0a588752c827daef74960bbc80d7f5c4f73c4dd\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"299ef4872a2446a9e4b2796c7954e406e7c93cb3\", \"got_revision_cp\": \"refs/heads/master@{#852854}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"cf9b85e768229a798eec3d84233fef71de9ec7d8\", \"got_v8_revision_cp\": \"refs/heads/9.0.160@{#1}\", \"got_webrtc_revision\": \"7bad75b3906ae78b67b2a8cec095d877deb58215\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33214}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"299ef4872a2446a9e4b2796c7954e406e7c93cb3\", \"swarm_hashes_refs/heads/master(at){#852854}_without_patch\": {\"absl_hardening_tests\": \"a80780b48b3d0cd83668962442aabb53f53974bd\", \"accessibility_unittests\": \"3fa15b53bd25c35208ead66a9b208535882c3c84\", \"angle_unittests\": \"d1cc0efde9f6beef1ce560144732de91fe11dcd5\", \"app_shell_unittests\": \"013862b2970555ff9e2c976c6f922a2e1ce819f0\", \"aura_unittests\": \"0ab60ae8f26f01f24e594b42cdf4efb8db737bf7\", \"base_unittests\": \"06b57f23f4bd318586a202c8b891d322a3d1b099\", \"base_util_unittests\": \"49d94c0fbfccd1a0e27c3b2e25466703e825722e\", \"blink_common_unittests\": \"7138e4622fba852f5d24c008e6ea1fbf72e36732\", \"blink_fuzzer_unittests\": \"1153d738fff91c927a5598e0c765008167708018\", \"blink_heap_unittests\": \"d9c80e34b8a305bbeaf2b1540666eda3c4e500f9\", \"blink_platform_unittests\": \"52e3087b457b00b93a8b9a41dfda38be741f9936\", \"blink_python_tests\": \"8d3e38bd884807d339ff1c14c11dd4dc9d2fb1a2\", \"blink_unittests\": \"33a2f2814cfedbd81b351cbc269787afb40c136b\", \"blink_web_tests\": \"3292e1ea1629debdaad84baffa4e5218c735de8d\", \"boringssl_crypto_tests\": \"7011543503c5b06b10f3661736248a2283174a2b\", \"boringssl_ssl_tests\": \"a747d32267ed606b45d56657c54117b26f2f989f\", \"browser_tests\": \"5fabd7ae241c7b529c073a8d5008710f4f560c96\", \"capture_unittests\": \"a205981d6e392310165d209f861c0538f5258b3b\", \"cast_unittests\": \"01fa1d8f04e0cc69ffedf5c38dbbc6456deb265e\", \"cc_unittests\": \"3edf2ff4861f1d7d1cdb271a9d90f475bae56555\", \"chrome_app_unittests\": \"b5467138bb3a8ca4eac0ca1e6421b7524e9b9322\", \"chromedriver_unittests\": \"43f139522a128780231d367d54b8ae4c01a309f0\", \"components_browsertests\": \"f8818aded972ade3c84e7a1440013f5a54d94126\", \"components_unittests\": \"7bf12050678a8746928dd80c75f781af08ab1330\", \"compositor_unittests\": \"c7b78191b5f9ef0c82a624e7e90e332e3900a52b\", \"content_browsertests\": \"39904c1eace9156068aab2d26d242eae9f11f39d\", \"content_shell_crash_test\": \"ca16f6fa72aee260a4aba38d2fe8e88522ce4169\", \"content_unittests\": \"a6d0499b92560413ebea0f1ba8638b43134aa180\", \"crashpad_tests\": \"52933b4000805dbb7f0ddcb06f0e00c791477b06\", \"cronet_tests\": \"0aa834121bc09f4c16614a923e9b858142482d47\", \"cronet_unittests\": \"ec93c6302796830efe768772d1c50e8b376da342\", \"crypto_unittests\": \"748c3693e97988206fce6fb2c8d37e16e3b9dfd8\", \"dbus_unittests\": \"d5a9e67c747fc0209151771911c28b0cc8195910\", \"device_unittests\": \"35b2d76a6266f33c0f46c79fa4a9f437b5c8d086\", \"display_unittests\": \"fa18b501fdc9a26be33bba1f27ce608c6f4b6ff3\", \"events_unittests\": \"c146f9aa3bd9557584627f779ab72cee51bdbad0\", \"extensions_browsertests\": \"2b0f6e2d5dac5f571c58375eccfd080742c54627\", \"extensions_unittests\": \"1335fe26b682b0beaf563a017be66062670fde75\", \"filesystem_service_unittests\": \"04c096b61ae01ddb62a16f0d54b94a3bda7802e7\", \"flatbuffers_unittests\": \"eac01a3774a90cf68bd2cb5c5e10e20502448f17\", \"gcm_unit_tests\": \"f42b2d255b0c91f5629266e51bfd8e8941a567a2\", \"gfx_unittests\": \"aeb7d4aa786b422468e3b994036e1fa1ebd1118c\", \"gin_unittests\": \"63d5422b35bf4bb55af8e820e078454ff8ad9aee\", \"google_apis_unittests\": \"9317879d5196e5a57d37ba5e92bfd94a686944b0\", \"gpu_unittests\": \"8e54f81c7a6520b97e354795c93a505c286f5e64\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"0013f3ca1fba72cf02bff2af7e23bbd8e530844e\", \"headless_browsertests\": \"e8877dd9a4614575a7b00c1e9d7c861d71b18ae9\", \"headless_unittests\": \"22c18577e06f1ebb07e3459788ac288e46c3638a\", \"interactive_ui_tests\": \"7edd978aa6cd5cf771a0ac335c96403e52d1eb07\", \"ipc_tests\": \"25716ad980a5762acb5b96347fbae30b9d574310\", \"jingle_unittests\": \"247da14ec9d21dfabf722d9b42cd36b460298026\", \"latency_unittests\": \"4c0f949e4e48a9a6737877212a87e8ff851b183f\", \"libjingle_xmpp_unittests\": \"141e0fa7bc442ed997808111af22a15620b4ec93\", \"liburlpattern_unittests\": \"3b49763654dbd0cd9ad49ce591228dc6d7fa827b\", \"media_blink_unittests\": \"81818680b1897892858c5368ccd026ea6c4da459\", \"media_unittests\": \"7aeedb7bb0fa38d4940cd6ceefe26b172db59cb0\", \"message_center_unittests\": \"fbec09eadae6bc651e1115e5cadc0ade56c5c6ab\", \"metrics_python_tests\": \"822f7b59ffcb7e5abeb92121fda82907f1d62696\", \"midi_unittests\": \"42932ab8a0e0d09f4d15ea1bf43cd9ad22049060\", \"mojo_core_unittests\": \"d8306a09e25295d68fa303b15a54c5735b09ff56\", \"mojo_unittests\": \"d4918e5244985429a766f4c0629d300e19b7cfe6\", \"nacl_helper_nonsfi_unittests\": \"47a6669b9c7832107902528a60d8aa302ee42f02\", \"nacl_loader_unittests\": \"88354a9af9569d20fe5e720ccc7773de7364f6e4\", \"native_theme_unittests\": \"421cdf45846a6f4c50c152a8ebb6a416830197d3\", \"net_unittests\": \"557ae82d14ff92659629a765d40b1ca7e068af3f\", \"openscreen_unittests\": \"e3f2dc04195a7c6a24af85d9d4c153c82bb4b647\", \"pdf_unittests\": \"a05f0e3e3ed9c46aa9cfbf3f58139d090abd9317\", \"perfetto_unittests\": \"9cf7a06d105389ba5dc6bf7b3835979682dbb69f\", \"ppapi_unittests\": \"9c52e53be80045c413ba22bef5cbbefa4a14910e\", \"printing_unittests\": \"b2f666e07e1de3af4b4b524a16de5321dc42f69b\", \"remoting_unittests\": \"cdefa7a1bae199e747ebd045709d9c95ffdd8128\", \"sandbox_linux_unittests\": \"e56bf4c15ad25f77d49a2fe72b5eb9ce56d4b732\", \"service_manager_unittests\": \"d21284878b9acdb50fb1c6ab0a687148a6dd2156\", \"services_unittests\": \"eee6229d9de0208b2aefa5fb695cf040a1cbc713\", \"shell_dialogs_unittests\": \"e26454a45ca92bc0c898aa86ff776639eca78522\", \"skia_unittests\": \"9c2d11ae1f244537f1d28b2f90437ed953e90252\", \"snapshot_unittests\": \"5d1cfa506bf18589e428dd8347e2d21473b4f7d9\", \"sql_unittests\": \"f218ccaa854f923dff2f9a57f9ca4b9c3bdff23a\", \"storage_unittests\": \"620044b61c287dc77ac3bb4debac4fb4b53ca17b\", \"sync_integration_tests\": \"ba3e87de1f7423cf0aa0891e4cc0291ab5537c5a\", \"telemetry_gpu_unittests\": \"31da3813d985836701240d141129451e65bec6c8\", \"telemetry_perf_unittests\": \"19fe2a58a8a434923c396b0ca10613634642d614\", \"telemetry_unittests\": \"37effdea8c74456702335b9b8ebc0b36010cf1cc\", \"traffic_annotation_auditor_unittests\": \"d72465ce41166f96f0c69a0dbf808a3ae96c6dd8\", \"ui_base_unittests\": \"4ad1583d738548c14259d8c73badb4bc0f4decd2\", \"ui_touch_selection_unittests\": \"6a4aae0b4b7e0df94537bba2003921da944e799a\", \"unit_tests\": \"8cd040681e628370fa0d55fa43079912cf2d9870\", \"url_unittests\": \"83a0f1be28cd5b524611c4aa77fd43acd7e90758\", \"views_perftests\": \"3f174d7d37865b059ffc97c07dc7714167cae105\", \"views_unittests\": \"af955d039093b81b36a5d2bf1a6af33b0cbe0d3f\", \"viz_unittests\": \"e338d0d989357fad4936528fd0d99aa4b900a09c\", \"vr_common_unittests\": \"7cb4485354ca9f76661b7f66f17a98da00895ddd\", \"vr_pixeltests\": \"7fe4d5be7d294dc71dbfcc4abad838241a66b82c\", \"webdriver_wpt_tests\": \"c874ff48c0848f8b896a976acaaced4c573cb2e9\", \"weblayer_browsertests\": \"b7922179755dcb58dbcf23a29f8e703542914cfe\", \"weblayer_unittests\": \"d7ccaf8f3c095923e6f6263101974c29e1cc13bd\", \"wm_unittests\": \"6c82664e7d8a8d819451b3147459474dd489cd3d\", \"wtf_unittests\": \"318fdc112a552cce574bc3010b5aac5a91260bec\", \"x11_unittests\": \"b81c634d1eee1038a5ce1e3ee84aba94084b5a0a\", \"xr_browser_tests\": \"3740f7432fd212e051fa09a0f4ed847090e7613e\", \"zlib_unittests\": \"94407c12347ffc68beab9cd40ac406816d19a8fc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_171aeb6ea7c277f8a23548bef504d6412b8f4fe5eb401735c265dcbe781a3afe_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-68-2v8w\"], \"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.7.12\"], \"server_version\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612997867241428",
"status": "COMPLETED",
"status_changed_ts": "1613000792038600",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180470",
"builder:Linux Builder (dbg)",
"buildset:commit/git/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/299ef4872a2446a9e4b2796c7954e406e7c93cb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021072928109672336",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855642866174900880/+/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:51a6fbbad4ca9b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613000792100282",
"url": "https://ci.chromium.org/b/8855642866174900880",
"utcnow_ts": "1613000792536471"
}
}
[23:46:32.545] Invocation finished in 48m48.303480272s with status SUCCEEDED