[23:35:40.563] New invocation is queued and will start shortly
[23:35:45.650] Starting the invocation (attempt 1)
[23:35:45.688] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:35:45.688] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:35:45.688] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052960673407257584",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d0f43c610ee0f3be164ce8843397d02c5fba22ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052960673407257584",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"gitiles_ref:refs/heads/master"
]
}
[23:35:46.448] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582587345775494",
"id": "8887530607274367792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0f43c610ee0f3be164ce8843397d02c5fba22ff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582587346227482",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168983",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052960673407257584",
"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/8887530607274367792/+/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": "1582587346227652",
"url": "https://ci.chromium.org/b/8887530607274367792",
"utcnow_ts": "1582587346430463"
}
}
[23:35:46.448] Task URL: https://ci.chromium.org/b/8887530607274367792
[23:35:46.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:2:0) after 1m0s
[23:36:46.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:2:0)
[23:36:46.511] Timer tick, asking Buildbucket for the build status
[23:36:46.902] Build 8887530607274367792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:46.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:3:0) after 1m0s
[23:37:46.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:3:0)
[23:37:46.984] Timer tick, asking Buildbucket for the build status
[23:37:47.217] Build 8887530607274367792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:47.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:4:0) after 1m0s
[23:38:47.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:4:0)
[23:38:47.292] Timer tick, asking Buildbucket for the build status
[23:38:47.713] Build 8887530607274367792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:47.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:5:0) after 1m0s
[23:39:47.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:5:0)
[23:39:47.812] Timer tick, asking Buildbucket for the build status
[23:39:47.907] Build 8887530607274367792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:47.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:6:0) after 1m0s
[23:40:12.952] Received PubSub notification, asking Buildbucket for the build status
[23:40:13.043] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:48.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:6:0)
[23:40:48.012] Timer tick, asking Buildbucket for the build status
[23:40:48.120] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:48.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:8:0) after 1m0s
[23:41:48.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:8:0)
[23:41:48.188] Timer tick, asking Buildbucket for the build status
[23:41:48.342] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:48.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:9:0) after 1m0s
[23:42:48.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:9:0)
[23:42:48.361] Timer tick, asking Buildbucket for the build status
[23:42:48.474] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:48.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:10:0) after 1m0s
[23:43:48.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:10:0)
[23:43:48.519] Timer tick, asking Buildbucket for the build status
[23:43:48.733] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:48.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:11:0) after 1m0s
[23:44:50.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:11:0)
[23:44:50.856] Timer tick, asking Buildbucket for the build status
[23:44:50.986] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:50.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:12:0) after 1m0s
[23:45:50.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:12:0)
[23:45:50.996] Timer tick, asking Buildbucket for the build status
[23:45:51.107] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:51.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:13:0) after 1m0s
[23:46:51.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:13:0)
[23:46:51.128] Timer tick, asking Buildbucket for the build status
[23:46:51.285] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:51.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:14:0) after 1m0s
[23:47:51.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:14:0)
[23:47:51.254] Timer tick, asking Buildbucket for the build status
[23:47:51.535] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:51.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:15:0) after 1m0s
[23:48:51.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:15:0)
[23:48:51.536] Timer tick, asking Buildbucket for the build status
[23:48:51.704] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:51.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:16:0) after 1m0s
[23:49:51.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:16:0)
[23:49:51.758] Timer tick, asking Buildbucket for the build status
[23:49:51.908] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:51.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:17:0) after 1m0s
[23:50:51.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:17:0)
[23:50:51.974] Timer tick, asking Buildbucket for the build status
[23:50:52.214] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:18:0) after 1m0s
[23:51:52.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:18:0)
[23:51:52.227] Timer tick, asking Buildbucket for the build status
[23:51:53.454] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:53.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:19:0) after 1m0s
[23:52:53.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:19:0)
[23:52:53.482] Timer tick, asking Buildbucket for the build status
[23:52:53.623] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:20:0) after 1m0s
[23:53:53.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:20:0)
[23:53:53.672] Timer tick, asking Buildbucket for the build status
[23:53:53.811] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:53.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:21:0) after 1m0s
[23:54:53.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:21:0)
[23:54:53.945] Timer tick, asking Buildbucket for the build status
[23:54:54.110] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:54.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:22:0) after 1m0s
[23:55:54.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:22:0)
[23:55:54.157] Timer tick, asking Buildbucket for the build status
[23:55:54.302] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:54.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:23:0) after 1m0s
[23:56:54.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:23:0)
[23:56:54.401] Timer tick, asking Buildbucket for the build status
[23:56:54.643] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:54.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:24:0) after 1m0s
[23:57:54.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:24:0)
[23:57:54.871] Timer tick, asking Buildbucket for the build status
[23:57:55.113] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:55.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:25:0) after 1m0s
[23:58:55.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:25:0)
[23:58:55.239] Timer tick, asking Buildbucket for the build status
[23:58:55.364] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:55.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:26:0) after 1m0s
[23:59:55.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:26:0)
[23:59:55.507] Timer tick, asking Buildbucket for the build status
[23:59:55.577] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:55.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:27:0) after 1m0s
[00:00:55.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:27:0)
[00:00:55.775] Timer tick, asking Buildbucket for the build status
[00:00:55.930] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:55.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:28:0) after 1m0s
[00:01:56.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:28:0)
[00:01:56.177] Timer tick, asking Buildbucket for the build status
[00:01:56.300] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:56.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:29:0) after 1m0s
[00:02:56.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:29:0)
[00:02:56.330] Timer tick, asking Buildbucket for the build status
[00:02:56.495] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:56.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:30:0) after 1m0s
[00:03:56.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:30:0)
[00:03:56.523] Timer tick, asking Buildbucket for the build status
[00:03:56.691] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:56.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:31:0) after 1m0s
[00:04:56.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:31:0)
[00:04:56.713] Timer tick, asking Buildbucket for the build status
[00:04:56.918] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:56.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:32:0) after 1m0s
[00:05:56.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:32:0)
[00:05:56.969] Timer tick, asking Buildbucket for the build status
[00:05:57.150] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:57.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:33:0) after 1m0s
[00:06:57.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:33:0)
[00:06:57.205] Timer tick, asking Buildbucket for the build status
[00:06:57.528] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:57.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:34:0) after 1m0s
[00:07:57.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:34:0)
[00:07:57.555] Timer tick, asking Buildbucket for the build status
[00:07:57.703] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:57.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:35:0) after 1m0s
[00:08:57.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:35:0)
[00:08:57.723] Timer tick, asking Buildbucket for the build status
[00:08:57.798] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:57.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:36:0) after 1m0s
[00:09:57.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:36:0)
[00:09:57.892] Timer tick, asking Buildbucket for the build status
[00:09:58.217] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:58.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:37:0) after 1m0s
[00:10:58.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:37:0)
[00:10:58.248] Timer tick, asking Buildbucket for the build status
[00:10:58.360] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:58.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:38:0) after 1m0s
[00:11:58.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:38:0)
[00:11:58.366] Timer tick, asking Buildbucket for the build status
[00:11:58.623] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:58.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:39:0) after 1m0s
[00:12:58.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:39:0)
[00:12:58.664] Timer tick, asking Buildbucket for the build status
[00:12:58.916] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:58.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:40:0) after 1m0s
[00:13:58.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:40:0)
[00:13:58.938] Timer tick, asking Buildbucket for the build status
[00:13:59.188] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:59.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:41:0) after 1m0s
[00:14:59.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:41:0)
[00:14:59.173] Timer tick, asking Buildbucket for the build status
[00:14:59.327] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:42:0) after 1m0s
[00:15:59.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:42:0)
[00:15:59.353] Timer tick, asking Buildbucket for the build status
[00:15:59.691] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:59.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:43:0) after 1m0s
[00:16:59.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:43:0)
[00:16:59.721] Timer tick, asking Buildbucket for the build status
[00:16:59.866] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:59.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:44:0) after 1m0s
[00:17:59.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:44:0)
[00:17:59.847] Timer tick, asking Buildbucket for the build status
[00:17:59.970] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:59.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:45:0) after 1m0s
[00:18:59.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:45:0)
[00:18:59.991] Timer tick, asking Buildbucket for the build status
[00:19:00.349] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:46:0) after 1m0s
[00:20:00.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:46:0)
[00:20:00.509] Timer tick, asking Buildbucket for the build status
[00:20:00.751] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:00.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:47:0) after 1m0s
[00:21:00.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:47:0)
[00:21:00.903] Timer tick, asking Buildbucket for the build status
[00:21:01.004] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:01.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:48:0) after 1m0s
[00:22:01.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:48:0)
[00:22:01.149] Timer tick, asking Buildbucket for the build status
[00:22:01.368] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:01.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:49:0) after 1m0s
[00:23:01.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:49:0)
[00:23:01.530] Timer tick, asking Buildbucket for the build status
[00:23:02.298] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:02.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:50:0) after 1m0s
[00:24:02.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:50:0)
[00:24:02.328] Timer tick, asking Buildbucket for the build status
[00:24:02.494] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:02.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:51:0) after 1m0s
[00:25:02.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:51:0)
[00:25:02.579] Timer tick, asking Buildbucket for the build status
[00:25:02.866] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:02.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:52:0) after 1m0s
[00:26:02.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:52:0)
[00:26:02.927] Timer tick, asking Buildbucket for the build status
[00:26:03.146] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:03.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:53:0) after 1m0s
[00:27:03.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:53:0)
[00:27:03.201] Timer tick, asking Buildbucket for the build status
[00:27:03.503] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:03.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:54:0) after 1m0s
[00:28:03.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:54:0)
[00:28:03.560] Timer tick, asking Buildbucket for the build status
[00:28:03.714] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:03.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:55:0) after 1m0s
[00:29:03.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:55:0)
[00:29:03.758] Timer tick, asking Buildbucket for the build status
[00:29:03.992] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:03.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:56:0) after 1m0s
[00:30:04.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:56:0)
[00:30:04.021] Timer tick, asking Buildbucket for the build status
[00:30:04.753] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:04.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:57:0) after 1m0s
[00:31:04.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:57:0)
[00:31:04.851] Timer tick, asking Buildbucket for the build status
[00:31:05.238] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:05.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:58:0) after 1m0s
[00:32:05.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:58:0)
[00:32:05.227] Timer tick, asking Buildbucket for the build status
[00:32:05.509] Build 8887530607274367792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:05.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052960673407257584:59:0) after 1m0s
[00:32:39.471] Received PubSub notification, asking Buildbucket for the build status
[00:32:39.733] Build 8887530607274367792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:32:39.733] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582590758850424",
"created_by": "project:chromium",
"created_ts": "1582587345775494",
"id": "8887530607274367792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0f43c610ee0f3be164ce8843397d02c5fba22ff\"}}",
"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-44-sd4e\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168983, \"got_angle_revision\": \"e3aee0b42a11f2c098bae8912a107e88494b37bb\", \"got_dawn_revision\": \"1249ada986fc62a95439b8c8ec805fd3dff1e46d\", \"got_nacl_revision\": \"530e1f0dae34020864c81e5cd52be54d9c656690\", \"got_revision\": \"d0f43c610ee0f3be164ce8843397d02c5fba22ff\", \"got_revision_cp\": \"refs/heads/master@{#744117}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"214ec337a0b2745e6c41fbb3d562fa517122812f\", \"got_v8_revision\": \"def23d3c03e73e345896a5a93de79197b9c9cc7b\", \"got_v8_revision_cp\": \"refs/heads/8.2.161@{#1}\", \"got_webrtc_revision\": \"1dea1ea412021819bddbc9400dcca7d9dd2eba74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30581}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0f43c610ee0f3be164ce8843397d02c5fba22ff\", \"swarm_hashes_refs/heads/master(at){#744117}_without_patch\": {\"accessibility_unittests\": \"7568daadf8a522303ce46e66d14f0f54923ad255\", \"angle_unittests\": \"887844ff04da3545001c72f2ac03684530d4cd5d\", \"app_shell_unittests\": \"82d728400b5ef1e77c13b82d54b7c0321fd00897\", \"aura_unittests\": \"0692a285b90998d5500d3b3d9f765042cc428b8a\", \"base_unittests\": \"cf89706b2b976e16f1c7d50b8ddbf5a0149935c9\", \"base_util_unittests\": \"d895d1151507c3ca3f59beb775e386b2fc179def\", \"blink_common_unittests\": \"62dccba30716e88b9fe3a3e8e3d46620d7b62ba3\", \"blink_fuzzer_unittests\": \"3bf20a51a6e07b18041bf1d8f54efe8ee30ba4df\", \"blink_heap_unittests\": \"9fec41c1650267a512d807ec2b9ef4a851773ce1\", \"blink_platform_unittests\": \"b6dec125058d49863e0566fd8d29a9f0ef675c7a\", \"blink_python_tests\": \"005a52d3ce99cd67b1596976fffd567cf6b477bb\", \"blink_unittests\": \"1d98871bbbff04afb4ec605eb106992f812544e6\", \"blink_web_tests\": \"c1a3ae7c3f74d108b343348db009b2ea844a88c7\", \"boringssl_crypto_tests\": \"97a3dc1c99b47c2115076ba7f56fdd51ffd8670f\", \"boringssl_ssl_tests\": \"3599e53644d40bf11c32ef4dffd734a12566622c\", \"browser_tests\": \"2fb86d968dabf3d58146900ce94710cffbff8ede\", \"cacheinvalidation_unittests\": \"82a239912102b4c88536d7960e969be6ef0de62d\", \"capture_unittests\": \"737a095b5d3272ce302eee3f1211a9db9a9847dd\", \"cast_unittests\": \"6d934584e6370061dd43bc135670bccc678cb5ed\", \"cc_unittests\": \"e0987f809d6cd54b48e7a7bc11261d0c71558cc4\", \"chrome_app_unittests\": \"76ccefc26db00b057befd11088ec02238c4a5966\", \"chromedriver_unittests\": \"2eee088a8ef76d38b6996f1eb0b509ad1178362f\", \"components_browsertests\": \"c642ac57a46937eddf1f1ed160d5944742903671\", \"components_unittests\": \"7601b7ecae4e9184cd44d68cba52ef7dde188899\", \"compositor_unittests\": \"3bbf98755966f3defedcfcdcab31772f8a790367\", \"content_browsertests\": \"06e8c872fd6c28252caf433f4c72b604fb8558aa\", \"content_shell_crash_test\": \"31036e17fde30baf7312dcc9643a99904aad90ac\", \"content_unittests\": \"cab577ae58a605fd6b08f57cfb5fcb148f2471c5\", \"crashpad_tests\": \"513371200d1fd1f76a974b8677077fc1a71ee84a\", \"cronet_tests\": \"0ed811e01cd64cd6ba98b7488e1612f08a200a55\", \"cronet_unittests\": \"5f5f8f5b24effe073d57c9b1ba51400057bdafc0\", \"crypto_unittests\": \"fe193777f94212058d79754e61ece9d3455888e0\", \"dbus_unittests\": \"192e8dd969ad3641b742b993ee43af0430713284\", \"device_unittests\": \"b2a16c16716fdb000831a7f94fc71c84f3f910d2\", \"display_unittests\": \"d480214aa3af113d31c466c54d71d0230c74125d\", \"events_unittests\": \"553771dd00a5a8525ec3a945697eca343c514477\", \"extensions_browsertests\": \"dfe7c62be6371e4877dbffc7b7ec3c65223e0a54\", \"extensions_unittests\": \"54465a7b3939e799db4a1c724bb2b1ebaf7654eb\", \"filesystem_service_unittests\": \"bed5870fc1aa60ef16230d398c069c0d1040586c\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"d71b7f425c9c991837680eeb8fdd72ca9e82e494\", \"gfx_unittests\": \"2115eb668c3918525883a10dca85b6716dac34cc\", \"gin_unittests\": \"f9d61f7eeecfbd1308fe236a02e947928c3ff3d6\", \"google_apis_unittests\": \"9fccb96972459d1e9e2a0c84c5a2cd7bdcc7a03a\", \"gpu_unittests\": \"1af736ce6b35af41d8ce6a1222143119e2de7243\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"c2414da6c4aa47110ae5cbaf465b75ce4b64bec1\", \"headless_browsertests\": \"12f5fcfbaf0dfef57b80e7096409ce174cc80852\", \"headless_unittests\": \"14f3b31405576a8a552d543daec81054187db22c\", \"interactive_ui_tests\": \"c5c8b9fb1d425b1abd2124777fc6af32ca62a2b0\", \"ipc_tests\": \"4a5e96b9b1eeae57de7172e2360d04f7f6f0aecc\", \"jingle_unittests\": \"1f17f8be31b46861e986437666815875d94126bc\", \"latency_unittests\": \"6f2f295efca5a020fd6a7411fe19a746f1f665a0\", \"libjingle_xmpp_unittests\": \"e6319d7f9049fd5c79e2fb567dff1a0d675f64f6\", \"media_blink_unittests\": \"a517f34ab887046466dd78bb4eb8a356f8aa2a89\", \"media_service_unittests\": \"647db29d983c80630a0d26eff3918833336d38ef\", \"media_unittests\": \"e79c9bdd0a10aead9cd07a903820afd43e621cba\", \"message_center_unittests\": \"6ccc7331c25528ac1b2f32b361dc0abcdcda6ea6\", \"metrics_python_tests\": \"f5aea4f32f3594fe723511e4ebc200f2ea822da2\", \"midi_unittests\": \"e365025be7e7f152bf1b89b7f88dc1d0e8410b9a\", \"mojo_core_unittests\": \"f0e733e6dc289fe1405042229a47ffd627f39f3f\", \"mojo_unittests\": \"59070aa1c147084625d2cb5f1fee51a9d6e95021\", \"nacl_helper_nonsfi_unittests\": \"d7398ffa7b105f8f2a3c08e277fc16e8d3481819\", \"nacl_loader_unittests\": \"18de22b058f189ec3d50b46bc7dec0c252377b0e\", \"native_theme_unittests\": \"342fca186360437f7f29fc01a6596b931cab61c2\", \"net_unittests\": \"4c06e3c3ff4121626c56f0c03eada78c6886a24c\", \"pdf_unittests\": \"1d857da79dd5cb9157f615e9fed8b9fe542cc552\", \"perfetto_unittests\": \"d89102aea53468593dcbfaa522e72c2b4ee15f59\", \"ppapi_unittests\": \"ad1180c2226b99b9ccb707f43f40302b90b594d8\", \"printing_unittests\": \"884b65a78eb4399b1febc6ce3e73bb4f5fe56ecb\", \"remoting_unittests\": \"627a3b244d0a7fbba404fffa5f0c42df51c741ba\", \"sandbox_linux_unittests\": \"24e3fd127b75d5660502da043ed446016c65fd51\", \"service_manager_unittests\": \"4ce7f8091f06367d4516fe39095b037049228593\", \"services_unittests\": \"43eaa4e1c8deaa6635779f997cb652de80afca38\", \"shell_dialogs_unittests\": \"0a17b8a37c8c07d805ba823d78d3c7f2d7d51447\", \"skia_unittests\": \"d0107ec4270e82094819bcbef0c98bf33363a522\", \"snapshot_unittests\": \"c7063be51cee6f71d3363d53cdac5a36f68b3ee0\", \"sql_unittests\": \"fa2aac2fc090935168c79000a737f4d6b6d7a4d7\", \"storage_unittests\": \"cbcfef54dc4333dc4221b8e656983d6e89d6bc86\", \"sync_integration_tests\": \"52775836fc1f7a987626050e3dc64af5fd23ec38\", \"telemetry_gpu_unittests\": \"d1cd75b23d4f9cadacb0740bacfa1fd07aadcea1\", \"telemetry_perf_unittests\": \"de4a4c9edc691c68fe5ee78d06b1b91988b30017\", \"telemetry_unittests\": \"5b37234dd7515a1362e564c3128c881e31f086a3\", \"traffic_annotation_auditor_unittests\": \"55f7d6e95e3c2722ba466453ccf443a5423ec6e8\", \"ui_base_unittests\": \"b2374296b35ff19910619edce75e283bfd51aca9\", \"ui_touch_selection_unittests\": \"d4d4ca6fd4263a718f5266874ab72400722af737\", \"unit_tests\": \"0c0f81f0656611c118422c09727685d11b9c1d9e\", \"url_unittests\": \"3f1cd30a3a69bd1dd6aac9b54ea03b2f8ff29130\", \"views_perftests\": \"2ee95dd06aa88d06fc32ca9365decf7ab528bde1\", \"views_unittests\": \"4dc5e829d07cb46a89a8e1c919b1a2b288c14232\", \"viz_unittests\": \"cf3db265845e01085c2ada665b4570e074f8c24d\", \"vr_common_unittests\": \"3864215780faa74eb5d867c2865b3dff004dbd43\", \"vr_pixeltests\": \"ca3f8f46b59ced21f2bb2819f4700749c7e6604f\", \"webdriver_wpt_tests\": \"2bc3258b700a2c458012a07161ff45faf5ee4401\", \"weblayer_browsertests\": \"e4b7fcdcc174eb6a9cc1313caab7864b68387398\", \"wm_unittests\": \"5b7fe5ca0b6e5a701b2a6121ed2042b6b3acbe81\", \"wtf_unittests\": \"eda526ee88107a8847a7bbf4dfd55404838159f7\", \"xr_browser_tests\": \"3ac0d80643711ac32e670b4773c1fc18ce078c58\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_bb898022d2469672cf25def24fe6674f04bc82432723cbfd6a0db18494567798_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-44-sd4e\"], \"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\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582587610249429",
"status": "COMPLETED",
"status_changed_ts": "1582590759209443",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168983",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0f43c610ee0f3be164ce8843397d02c5fba22ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052960673407257584",
"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/8887530607274367792/+/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:4a92600699887e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582590759214837",
"url": "https://ci.chromium.org/b/8887530607274367792",
"utcnow_ts": "1582590759682439"
}
}
[00:32:39.733] Invocation finished in 56m59.189764193s with status SUCCEEDED