[18:24:54.911] New invocation is queued and will start shortly
[18:24:55.989] Starting the invocation (attempt 1)
[18:24:56.024] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:24:56.025] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:24:56.025] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021543077444879120",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"303523162625926b985ef176fd1acb1d0b934c89\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021543077444879120",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/303523162625926b985ef176fd1acb1d0b934c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/303523162625926b985ef176fd1acb1d0b934c89",
"gitiles_ref:refs/heads/master"
]
}
[18:24:57.332] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612549496127959",
"id": "8856113015507410864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"303523162625926b985ef176fd1acb1d0b934c89\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612549497002778",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180316",
"builder:Linux Builder (dbg)",
"buildset:commit/git/303523162625926b985ef176fd1acb1d0b934c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/303523162625926b985ef176fd1acb1d0b934c89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021543077444879120",
"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/8856113015507410864/+/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": "1612549497002922",
"url": "https://ci.chromium.org/b/8856113015507410864",
"utcnow_ts": "1612549497311173"
}
}
[18:24:57.332] Task URL: https://ci.chromium.org/b/8856113015507410864
[18:24:57.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:2:0) after 1m0s
[18:25:00.909] Received PubSub notification, asking Buildbucket for the build status
[18:25:01.202] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:57.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:2:0)
[18:25:57.357] Timer tick, asking Buildbucket for the build status
[18:25:57.465] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:57.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:4:0) after 1m0s
[18:26:57.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:4:0)
[18:26:57.530] Timer tick, asking Buildbucket for the build status
[18:26:57.810] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:57.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:5:0) after 1m0s
[18:27:57.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:5:0)
[18:27:57.856] Timer tick, asking Buildbucket for the build status
[18:27:57.948] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:57.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:6:0) after 1m0s
[18:28:57.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:6:0)
[18:28:57.963] Timer tick, asking Buildbucket for the build status
[18:28:58.068] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:58.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:7:0) after 1m0s
[18:29:58.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:7:0)
[18:29:58.120] Timer tick, asking Buildbucket for the build status
[18:29:58.271] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:8:0) after 1m0s
[18:30:58.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:8:0)
[18:30:58.289] Timer tick, asking Buildbucket for the build status
[18:30:58.367] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:58.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:9:0) after 1m0s
[18:31:58.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:9:0)
[18:31:58.395] Timer tick, asking Buildbucket for the build status
[18:31:58.450] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:58.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:10:0) after 1m0s
[18:32:58.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:10:0)
[18:32:58.493] Timer tick, asking Buildbucket for the build status
[18:32:58.715] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:58.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:11:0) after 1m0s
[18:33:58.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:11:0)
[18:33:58.717] Timer tick, asking Buildbucket for the build status
[18:33:59.191] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:59.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:12:0) after 1m0s
[18:34:59.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:12:0)
[18:34:59.187] Timer tick, asking Buildbucket for the build status
[18:35:00.199] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:00.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:13:0) after 1m0s
[18:36:00.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:13:0)
[18:36:00.459] Timer tick, asking Buildbucket for the build status
[18:36:00.721] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:00.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:14:0) after 1m0s
[18:37:01.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:14:0)
[18:37:01.193] Timer tick, asking Buildbucket for the build status
[18:37:01.255] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:01.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:15:0) after 1m0s
[18:38:01.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:15:0)
[18:38:01.400] Timer tick, asking Buildbucket for the build status
[18:38:01.460] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:01.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:16:0) after 1m0s
[18:39:02.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:16:0)
[18:39:02.023] Timer tick, asking Buildbucket for the build status
[18:39:02.289] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:02.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:17:0) after 1m0s
[18:40:02.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:17:0)
[18:40:02.412] Timer tick, asking Buildbucket for the build status
[18:40:02.572] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:02.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:18:0) after 1m0s
[18:41:02.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:18:0)
[18:41:02.698] Timer tick, asking Buildbucket for the build status
[18:41:02.768] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:02.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:19:0) after 1m0s
[18:42:02.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:19:0)
[18:42:02.789] Timer tick, asking Buildbucket for the build status
[18:42:02.856] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:02.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:20:0) after 1m0s
[18:43:02.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:20:0)
[18:43:02.878] Timer tick, asking Buildbucket for the build status
[18:43:03.245] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:03.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:21:0) after 1m0s
[18:44:03.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:21:0)
[18:44:03.300] Timer tick, asking Buildbucket for the build status
[18:44:03.372] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:03.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:22:0) after 1m0s
[18:45:03.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:22:0)
[18:45:03.380] Timer tick, asking Buildbucket for the build status
[18:45:03.786] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:03.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:23:0) after 1m0s
[18:46:03.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:23:0)
[18:46:03.857] Timer tick, asking Buildbucket for the build status
[18:46:04.149] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:04.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:24:0) after 1m0s
[18:47:04.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:24:0)
[18:47:04.188] Timer tick, asking Buildbucket for the build status
[18:47:04.258] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:04.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:25:0) after 1m0s
[18:48:04.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:25:0)
[18:48:04.305] Timer tick, asking Buildbucket for the build status
[18:48:04.378] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:04.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:26:0) after 1m0s
[18:49:04.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:26:0)
[18:49:04.473] Timer tick, asking Buildbucket for the build status
[18:49:04.544] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:04.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:27:0) after 1m0s
[18:50:04.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:27:0)
[18:50:04.552] Timer tick, asking Buildbucket for the build status
[18:50:04.751] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:28:0) after 1m0s
[18:51:04.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:28:0)
[18:51:04.829] Timer tick, asking Buildbucket for the build status
[18:51:04.902] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:04.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:29:0) after 1m0s
[18:52:04.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:29:0)
[18:52:04.978] Timer tick, asking Buildbucket for the build status
[18:52:05.046] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:05.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:30:0) after 1m0s
[18:53:05.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:30:0)
[18:53:05.025] Timer tick, asking Buildbucket for the build status
[18:53:05.102] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:05.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:31:0) after 1m0s
[18:54:05.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:31:0)
[18:54:05.197] Timer tick, asking Buildbucket for the build status
[18:54:05.286] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:05.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:32:0) after 1m0s
[18:55:05.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:32:0)
[18:55:05.290] Timer tick, asking Buildbucket for the build status
[18:55:05.438] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:05.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:33:0) after 1m0s
[18:56:05.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:33:0)
[18:56:05.524] Timer tick, asking Buildbucket for the build status
[18:56:05.595] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:05.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:34:0) after 1m0s
[18:57:05.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:34:0)
[18:57:05.609] Timer tick, asking Buildbucket for the build status
[18:57:05.836] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:05.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:35:0) after 1m0s
[18:58:05.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:35:0)
[18:58:05.881] Timer tick, asking Buildbucket for the build status
[18:58:07.644] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:07.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:36:0) after 1m0s
[18:59:07.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:36:0)
[18:59:07.661] Timer tick, asking Buildbucket for the build status
[18:59:07.785] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:07.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:37:0) after 1m0s
[19:00:07.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:37:0)
[19:00:07.765] Timer tick, asking Buildbucket for the build status
[19:00:07.928] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:07.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:38:0) after 1m0s
[19:01:08.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:38:0)
[19:01:08.002] Timer tick, asking Buildbucket for the build status
[19:01:08.303] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:08.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:39:0) after 1m0s
[19:02:08.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:39:0)
[19:02:08.361] Timer tick, asking Buildbucket for the build status
[19:02:08.442] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:08.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:40:0) after 1m0s
[19:03:08.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:40:0)
[19:03:08.504] Timer tick, asking Buildbucket for the build status
[19:03:09.016] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:09.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:41:0) after 1m0s
[19:04:09.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:41:0)
[19:04:09.038] Timer tick, asking Buildbucket for the build status
[19:04:09.165] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:09.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:42:0) after 1m0s
[19:05:09.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:42:0)
[19:05:09.305] Timer tick, asking Buildbucket for the build status
[19:05:09.433] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:09.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:43:0) after 1m0s
[19:06:09.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:43:0)
[19:06:09.477] Timer tick, asking Buildbucket for the build status
[19:06:09.534] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:44:0) after 1m0s
[19:07:09.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:44:0)
[19:07:09.545] Timer tick, asking Buildbucket for the build status
[19:07:09.625] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:09.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:45:0) after 1m0s
[19:08:09.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:45:0)
[19:08:09.781] Timer tick, asking Buildbucket for the build status
[19:08:09.836] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:09.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:46:0) after 1m0s
[19:09:09.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:46:0)
[19:09:09.862] Timer tick, asking Buildbucket for the build status
[19:09:10.112] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:47:0) after 1m0s
[19:10:10.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:47:0)
[19:10:10.118] Timer tick, asking Buildbucket for the build status
[19:10:10.264] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:10.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:48:0) after 1m0s
[19:11:10.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:48:0)
[19:11:10.422] Timer tick, asking Buildbucket for the build status
[19:11:10.511] Build 8856113015507410864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:10.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021543077444879120:49:0) after 1m0s
[19:11:33.168] Received PubSub notification, asking Buildbucket for the build status
[19:11:33.257] Build 8856113015507410864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:11:33.257] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612552291645175",
"created_by": "project:chromium",
"created_ts": "1612549496127959",
"id": "8856113015507410864",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"303523162625926b985ef176fd1acb1d0b934c89\"}}",
"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\": \"303523162625926b985ef176fd1acb1d0b934c89\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-128-wqyx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180316, \"got_angle_revision\": \"b2de0688d7c95c58b4bf1182f53bf43e42a2d99c\", \"got_dawn_revision\": \"185c6a5b0f358c115e3d3ef43afbb157d4c4b591\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"303523162625926b985ef176fd1acb1d0b934c89\", \"got_revision_cp\": \"refs/heads/master@{#851203}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a8da847d13385bb1c4322ae3c456e4896976c93b\", \"got_v8_revision\": \"bf60416e680c7eab4f2dd7589563f2145fbfdd0a\", \"got_v8_revision_cp\": \"refs/heads/9.0.136@{#1}\", \"got_webrtc_revision\": \"1184b5537fdc37535cb3d099db6a49a2b759f20b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33176}\", \"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\": \"303523162625926b985ef176fd1acb1d0b934c89\", \"swarm_hashes_refs/heads/master(at){#851203}_without_patch\": {\"absl_hardening_tests\": \"0f41e2d3f442746844080d991c182f975c5b4787\", \"accessibility_unittests\": \"5869769fc490ab9aeaa4f7663ef7ac35d5646a17\", \"angle_unittests\": \"bfeb669978875dbaf7645c5c011fe398a38fb720\", \"app_shell_unittests\": \"81c54522ccb0353653a61bddb7309abc1dc4f50d\", \"aura_unittests\": \"c1857b4cccad210fa3c979c53f30b5b2d9ade4dd\", \"base_unittests\": \"e67e01baa406cfd1433388edd4fc377be75c44a2\", \"base_util_unittests\": \"ff44feda81b883643f219ce626308a35a8f001b4\", \"blink_common_unittests\": \"d094437247a27eac5e0c0f82550b754901052531\", \"blink_fuzzer_unittests\": \"24b19351a95229c429cf3cdd4961fcaa41c1f0fa\", \"blink_heap_unittests\": \"61bb15b7595718e2744cf732733fb78d87a30a4b\", \"blink_platform_unittests\": \"6dfbe063db1c695f7359581537fcb52b907cbcae\", \"blink_python_tests\": \"2251c9936d50511a1f6ddb1e650cd125625ece9d\", \"blink_unittests\": \"eb7151e89be277c66276e8dbeb54ad05449ed738\", \"blink_web_tests\": \"958f3c781c1408411a62ab5a71878644ac2390c4\", \"boringssl_crypto_tests\": \"9888b00bf3442e81f7128f3ee30dd6a6db4a7be1\", \"boringssl_ssl_tests\": \"075dcb2e238a6e78b81d251bd7b75e20dc6492ef\", \"browser_tests\": \"5324a24fd8114e3a46f132c6e5192fbb54ef7475\", \"capture_unittests\": \"b491367429cc973b5ca047e045dc944a928ab4fd\", \"cast_unittests\": \"829162a114293c6d0996079b5f99d061666c15dd\", \"cc_unittests\": \"e4eae491c9c33d6600fac81f258e4af80f7cf135\", \"chrome_app_unittests\": \"ac4375f479b90f2bf10a3a3777837d5645ed2fb2\", \"chromedriver_unittests\": \"b67a8e0cda2dc6762c86b3fa6b3e24821c7662a2\", \"components_browsertests\": \"ecde881bbbf0703abb20fcf1b56b25b3502e9f2a\", \"components_unittests\": \"5a4159fd68c9ca3323a99f2bb3e850a4eb4a4530\", \"compositor_unittests\": \"0b453ff3aeea132bd21d87d09dca15d88e6ce3d9\", \"content_browsertests\": \"c5161ed2a09bfef73b397b7468520b9fbecb3bbb\", \"content_shell_crash_test\": \"f319d21ba29678095e8e73579eef71731f453155\", \"content_unittests\": \"2c81e55341a5e08c6e3dda44790bdfc84da4adda\", \"crashpad_tests\": \"a10e0dd0f01326332b318064802686b754c64256\", \"cronet_tests\": \"749041c362a1089f8b3d86b69225bab23cbd784a\", \"cronet_unittests\": \"b92e1d2cc92fef95babc4118a716402322dfe797\", \"crypto_unittests\": \"1dff715fdf604a8cd511ace41116483d2830ec8d\", \"dbus_unittests\": \"625ae670646942f3abdfb4896bf67085cbfc7d37\", \"device_unittests\": \"84286c7fa98a15ef361aa5c5f7e63d217c7f79f7\", \"display_unittests\": \"c170c0668cc94999f0b94530eeb99e95d2c6d4ed\", \"events_unittests\": \"688f419bfa76feb272a64458d55724168fbe911b\", \"extensions_browsertests\": \"f90f6a6008e0c88d609feaf93f2fb790c6b13ba8\", \"extensions_unittests\": \"d6e1c6f4a4f8ccdb6aecbbc5ca9f972f8a63d9ae\", \"filesystem_service_unittests\": \"f8d4923b79d231572f6af1ca6ec010f49c2e1ad4\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"6f2eb96c380ec9f43c72af13556ffd100c06d6ff\", \"gfx_unittests\": \"ec41f991a1a27d632671f0f1e1ac69c85aae4fbe\", \"gin_unittests\": \"ebeefda73fa287d599cbe76128e1d449da41bfea\", \"google_apis_unittests\": \"f8d6a10701eed33f242cb4cd423c2fe6739c545c\", \"gpu_unittests\": \"b79f6be55f991a2383e855d90724c05c5bc8d467\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"3a269544cccf8626f51d1401bc62f698d65e0dd9\", \"headless_browsertests\": \"b309f6410cf011d96c2dba1ca32350f8bb884cd0\", \"headless_unittests\": \"114d42f9955d44bad09aacd7f9430d81600603d6\", \"interactive_ui_tests\": \"690f49ee6157475da1b95e7bb054c62d5c87c86c\", \"ipc_tests\": \"d6e2919053a13ec03065d42a1dd01b906700800d\", \"jingle_unittests\": \"0ae2edf4f67e90e884bd1afd0e90904a9bcc268e\", \"latency_unittests\": \"f9ac863946b153bb08d52f7917144f84124d9f5c\", \"libjingle_xmpp_unittests\": \"fe14cf9c7b3834ec0b2928a3960e0bf07cc7e9d9\", \"liburlpattern_unittests\": \"241a25d6200be2bca1adf23176e5af71c11ab37d\", \"media_blink_unittests\": \"c3bce068da2dd53815f4dd290405baa2d1b90899\", \"media_unittests\": \"271c1758345af21f16870866094105f614be6a15\", \"message_center_unittests\": \"8941b996b06453091c61ffc468d4ef48c515ca8b\", \"metrics_python_tests\": \"895742ec816c5e1586cb29169af268a4a4c59220\", \"midi_unittests\": \"2f4688dc284d367c10e4abb2f7708f3fb757650d\", \"mojo_core_unittests\": \"1dfbac1d35f7a82734afb2218f8f4b4a337b3475\", \"mojo_unittests\": \"b6ca3567135ac98919fa95aa2c18812a41453c1d\", \"nacl_helper_nonsfi_unittests\": \"555d1e742adc6d6058567f17f5015f386fc60a64\", \"nacl_loader_unittests\": \"344f90c94434240573d91298d95fc20457ac2b0b\", \"native_theme_unittests\": \"7399bc29dbf65fa8d419d89f26f4a1d004accd92\", \"net_unittests\": \"b96038d11f17b4c72e935f8e949dba69d2c216d4\", \"openscreen_unittests\": \"f3a6d3ad143935fe2076dbef6cf30bb4d5a49327\", \"pdf_unittests\": \"6192802da9e224ca5c7fd101870a0fb5b3b49796\", \"perfetto_unittests\": \"3e81af1166dded41d003186938325b669a11c3d1\", \"ppapi_unittests\": \"a66a5e8b70cda6760c31a4347d23e58dfa9bd599\", \"printing_unittests\": \"8c321e8a6a32c66c7b292c460847e3cfcd6616a6\", \"remoting_unittests\": \"7abad3f755aa7e76cbbdc5194922d5ab106cbe5b\", \"sandbox_linux_unittests\": \"e05dac0d245a857951274f004f4cea85fd471f9f\", \"service_manager_unittests\": \"f604a5fc255260c03a002f023f270f564a6c31e3\", \"services_unittests\": \"f18e59d8cdc770b59d8ac30e172c24de9aaeb7b0\", \"shell_dialogs_unittests\": \"d2183bee963255dbdbb7ecb07c283f9ee95fa5d0\", \"skia_unittests\": \"5bbc842320e05cf2c0a1a8935266e84d8bbf0c08\", \"snapshot_unittests\": \"75120e49bc769280e3ed220b46b3e1ba6581d40a\", \"sql_unittests\": \"7abf69e4056d02f1e02301c1905b182b21f41ead\", \"storage_unittests\": \"006c48bea22cadc8128efb5f432db5c70a16c69c\", \"sync_integration_tests\": \"93ec55ef7575ef1c153f20ea6601df2f45f664f0\", \"telemetry_gpu_unittests\": \"db69b4d1763b4cbce64a0163015f257cb0e7309a\", \"telemetry_perf_unittests\": \"bb02f782123efccf6500137f6a88f7f14b67c352\", \"telemetry_unittests\": \"5983611ee1a2c73652fca2b487b0f830b1c16d4c\", \"traffic_annotation_auditor_unittests\": \"91a82ebbc1fad57f21cfa18fc7f4430abf715d9d\", \"ui_base_unittests\": \"5b2de72e837f27de0a8b2880463c0960f15089fc\", \"ui_touch_selection_unittests\": \"6cbd2476673305cdd20dc742c95db1aa1ea2adf0\", \"unit_tests\": \"3894da961bd518eb7249637dc5707214d2d42976\", \"url_unittests\": \"8af9bd194ecb3235ddae88ef6d0bb47edd99340f\", \"views_perftests\": \"6aa7f26c1c8d33a889765633f3a260ee9b89ca61\", \"views_unittests\": \"4ac71048489c17808cd214f6e0af92d8964bf88d\", \"viz_unittests\": \"51e396037b19b9ff82ed12fa11f7fd2adda17d5b\", \"vr_common_unittests\": \"835efc2c7ead8fe5811c400aff47d957a8cd35e6\", \"vr_pixeltests\": \"4a4c90024bab41324cbea9ec2c16417cb42d9410\", \"webdriver_wpt_tests\": \"fe2dcd9fbe94cb93825b8dc79b77157cba7337cd\", \"weblayer_browsertests\": \"934696c9a1f5ea3547e8de3c231fcdf100d56d0e\", \"weblayer_unittests\": \"32f09324ef92d8f21d4c6fc622a2bcae55f03660\", \"wm_unittests\": \"f977fb1b29314ff47973fa079e80321f7cc12f32\", \"wtf_unittests\": \"caa1e67eed21264a19b8a04ea1d64695ed81880d\", \"x11_unittests\": \"8cc344b0d8d148a7a9bb664e24bf03111ad279f1\", \"xr_browser_tests\": \"20571b946a455bebfd51f6aecdb0f005043cd4ad\", \"zlib_unittests\": \"881dd0ca25d4de8836310111c6823cf6a3040d0d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_37a6efb75484d21403d66fa62f2f0e5111772231983ba4ec0093d39fca548be8_v2\", \"builder_d3ee47a27de6e242d9ac174bcd2903a12a57590a5abb70af1d9c4989bd7f5749_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-128-wqyx\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612549500004518",
"status": "COMPLETED",
"status_changed_ts": "1612552292630055",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180316",
"builder:Linux Builder (dbg)",
"buildset:commit/git/303523162625926b985ef176fd1acb1d0b934c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/303523162625926b985ef176fd1acb1d0b934c89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021543077444879120",
"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/8856113015507410864/+/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:518c4229cf62fa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612552292647425",
"url": "https://ci.chromium.org/b/8856113015507410864",
"utcnow_ts": "1612552293247923"
}
}
[19:11:33.257] Invocation finished in 46m38.3606937s with status SUCCEEDED