[02:00:42.453] New invocation is queued and will start shortly
[02:00:43.655] Starting the invocation (attempt 1)
[02:00:43.696] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:00:43.696] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:00:43.696] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024322907436622960",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9024322907436622960",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"gitiles_ref:refs/heads/master"
]
}
[02:00:45.549] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609898443818484",
"id": "8858892845332908864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609898445282727",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179361",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024322907436622960",
"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/8858892845332908864/+/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": "1609898445283319",
"url": "https://ci.chromium.org/b/8858892845332908864",
"utcnow_ts": "1609898445529712"
}
}
[02:00:45.550] Task URL: https://ci.chromium.org/b/8858892845332908864
[02:00:45.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:2:0) after 1m0s
[02:00:49.819] Received PubSub notification, asking Buildbucket for the build status
[02:00:50.309] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:45.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:2:0)
[02:01:45.609] Timer tick, asking Buildbucket for the build status
[02:01:45.874] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:45.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:4:0) after 1m0s
[02:02:45.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:4:0)
[02:02:45.886] Timer tick, asking Buildbucket for the build status
[02:02:46.123] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:46.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:5:0) after 1m0s
[02:03:46.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:5:0)
[02:03:46.241] Timer tick, asking Buildbucket for the build status
[02:03:46.601] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:46.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:6:0) after 1m0s
[02:04:46.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:6:0)
[02:04:46.606] Timer tick, asking Buildbucket for the build status
[02:04:46.779] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:46.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:7:0) after 1m0s
[02:05:46.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:7:0)
[02:05:46.818] Timer tick, asking Buildbucket for the build status
[02:05:47.214] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:47.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:8:0) after 1m0s
[02:06:47.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:8:0)
[02:06:47.226] Timer tick, asking Buildbucket for the build status
[02:06:47.392] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:47.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:9:0) after 1m0s
[02:07:47.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:9:0)
[02:07:47.428] Timer tick, asking Buildbucket for the build status
[02:07:47.594] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:47.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:10:0) after 1m0s
[02:08:47.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:10:0)
[02:08:47.660] Timer tick, asking Buildbucket for the build status
[02:08:48.050] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:48.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:11:0) after 1m0s
[02:09:48.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:11:0)
[02:09:48.135] Timer tick, asking Buildbucket for the build status
[02:09:48.604] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:48.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:12:0) after 1m0s
[02:10:48.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:12:0)
[02:10:48.582] Timer tick, asking Buildbucket for the build status
[02:10:49.052] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:49.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:13:0) after 1m0s
[02:11:49.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:13:0)
[02:11:49.133] Timer tick, asking Buildbucket for the build status
[02:11:49.225] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:49.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:14:0) after 1m0s
[02:12:49.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:14:0)
[02:12:49.367] Timer tick, asking Buildbucket for the build status
[02:12:49.470] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:49.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:15:0) after 1m0s
[02:13:49.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:15:0)
[02:13:49.513] Timer tick, asking Buildbucket for the build status
[02:13:49.660] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:49.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:16:0) after 1m0s
[02:14:49.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:16:0)
[02:14:49.728] Timer tick, asking Buildbucket for the build status
[02:14:49.843] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:49.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:17:0) after 1m0s
[02:15:49.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:17:0)
[02:15:49.862] Timer tick, asking Buildbucket for the build status
[02:15:50.219] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:50.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:18:0) after 1m0s
[02:16:50.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:18:0)
[02:16:50.296] Timer tick, asking Buildbucket for the build status
[02:16:50.359] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:50.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:19:0) after 1m0s
[02:17:50.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:19:0)
[02:17:50.433] Timer tick, asking Buildbucket for the build status
[02:17:50.502] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:50.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:20:0) after 1m0s
[02:18:50.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:20:0)
[02:18:50.578] Timer tick, asking Buildbucket for the build status
[02:18:50.706] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:50.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:21:0) after 1m0s
[02:19:50.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:21:0)
[02:19:50.790] Timer tick, asking Buildbucket for the build status
[02:19:51.418] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:51.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:22:0) after 1m0s
[02:20:51.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:22:0)
[02:20:51.426] Timer tick, asking Buildbucket for the build status
[02:20:51.557] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:51.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:23:0) after 1m0s
[02:21:51.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:23:0)
[02:21:51.627] Timer tick, asking Buildbucket for the build status
[02:21:51.807] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:51.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:24:0) after 1m0s
[02:22:51.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:24:0)
[02:22:51.970] Timer tick, asking Buildbucket for the build status
[02:22:52.052] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:52.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:25:0) after 1m0s
[02:23:52.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:25:0)
[02:23:52.103] Timer tick, asking Buildbucket for the build status
[02:23:52.219] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:52.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:26:0) after 1m0s
[02:24:52.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:26:0)
[02:24:52.228] Timer tick, asking Buildbucket for the build status
[02:24:52.547] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:52.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:27:0) after 1m0s
[02:25:52.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:27:0)
[02:25:52.542] Timer tick, asking Buildbucket for the build status
[02:25:52.815] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:28:0) after 1m0s
[02:26:52.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:28:0)
[02:26:52.831] Timer tick, asking Buildbucket for the build status
[02:26:53.181] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:53.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:29:0) after 1m0s
[02:27:53.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:29:0)
[02:27:53.239] Timer tick, asking Buildbucket for the build status
[02:27:53.651] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:53.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:30:0) after 1m0s
[02:28:53.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:30:0)
[02:28:53.724] Timer tick, asking Buildbucket for the build status
[02:28:54.115] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:31:0) after 1m0s
[02:29:54.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:31:0)
[02:29:54.172] Timer tick, asking Buildbucket for the build status
[02:29:54.276] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:54.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:32:0) after 1m0s
[02:30:54.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:32:0)
[02:30:54.273] Timer tick, asking Buildbucket for the build status
[02:30:54.776] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:54.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:33:0) after 1m0s
[02:31:54.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:33:0)
[02:31:54.846] Timer tick, asking Buildbucket for the build status
[02:31:54.906] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:34:0) after 1m0s
[02:32:54.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:34:0)
[02:32:54.981] Timer tick, asking Buildbucket for the build status
[02:32:55.059] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:55.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:35:0) after 1m0s
[02:33:55.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:35:0)
[02:33:55.084] Timer tick, asking Buildbucket for the build status
[02:33:55.169] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:55.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:36:0) after 1m0s
[02:34:55.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:36:0)
[02:34:55.177] Timer tick, asking Buildbucket for the build status
[02:34:55.255] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:55.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:37:0) after 1m0s
[02:35:55.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:37:0)
[02:35:55.316] Timer tick, asking Buildbucket for the build status
[02:35:55.860] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:55.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:38:0) after 1m0s
[02:36:55.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:38:0)
[02:36:55.936] Timer tick, asking Buildbucket for the build status
[02:36:56.134] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:56.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:39:0) after 1m0s
[02:37:56.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:39:0)
[02:37:56.803] Timer tick, asking Buildbucket for the build status
[02:37:57.088] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:57.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:40:0) after 1m0s
[02:38:57.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:40:0)
[02:38:57.184] Timer tick, asking Buildbucket for the build status
[02:38:57.300] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:57.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:41:0) after 1m0s
[02:39:57.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:41:0)
[02:39:57.367] Timer tick, asking Buildbucket for the build status
[02:39:57.495] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:57.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:42:0) after 1m0s
[02:40:57.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:42:0)
[02:40:57.587] Timer tick, asking Buildbucket for the build status
[02:40:57.937] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:57.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:43:0) after 1m0s
[02:41:58.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:43:0)
[02:41:58.003] Timer tick, asking Buildbucket for the build status
[02:41:58.263] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:58.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:44:0) after 1m0s
[02:42:58.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:44:0)
[02:42:58.329] Timer tick, asking Buildbucket for the build status
[02:42:58.760] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:58.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:45:0) after 1m0s
[02:43:58.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:45:0)
[02:43:58.864] Timer tick, asking Buildbucket for the build status
[02:43:59.045] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:59.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:46:0) after 1m0s
[02:44:59.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:46:0)
[02:44:59.067] Timer tick, asking Buildbucket for the build status
[02:44:59.135] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:59.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:47:0) after 1m0s
[02:45:59.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:47:0)
[02:45:59.227] Timer tick, asking Buildbucket for the build status
[02:45:59.359] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:59.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:48:0) after 1m0s
[02:46:59.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:48:0)
[02:46:59.386] Timer tick, asking Buildbucket for the build status
[02:46:59.454] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:59.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:49:0) after 1m0s
[02:47:59.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:49:0)
[02:47:59.509] Timer tick, asking Buildbucket for the build status
[02:47:59.584] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:59.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:50:0) after 1m0s
[02:48:59.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:50:0)
[02:48:59.600] Timer tick, asking Buildbucket for the build status
[02:48:59.907] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:59.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:51:0) after 1m0s
[02:49:59.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:51:0)
[02:49:59.932] Timer tick, asking Buildbucket for the build status
[02:50:00.120] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:00.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:52:0) after 1m0s
[02:51:00.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:52:0)
[02:51:00.181] Timer tick, asking Buildbucket for the build status
[02:51:00.460] Build 8858892845332908864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:00.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9024322907436622960:53:0) after 1m0s
[02:51:47.288] Received PubSub notification, asking Buildbucket for the build status
[02:51:47.380] Build 8858892845332908864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:51:47.380] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609901506482222",
"created_by": "project:chromium",
"created_ts": "1609898443818484",
"id": "8858892845332908864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\"}}",
"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\": \"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\", \"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-144-ika8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179361, \"got_angle_revision\": \"e91097bf3a24895f23b928ed12087dcbb1d54d7b\", \"got_dawn_revision\": \"200941c797512895039e9f0315fc18fd9d9734ad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\", \"got_revision_cp\": \"refs/heads/master@{#840444}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"c8d1d1cbceae8f59975b2ec7d86981ec3fabb11b\", \"got_v8_revision_cp\": \"refs/heads/8.9.212@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"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\": \"dd3c4e3981ce672c863bc6a6f60c6658dbcb2188\", \"swarm_hashes_refs/heads/master(at){#840444}_without_patch\": {\"absl_hardening_tests\": \"7c53e96661f287f33947a2cec725d353073b12e9\", \"accessibility_unittests\": \"ea2214b18d809f570608a0f47ce86e43e74f40ae\", \"angle_unittests\": \"38c7b9f4ecf83118ff16beac698271c9717e9563\", \"app_shell_unittests\": \"0f184e00a9a853facf26820520396bb56d9ff23d\", \"aura_unittests\": \"6e225443f91299229fc936f51b0dc1a583983d2c\", \"base_unittests\": \"dcba12b4cfe63b537d367e6673d80e17d178d564\", \"base_util_unittests\": \"f61da2c01cda4ac288accb38ef1057c9c3461a7d\", \"blink_common_unittests\": \"56c968d176f8aff582e3c58a7bdff16c5e72ab46\", \"blink_fuzzer_unittests\": \"4985ceed5edb980bb52ea7fe2cf1c1ee77bf7ced\", \"blink_heap_unittests\": \"79e7df03de825f4d3cc54696858e9dc7e5fcf9d3\", \"blink_platform_unittests\": \"98e9e0b2037d2b08e928b7f32fa2c8c2d2b14211\", \"blink_python_tests\": \"34011a1af97398c570d28627a3c2b1dfd4392b05\", \"blink_unittests\": \"48591f15926a7a4cd7e23d64a1a5258bd1bb336b\", \"blink_web_tests\": \"27eee5946ba1f511866c7d317302d71c362c46ed\", \"boringssl_crypto_tests\": \"01263081e842171d17272568da64c144f0d19bfc\", \"boringssl_ssl_tests\": \"5dfb4129b416b8454d745bd79b12a572d38f9b39\", \"browser_tests\": \"b5b2689ec65e5cf07f2b385afd2fee746aea173a\", \"capture_unittests\": \"afee240dd14ff6b37c956151a7fec9bc10d2bdcf\", \"cast_unittests\": \"57b5474694527785797b1c0eb9fb936977ee4f8f\", \"cc_unittests\": \"294dd8adf6d9799a968c50feaa743ca150015ba1\", \"chrome_app_unittests\": \"79f362eaf3c5086fb3df74ffde03d46fd3be5846\", \"chromedriver_unittests\": \"941d65d3b706e4b50237c00a876a9d7da36405e2\", \"components_browsertests\": \"db5c3ed4d3b92d143d0956489cf715972c5e38cb\", \"components_unittests\": \"7a01939bf0fc755f2f3879b72709ab3469f36855\", \"compositor_unittests\": \"53f990fd2c3ae6c0679b5a5cd490086608fc45cf\", \"content_browsertests\": \"57387033c2ae7114e881c68182dfb7cc59102701\", \"content_shell_crash_test\": \"f9364a692f4af1bcd2001918902d08ff504ffe23\", \"content_unittests\": \"6204830e9e8e520c54da086fd89b6b05d3957a10\", \"crashpad_tests\": \"0e5cc3cda1ea83049cbabfa590efbf3d0b6efbf8\", \"cronet_tests\": \"158bf356e50248b10f1f9c667c895d5fd2008b57\", \"cronet_unittests\": \"40db2723959bbba4a07cf732dcc5a5d91c9668eb\", \"crypto_unittests\": \"b65302e34ce7713fa3ebca29130c194d3ef39c36\", \"dbus_unittests\": \"d0acff16f75a472d3284bc91909034e38d60624e\", \"device_unittests\": \"7e983af7f89378e4631f486c1d222670467351ec\", \"display_unittests\": \"038f53ca884dd0bf9bd08ff63f5f90ac217356e4\", \"events_unittests\": \"a4bf0ac5058855fe1dceb4717fcd66d48c5d043a\", \"extensions_browsertests\": \"2fe03ba1cd3c36d7b6394b9ba2e941392b9b809d\", \"extensions_unittests\": \"8a1c87941304f77de42bc6bc5b90a0371449a3ab\", \"filesystem_service_unittests\": \"83a8eafaa0b7e40590d3cde41a694b847036cf8e\", \"flatbuffers_unittests\": \"5762a2d38cb6eb71feec5b164d5ef6080dd7e0e9\", \"gcm_unit_tests\": \"04ed0eecca298c7c56c2684f5d09fe2faaabc789\", \"gfx_unittests\": \"925f2c578f9a5767e74006900adfa949234fcba0\", \"gin_unittests\": \"ce4beffb89d01de020db067d9dd13787d75498c1\", \"google_apis_unittests\": \"373b73d052e29071e3f766796f02859ac20e39d6\", \"gpu_unittests\": \"7aa5b86bcced1d62b2dd1cbcbdc6eef57bc7675c\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"02ff6f547a35588e000e178a029f9a7fd95bd536\", \"headless_browsertests\": \"aacfb057baf3edcb77927258bf6ac2032984e093\", \"headless_unittests\": \"f16fbce6a0bf535b5122a790d8ba35b59354d480\", \"interactive_ui_tests\": \"ab59bf75ff14080311d9840514a9944743d4427e\", \"ipc_tests\": \"e04eee30d0ca7436d7ab6fccb64e3657db4fd1cc\", \"jingle_unittests\": \"e19cdee66d9bb622dfe8ffcd86c12183d6adea26\", \"latency_unittests\": \"0d514e968c1739dd8280c1695bcb6e65815eb8f8\", \"libjingle_xmpp_unittests\": \"7177420d4d0618af143ccaa8ca88d73210e47910\", \"liburlpattern_unittests\": \"713e9d0d6b262eacbe90c9339be8100489d30746\", \"media_blink_unittests\": \"a0a4efbdb253449cd22c87a932ce7a6f2a524bd5\", \"media_unittests\": \"1f451aaaf77d357bcb9159bbf21b1a95fbb06ae2\", \"message_center_unittests\": \"b98eeb2350a6b4e271d775a2895ff17ff327eab1\", \"metrics_python_tests\": \"cb581077fb2b00d6202c7d5ee37060189cceae74\", \"midi_unittests\": \"72f2b67ad737b3195b2898f4f16ae2a07c2b5c0c\", \"mojo_core_unittests\": \"276f6cfe3f19c8e504c08b448cb9e36b8bb9b90a\", \"mojo_unittests\": \"3fcde9bfa258f5d83d0db3e1bb8ab1f1fbe1f912\", \"nacl_helper_nonsfi_unittests\": \"71730d21a3390b7ad2b656bf8925f779e58f687d\", \"nacl_loader_unittests\": \"3c8298e9ae569ae1e21635d3395676334b3b2b86\", \"native_theme_unittests\": \"16edc471d72c62bd76a17d84baac9c6adadcb228\", \"net_unittests\": \"1719afe631f4fb61037ef63451a855429c6eb325\", \"openscreen_unittests\": \"e48b98acb971804e51a30af99d3929e50759db94\", \"pdf_unittests\": \"85d6bb1b1d670945d9210c05923a32e0209768a1\", \"perfetto_unittests\": \"50ddc8d70e8646cd0b226666aa009e9fd1a67ba7\", \"ppapi_unittests\": \"35a868ad0b15d6af54b58c67c28e4b1d59da64d0\", \"printing_unittests\": \"98d116502bc7c48f0711b987f9b4b6433cc18e8e\", \"remoting_unittests\": \"6df9cdfa29b0b2a44cf9cf5276decde7e20af9cc\", \"sandbox_linux_unittests\": \"e7422fad0be5c56a43eeb5c86363bd28a283519f\", \"service_manager_unittests\": \"ff4f8e39a10219bc27f9c1427781ee97575b7d4c\", \"services_unittests\": \"bb81490bf66821b0c780914058633b0317d9dcfa\", \"shell_dialogs_unittests\": \"7b308acdba5be0a5f7e5c4ec3cd5e1a20da56214\", \"skia_unittests\": \"2ca18ab42cdcffcecdb64af8b76d6e89a0fca0e8\", \"snapshot_unittests\": \"a5e199f651e0a004806d54d99e71fec050947323\", \"sql_unittests\": \"4eda190220ea251e7869fe35b9de7b17c0223c9b\", \"storage_unittests\": \"9e30b6040718b8252936e735856a54111f0417d9\", \"sync_integration_tests\": \"2717ac85a143b0fc8e9962d718dfcbc00cb3c12d\", \"telemetry_gpu_unittests\": \"15d33f667593c183215b96d42c889c2cde04bf6c\", \"telemetry_perf_unittests\": \"b3a91143db6401bccac04c571cdc288adf072170\", \"telemetry_unittests\": \"6e941c9de417aadd976bca0c2b59d9d58fbfff54\", \"traffic_annotation_auditor_unittests\": \"5a07bc0b584f98629006ea378ab03ee550e67fc8\", \"ui_base_unittests\": \"300bbc6d7eb422a3b91849a4a956c508b6d28d11\", \"ui_touch_selection_unittests\": \"32a15333b160817ebaf346426f035f1fdaa776fd\", \"unit_tests\": \"f24f3baaf0cca317c22024d9a4f4e0cc6a76fc21\", \"url_unittests\": \"2772b9612ea4e3a02a25939f034c336ec7b8d1ee\", \"views_perftests\": \"a844b9f4857c799399e753166cab619e2a8a9f24\", \"views_unittests\": \"604be31295eac3492d34d0d95dcaf0fd443bdab7\", \"viz_unittests\": \"b5e3b7c9a79c06853957de13231f8e3dd603f6a3\", \"vr_common_unittests\": \"3e32335be6651dd94f5726be921cef8c2473f8fa\", \"vr_pixeltests\": \"f9f2b0865e57b3437b0e4a08a2a71452a483f954\", \"webdriver_wpt_tests\": \"fcd214f399e2b09787b947888d461e0cf61e76f5\", \"weblayer_browsertests\": \"cde2c1de00cb0bcf111784f871a47553e1ea205d\", \"weblayer_unittests\": \"3548cbf470467a67a2626be6da953cc6b0d773ab\", \"wm_unittests\": \"be58e5a656743d36290d7ef5dc4933574caff632\", \"wtf_unittests\": \"13374dbc518bcfffeaad571142f57df6db2789ad\", \"x11_unittests\": \"33c5954adae555b30879492eb4291e5a0d61566c\", \"xr_browser_tests\": \"123be0e2ff802b45e896d817e2e821307e320026\", \"zlib_unittests\": \"a126b451d4ffc813c8521dc0c0de03eee0899e40\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_03bc629269a55e89b115ec4e4b472997df6f6f4caff479f65f24a3c64aef44c9_v2\", \"builder_1143bf8a0c86d96d189f99a4f0f749b4f3d1e46c849c82cdd2c6ebe168938b3a_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_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-central1-b-8-144-ika8\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609898449069835",
"status": "COMPLETED",
"status_changed_ts": "1609901506863402",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179361",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd3c4e3981ce672c863bc6a6f60c6658dbcb2188",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024322907436622960",
"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/8858892845332908864/+/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:50ee3e5559a3a710",
"user_agent:luci-scheduler"
],
"updated_ts": "1609901506894702",
"url": "https://ci.chromium.org/b/8858892845332908864",
"utcnow_ts": "1609901507371064"
}
}
[02:51:47.380] Invocation finished in 51m4.951513278s with status SUCCEEDED