[19:26:04.969] New invocation is queued and will start shortly
[19:26:06.415] Starting the invocation (attempt 1)
[19:26:06.519] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:26:06.519] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:26:06.519] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021086244282142160",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021086244282142160",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"gitiles_ref:refs/heads/master"
]
}
[19:26:08.509] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612985166732677",
"id": "8855656181767561600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612985168105215",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180465",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021086244282142160",
"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/8855656181767561600/+/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": "1612985168105383",
"url": "https://ci.chromium.org/b/8855656181767561600",
"utcnow_ts": "1612985168486749"
}
}
[19:26:08.509] Task URL: https://ci.chromium.org/b/8855656181767561600
[19:26:08.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:2:0) after 1m0s
[19:26:10.356] Received PubSub notification, asking Buildbucket for the build status
[19:26:10.672] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:08.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:2:0)
[19:27:08.528] Timer tick, asking Buildbucket for the build status
[19:27:08.829] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:08.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:4:0) after 1m0s
[19:28:08.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:4:0)
[19:28:08.970] Timer tick, asking Buildbucket for the build status
[19:28:09.316] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:09.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:5:0) after 1m0s
[19:29:09.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:5:0)
[19:29:09.526] Timer tick, asking Buildbucket for the build status
[19:29:10.003] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:10.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:6:0) after 1m0s
[19:30:31.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:6:0)
[19:30:31.155] Timer tick, asking Buildbucket for the build status
[19:30:31.230] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:31.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:7:0) after 1m0s
[19:31:31.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:7:0)
[19:31:31.814] Timer tick, asking Buildbucket for the build status
[19:31:32.027] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:32.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:8:0) after 1m0s
[19:32:32.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:8:0)
[19:32:32.051] Timer tick, asking Buildbucket for the build status
[19:32:32.144] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:32.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:9:0) after 1m0s
[19:33:32.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:9:0)
[19:33:32.217] Timer tick, asking Buildbucket for the build status
[19:33:32.309] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:32.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:10:0) after 1m0s
[19:34:32.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:10:0)
[19:34:32.423] Timer tick, asking Buildbucket for the build status
[19:34:32.593] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:32.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:11:0) after 1m0s
[19:35:32.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:11:0)
[19:35:32.657] Timer tick, asking Buildbucket for the build status
[19:35:32.874] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:32.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:12:0) after 1m0s
[19:36:33.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:12:0)
[19:36:33.084] Timer tick, asking Buildbucket for the build status
[19:36:33.430] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:33.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:13:0) after 1m0s
[19:37:33.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:13:0)
[19:37:33.598] Timer tick, asking Buildbucket for the build status
[19:37:33.706] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:33.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:14:0) after 1m0s
[19:38:33.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:14:0)
[19:38:33.736] Timer tick, asking Buildbucket for the build status
[19:38:33.841] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:15:0) after 1m0s
[19:39:33.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:15:0)
[19:39:33.968] Timer tick, asking Buildbucket for the build status
[19:39:34.292] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:34.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:16:0) after 1m0s
[19:40:34.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:16:0)
[19:40:34.363] Timer tick, asking Buildbucket for the build status
[19:40:35.002] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:35.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:17:0) after 1m0s
[19:41:35.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:17:0)
[19:41:35.032] Timer tick, asking Buildbucket for the build status
[19:41:35.203] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:35.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:18:0) after 1m0s
[19:42:35.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:18:0)
[19:42:35.343] Timer tick, asking Buildbucket for the build status
[19:42:35.447] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:35.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:19:0) after 1m0s
[19:43:35.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:19:0)
[19:43:35.480] Timer tick, asking Buildbucket for the build status
[19:43:35.576] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:35.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:20:0) after 1m0s
[19:44:35.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:20:0)
[19:44:35.620] Timer tick, asking Buildbucket for the build status
[19:44:35.726] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:35.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:21:0) after 1m0s
[19:45:35.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:21:0)
[19:45:35.733] Timer tick, asking Buildbucket for the build status
[19:45:35.926] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:35.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:22:0) after 1m0s
[19:46:36.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:22:0)
[19:46:36.040] Timer tick, asking Buildbucket for the build status
[19:46:36.159] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:36.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:23:0) after 1m0s
[19:47:36.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:23:0)
[19:47:36.151] Timer tick, asking Buildbucket for the build status
[19:47:36.234] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:36.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:24:0) after 1m0s
[19:48:36.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:24:0)
[19:48:36.311] Timer tick, asking Buildbucket for the build status
[19:48:36.772] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:36.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:25:0) after 1m0s
[19:49:36.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:25:0)
[19:49:36.849] Timer tick, asking Buildbucket for the build status
[19:49:36.943] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:36.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:26:0) after 1m0s
[19:50:37.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:26:0)
[19:50:37.054] Timer tick, asking Buildbucket for the build status
[19:50:37.139] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:37.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:27:0) after 1m0s
[19:51:37.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:27:0)
[19:51:37.220] Timer tick, asking Buildbucket for the build status
[19:51:37.316] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:28:0) after 1m0s
[19:52:37.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:28:0)
[19:52:37.447] Timer tick, asking Buildbucket for the build status
[19:52:37.533] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:37.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:29:0) after 1m0s
[19:53:37.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:29:0)
[19:53:37.539] Timer tick, asking Buildbucket for the build status
[19:53:37.667] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:37.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:30:0) after 1m0s
[19:54:37.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:30:0)
[19:54:37.808] Timer tick, asking Buildbucket for the build status
[19:54:37.928] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:31:0) after 1m0s
[19:55:37.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:31:0)
[19:55:37.960] Timer tick, asking Buildbucket for the build status
[19:55:38.044] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:38.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:32:0) after 1m0s
[19:56:38.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:32:0)
[19:56:38.103] Timer tick, asking Buildbucket for the build status
[19:56:38.187] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:38.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:33:0) after 1m0s
[19:57:38.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:33:0)
[19:57:38.245] Timer tick, asking Buildbucket for the build status
[19:57:38.500] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:38.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:34:0) after 1m0s
[19:58:38.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:34:0)
[19:58:38.523] Timer tick, asking Buildbucket for the build status
[19:58:38.629] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:38.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:35:0) after 1m0s
[19:59:38.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:35:0)
[19:59:38.671] Timer tick, asking Buildbucket for the build status
[19:59:38.906] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:38.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:36:0) after 1m0s
[20:00:38.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:36:0)
[20:00:38.952] Timer tick, asking Buildbucket for the build status
[20:00:39.418] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:39.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:37:0) after 1m0s
[20:01:39.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:37:0)
[20:01:39.521] Timer tick, asking Buildbucket for the build status
[20:01:39.647] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:39.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:38:0) after 1m0s
[20:02:39.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:38:0)
[20:02:39.726] Timer tick, asking Buildbucket for the build status
[20:02:39.912] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:39.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:39:0) after 1m0s
[20:03:39.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:39:0)
[20:03:39.942] Timer tick, asking Buildbucket for the build status
[20:03:40.116] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:40.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:40:0) after 1m0s
[20:04:40.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:40:0)
[20:04:40.192] Timer tick, asking Buildbucket for the build status
[20:04:40.476] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:40.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:41:0) after 1m0s
[20:05:40.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:41:0)
[20:05:40.586] Timer tick, asking Buildbucket for the build status
[20:05:40.715] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:42:0) after 1m0s
[20:06:40.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:42:0)
[20:06:40.716] Timer tick, asking Buildbucket for the build status
[20:06:40.946] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:40.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:43:0) after 1m0s
[20:07:41.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:43:0)
[20:07:41.040] Timer tick, asking Buildbucket for the build status
[20:07:41.119] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:41.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:44:0) after 1m0s
[20:08:41.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:44:0)
[20:08:41.118] Timer tick, asking Buildbucket for the build status
[20:08:41.237] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:41.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:45:0) after 1m0s
[20:09:41.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:45:0)
[20:09:41.260] Timer tick, asking Buildbucket for the build status
[20:09:41.354] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:41.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:46:0) after 1m0s
[20:10:41.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:46:0)
[20:10:41.378] Timer tick, asking Buildbucket for the build status
[20:10:41.542] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:41.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:47:0) after 1m0s
[20:11:41.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:47:0)
[20:11:41.599] Timer tick, asking Buildbucket for the build status
[20:11:41.693] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:41.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:48:0) after 1m0s
[20:12:41.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:48:0)
[20:12:41.748] Timer tick, asking Buildbucket for the build status
[20:12:41.826] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:41.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:49:0) after 1m0s
[20:13:41.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:49:0)
[20:13:41.853] Timer tick, asking Buildbucket for the build status
[20:13:41.929] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:41.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:50:0) after 1m0s
[20:14:41.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:50:0)
[20:14:41.958] Timer tick, asking Buildbucket for the build status
[20:14:42.272] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:42.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:51:0) after 1m0s
[20:15:42.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:51:0)
[20:15:42.280] Timer tick, asking Buildbucket for the build status
[20:15:42.414] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:42.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:52:0) after 1m0s
[20:16:42.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:52:0)
[20:16:42.427] Timer tick, asking Buildbucket for the build status
[20:16:42.522] Build 8855656181767561600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021086244282142160:53:0) after 1m0s
[20:17:26.259] Received PubSub notification, asking Buildbucket for the build status
[20:17:26.355] Build 8855656181767561600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:17:26.355] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612988245342230",
"created_by": "project:chromium",
"created_ts": "1612985166732677",
"id": "8855656181767561600",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\"}}",
"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\": \"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180465, \"got_angle_revision\": \"0f74ae58ed185108ec38a4cb038ef3c31acd9ff4\", \"got_dawn_revision\": \"e0a588752c827daef74960bbc80d7f5c4f73c4dd\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\", \"got_revision_cp\": \"refs/heads/master@{#852744}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"ddadcacd13fae633df256fb967e61d4dbf1c8083\", \"got_v8_revision_cp\": \"refs/heads/9.0.157@{#1}\", \"got_webrtc_revision\": \"fa5ad8c0b5efb1b3ad90d8a726feb5cb221a04fe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33213}\", \"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\": \"1ea620809a241de8dc2ba5666f3bee46ffda9cf9\", \"swarm_hashes_refs/heads/master(at){#852744}_without_patch\": {\"absl_hardening_tests\": \"a80780b48b3d0cd83668962442aabb53f53974bd\", \"accessibility_unittests\": \"cf71c2ab9070ef369aa3c5a6b242bc78cb7e7e73\", \"angle_unittests\": \"68d2e10aab23728ac922f70f392596c299d98984\", \"app_shell_unittests\": \"f1e0985e855a768b39a381bca1a3cd79e9095b7d\", \"aura_unittests\": \"3a62944996f82dcb0c1a52f37af923ced26e3d5d\", \"base_unittests\": \"e77268a6db5c1b5099116687de8d859da6cb6ae0\", \"base_util_unittests\": \"49d94c0fbfccd1a0e27c3b2e25466703e825722e\", \"blink_common_unittests\": \"7b9e2c272b510c018f5c33a081518a5201f897a6\", \"blink_fuzzer_unittests\": \"638f6847d9153ec0d81ca87f04266932454befa1\", \"blink_heap_unittests\": \"8400841767dca8dc1bbf205c3c14f97e679afedd\", \"blink_platform_unittests\": \"89cdabdd7ca78cbf8eceb10f2fdde8016b958ece\", \"blink_python_tests\": \"356c75c386b4f2b444daf9d65dc14a1067f919f2\", \"blink_unittests\": \"a5b1da04d29c190e3abae41426b74518a24c04a4\", \"blink_web_tests\": \"2bc405b7544a7bc0971b5bcc3735ddfd9b74d75b\", \"boringssl_crypto_tests\": \"7011543503c5b06b10f3661736248a2283174a2b\", \"boringssl_ssl_tests\": \"a747d32267ed606b45d56657c54117b26f2f989f\", \"browser_tests\": \"e411388233e04b3fe26bbf33d39d6b7baa5942ef\", \"capture_unittests\": \"79b20bf16444ed90bc91fc7d2c858109bc312357\", \"cast_unittests\": \"80dd2919e0ac4c7edb9a682256e4bb43718f50e2\", \"cc_unittests\": \"97c2552d4e790497f9e44f77c020efdc8f84439d\", \"chrome_app_unittests\": \"9b6de5375ce9bda5f4d891f51e51f7fbbc4b430f\", \"chromedriver_unittests\": \"8de3c37d06c2305e658207977027067a3d1eb93c\", \"components_browsertests\": \"1f974cb894808abb401265d1d30be9770c2cf27c\", \"components_unittests\": \"e239e0823fa199e77411dc4e78392847f533bb24\", \"compositor_unittests\": \"88fa31ee8618efe1b6de16a1fda6cd55debf9a49\", \"content_browsertests\": \"cf5ae8478983743e1cf9a823d986ff63ca554183\", \"content_shell_crash_test\": \"41985d71cc4f5fd04a29401078fc93ff7d123a1b\", \"content_unittests\": \"26bf3fa6e968c69fcc7f443819872261085ba08d\", \"crashpad_tests\": \"52933b4000805dbb7f0ddcb06f0e00c791477b06\", \"cronet_tests\": \"60390e06fb07f141eaf942bc5ee06c1886699f5e\", \"cronet_unittests\": \"ba126c5f6c7fba7e576a753699a98b0cd4c2010e\", \"crypto_unittests\": \"7295d8b95bfdae847e39360a48fe71e876871401\", \"dbus_unittests\": \"d5a9e67c747fc0209151771911c28b0cc8195910\", \"device_unittests\": \"4162cdfc7ff0e9f9a6b453d872d411d920c005e3\", \"display_unittests\": \"6874f6e9e86c00b6d45165eab039bf5a4d03cdee\", \"events_unittests\": \"a298fb85fae1bd9db073042da92e41fe97bb0a43\", \"extensions_browsertests\": \"1b709c4b33c8145b825ff926023240e49e2281fa\", \"extensions_unittests\": \"bac7bad920af6c3e6e14717a19e2962784228899\", \"filesystem_service_unittests\": \"022cccc12143a5a60b40095ad11928192a919c32\", \"flatbuffers_unittests\": \"eac01a3774a90cf68bd2cb5c5e10e20502448f17\", \"gcm_unit_tests\": \"ea72f0c5ba7e55cc6eb39ff6678ee1f2403f069c\", \"gfx_unittests\": \"e01a1c230e77f481ba48a9f2ad6d285895ac2ae7\", \"gin_unittests\": \"0980d4f80a76bf781f796029cb04972f1cd02e7d\", \"google_apis_unittests\": \"73292443a1107ba49b831b1548f45c13762da24a\", \"gpu_unittests\": \"b2d23569f5cc8d0b5c415c0228f3450aaa78d219\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"1ba49e7938205083d46131c3980d969f89db6069\", \"headless_browsertests\": \"2d6c0c341b300e2321ff97d52bcf1b65171fb5c1\", \"headless_unittests\": \"f111813aefd738e15852495b5e89c4d67f2c3d47\", \"interactive_ui_tests\": \"bf095de839b3e151b69c7240c6def9f995834fd9\", \"ipc_tests\": \"85a5e36f7993b26600c23d946d6ebe1b112deb28\", \"jingle_unittests\": \"df03fb98e722fe738a4bf6a72b035cfcc822b97d\", \"latency_unittests\": \"6d79db13a37894c39ea0393c7b1e60e1c5e1e580\", \"libjingle_xmpp_unittests\": \"f06ba12a18f160ffe8439de71f5cd093d2bd2c31\", \"liburlpattern_unittests\": \"3b49763654dbd0cd9ad49ce591228dc6d7fa827b\", \"media_blink_unittests\": \"98ab2f2371ad126982a9a0eb0e5c28af690ecd53\", \"media_unittests\": \"e7da694885fdf000d5725d254c979d8c985feee0\", \"message_center_unittests\": \"f62b892bf0fc8b7ae44e8785c6969447765c20fa\", \"metrics_python_tests\": \"822f7b59ffcb7e5abeb92121fda82907f1d62696\", \"midi_unittests\": \"c09c5974b7d3b0bd87a94993b009fc52a91d00fc\", \"mojo_core_unittests\": \"a7dc099e1dbb38febbe7613064b7559e566565d2\", \"mojo_unittests\": \"02f5247357c49983f634231f5b0a5937722b7b83\", \"nacl_helper_nonsfi_unittests\": \"47a6669b9c7832107902528a60d8aa302ee42f02\", \"nacl_loader_unittests\": \"2e68718c72c516269f012d9e0ad836ddceced1b0\", \"native_theme_unittests\": \"333d0dd3f558b3ddf35b34a8cef095009f5b1888\", \"net_unittests\": \"7be4a44719623109d8a2264e610966f50de1fbf5\", \"openscreen_unittests\": \"44e5b29616e1e0d86b35d9608db5ccbd1a49bbfc\", \"pdf_unittests\": \"5ccca735f345e0742b6dfa9799b11f58deb601f9\", \"perfetto_unittests\": \"e9a3c2c0b76dedb35abf4fcfc998013b60a1bc9a\", \"ppapi_unittests\": \"d8cfc700846802389143d7d6bc9405b13e2dac56\", \"printing_unittests\": \"cf167c9a45902bf5ca5d0cffd12944f5e91b1ee7\", \"remoting_unittests\": \"cf6bbea55e7dc33d0f8653c2843639d760730840\", \"sandbox_linux_unittests\": \"ba19da457c6acdd63eefc8c9c6651f60c6dbd8e2\", \"service_manager_unittests\": \"de196cbd635d5f87eb33871faabddc22e07322f6\", \"services_unittests\": \"31b1271f5243ec41963b0f71c83bbec95d19db82\", \"shell_dialogs_unittests\": \"ff7e0e4db425467fac6d24cf7614a99da59ac633\", \"skia_unittests\": \"7d85fd96b88b3587c5ad0de568286356e9d047bb\", \"snapshot_unittests\": \"4117e7c72803bdef12f5cdcf97f5e4a71aef41d6\", \"sql_unittests\": \"b1fae66052d0c926cbcad2f451778f0b631a3ecc\", \"storage_unittests\": \"a819d94907b895ae9d4b3a85394d3ce2cd97a0d5\", \"sync_integration_tests\": \"b30100dae721a8d1f4d307c64792664cae1fba4c\", \"telemetry_gpu_unittests\": \"ff0e71ba1b95c1efc46cfb383a02bd95923c5a9f\", \"telemetry_perf_unittests\": \"e7a7454fbfa9523a2e2d880526b779242e5ac7be\", \"telemetry_unittests\": \"6d10a87066265d432f20b7ffafbbc024a87bc749\", \"traffic_annotation_auditor_unittests\": \"f285c2e9c771d0e2a009b29c6b8baf150d659d20\", \"ui_base_unittests\": \"c2d090a0f5a6bef99c6ac4eaa3f6d4cf1a9900db\", \"ui_touch_selection_unittests\": \"f31bb77d7a83f076698f8d66726a84af9b2016ee\", \"unit_tests\": \"def4cc3fc9566384f9f43c8deb0878d10d2fbe58\", \"url_unittests\": \"0cc607063462f4a55c65cd90998298bda895f186\", \"views_perftests\": \"c8aa1df794e909f3a44e4452c4cee1bc42c357fd\", \"views_unittests\": \"44750b8a40af8ac14069c1716dd3a2a68db396f6\", \"viz_unittests\": \"c3a471c39d25a6a191954613e7504bae7ba8a3a6\", \"vr_common_unittests\": \"51a82b8085c52b8c667496d5dd062bd4d11fad11\", \"vr_pixeltests\": \"7b6d35840745d1ef159950c08d9a4cb2c53710ae\", \"webdriver_wpt_tests\": \"ce84075d6034cfb8e714de3ef604d6e9efe671b7\", \"weblayer_browsertests\": \"4113cab458d36ac56c134ffe02c8d58fbaa51638\", \"weblayer_unittests\": \"c8733f0e32bc7957feb22676a11d208766c45a15\", \"wm_unittests\": \"1a76e9c87e3729f525bc822e230d90f4a6442722\", \"wtf_unittests\": \"6aa13baf72e06a12f7bd479c99d768fd5dd74a11\", \"x11_unittests\": \"65c27828636403efee9a5dc790f60d6dd064fc61\", \"xr_browser_tests\": \"935f2e81dc8a96fddb3b9273d5a2755c34130b42\", \"zlib_unittests\": \"94407c12347ffc68beab9cd40ac406816d19a8fc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_171aeb6ea7c277f8a23548bef504d6412b8f4fe5eb401735c265dcbe781a3afe_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-68-2v8w\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612985168998983",
"status": "COMPLETED",
"status_changed_ts": "1612988245754318",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180465",
"builder:Linux Builder (dbg)",
"buildset:commit/git/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ea620809a241de8dc2ba5666f3bee46ffda9cf9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021086244282142160",
"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/8855656181767561600/+/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:51a639fa0d601310",
"user_agent:luci-scheduler"
],
"updated_ts": "1612988245792214",
"url": "https://ci.chromium.org/b/8855656181767561600",
"utcnow_ts": "1612988246347213"
}
}
[20:17:26.355] Invocation finished in 51m21.405572637s with status SUCCEEDED