[13:27:00.449] New invocation is queued and will start shortly
[13:27:02.320] Starting the invocation (attempt 1)
[13:27:02.444] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:27:02.448] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:27:02.448] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021743014127610992",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021743014127610992",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"gitiles_ref:refs/heads/master"
]
}
[13:27:04.698] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612358822730600",
"id": "8856312951055057040",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612358824155970",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021743014127610992",
"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/8856312951055057040/+/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": "1612358824156917",
"url": "https://ci.chromium.org/b/8856312951055057040",
"utcnow_ts": "1612358824637956"
}
}
[13:27:04.698] Task URL: https://ci.chromium.org/b/8856312951055057040
[13:27:04.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:2:0) after 1m0s
[13:27:09.155] Received PubSub notification, asking Buildbucket for the build status
[13:27:09.341] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:04.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:2:0)
[13:28:04.742] Timer tick, asking Buildbucket for the build status
[13:28:05.020] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:05.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:4:0) after 1m0s
[13:29:05.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:4:0)
[13:29:05.108] Timer tick, asking Buildbucket for the build status
[13:29:05.531] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:05.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:5:0) after 1m0s
[13:30:05.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:5:0)
[13:30:05.648] Timer tick, asking Buildbucket for the build status
[13:30:05.947] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:05.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:6:0) after 1m0s
[13:31:05.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:6:0)
[13:31:05.933] Timer tick, asking Buildbucket for the build status
[13:31:06.338] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:06.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:7:0) after 1m0s
[13:32:06.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:7:0)
[13:32:06.403] Timer tick, asking Buildbucket for the build status
[13:32:06.493] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:06.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:8:0) after 1m0s
[13:33:06.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:8:0)
[13:33:06.582] Timer tick, asking Buildbucket for the build status
[13:33:06.681] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:06.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:9:0) after 1m0s
[13:34:06.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:9:0)
[13:34:06.724] Timer tick, asking Buildbucket for the build status
[13:34:06.910] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:06.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:10:0) after 1m0s
[13:35:06.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:10:0)
[13:35:06.939] Timer tick, asking Buildbucket for the build status
[13:35:07.100] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:07.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:11:0) after 1m0s
[13:36:07.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:11:0)
[13:36:07.187] Timer tick, asking Buildbucket for the build status
[13:36:07.380] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:07.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:12:0) after 1m0s
[13:37:07.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:12:0)
[13:37:07.410] Timer tick, asking Buildbucket for the build status
[13:37:08.185] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:08.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:13:0) after 1m0s
[13:38:08.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:13:0)
[13:38:08.212] Timer tick, asking Buildbucket for the build status
[13:38:08.429] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:14:0) after 1m0s
[13:39:08.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:14:0)
[13:39:08.448] Timer tick, asking Buildbucket for the build status
[13:39:08.819] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:15:0) after 1m0s
[13:40:08.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:15:0)
[13:40:08.847] Timer tick, asking Buildbucket for the build status
[13:40:09.017] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:09.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:16:0) after 1m0s
[13:41:09.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:16:0)
[13:41:09.078] Timer tick, asking Buildbucket for the build status
[13:41:09.483] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:09.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:17:0) after 1m0s
[13:42:09.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:17:0)
[13:42:09.542] Timer tick, asking Buildbucket for the build status
[13:42:09.649] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:09.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:18:0) after 1m0s
[13:43:09.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:18:0)
[13:43:09.715] Timer tick, asking Buildbucket for the build status
[13:43:09.793] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:09.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:19:0) after 1m0s
[13:44:09.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:19:0)
[13:44:09.981] Timer tick, asking Buildbucket for the build status
[13:44:10.053] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:10.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:20:0) after 1m0s
[13:45:10.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:20:0)
[13:45:10.203] Timer tick, asking Buildbucket for the build status
[13:45:10.294] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:10.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:21:0) after 1m0s
[13:46:10.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:21:0)
[13:46:10.359] Timer tick, asking Buildbucket for the build status
[13:46:10.429] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:10.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:22:0) after 1m0s
[13:47:10.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:22:0)
[13:47:10.559] Timer tick, asking Buildbucket for the build status
[13:47:10.712] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:10.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:23:0) after 1m0s
[13:48:10.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:23:0)
[13:48:10.799] Timer tick, asking Buildbucket for the build status
[13:48:11.127] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:11.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:24:0) after 1m0s
[13:49:11.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:24:0)
[13:49:11.180] Timer tick, asking Buildbucket for the build status
[13:49:11.320] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:11.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:25:0) after 1m0s
[13:50:11.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:25:0)
[13:50:11.475] Timer tick, asking Buildbucket for the build status
[13:50:11.551] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:11.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:26:0) after 1m0s
[13:51:11.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:26:0)
[13:51:11.823] Timer tick, asking Buildbucket for the build status
[13:51:12.042] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:12.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:27:0) after 1m0s
[13:52:12.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:27:0)
[13:52:12.117] Timer tick, asking Buildbucket for the build status
[13:52:12.429] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:12.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:28:0) after 1m0s
[13:53:12.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:28:0)
[13:53:12.764] Timer tick, asking Buildbucket for the build status
[13:53:13.104] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:13.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:29:0) after 1m0s
[13:54:13.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:29:0)
[13:54:13.244] Timer tick, asking Buildbucket for the build status
[13:54:13.318] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:13.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:30:0) after 1m0s
[13:55:13.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:30:0)
[13:55:13.337] Timer tick, asking Buildbucket for the build status
[13:55:13.535] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:13.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:31:0) after 1m0s
[13:56:13.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:31:0)
[13:56:13.619] Timer tick, asking Buildbucket for the build status
[13:56:13.805] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:13.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:32:0) after 1m0s
[13:57:14.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:32:0)
[13:57:14.064] Timer tick, asking Buildbucket for the build status
[13:57:14.213] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:14.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:33:0) after 1m0s
[13:58:14.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:33:0)
[13:58:14.345] Timer tick, asking Buildbucket for the build status
[13:58:14.443] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:14.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:34:0) after 1m0s
[13:59:14.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:34:0)
[13:59:14.450] Timer tick, asking Buildbucket for the build status
[13:59:14.536] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:14.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:35:0) after 1m0s
[14:00:14.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:35:0)
[14:00:14.570] Timer tick, asking Buildbucket for the build status
[14:00:14.843] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:14.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:36:0) after 1m0s
[14:01:14.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:36:0)
[14:01:14.888] Timer tick, asking Buildbucket for the build status
[14:01:14.940] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:14.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:37:0) after 1m0s
[14:02:15.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:37:0)
[14:02:15.001] Timer tick, asking Buildbucket for the build status
[14:02:15.130] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:15.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:38:0) after 1m0s
[14:03:15.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:38:0)
[14:03:15.229] Timer tick, asking Buildbucket for the build status
[14:03:15.360] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:15.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:39:0) after 1m0s
[14:04:15.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:39:0)
[14:04:15.421] Timer tick, asking Buildbucket for the build status
[14:04:15.636] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:15.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:40:0) after 1m0s
[14:05:15.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:40:0)
[14:05:15.672] Timer tick, asking Buildbucket for the build status
[14:05:15.906] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:15.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:41:0) after 1m0s
[14:06:15.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:41:0)
[14:06:15.903] Timer tick, asking Buildbucket for the build status
[14:06:16.199] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:16.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:42:0) after 1m0s
[14:07:16.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:42:0)
[14:07:16.300] Timer tick, asking Buildbucket for the build status
[14:07:17.272] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:43:0) after 1m0s
[14:08:17.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:43:0)
[14:08:17.327] Timer tick, asking Buildbucket for the build status
[14:08:23.455] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:23.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:44:0) after 1m0s
[14:09:23.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:44:0)
[14:09:23.468] Timer tick, asking Buildbucket for the build status
[14:09:23.537] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:23.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:45:0) after 1m0s
[14:10:23.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:45:0)
[14:10:23.554] Timer tick, asking Buildbucket for the build status
[14:10:23.613] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:23.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:46:0) after 1m0s
[14:11:23.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:46:0)
[14:11:23.664] Timer tick, asking Buildbucket for the build status
[14:11:23.731] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:23.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:47:0) after 1m0s
[14:12:23.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:47:0)
[14:12:23.782] Timer tick, asking Buildbucket for the build status
[14:12:23.875] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:23.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:48:0) after 1m0s
[14:13:24.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:48:0)
[14:13:24.269] Timer tick, asking Buildbucket for the build status
[14:13:24.555] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:24.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:49:0) after 1m0s
[14:14:24.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:49:0)
[14:14:24.700] Timer tick, asking Buildbucket for the build status
[14:14:24.789] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:24.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:50:0) after 1m0s
[14:15:24.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:50:0)
[14:15:24.970] Timer tick, asking Buildbucket for the build status
[14:15:25.112] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:51:0) after 1m0s
[14:16:25.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:51:0)
[14:16:25.157] Timer tick, asking Buildbucket for the build status
[14:16:25.238] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:25.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:52:0) after 1m0s
[14:17:25.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:52:0)
[14:17:25.375] Timer tick, asking Buildbucket for the build status
[14:17:26.502] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:26.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:53:0) after 1m0s
[14:18:26.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:53:0)
[14:18:26.854] Timer tick, asking Buildbucket for the build status
[14:18:27.706] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:27.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:54:0) after 1m0s
[14:19:27.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:54:0)
[14:19:27.814] Timer tick, asking Buildbucket for the build status
[14:19:27.872] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:27.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:55:0) after 1m0s
[14:20:28.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:55:0)
[14:20:28.057] Timer tick, asking Buildbucket for the build status
[14:20:28.131] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:28.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:56:0) after 1m0s
[14:21:28.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:56:0)
[14:21:28.201] Timer tick, asking Buildbucket for the build status
[14:21:28.269] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:57:0) after 1m0s
[14:22:28.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:57:0)
[14:22:28.497] Timer tick, asking Buildbucket for the build status
[14:22:28.609] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:28.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:58:0) after 1m0s
[14:23:28.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:58:0)
[14:23:28.774] Timer tick, asking Buildbucket for the build status
[14:23:28.853] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:28.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:59:0) after 1m0s
[14:24:29.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:59:0)
[14:24:29.870] Timer tick, asking Buildbucket for the build status
[14:24:30.097] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:30.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:60:0) after 1m0s
[14:25:30.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:60:0)
[14:25:30.274] Timer tick, asking Buildbucket for the build status
[14:25:30.347] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:30.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:61:0) after 1m0s
[14:26:30.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:61:0)
[14:26:30.526] Timer tick, asking Buildbucket for the build status
[14:26:30.747] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:30.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:62:0) after 1m0s
[14:27:31.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:62:0)
[14:27:31.000] Timer tick, asking Buildbucket for the build status
[14:27:31.249] Build 8856312951055057040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:31.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021743014127610992:63:0) after 1m0s
[14:27:32.795] Received PubSub notification, asking Buildbucket for the build status
[14:27:33.521] Build 8856312951055057040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:27:33.521] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612362451382565",
"created_by": "project:chromium",
"created_ts": "1612358822730600",
"id": "8856312951055057040",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\"}}",
"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\": \"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\", \"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-159-2xnu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180235, \"got_angle_revision\": \"2e54a1e7fc49e1c1c659d7be659b832954112106\", \"got_dawn_revision\": \"fd5fd05db039710c797ee8bac5e6d999173e5fc3\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\", \"got_revision_cp\": \"refs/heads/master@{#850085}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"53720ace941d84ac17ae67a94166a363dcf0cacf\", \"got_v8_revision_cp\": \"refs/heads/9.0.123@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0\", \"swarm_hashes_refs/heads/master(at){#850085}_without_patch\": {\"absl_hardening_tests\": \"73fda4f9c8e763a0854d26273e228773761f16a8\", \"accessibility_unittests\": \"5ef5585800985afc72b11b72f22cbcc45fee10ca\", \"angle_unittests\": \"4ff706f51b9f8a7ef44ccb19111f690802aeed28\", \"app_shell_unittests\": \"3dd9b24f5d9df810884243ea17079e9e6476fbd7\", \"aura_unittests\": \"e56ef2290d860a85ffe7f89636a3b5f67ef0af3a\", \"base_unittests\": \"7336eff6b1a3dc1cca0f2ce0ffd0ae6fd119473d\", \"base_util_unittests\": \"dff6b2b0e7d1e6f834de8373bea5e12442c5e6b8\", \"blink_common_unittests\": \"ad5dcd4ded066a9fb064d9435fcfbfcfa8286954\", \"blink_fuzzer_unittests\": \"adffc0055c836750f9123d87c6e6246271ad2029\", \"blink_heap_unittests\": \"ca3b3b57e3340b52f7a388b16c9ca85aee5f2406\", \"blink_platform_unittests\": \"f4a8d1436ab5699c11f615f6fce06dd49c8040eb\", \"blink_python_tests\": \"7aa1e1f8e8c2835334ffe95182792f547858e25f\", \"blink_unittests\": \"db5db2ce117fdb31a1ab21308461837d5577ac75\", \"blink_web_tests\": \"f767b549d662a2968508b88e039c871526731390\", \"boringssl_crypto_tests\": \"56f82a1a3f475b40ed9b19173373ef4ea0933abe\", \"boringssl_ssl_tests\": \"90393c36c412648fdf9852fed3c3972fd595bc79\", \"browser_tests\": \"b722daec85f1f62940b692f5910dbe5e471fece3\", \"capture_unittests\": \"1fa0c4829d009c34146989e6c7087d65b258a73b\", \"cast_unittests\": \"8220ff4c32810b48b07354f2c448e960a2627c12\", \"cc_unittests\": \"152412a39d77773d7b02320d13b8ba41b1bdc7ae\", \"chrome_app_unittests\": \"e2a04210619214551c5b85a1e8924dd60eb7c555\", \"chromedriver_unittests\": \"e7fd64c83912d2e278ddd5082e3883fb64712c2f\", \"components_browsertests\": \"0e7b50c33e97b2331fb6cad39bf761dc21218263\", \"components_unittests\": \"87ffc3427c1bf5fd6c92a4ab42de8c7874a5e6c3\", \"compositor_unittests\": \"62e97475ea09aeed83fbd6b0d4320d28b43ef0ab\", \"content_browsertests\": \"d315363ce395850e7410d2720814edad0267bcfe\", \"content_shell_crash_test\": \"4068b04b8844d6ad4bda3c6dae7a546aa594a874\", \"content_unittests\": \"6857945d81bdc1601322721cd38ccdddb69b38a9\", \"crashpad_tests\": \"c8f19bf2a501e800de5963148e5db565e2a26dc4\", \"cronet_tests\": \"fcbc50cf09f3c28e8711a42518be4bf56afa2a8e\", \"cronet_unittests\": \"7d1da07ea4bbf7b5bf127344027f0861fcc39667\", \"crypto_unittests\": \"09411f6e651eee3299dba3b581c2650f788db7ec\", \"dbus_unittests\": \"e35dfd6a8fc2d5b10289685a40f8d8eb5afb9ed3\", \"device_unittests\": \"5f388ec27252d26842d1575337dfd61fbcfec871\", \"display_unittests\": \"6fc62a4b6a8824dbd1ab9bac59580fa835c6f9a7\", \"events_unittests\": \"48c09730139f9cfc4e5a177c79ce679c1f1e72a4\", \"extensions_browsertests\": \"137714bfa0f886c3e42f8a3d47a6e83769fe1edf\", \"extensions_unittests\": \"b35010c4b2de9ac6b8ef16d9c0474b0e16aba139\", \"filesystem_service_unittests\": \"27a642d4954e7ae2ae7b80d370aba2460aabb64c\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"92be11dedd0edb0033edb9b58d37c24bc2196dd5\", \"gfx_unittests\": \"87c62634d11545ad955f2bd92f47d1701823cbb8\", \"gin_unittests\": \"c4336d673b5fb039f1866de75393327816a8ca8f\", \"google_apis_unittests\": \"d4f2c80a84a4ed128200e53ed94b11bb39b59e59\", \"gpu_unittests\": \"987b96b1070f4da0ac2c871be2b0d73ec714cd72\", \"grit_python_unittests\": \"0532571aa381198443b89c1ec536d42cf612fc22\", \"gwp_asan_unittests\": \"f902b1314d806e81523c960fee270fac58e6c5ef\", \"headless_browsertests\": \"dcf96cf1c06090e4bb827df2e8ad4eb3aee6c70d\", \"headless_unittests\": \"44f3ec9f6db40295626f0e970e26e7d7e0216d45\", \"interactive_ui_tests\": \"bcc044d228d31835899c86722ad77c53dbc29b47\", \"ipc_tests\": \"eac49a2661523839ee7e6cea5e62ba3c2e1c8393\", \"jingle_unittests\": \"aecd43008462db85e214b7622b3f0dcf698bcdc5\", \"latency_unittests\": \"cae803b39103021c66dec58d445d040e3d1dcd67\", \"libjingle_xmpp_unittests\": \"826a53a97a6450021e9591cf1bae07fb2c6941d6\", \"liburlpattern_unittests\": \"b9f449708939cae68078f02db208ac881903799b\", \"media_blink_unittests\": \"b79cd27f86f37b505e37cf260382ca3d7c882cf7\", \"media_unittests\": \"45e91e58f24579436de84d8a8a4a162235a7dd86\", \"message_center_unittests\": \"aec5cc3bb2391f129ba042735560cc3fa68e4a69\", \"metrics_python_tests\": \"b14fa95bc2357ed6c2e875d721cc67e3baccee8f\", \"midi_unittests\": \"5121311ec0767c48a8ce0d7c13b2d210d034f386\", \"mojo_core_unittests\": \"d4c50720946eb4a81a2fad669d4e1a219c8a3b65\", \"mojo_unittests\": \"41428312dbac7e010ce21cbf82afc278401dd839\", \"nacl_helper_nonsfi_unittests\": \"7f6a03d5604cb17a5fddad91138e0f49969b96cb\", \"nacl_loader_unittests\": \"4b1fd5ef27f459459037394c2c67c417dc65ba7d\", \"native_theme_unittests\": \"bd42101f920bd05b454b071a67e4ca9090bc6102\", \"net_unittests\": \"6503139493f8505efb0f38b0f98570bb45fa7c66\", \"openscreen_unittests\": \"ca5de6e686fa54dfc2e15c1d8fc04a32d53f2a59\", \"pdf_unittests\": \"fe05a53db9a284dbdb4c552fc9d10d86cd146402\", \"perfetto_unittests\": \"3b303f558b31c50d740f9d6808db62d61f305bde\", \"ppapi_unittests\": \"ae8b4b62df2b8faec5e75b43ce64267c8185705f\", \"printing_unittests\": \"8b218c16b6fb535a7437f6f370cdd23d936f7ca8\", \"remoting_unittests\": \"431706eae8d807f52a1c499d6dc53280087e65a3\", \"sandbox_linux_unittests\": \"7d6713cfb9f40efe4ca0d25cd97f595b6ae8e72b\", \"service_manager_unittests\": \"8e530d62303d78b6ac19ede8c4bcd68c7bb710cb\", \"services_unittests\": \"5ecddee40e133c44c662e340677a0ef45014a114\", \"shell_dialogs_unittests\": \"cda1d81017fd381663458970bdf1adde8fcbe225\", \"skia_unittests\": \"bc36dbac25e8998767c56b2234135e0bfe769ea4\", \"snapshot_unittests\": \"eba8c7fb412c9881a8656373505ae9de61ecf353\", \"sql_unittests\": \"4e3104651f93e7ca5234844cc998bcc652671ced\", \"storage_unittests\": \"86ca5b87688e778e17c4100f2820af85615033d3\", \"sync_integration_tests\": \"9111cd46b02ca458dda32c02f7dc404c6883fc71\", \"telemetry_gpu_unittests\": \"14fcf0325488ccbc259ba5ee6d49001a36581fd9\", \"telemetry_perf_unittests\": \"a8b31a2db612d83720ffcae7a5b3f1882463f687\", \"telemetry_unittests\": \"a7f7d8813e57d39114b369fc5144a041ce94df4f\", \"traffic_annotation_auditor_unittests\": \"78691526921e43f0017292afc5bb933da10252be\", \"ui_base_unittests\": \"66856c7569ce39f7bb120a2efb55011d5e064c70\", \"ui_touch_selection_unittests\": \"15bbc713f662b2fb86a991b42aca90304d0268b9\", \"unit_tests\": \"19aa3c77d4af9f8ec2b7c65f9f60feeb9e604743\", \"url_unittests\": \"e34fe1f663c2d65335fc58809e1769ae41338f76\", \"views_perftests\": \"c26df05aae26b5769a42bc50e03769c7654daedd\", \"views_unittests\": \"596392056682b0dcc937fec9bf36935ca64eb559\", \"viz_unittests\": \"fe93540eedc64fabb726aff8b0b7f483df20810b\", \"vr_common_unittests\": \"c8ffd3c559dd5a8d29a0bf1ca9ab3e48931bbd5f\", \"vr_pixeltests\": \"79f9c7db49bb8366d4889aae70529943fb79af17\", \"webdriver_wpt_tests\": \"8103738b1291ea2975fab8fd54d37b9fe95386ba\", \"weblayer_browsertests\": \"7491bf7bec8a10fbaf198fe68491c762fa842611\", \"weblayer_unittests\": \"cc189482d0078e428d1274474f92a7ab7842b11d\", \"wm_unittests\": \"ce45b4d6fad882bd80685a3e1b9278043d0e6d30\", \"wtf_unittests\": \"018ca2ffe4ebc0e7c31ada1537240a0158a009f0\", \"x11_unittests\": \"7c2b5ffc2e1ea04c414739193ead69eca9de30be\", \"xr_browser_tests\": \"86d46c4f379a6057645d95bb906b8e651f1ed1ea\", \"zlib_unittests\": \"5276b952d5274b9dc6b048591ce114ec41331eaa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a2b13219f689d34aa475139e9738b55334bf25923df6aa4978f2ee96f164d56_v2\", \"builder_7ed5e98f023cd9e0abec02df990f9772adc652ea96b625245e768b064914efaf_v2\", \"builder_8f7e40299f74ff9d94767563834f98f87bf45cac7401cd036aab5fd865cb3b58_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_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-159-2xnu\"], \"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": "1612358828284085",
"status": "COMPLETED",
"status_changed_ts": "1612362451791751",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8dcc3dc5c95e730ec8b667c16ed9e582949d7aa0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021743014127610992",
"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/8856312951055057040/+/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:5180e4bae32be010",
"user_agent:luci-scheduler"
],
"updated_ts": "1612362451801009",
"url": "https://ci.chromium.org/b/8856312951055057040",
"utcnow_ts": "1612362453442142"
}
}
[14:27:33.521] Invocation finished in 1h0m33.10545964s with status SUCCEEDED