[00:37:54.414] New invocation is queued and will start shortly
[00:37:55.488] Starting the invocation (attempt 1)
[00:37:55.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:55.525] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:55.526] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018529910943640144",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018529910943640144",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"gitiles_ref:refs/heads/master"
]
}
[00:37:56.462] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615423075604206",
"id": "8853099849033824640",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615423076243784",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181285",
"builder:Linux Builder (dbg)",
"buildset:commit/git/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018529910943640144",
"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/8853099849033824640/+/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": "1615423076243970",
"url": "https://ci.chromium.org/b/8853099849033824640",
"utcnow_ts": "1615423076453886"
}
}
[00:37:56.462] Task URL: https://ci.chromium.org/b/8853099849033824640
[00:37:56.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:2:0) after 1m0s
[00:37:58.196] Received PubSub notification, asking Buildbucket for the build status
[00:37:58.253] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:2:0)
[00:38:56.480] Timer tick, asking Buildbucket for the build status
[00:38:56.547] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:4:0) after 1m0s
[00:39:56.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:4:0)
[00:39:56.586] Timer tick, asking Buildbucket for the build status
[00:39:56.650] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:5:0) after 1m0s
[00:40:56.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:5:0)
[00:40:56.672] Timer tick, asking Buildbucket for the build status
[00:40:56.743] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:56.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:6:0) after 1m0s
[00:41:56.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:6:0)
[00:41:56.808] Timer tick, asking Buildbucket for the build status
[00:41:57.011] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:57.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:7:0) after 1m0s
[00:42:57.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:7:0)
[00:42:57.133] Timer tick, asking Buildbucket for the build status
[00:42:57.438] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:57.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:8:0) after 1m0s
[00:43:57.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:8:0)
[00:43:57.457] Timer tick, asking Buildbucket for the build status
[00:43:57.576] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:57.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:9:0) after 1m0s
[00:44:57.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:9:0)
[00:44:57.622] Timer tick, asking Buildbucket for the build status
[00:44:57.994] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:57.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:10:0) after 1m0s
[00:45:58.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:10:0)
[00:45:58.093] Timer tick, asking Buildbucket for the build status
[00:45:58.170] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:58.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:11:0) after 1m0s
[00:46:58.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:11:0)
[00:46:58.517] Timer tick, asking Buildbucket for the build status
[00:46:58.592] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:12:0) after 1m0s
[00:47:58.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:12:0)
[00:47:58.735] Timer tick, asking Buildbucket for the build status
[00:47:58.849] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:58.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:13:0) after 1m0s
[00:48:58.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:13:0)
[00:48:58.891] Timer tick, asking Buildbucket for the build status
[00:48:59.058] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:59.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:14:0) after 1m0s
[00:49:59.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:14:0)
[00:49:59.173] Timer tick, asking Buildbucket for the build status
[00:49:59.236] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:59.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:15:0) after 1m0s
[00:50:59.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:15:0)
[00:50:59.306] Timer tick, asking Buildbucket for the build status
[00:50:59.378] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:59.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:16:0) after 1m0s
[00:51:59.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:16:0)
[00:51:59.480] Timer tick, asking Buildbucket for the build status
[00:51:59.558] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:59.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:17:0) after 1m0s
[00:52:59.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:17:0)
[00:52:59.626] Timer tick, asking Buildbucket for the build status
[00:52:59.705] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:59.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:18:0) after 1m0s
[00:53:59.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:18:0)
[00:53:59.776] Timer tick, asking Buildbucket for the build status
[00:53:59.851] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:59.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:19:0) after 1m0s
[00:54:59.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:19:0)
[00:54:59.921] Timer tick, asking Buildbucket for the build status
[00:54:59.988] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:59.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:20:0) after 1m0s
[00:56:00.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:20:0)
[00:56:00.049] Timer tick, asking Buildbucket for the build status
[00:56:00.314] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:00.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:21:0) after 1m0s
[00:57:00.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:21:0)
[00:57:00.728] Timer tick, asking Buildbucket for the build status
[00:57:00.788] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:00.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:22:0) after 1m0s
[00:58:00.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:22:0)
[00:58:00.951] Timer tick, asking Buildbucket for the build status
[00:58:01.098] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:01.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:23:0) after 1m0s
[00:59:01.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:23:0)
[00:59:01.159] Timer tick, asking Buildbucket for the build status
[00:59:01.234] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:01.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:24:0) after 1m0s
[01:00:01.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:24:0)
[01:00:01.517] Timer tick, asking Buildbucket for the build status
[01:00:01.581] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:01.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:25:0) after 1m0s
[01:01:02.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:25:0)
[01:01:02.174] Timer tick, asking Buildbucket for the build status
[01:01:02.243] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:02.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:26:0) after 1m0s
[01:02:02.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:26:0)
[01:02:02.297] Timer tick, asking Buildbucket for the build status
[01:02:02.508] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:02.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:27:0) after 1m0s
[01:03:02.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:27:0)
[01:03:02.548] Timer tick, asking Buildbucket for the build status
[01:03:02.629] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:28:0) after 1m0s
[01:04:02.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:28:0)
[01:04:02.725] Timer tick, asking Buildbucket for the build status
[01:04:02.830] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:02.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:29:0) after 1m0s
[01:05:02.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:29:0)
[01:05:02.902] Timer tick, asking Buildbucket for the build status
[01:05:02.971] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:02.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:30:0) after 1m0s
[01:06:02.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:30:0)
[01:06:02.993] Timer tick, asking Buildbucket for the build status
[01:06:03.064] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:03.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:31:0) after 1m0s
[01:07:03.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:31:0)
[01:07:03.149] Timer tick, asking Buildbucket for the build status
[01:07:03.515] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:03.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:32:0) after 1m0s
[01:08:03.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:32:0)
[01:08:03.566] Timer tick, asking Buildbucket for the build status
[01:08:03.748] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:03.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:33:0) after 1m0s
[01:09:03.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:33:0)
[01:09:03.739] Timer tick, asking Buildbucket for the build status
[01:09:06.192] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:06.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:34:0) after 1m0s
[01:10:06.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:34:0)
[01:10:06.318] Timer tick, asking Buildbucket for the build status
[01:10:06.411] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:06.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:35:0) after 1m0s
[01:11:06.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:35:0)
[01:11:06.469] Timer tick, asking Buildbucket for the build status
[01:11:06.564] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:06.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:36:0) after 1m0s
[01:12:06.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:36:0)
[01:12:06.578] Timer tick, asking Buildbucket for the build status
[01:12:06.844] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:06.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:37:0) after 1m0s
[01:13:06.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:37:0)
[01:13:06.845] Timer tick, asking Buildbucket for the build status
[01:13:06.941] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:38:0) after 1m0s
[01:14:07.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:38:0)
[01:14:07.019] Timer tick, asking Buildbucket for the build status
[01:14:07.095] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:07.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:39:0) after 1m0s
[01:15:07.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:39:0)
[01:15:07.177] Timer tick, asking Buildbucket for the build status
[01:15:07.272] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:07.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:40:0) after 1m0s
[01:16:07.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:40:0)
[01:16:07.357] Timer tick, asking Buildbucket for the build status
[01:16:07.615] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:07.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:41:0) after 1m0s
[01:17:07.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:41:0)
[01:17:07.634] Timer tick, asking Buildbucket for the build status
[01:17:07.728] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:07.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:42:0) after 1m0s
[01:18:07.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:42:0)
[01:18:07.748] Timer tick, asking Buildbucket for the build status
[01:18:08.128] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:08.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:43:0) after 1m0s
[01:19:08.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:43:0)
[01:19:08.194] Timer tick, asking Buildbucket for the build status
[01:19:08.275] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:08.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:44:0) after 1m0s
[01:20:08.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:44:0)
[01:20:08.354] Timer tick, asking Buildbucket for the build status
[01:20:08.440] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:08.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:45:0) after 1m0s
[01:21:08.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:45:0)
[01:21:08.513] Timer tick, asking Buildbucket for the build status
[01:21:08.587] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:46:0) after 1m0s
[01:22:09.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:46:0)
[01:22:09.121] Timer tick, asking Buildbucket for the build status
[01:22:09.304] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:09.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:47:0) after 1m0s
[01:23:09.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:47:0)
[01:23:09.452] Timer tick, asking Buildbucket for the build status
[01:23:09.556] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:09.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:48:0) after 1m0s
[01:24:09.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:48:0)
[01:24:09.969] Timer tick, asking Buildbucket for the build status
[01:24:10.036] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:49:0) after 1m0s
[01:25:10.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:49:0)
[01:25:10.161] Timer tick, asking Buildbucket for the build status
[01:25:10.222] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:10.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:50:0) after 1m0s
[01:26:10.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:50:0)
[01:26:10.352] Timer tick, asking Buildbucket for the build status
[01:26:10.416] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:10.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:51:0) after 1m0s
[01:27:10.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:51:0)
[01:27:10.558] Timer tick, asking Buildbucket for the build status
[01:27:10.631] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:52:0) after 1m0s
[01:28:10.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:52:0)
[01:28:10.660] Timer tick, asking Buildbucket for the build status
[01:28:10.732] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:53:0) after 1m0s
[01:29:10.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:53:0)
[01:29:10.845] Timer tick, asking Buildbucket for the build status
[01:29:10.932] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:10.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:54:0) after 1m0s
[01:30:11.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:54:0)
[01:30:11.001] Timer tick, asking Buildbucket for the build status
[01:30:11.127] Build 8853099849033824640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:11.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018529910943640144:55:0) after 1m0s
[01:30:22.351] Received PubSub notification, asking Buildbucket for the build status
[01:30:22.567] Build 8853099849033824640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:30:22.567] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615426221573205",
"created_by": "project:chromium",
"created_ts": "1615423075604206",
"id": "8853099849033824640",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\"}}",
"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\": \"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\", \"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-120-qgyz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181285, \"got_angle_revision\": \"331640e5c19e63209de0307ae37dc1ec69a1f4e0\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\", \"got_revision_cp\": \"refs/heads/master@{#861780}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"f6b9f78f5d13401dd4ba1dfdacb65056c89715b5\", \"got_v8_revision_cp\": \"refs/heads/9.1.93@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"83fbf5c6db8c7d694b6069cdbdfff67c071278fb\", \"swarm_hashes_refs/heads/master(at){#861780}_without_patch\": {\"absl_hardening_tests\": \"edf06d607f22a2d982fe62cab4d32e25a64b8ea6\", \"accessibility_unittests\": \"ca142b0a25700b006c635f659ea67714103136b3\", \"angle_unittests\": \"28385342c988ed88d722b81e4eb64a0d9375abcd\", \"app_shell_unittests\": \"b09b5a51a51e0650386d05d1954f29029cbbc972\", \"aura_unittests\": \"99da5ada3ccf51af95634dd7265a9466e384fb00\", \"base_unittests\": \"1605cbdf2f6179c46bf7f9d212d72a6a3899fe51\", \"base_util_unittests\": \"ea5c3a4025a17c26de7eb861840a250940444258\", \"blink_common_unittests\": \"44ffcb71e45b25d5a86795fe6bea6b59306bb74a\", \"blink_fuzzer_unittests\": \"c38a442809ac77ad319abae321fd023f9bb07e91\", \"blink_heap_unittests\": \"18c0ae33008dc15d68e8bc60fb2ab91825da9bd1\", \"blink_platform_unittests\": \"acbb8205bd18c040af597f7b484a41fdaf0b2e06\", \"blink_python_tests\": \"006ffec52ed2c96299243879afbbb5f43cd7c275\", \"blink_unittests\": \"09f38b3eeea7e2b6fc46a5ec1c3841cab8733f2b\", \"blink_web_tests\": \"54b54cd4aa2188ab1a6e67bc4213e51acb474cff\", \"boringssl_crypto_tests\": \"b3b69ff79895de3a0960d6aecf5239cade723628\", \"boringssl_ssl_tests\": \"ab712429455909d8b6b78ade69d83679cb254077\", \"browser_tests\": \"df0ab20af41d29a6ba74a88c6d1a27784554f270\", \"capture_unittests\": \"11655de373f2d1f6d4355dc7ee740ef2e286eca4\", \"cast_unittests\": \"4d0c174881442f0c92ae303ce4e23821a3d01a85\", \"cc_unittests\": \"b6a22478b2e9cdfbdc015ffb062732fa8f750ab8\", \"chrome_app_unittests\": \"01122bc662d624c2fecfeaf2d67a31e99ca1c2bc\", \"chromedriver_unittests\": \"d51efa095c5d3dafdf3e8bf4eed888e311ff2489\", \"color_unittests\": \"d0bc899b18e790d1048908ece57e9b90fbec8af6\", \"components_browsertests\": \"ad2ce58703b92ee6c8e63cb54dc3aef98b630a72\", \"components_unittests\": \"44c572383395aeaec9aea4441ac4a486e66ca80c\", \"compositor_unittests\": \"18c0dd0a5c8fcf172dbaa9460db800fde5b33596\", \"content_browsertests\": \"6d2cc6dfeec4a8f056c4955fce725bd21efb152f\", \"content_shell_crash_test\": \"955bf6dacfb88d060a2ce028de155c730d5d54a5\", \"content_unittests\": \"6de649db6acd539aab88cacb25554d21747463ee\", \"crashpad_tests\": \"81011ec44ff8df7e21e7ee0d746a3e156f5fb171\", \"cronet_tests\": \"d9637a24bc92a60c8b6997a35b3bcf4f938df723\", \"cronet_unittests\": \"9a388529e19dfdb4c0c13a8e88155496a725abb8\", \"crypto_unittests\": \"d2595fbec88ed3bad0bc1bb0d74060d21418657e\", \"dbus_unittests\": \"5d0349448d1f08dc3cd7ff19d5865bb1f4c24ebb\", \"device_unittests\": \"59ee2ed1bb848cb6411b3d0cc1383846607221e1\", \"display_unittests\": \"15700d1e8faec34df46c352e2021c864f55094b9\", \"events_unittests\": \"81d40ccd983e281f63ea6157015e46a1669fd6e6\", \"extensions_browsertests\": \"ed4096d5ca78749cd7664a4a1d34017330e63b38\", \"extensions_unittests\": \"38e1ba261c99e38b11b8e2f5b956abbadcd8b9ee\", \"filesystem_service_unittests\": \"986e685ec164c173f3727c3a5d48c0911c9d685e\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"ec9ffad03a0376cad5b748b89df0a7de4a5ff653\", \"gfx_unittests\": \"352ac29761d71ee3632f99349959e73fce16c37f\", \"gin_unittests\": \"0fba9867b4aed0a9407616595da68b9bc265afb2\", \"google_apis_unittests\": \"d0cd5bc8b37ce59d74d2ada77a7cc7dd8cc272e0\", \"gpu_unittests\": \"107394137e2500825a706323bf80750d24ad3e35\", \"grit_python_unittests\": \"2629172029a5ce27ead3b3791972502f1e7f17c8\", \"gwp_asan_unittests\": \"01ee4b6593b17e7b5669ca79f496d61e5881a7eb\", \"headless_browsertests\": \"e5b786c23cc5a83c43f59e4ec7a4d46bebea2cdf\", \"headless_unittests\": \"855b0094833b791670dc0f0dc8e4d38fa8b1e711\", \"interactive_ui_tests\": \"089d0d9df21eb128c982ccd73de5b1a7dd59e506\", \"ipc_tests\": \"b5d1a8eb7c3c51b59c89b7f4bd8e46bd0f2d3cb9\", \"jingle_unittests\": \"274b9b4aa8156ed3ff30f4aec31aa6f76057a3fa\", \"latency_unittests\": \"5e02c4412b4760e4760666a8967eef12e8ab4b0e\", \"libjingle_xmpp_unittests\": \"b22aaea32d899ba902cfa0b1ace11797ab22c759\", \"liburlpattern_unittests\": \"63239e2a1c011b27197b3d0d8d514d9ab7ffeb46\", \"media_blink_unittests\": \"8f4848cd62f5f7c4c9cc12da7da591d67c7b88b2\", \"media_unittests\": \"0ca711010e57e86a449c3aa334eb04769de0caf4\", \"message_center_unittests\": \"3edc85a2dc15ecfc807010b7c5b7dca9e0cc3cb7\", \"metrics_python_tests\": \"f9ad1586f82f6ed6cb891778ea5f6d48ca421adb\", \"midi_unittests\": \"9a3c114a6b1af12ea0b008ee453f0e7536f8dfd3\", \"mojo_core_unittests\": \"c5f1536f75b09a8b40fa4a152760d2d736d29e92\", \"mojo_unittests\": \"15c60c5b5cddf1bdd7b181517cec24d293b51e53\", \"nacl_helper_nonsfi_unittests\": \"63ff8526966c399e904d8287e10ad1ea76c12765\", \"nacl_loader_unittests\": \"fdbdccecaac86784ac81f029eab06fe49f4807f9\", \"native_theme_unittests\": \"5d2a27eabef2d5b6282d32075673fd1736297139\", \"net_unittests\": \"af43bd42921c6d0427c052f07d3af6a99787b3c3\", \"openscreen_unittests\": \"6d98f2b88926cb7b2c2c98a4fec36a00b8c94e32\", \"pdf_unittests\": \"e72bf0be4d7a5b78bf9a09d7f01325184bdb2b4d\", \"perfetto_unittests\": \"339d2a2c389351f452ff8bb0a430971225ec0178\", \"ppapi_unittests\": \"f7f020cb8a2b0cf55ed69224ccef71009d11d3b0\", \"printing_unittests\": \"1be8c65d4f980135dbc7c585bcc0923277fd6461\", \"remoting_unittests\": \"7928c2e04cca2fe023a447e0e84bcd56520146e3\", \"sandbox_linux_unittests\": \"7a2375a57100ac53ca7a4a9ed0ad51244122a472\", \"service_manager_unittests\": \"dfee69160d786da6ec820aea030699fcd5bfd64f\", \"services_unittests\": \"a06707e349df4493751c39adae6c416641289445\", \"shell_dialogs_unittests\": \"8aacbf3b4d8e9bab31265572baab2acc45ac1835\", \"skia_unittests\": \"ba9fe734f6acf2dbcd1030bda0478d2e5e54d288\", \"snapshot_unittests\": \"cc1d25cae1ad8951c8f338a24508cd85851945b1\", \"sql_unittests\": \"a7ed6f3d63332b98af480263fd9164a5cdf4898a\", \"storage_unittests\": \"30f67094938b4664712e87d118574b9709f10a2e\", \"sync_integration_tests\": \"4246006a06cbfe6d64788021366833729b54946f\", \"telemetry_gpu_unittests\": \"95a546eaa4cad8f172cb26b6847bb2d1c42b1cdc\", \"telemetry_perf_unittests\": \"f281f678fa39723369921992c09732d1071224d2\", \"telemetry_unittests\": \"60db93f6c527683549a0b25a7c334be482ad2c5c\", \"traffic_annotation_auditor_unittests\": \"7ef7c0d3093059f967f28cc8c245993a277ab933\", \"ui_base_unittests\": \"74f64afbb21dd47e3a5656d12b12f09c928b870d\", \"ui_touch_selection_unittests\": \"07a695eb784e48f0d51d3d429869ccd68df98ceb\", \"unit_tests\": \"28f80664fb586e71a322d24d7ef0dcf5ac5b09c0\", \"url_unittests\": \"22d458ef86bf2db054ca646fd4507af39b7d2f27\", \"views_perftests\": \"0018ce7ce8a8b26a51af3f583c3f60c3f39322cd\", \"views_unittests\": \"2d02a445f869e76708b86a16a235f11d5b419c23\", \"viz_unittests\": \"cd6f068bfa9df38d849dfb36bed4c789576ae1a1\", \"vr_common_unittests\": \"b719f86d77a0eb85561bff0b82e6b0bfdb5c6f21\", \"vr_pixeltests\": \"3344e5eb63afbdc3f3db3959744f8178b8b8abe9\", \"webdriver_wpt_tests\": \"15ea4685bde0ce121f624fc6a216353c0e757143\", \"weblayer_browsertests\": \"678db554618f33b8e008f0ed59b44e5b5196a165\", \"weblayer_unittests\": \"8d8277ec51a77cabbae4cff219a9103250bbff3c\", \"wm_unittests\": \"639439d1a6cc629b451e8a2d9627ef9e122a9b6c\", \"wtf_unittests\": \"d405092b10282cf9fb6c51508982e3d95d01925a\", \"x11_unittests\": \"dfeb293baa081fd7573644b9634b70abd0a29891\", \"xr_browser_tests\": \"08103f4f6399f2f404dc966dc67c6d4fd10741ef\", \"zlib_unittests\": \"f2dd5adafa0e9d9a7380018c8d4cb5b7ac3b8b85\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_13c9e4757ca6a1772742c665222564667630a6453df92e57dfb1ace791cbcc32_v2\", \"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_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-120-qgyz\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615423077623401",
"status": "COMPLETED",
"status_changed_ts": "1615426222007699",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181285",
"builder:Linux Builder (dbg)",
"buildset:commit/git/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83fbf5c6db8c7d694b6069cdbdfff67c071278fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018529910943640144",
"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/8853099849033824640/+/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:52378980e06d5710",
"user_agent:luci-scheduler"
],
"updated_ts": "1615426222012243",
"url": "https://ci.chromium.org/b/8853099849033824640",
"utcnow_ts": "1615426222551792"
}
}
[01:30:22.567] Invocation finished in 52m28.168368614s with status SUCCEEDED