[17:27:42.131] New invocation is queued and will start shortly
[17:27:43.221] Starting the invocation (attempt 1)
[17:27:43.272] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:27:43.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:27:43.272] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054523972748830304",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054523972748830304",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"gitiles_ref:refs/heads/master"
]
}
[17:27:44.102] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1581096463412815",
"id": "8889093910739895920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581096463808250",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168348",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054523972748830304",
"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/8889093910739895920/+/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": "1581096463808355",
"url": "https://ci.chromium.org/b/8889093910739895920",
"utcnow_ts": "1581096464094585"
}
}
[17:27:44.102] Task URL: https://ci.chromium.org/b/8889093910739895920
[17:27:44.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:2:0) after 1m0s
[17:28:44.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:2:0)
[17:28:44.136] Timer tick, asking Buildbucket for the build status
[17:28:44.575] Build 8889093910739895920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:44.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:3:0) after 1m0s
[17:29:44.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:3:0)
[17:29:44.701] Timer tick, asking Buildbucket for the build status
[17:29:44.832] Build 8889093910739895920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:44.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:4:0) after 1m0s
[17:30:44.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:4:0)
[17:30:44.893] Timer tick, asking Buildbucket for the build status
[17:30:45.437] Build 8889093910739895920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:45.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:5:0) after 1m0s
[17:31:45.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:5:0)
[17:31:45.471] Timer tick, asking Buildbucket for the build status
[17:31:46.012] Build 8889093910739895920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:46.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:6:0) after 1m0s
[17:32:10.586] Received PubSub notification, asking Buildbucket for the build status
[17:32:11.094] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:46.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:6:0)
[17:32:46.039] Timer tick, asking Buildbucket for the build status
[17:32:46.596] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:46.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:8:0) after 1m0s
[17:33:46.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:8:0)
[17:33:46.583] Timer tick, asking Buildbucket for the build status
[17:33:46.729] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:46.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:9:0) after 1m0s
[17:34:46.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:9:0)
[17:34:46.917] Timer tick, asking Buildbucket for the build status
[17:34:47.651] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:47.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:10:0) after 1m0s
[17:35:47.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:10:0)
[17:35:47.697] Timer tick, asking Buildbucket for the build status
[17:35:47.852] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:47.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:11:0) after 1m0s
[17:36:47.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:11:0)
[17:36:47.879] Timer tick, asking Buildbucket for the build status
[17:36:48.101] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:48.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:12:0) after 1m0s
[17:37:48.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:12:0)
[17:37:48.217] Timer tick, asking Buildbucket for the build status
[17:37:48.404] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:48.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:13:0) after 1m0s
[17:38:48.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:13:0)
[17:38:48.421] Timer tick, asking Buildbucket for the build status
[17:38:48.752] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:48.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:14:0) after 1m0s
[17:39:48.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:14:0)
[17:39:48.811] Timer tick, asking Buildbucket for the build status
[17:39:49.446] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:49.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:15:0) after 1m0s
[17:40:49.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:15:0)
[17:40:49.515] Timer tick, asking Buildbucket for the build status
[17:40:49.671] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:49.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:16:0) after 1m0s
[17:41:49.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:16:0)
[17:41:49.801] Timer tick, asking Buildbucket for the build status
[17:41:49.977] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:49.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:17:0) after 1m0s
[17:42:50.009] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:17:0)
[17:42:50.009] Timer tick, asking Buildbucket for the build status
[17:42:50.260] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:50.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:18:0) after 1m0s
[17:43:50.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:18:0)
[17:43:50.286] Timer tick, asking Buildbucket for the build status
[17:43:52.385] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:52.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:19:0) after 1m0s
[17:44:52.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:19:0)
[17:44:52.390] Timer tick, asking Buildbucket for the build status
[17:44:52.998] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:52.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:20:0) after 1m0s
[17:45:53.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:20:0)
[17:45:53.072] Timer tick, asking Buildbucket for the build status
[17:45:53.205] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:53.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:21:0) after 1m0s
[17:46:53.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:21:0)
[17:46:53.367] Timer tick, asking Buildbucket for the build status
[17:46:54.056] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:54.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:22:0) after 1m0s
[17:47:54.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:22:0)
[17:47:54.167] Timer tick, asking Buildbucket for the build status
[17:47:54.581] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:54.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:23:0) after 1m0s
[17:48:54.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:23:0)
[17:48:54.623] Timer tick, asking Buildbucket for the build status
[17:48:55.214] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:55.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:24:0) after 1m0s
[17:49:55.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:24:0)
[17:49:55.238] Timer tick, asking Buildbucket for the build status
[17:49:55.420] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:55.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:25:0) after 1m0s
[17:50:55.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:25:0)
[17:50:55.641] Timer tick, asking Buildbucket for the build status
[17:50:56.181] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:56.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:26:0) after 1m0s
[17:51:56.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:26:0)
[17:51:56.245] Timer tick, asking Buildbucket for the build status
[17:51:56.418] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:56.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:27:0) after 1m0s
[17:52:56.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:27:0)
[17:52:56.486] Timer tick, asking Buildbucket for the build status
[17:52:57.312] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:57.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:28:0) after 1m0s
[17:53:57.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:28:0)
[17:53:57.355] Timer tick, asking Buildbucket for the build status
[17:53:58.227] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:58.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:29:0) after 1m0s
[17:54:58.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:29:0)
[17:54:58.203] Timer tick, asking Buildbucket for the build status
[17:54:58.397] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:58.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:30:0) after 1m0s
[17:55:58.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:30:0)
[17:55:58.503] Timer tick, asking Buildbucket for the build status
[17:55:59.455] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:59.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:31:0) after 1m0s
[17:56:59.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:31:0)
[17:56:59.477] Timer tick, asking Buildbucket for the build status
[17:56:59.622] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:59.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:32:0) after 1m0s
[17:57:59.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:32:0)
[17:57:59.636] Timer tick, asking Buildbucket for the build status
[17:58:00.808] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:00.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:33:0) after 1m0s
[17:59:01.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:33:0)
[17:59:01.108] Timer tick, asking Buildbucket for the build status
[17:59:01.391] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:01.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:34:0) after 1m0s
[18:00:01.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:34:0)
[18:00:01.629] Timer tick, asking Buildbucket for the build status
[18:00:01.849] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:01.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:35:0) after 1m0s
[18:01:02.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:35:0)
[18:01:02.028] Timer tick, asking Buildbucket for the build status
[18:01:02.180] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:02.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:36:0) after 1m0s
[18:02:02.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:36:0)
[18:02:02.295] Timer tick, asking Buildbucket for the build status
[18:02:02.684] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:02.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:37:0) after 1m0s
[18:03:02.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:37:0)
[18:03:02.835] Timer tick, asking Buildbucket for the build status
[18:03:02.983] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:02.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:38:0) after 1m0s
[18:04:03.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:38:0)
[18:04:03.099] Timer tick, asking Buildbucket for the build status
[18:04:03.296] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:03.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:39:0) after 1m0s
[18:05:03.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:39:0)
[18:05:03.310] Timer tick, asking Buildbucket for the build status
[18:05:03.524] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:03.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:40:0) after 1m0s
[18:06:03.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:40:0)
[18:06:03.606] Timer tick, asking Buildbucket for the build status
[18:06:04.295] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:04.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:41:0) after 1m0s
[18:07:04.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:41:0)
[18:07:04.337] Timer tick, asking Buildbucket for the build status
[18:07:04.482] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:04.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:42:0) after 1m0s
[18:08:04.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:42:0)
[18:08:04.523] Timer tick, asking Buildbucket for the build status
[18:08:04.669] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:04.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:43:0) after 1m0s
[18:09:04.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:43:0)
[18:09:04.710] Timer tick, asking Buildbucket for the build status
[18:09:04.907] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:04.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:44:0) after 1m0s
[18:10:05.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:44:0)
[18:10:05.045] Timer tick, asking Buildbucket for the build status
[18:10:05.217] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:05.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:45:0) after 1m0s
[18:11:05.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:45:0)
[18:11:05.327] Timer tick, asking Buildbucket for the build status
[18:11:05.771] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:05.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:46:0) after 1m0s
[18:12:05.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:46:0)
[18:12:05.958] Timer tick, asking Buildbucket for the build status
[18:12:06.945] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:06.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:47:0) after 1m0s
[18:13:07.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:47:0)
[18:13:07.062] Timer tick, asking Buildbucket for the build status
[18:13:07.237] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:07.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:48:0) after 1m0s
[18:14:07.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:48:0)
[18:14:07.454] Timer tick, asking Buildbucket for the build status
[18:14:07.599] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:07.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:49:0) after 1m0s
[18:15:07.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:49:0)
[18:15:07.730] Timer tick, asking Buildbucket for the build status
[18:15:08.687] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:08.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:50:0) after 1m0s
[18:16:08.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:50:0)
[18:16:08.749] Timer tick, asking Buildbucket for the build status
[18:16:10.184] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:51:0) after 1m0s
[18:17:10.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:51:0)
[18:17:10.432] Timer tick, asking Buildbucket for the build status
[18:17:11.132] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:52:0) after 1m0s
[18:18:11.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:52:0)
[18:18:11.182] Timer tick, asking Buildbucket for the build status
[18:18:11.525] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:53:0) after 1m0s
[18:19:11.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:53:0)
[18:19:11.651] Timer tick, asking Buildbucket for the build status
[18:19:12.589] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:12.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:54:0) after 1m0s
[18:20:12.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:54:0)
[18:20:12.802] Timer tick, asking Buildbucket for the build status
[18:20:14.054] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:55:0) after 1m0s
[18:21:14.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:55:0)
[18:21:14.103] Timer tick, asking Buildbucket for the build status
[18:21:14.280] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:14.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:56:0) after 1m0s
[18:22:14.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:56:0)
[18:22:14.484] Timer tick, asking Buildbucket for the build status
[18:22:14.662] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:14.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:57:0) after 1m0s
[18:23:14.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:57:0)
[18:23:14.919] Timer tick, asking Buildbucket for the build status
[18:23:15.055] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:15.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:58:0) after 1m0s
[18:24:15.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:58:0)
[18:24:15.150] Timer tick, asking Buildbucket for the build status
[18:24:15.839] Build 8889093910739895920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:15.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054523972748830304:59:0) after 1m0s
[18:24:37.224] Received PubSub notification, asking Buildbucket for the build status
[18:24:37.465] Build 8889093910739895920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:24:37.465] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1581099876325660",
"created_by": "project:chromium",
"created_ts": "1581096463412815",
"id": "8889093910739895920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff\"}}",
"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\"}, \"$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-59-l64z\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168348, \"got_angle_revision\": \"51fd2958f9a27a70107ffbd2aec25c97c6daf1f1\", \"got_dawn_revision\": \"c30635174e125bda00771900089c34751e28faeb\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff\", \"got_revision_cp\": \"refs/heads/master@{#739438}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"534d12cd423038c36b88e1a14e96e8a66e342900\", \"got_v8_revision\": \"7be9f4654c1c4378f409024eeb2acc2dff91f8a7\", \"got_v8_revision_cp\": \"refs/heads/8.2.35@{#1}\", \"got_webrtc_revision\": \"9b881abea95736a8aec8f1933d4c88aa452d88e9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30483}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff\", \"swarm_hashes_refs/heads/master(at){#739438}_without_patch\": {\"accessibility_unittests\": \"d8f523831014dc8176e3d7ff283b663cc3be5842\", \"angle_unittests\": \"6873e51e73a84d2bc528c9dee5c41639b2a70b19\", \"app_shell_unittests\": \"cab689d103158f984bf219f5a636719ac446c677\", \"aura_unittests\": \"6b89727dd68ff39663f8498df82880394ae4731c\", \"base_unittests\": \"5dde20de31f4f4675b1ab1b2cc46561cf6ebe7d7\", \"base_util_unittests\": \"906910cddb87f4755d82dd435d27747f6c1badb6\", \"blink_common_unittests\": \"ba07e79378ab88cc6c4dd9c2420cd5faf1dea4d1\", \"blink_fuzzer_unittests\": \"aba767463cad7a2637e1cca26069aaa021f415d4\", \"blink_heap_unittests\": \"9d0e2067cf32f523819f024b4dcf707e46bf0c5d\", \"blink_platform_unittests\": \"93576a12f27b5ca80172ba1ec675a5709574ffef\", \"blink_python_tests\": \"6f43622e071efb81ceefd3c7a555f0f32366f6ff\", \"blink_unittests\": \"21945465a6f208cace0430fbe923669b3ad90406\", \"blink_web_tests\": \"225ee147aeb9b5d9d0f9dcf00e73915c680f9b6b\", \"boringssl_crypto_tests\": \"a10a169aa28122b4122bdeb0f64c700c8bf46507\", \"boringssl_ssl_tests\": \"bc5cd69267a8515d9e847f2b03d2067fdabc86ca\", \"browser_tests\": \"bc47b00afa850ed90ceb7be650d3557f4773550c\", \"cacheinvalidation_unittests\": \"f2964eee9064f6349c1800d9577e0d91db078200\", \"capture_unittests\": \"67a71d2d36c0ff1e254ef734f572d821b277e655\", \"cast_unittests\": \"c5c55abd51106ed7e9e118f4350e8a957205fa78\", \"cc_unittests\": \"6b33dffd3dec65e16b42f240e1f31fb6b97e8786\", \"chrome_app_unittests\": \"524acd056874ac89623f5280213cd58e96596d75\", \"chromedriver_unittests\": \"aa0d3e6f8cbe74db4b466646ad12608453401edf\", \"components_browsertests\": \"364bb84a4c4e5b8c44eddff64759e2d377723745\", \"components_unittests\": \"9f55f3b5f31d15bd803c8278acedfcff39b49410\", \"compositor_unittests\": \"d3ad8efb5263a157a669dbb8d5ba58ca5f8b867f\", \"content_browsertests\": \"1db8bf40746da852cbe3d78dfcd5d5bbf6a24317\", \"content_shell_crash_test\": \"757ba9953d56a26bba58812c772b51ce6789074a\", \"content_unittests\": \"c4141d2742da218a92976d36761ff26b3a3e3b5a\", \"crashpad_tests\": \"51b1d37b0fd48ea4473d84f994fb1d1db7c77bac\", \"cronet_tests\": \"0e1f6754a146f5b79ac73fa6d115cb6d297fd1c4\", \"cronet_unittests\": \"447bc7a0a17e8e937c28c19659ebfa0c299fec99\", \"crypto_unittests\": \"da018043f50d9d3b7a233d656e6b612f675fb53e\", \"dbus_unittests\": \"7950e48e51f7f1989f606f49f7843e1395ef832d\", \"device_unittests\": \"bcd71260a419dd6c2c2d9ae512965bd9446ac536\", \"display_unittests\": \"61921a03da41cc445eb8db4415c2053ea062b032\", \"events_unittests\": \"ebe858d8e892f415a8a9d7c958489d31b0789308\", \"extensions_browsertests\": \"a8a34d2bbb285afc40bc649115946fbc0d1ab123\", \"extensions_unittests\": \"3ad61434ebcd488c3f777630b1ccaaa96cac036f\", \"filesystem_service_unittests\": \"8f4c8b5b7a5b3bf1f50870d5ec24549c7c3f40f3\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"c312da51a428c8a1488a84790d23077b89f91c64\", \"gfx_unittests\": \"0980466db7d5b728c8d26cfcb2e52b8335d07e30\", \"gin_unittests\": \"7fb412be9e00e40208fee6acdd6c53be9a24953f\", \"google_apis_unittests\": \"2a1e67c27aca13892c8f55c4bd036e5025e81db6\", \"gpu_unittests\": \"cc993d3c8d25dec9474bb0b5bd08547c248508b8\", \"grit_python_unittests\": \"099090c88e4fb3ff73a77dec4109bf7081d8e891\", \"gwp_asan_unittests\": \"d7fc741ea7c6bb3421d6034614fc16efa73dab04\", \"headless_browsertests\": \"4e6e1d3ecdd92a6af5d3bd92940bcee829e90c50\", \"headless_unittests\": \"f8233558dfe3cea4e81ed049644b64f3e2fbf57d\", \"interactive_ui_tests\": \"e7eb3347816bc77eb104329167aaabeee7c5fdc3\", \"ipc_tests\": \"4ff3bcc11891a26db73313a6d27f919c91798941\", \"jingle_unittests\": \"11e131a336fd83b610f282bd1e417085f1a3c3a5\", \"latency_unittests\": \"b7496a85a105808e55721b3699692cb323e2adc4\", \"libjingle_xmpp_unittests\": \"df3962e1edebd5039bdfa5363dd5f67c6cde3568\", \"media_blink_unittests\": \"341fb92af557a5f0fe52be71104409b395ed3340\", \"media_service_unittests\": \"ee064513f5a0ebb4567ac06cc865e64954b8d8a9\", \"media_unittests\": \"9b5da2f6f26954287647d570f6f0c35829526cbe\", \"message_center_unittests\": \"1182a1109f569d0d1d8483ddd0e642560aeff69e\", \"metrics_python_tests\": \"749b296d66daa2e75bd93482679903110638dffe\", \"midi_unittests\": \"a4f370009c8b31f248c61d6f07fde26074c35f79\", \"mojo_core_unittests\": \"aa18c7f183e2d8bdce03bd7e444209f6601b69d4\", \"mojo_unittests\": \"c42c6f1a2780b7576c2d8ec30963319f2171a069\", \"nacl_helper_nonsfi_unittests\": \"f43515913e3be6f1abafed70b5150bbc951094ba\", \"nacl_loader_unittests\": \"0a00d7c626d600860bf9f2e163c719c8318efb43\", \"native_theme_unittests\": \"59cfe38af7f9042b7bb54c401c01e77165b6df3e\", \"net_unittests\": \"6a8d8a1925144ce70050f9c87472629bfb20c07f\", \"pdf_unittests\": \"6d92ee55b29adaa992d9b1820c9d9bea2ff227a5\", \"perfetto_unittests\": \"73984871101088c2ce428b16348e5f994b84fc9a\", \"ppapi_unittests\": \"520813b5d6c7b9cc44812808970c93e186db8202\", \"printing_unittests\": \"d19e6dc6c20d87cfd075fc3ff594c4ba8a0a6782\", \"remoting_unittests\": \"7364755107ba7b50db80b71115f45b218e81ba57\", \"sandbox_linux_unittests\": \"d89303ddbeb387c2412b01385e70a65d4e4ea8bd\", \"service_manager_unittests\": \"5c414b586b8c2ce3f2c991fd76b9d155da55831a\", \"services_unittests\": \"4ba0ecc98d7c249454720b06bffd3f46d813f80e\", \"shell_dialogs_unittests\": \"5fc2fbd908110e943af277143eb769e60ec652c9\", \"skia_unittests\": \"80d7c69eb5ddafb83aa1bb3eb227946337082758\", \"snapshot_unittests\": \"a6ab014ba5107702edadd889c2b1de829387c98d\", \"sql_unittests\": \"1847f8f72ab7a055794377234dd1bd991fb3c652\", \"storage_unittests\": \"c908e521a10b0f21f57ff4f83991a35db1a59e51\", \"sync_integration_tests\": \"42d925684751a82aa9329cceec965e6f1d5706b4\", \"telemetry_gpu_unittests\": \"b95afb7bdfa3f637ef07b9f64d76378a25eb8185\", \"telemetry_perf_unittests\": \"3bd4e75006dc4d134e80d508fa25dda833c2e0dd\", \"telemetry_unittests\": \"90b93958bceae6e8cc523edb210b1e18e80a2201\", \"traffic_annotation_auditor_unittests\": \"36e660fbc2ecf08337ceaf6b7413d0640f310add\", \"ui_base_unittests\": \"b29e0c5418a99231ea999884d736ae90c564e2ec\", \"ui_touch_selection_unittests\": \"10d20d2c3cdf98b0bc2c3e2876732d627866d144\", \"unit_tests\": \"c59ab0f84dbade8d60f8fade3bdae6f342fca6d9\", \"url_unittests\": \"517a32b047945785664413f3d83367e7ab1c6544\", \"views_perftests\": \"e7934f2c2ebc71cb2fe86d6ecd91d354fdf62648\", \"views_unittests\": \"b8a523facb7d6c2c06d281ea527b038293022483\", \"viz_unittests\": \"f1af5a04d17469674f213ffec968739e50cd5552\", \"vr_common_unittests\": \"599310fc7851f421467342cb2d870e44c8f2bdf8\", \"vr_pixeltests\": \"a5d8abf15e254f06bd4cef3b1772cc1bf5fecebd\", \"webdriver_wpt_tests\": \"b4e641f9c5e357d87964f328664b94d3c4cdb9b0\", \"weblayer_browsertests\": \"740e7f1d5db9a8f54f61aee7618f7f9b08ca8603\", \"wm_unittests\": \"d33c869d4a82ad466cc795b598ae383b391fa05d\", \"wtf_unittests\": \"f1c090a3a349d4b96f79f0b540bbdfcf1c8e3669\", \"xr_browser_tests\": \"18c3664d12f4261b622e70665a16a01327aca61a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_0f0f2920b57dc7c027977ee87520a3ddbf7f87ddb2741f9160320f85fd7d4389_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-59-l64z\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581096729664162",
"status": "COMPLETED",
"status_changed_ts": "1581099876845676",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168348",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a445bcbdc53f4237ce726d4b1b216d03b3d4a5ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054523972748830304",
"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/8889093910739895920/+/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:4a3982f72c819210",
"user_agent:luci-scheduler"
],
"updated_ts": "1581099876857574",
"url": "https://ci.chromium.org/b/8889093910739895920",
"utcnow_ts": "1581099877454695"
}
}
[18:24:37.465] Invocation finished in 56m55.353138745s with status SUCCEEDED