[07:07:55.518] New invocation is queued and will start shortly
[07:07:56.691] Starting the invocation (attempt 1)
[07:07:56.734] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:07:56.734] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:07:56.734] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029467606052574816",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9029467606052574816",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"gitiles_ref:refs/heads/master"
]
}
[07:07:58.171] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604992076905605",
"id": "8864037543925752544",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604992077866849",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177530",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029467606052574816",
"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/8864037543925752544/+/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": "1604992077867018",
"url": "https://ci.chromium.org/b/8864037543925752544",
"utcnow_ts": "1604992078157604"
}
}
[07:07:58.171] Task URL: https://ci.chromium.org/b/8864037543925752544
[07:07:58.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:2:0) after 1m0s
[07:08:02.499] Received PubSub notification, asking Buildbucket for the build status
[07:08:02.727] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:58.285] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:2:0)
[07:08:58.285] Timer tick, asking Buildbucket for the build status
[07:08:58.581] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:58.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:4:0) after 1m0s
[07:09:58.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:4:0)
[07:09:58.628] Timer tick, asking Buildbucket for the build status
[07:09:58.833] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:5:0) after 1m0s
[07:10:58.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:5:0)
[07:10:58.862] Timer tick, asking Buildbucket for the build status
[07:10:59.039] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:59.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:6:0) after 1m0s
[07:11:59.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:6:0)
[07:11:59.131] Timer tick, asking Buildbucket for the build status
[07:11:59.675] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:59.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:7:0) after 1m0s
[07:12:59.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:7:0)
[07:12:59.705] Timer tick, asking Buildbucket for the build status
[07:12:59.792] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:59.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:8:0) after 1m0s
[07:13:59.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:8:0)
[07:13:59.860] Timer tick, asking Buildbucket for the build status
[07:13:59.931] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:9:0) after 1m0s
[07:14:59.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:9:0)
[07:14:59.954] Timer tick, asking Buildbucket for the build status
[07:15:00.185] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:00.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:10:0) after 1m0s
[07:16:00.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:10:0)
[07:16:00.695] Timer tick, asking Buildbucket for the build status
[07:16:00.829] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:00.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:11:0) after 1m0s
[07:17:03.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:11:0)
[07:17:03.091] Timer tick, asking Buildbucket for the build status
[07:17:03.231] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:03.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:12:0) after 1m0s
[07:18:03.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:12:0)
[07:18:03.269] Timer tick, asking Buildbucket for the build status
[07:18:03.503] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:03.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:13:0) after 1m0s
[07:19:03.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:13:0)
[07:19:03.667] Timer tick, asking Buildbucket for the build status
[07:19:03.769] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:03.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:14:0) after 1m0s
[07:20:03.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:14:0)
[07:20:03.799] Timer tick, asking Buildbucket for the build status
[07:20:03.884] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:03.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:15:0) after 1m0s
[07:21:03.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:15:0)
[07:21:03.946] Timer tick, asking Buildbucket for the build status
[07:21:04.023] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:04.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:16:0) after 1m0s
[07:22:04.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:16:0)
[07:22:04.095] Timer tick, asking Buildbucket for the build status
[07:22:04.157] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:17:0) after 1m0s
[07:23:04.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:17:0)
[07:23:04.260] Timer tick, asking Buildbucket for the build status
[07:23:04.374] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:04.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:18:0) after 1m0s
[07:24:04.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:18:0)
[07:24:04.428] Timer tick, asking Buildbucket for the build status
[07:24:04.520] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:04.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:19:0) after 1m0s
[07:25:04.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:19:0)
[07:25:04.567] Timer tick, asking Buildbucket for the build status
[07:25:04.939] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:04.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:20:0) after 1m0s
[07:26:04.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:20:0)
[07:26:04.972] Timer tick, asking Buildbucket for the build status
[07:26:05.034] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:05.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:21:0) after 1m0s
[07:27:05.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:21:0)
[07:27:05.085] Timer tick, asking Buildbucket for the build status
[07:27:05.230] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:05.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:22:0) after 1m0s
[07:28:05.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:22:0)
[07:28:05.291] Timer tick, asking Buildbucket for the build status
[07:28:05.392] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:05.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:23:0) after 1m0s
[07:29:05.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:23:0)
[07:29:05.424] Timer tick, asking Buildbucket for the build status
[07:29:05.494] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:24:0) after 1m0s
[07:30:06.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:24:0)
[07:30:06.605] Timer tick, asking Buildbucket for the build status
[07:30:06.807] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:06.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:25:0) after 1m0s
[07:31:06.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:25:0)
[07:31:06.932] Timer tick, asking Buildbucket for the build status
[07:31:07.238] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:07.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:26:0) after 1m0s
[07:32:07.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:26:0)
[07:32:07.327] Timer tick, asking Buildbucket for the build status
[07:32:07.415] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:07.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:27:0) after 1m0s
[07:33:07.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:27:0)
[07:33:07.507] Timer tick, asking Buildbucket for the build status
[07:33:07.655] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:07.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:28:0) after 1m0s
[07:34:07.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:28:0)
[07:34:07.677] Timer tick, asking Buildbucket for the build status
[07:34:07.737] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:07.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:29:0) after 1m0s
[07:35:07.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:29:0)
[07:35:07.837] Timer tick, asking Buildbucket for the build status
[07:35:07.901] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:07.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:30:0) after 1m0s
[07:36:07.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:30:0)
[07:36:07.986] Timer tick, asking Buildbucket for the build status
[07:36:08.056] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:08.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:31:0) after 1m0s
[07:37:08.063] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:31:0)
[07:37:08.063] Timer tick, asking Buildbucket for the build status
[07:37:08.132] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:08.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:32:0) after 1m0s
[07:38:08.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:32:0)
[07:38:08.158] Timer tick, asking Buildbucket for the build status
[07:38:08.260] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:08.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:33:0) after 1m0s
[07:39:08.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:33:0)
[07:39:08.257] Timer tick, asking Buildbucket for the build status
[07:39:08.314] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:08.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:34:0) after 1m0s
[07:40:08.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:34:0)
[07:40:08.387] Timer tick, asking Buildbucket for the build status
[07:40:08.579] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:08.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:35:0) after 1m0s
[07:41:08.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:35:0)
[07:41:08.586] Timer tick, asking Buildbucket for the build status
[07:41:08.673] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:08.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:36:0) after 1m0s
[07:42:08.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:36:0)
[07:42:08.701] Timer tick, asking Buildbucket for the build status
[07:42:08.804] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:08.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:37:0) after 1m0s
[07:43:08.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:37:0)
[07:43:08.834] Timer tick, asking Buildbucket for the build status
[07:43:09.180] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:09.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:38:0) after 1m0s
[07:44:09.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:38:0)
[07:44:09.187] Timer tick, asking Buildbucket for the build status
[07:44:09.323] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:09.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:39:0) after 1m0s
[07:45:09.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:39:0)
[07:45:09.381] Timer tick, asking Buildbucket for the build status
[07:45:09.441] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:09.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:40:0) after 1m0s
[07:46:09.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:40:0)
[07:46:09.532] Timer tick, asking Buildbucket for the build status
[07:46:09.598] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:09.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:41:0) after 1m0s
[07:47:09.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:41:0)
[07:47:09.705] Timer tick, asking Buildbucket for the build status
[07:47:09.761] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:09.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:42:0) after 1m0s
[07:48:09.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:42:0)
[07:48:09.988] Timer tick, asking Buildbucket for the build status
[07:48:10.135] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:10.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:43:0) after 1m0s
[07:49:10.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:43:0)
[07:49:10.227] Timer tick, asking Buildbucket for the build status
[07:49:10.473] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:10.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:44:0) after 1m0s
[07:50:10.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:44:0)
[07:50:10.759] Timer tick, asking Buildbucket for the build status
[07:50:10.905] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:10.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:45:0) after 1m0s
[07:51:11.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:45:0)
[07:51:11.031] Timer tick, asking Buildbucket for the build status
[07:51:11.174] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:11.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:46:0) after 1m0s
[07:52:11.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:46:0)
[07:52:11.208] Timer tick, asking Buildbucket for the build status
[07:52:11.268] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:11.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:47:0) after 1m0s
[07:53:11.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:47:0)
[07:53:11.341] Timer tick, asking Buildbucket for the build status
[07:53:11.548] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:11.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:48:0) after 1m0s
[07:54:11.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:48:0)
[07:54:11.698] Timer tick, asking Buildbucket for the build status
[07:54:11.787] Build 8864037543925752544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:11.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9029467606052574816:49:0) after 1m0s
[07:54:40.505] Received PubSub notification, asking Buildbucket for the build status
[07:54:40.582] Build 8864037543925752544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:54:40.583] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604994879865194",
"created_by": "project:chromium",
"created_ts": "1604992076905605",
"id": "8864037543925752544",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\"}}",
"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\": \"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\", \"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-11-2b4d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177530, \"got_angle_revision\": \"528ae31edd58f95fac1cba36866b7b477a97f5a0\", \"got_dawn_revision\": \"c04a0132be6c384c90bd33b06929a9b7fc5d4726\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\", \"got_revision_cp\": \"refs/heads/master@{#825704}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"0833ef4127bc532629c6a7952fb8b18ffaa95e85\", \"got_v8_revision_cp\": \"refs/heads/8.8.269@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"f61ee8987ccd82bfc8845f2c7b8abb260a32220c\", \"swarm_hashes_refs/heads/master(at){#825704}_without_patch\": {\"absl_hardening_tests\": \"1e12862b344bda650868372884ec80762346b156\", \"accessibility_unittests\": \"b10cf5f35c596bfacf5f869d13693be21937333b\", \"angle_unittests\": \"c42adaf5035c895976012d14e01a37c52849a6ec\", \"app_shell_unittests\": \"01479f8c26a20178b9650a461d43686967353c9a\", \"aura_unittests\": \"8c59baa9afb570b0e3f1bb1dd1f45be4a2459936\", \"base_unittests\": \"9fdd927a885e070faa64937665c338e6ca422025\", \"base_util_unittests\": \"cd9a4d57b271cbffc72fb3a9793262a9b4caaf20\", \"blink_common_unittests\": \"d98f1732a018b922470e022f8cc142a88af515dd\", \"blink_fuzzer_unittests\": \"668ec5d6f7e77bbf058fb1ab5c63f9e93367d151\", \"blink_heap_unittests\": \"f6f3faa09a336d64c059811b78acd8a7c0842465\", \"blink_platform_unittests\": \"0acae73c9c7edad5b801dd97b0c021558889af08\", \"blink_python_tests\": \"cbff69f281f3a1a8801f623ce713c4d280459de4\", \"blink_unittests\": \"e28601b6034cc43caeea29de35cad5ca1a1b5877\", \"blink_web_tests\": \"1f0bfc2a31d9f1835a05e1ccb4152614f0248ee7\", \"boringssl_crypto_tests\": \"b5c3ab69192bd383ba0867184f142624284d8927\", \"boringssl_ssl_tests\": \"024df5b809bccababa83d93a2b917716ce149b52\", \"browser_tests\": \"c5127217f5c794f9dd07083d836086703df7df4e\", \"capture_unittests\": \"f70bfd8bd177bf970d9e4eee7ca503a4282a1ed0\", \"cast_unittests\": \"16aed083558d45a90b00f6f4109e646fbcf7763f\", \"cc_unittests\": \"fd694edbb5b5b0ebc70c1e144a4c47e1b7640207\", \"chrome_app_unittests\": \"4d4e421e52b358267d6f73fdeff128e1753ef184\", \"chromedriver_unittests\": \"bf372bd7fc0e4798c987e65a1bd1bdc734bf1314\", \"components_browsertests\": \"bf13c3c59074e3d818d1854c97f1da7a2f87b0af\", \"components_unittests\": \"2a140eef8497a8e0fd1cea9a75b4c2a9b51b770f\", \"compositor_unittests\": \"c510fd3a82aa86ce1c0d115c1e4f52a0d6ae0093\", \"content_browsertests\": \"bb69fbf1b0177703c0251cbbe194b90522d3be54\", \"content_shell_crash_test\": \"5c461f9a0122bfa74098c66d05ef7c0ca65608f7\", \"content_unittests\": \"d522ff16a54b7394ac091ee4c51de19a6321fd19\", \"crashpad_tests\": \"9ad1db04f54f144e6349785cfd4d34685144f045\", \"cronet_tests\": \"b846eee1e039682f1f931e85babc96ce148dd92a\", \"cronet_unittests\": \"f42f73ed54387a21c1726efc0e885a8c88362305\", \"crypto_unittests\": \"49d9e92041a674dc9b5e6413869eadef330ffedd\", \"dbus_unittests\": \"32c1775971fdb5cfd8eabee56c52a2b11e9f34c9\", \"device_unittests\": \"f9002c253630333ce0bc65d0dac1210cccf1e781\", \"display_unittests\": \"c959ef59ee4f31ba3fdb0ea6f2ef67123e897f28\", \"events_unittests\": \"41e461a752552d86e3d82ad52dce2348f71ed209\", \"extension_docserver_python_unittests\": \"e7063fef04c51ec718de1cb4d90a40a83cc47e61\", \"extensions_browsertests\": \"3ae690e5d5a52e6b2049ed18ec70d808a2604206\", \"extensions_unittests\": \"eccb8f290cf9ef7ed3d4bbf7a03e2bd9aa63cb32\", \"filesystem_service_unittests\": \"71fb36b180f5f5782c455e93cfe88b18c28efd41\", \"flatbuffers_unittests\": \"a75979d220fd6e42d14b6fb920789a229acd99ec\", \"gcm_unit_tests\": \"de144c230d3eb92788839a2dc461c901454672fa\", \"gfx_unittests\": \"82e1bebc8ae92248ddad1138bb16f1ae6a76f428\", \"gin_unittests\": \"497106420e831834aad717a2e28c3ca357e199bf\", \"google_apis_unittests\": \"6088b5479b85183a6df54457c53c4f654a5f7364\", \"gpu_unittests\": \"048ee0a84f3152cc9b502eadfd54c8e408974cad\", \"grit_python_unittests\": \"8567a2d537d6124a800e9d3ffe565d23c37a0400\", \"gwp_asan_unittests\": \"8e7d4880e15ac9afabdc22d9de60458552a16776\", \"headless_browsertests\": \"427b8107ab4e107589d58f53ce16c630a5704c48\", \"headless_unittests\": \"e1d20411d09af68dba2b33cd25df201220f47011\", \"interactive_ui_tests\": \"4d70108e9f160066e5812c62092654d826ed3d2d\", \"ipc_tests\": \"a37a0a6df78bd63c7c41b45b7b07e376c9ed18ff\", \"jingle_unittests\": \"1f775c23f03f9be89f1448d6e497b4d527db9150\", \"latency_unittests\": \"f4d14bebfced496b7313ae2cc03adf9ad26db9fe\", \"libjingle_xmpp_unittests\": \"a6d1f91e5554c3da4df62e2f667f37d76216b8c0\", \"liburlpattern_unittests\": \"0688db3d4945f24d257bc2a5ee12d77c59ebd2b6\", \"media_blink_unittests\": \"3821260d6309f94ba0900e3ed2fc6947446c772c\", \"media_unittests\": \"20d6c00347d56718e8d9b10bd008c73e2b2edb21\", \"message_center_unittests\": \"b440940d766864112353fe9390cceec363b65a52\", \"metrics_python_tests\": \"d4b53640f99b6cc06fbe843ac4406397ac2764e0\", \"midi_unittests\": \"cab8319dfc91f657f00edb6ddf6fe7a6f37eb97f\", \"mojo_core_unittests\": \"436d94e3f5e03b49940ed955626a16fd78cb20cd\", \"mojo_unittests\": \"78a03514d4494fcbddb7359d010045665d5e547f\", \"nacl_helper_nonsfi_unittests\": \"239b94ab72da9f1845e1043e7eb2da69b03ede4f\", \"nacl_loader_unittests\": \"f29f1c8a39d3c9ac3c49956052bc90fbddbb6176\", \"native_theme_unittests\": \"8abcc190b893b0c0fc759a1a80a8788fe840d333\", \"net_unittests\": \"a7c8a23a4b0a5a811b5c00b82d53e0cc6ab83418\", \"openscreen_unittests\": \"98b51e9ea8eef1a4b5aeaf66f60840d62b1ae82e\", \"pdf_unittests\": \"fc9a9f40e45380e3827c6fd916004e70c88f8f3d\", \"perfetto_unittests\": \"a055fbbbfd81c4a30ba46299e66ea12b50634dca\", \"ppapi_unittests\": \"b0f51458fd296c75580d980624c443d96fbc0fe2\", \"printing_unittests\": \"3768e7963931f7c339506f621758f63a6f5e5e2b\", \"remoting_unittests\": \"6597f433ed27cd610ce4c5a29df21ccbbcbcc1e3\", \"sandbox_linux_unittests\": \"6eb884c17ef1471d7cd28bc698c23bb95ef23260\", \"service_manager_unittests\": \"a69ebeea01488378ebc434c7aa0dd5371dc84d2b\", \"services_unittests\": \"883b5b3c7a47b6fafae413804dc10ec81845966a\", \"shell_dialogs_unittests\": \"619fc445e8e9d1f03220742ebf9f1389136c65e0\", \"skia_unittests\": \"bcbf4f5a93322f94970e77b5786a4761c4751580\", \"snapshot_unittests\": \"25ec8cd68f32b3a46825b44e2942bf1e82a95759\", \"sql_unittests\": \"9ad434d94627224add16be0ab6e01532e98a87ff\", \"storage_unittests\": \"b98896d235b659d2e19738aaa15cc476d6b10085\", \"sync_integration_tests\": \"5015fad77ee43bfac03a9f906e8c088fd0bf49e6\", \"telemetry_gpu_unittests\": \"d0ea74ed8d3c3c962e7e377ce5fd6539b3a2fab5\", \"telemetry_perf_unittests\": \"c1af47f259aaea0e49269cb1301940b5f1199f05\", \"telemetry_unittests\": \"cf7e6e3a60026e5495fbfd083f5841d1adfc8e69\", \"traffic_annotation_auditor_unittests\": \"c68f9a2d5657b90e004c185ef08cead74cb0ef46\", \"ui_base_unittests\": \"696ae15fa1856f8114b62abe3e428c9d1e073283\", \"ui_touch_selection_unittests\": \"a769736725acfe4e3c65dddf3247e248c8c98d5b\", \"unit_tests\": \"79edfcf6c2102379a8549de16203a6e93eac4757\", \"url_unittests\": \"5dcecac2396b664c10bf01fdf35b1c866fe94240\", \"views_perftests\": \"3848cd00312b55929177c0ab8798301e0de64866\", \"views_unittests\": \"da9a6125bd87e6e0cad85cde3d0398921513e6f6\", \"viz_unittests\": \"8e36a045c575139f9e8a1c461b838f9044332cb5\", \"vr_common_unittests\": \"bf66b04bded505b53bfafbd132e8bb2a62e85c3d\", \"vr_pixeltests\": \"bccd1973145d8ba0c53bbeb55aaddb998bd9dd3b\", \"webdriver_wpt_tests\": \"4965055a448d546726a2d134eab8a4fcc8a3e53a\", \"weblayer_browsertests\": \"5114e737545ea6b0003a7338932588c8c60edbda\", \"weblayer_unittests\": \"88c4dae68142237b9f93bc301a9f353145bfc692\", \"wm_unittests\": \"a4e5c611a7481e6a7a0bb969b83bc7938293f752\", \"wtf_unittests\": \"531ea2dfe9db81c349c9cc509fb7457beffdff44\", \"x11_unittests\": \"5918beac003dc1d87e8ed491a61797ccda8617c6\", \"xr_browser_tests\": \"74dc825d38ff9a1408e2d3787c4512123e42f0f2\", \"zlib_unittests\": \"07ccb718f2f945f2c48129f53c1c7dc5e9269480\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_423c17966b99e0a79c01db6cfc0136b5313fefdfff3f88d25a8a4e9f8c30f88c_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_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-11-2b4d\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604992081729736",
"status": "COMPLETED",
"status_changed_ts": "1604994880229697",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177530",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f61ee8987ccd82bfc8845f2c7b8abb260a32220c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029467606052574816",
"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/8864037543925752544/+/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:4fc9cd196c558710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604994880239787",
"url": "https://ci.chromium.org/b/8864037543925752544",
"utcnow_ts": "1604994880572348"
}
}
[07:54:40.583] Invocation finished in 46m45.089886678s with status SUCCEEDED