[21:19:37.376] New invocation is queued and will start shortly
[21:19:38.476] Starting the invocation (attempt 1)
[21:19:38.509] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:19:38.509] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:19:38.509] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023797009945767392",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9023797009945767392",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"gitiles_ref:refs/heads/master"
]
}
[21:19:39.513] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610399978866492",
"id": "8858366947718419712",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610399979288745",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179541",
"builder:Linux Builder (dbg)",
"buildset:commit/git/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023797009945767392",
"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/8858366947718419712/+/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": "1610399979288882",
"url": "https://ci.chromium.org/b/8858366947718419712",
"utcnow_ts": "1610399979505693"
}
}
[21:19:39.513] Task URL: https://ci.chromium.org/b/8858366947718419712
[21:19:39.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:2:0) after 1m0s
[21:19:56.112] Received PubSub notification, asking Buildbucket for the build status
[21:19:56.190] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:2:0)
[21:20:40.161] Timer tick, asking Buildbucket for the build status
[21:20:40.617] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:4:0) after 1m0s
[21:21:40.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:4:0)
[21:21:40.661] Timer tick, asking Buildbucket for the build status
[21:21:40.988] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:40.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:5:0) after 1m0s
[21:22:41.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:5:0)
[21:22:41.052] Timer tick, asking Buildbucket for the build status
[21:22:41.147] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:41.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:6:0) after 1m0s
[21:23:41.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:6:0)
[21:23:41.228] Timer tick, asking Buildbucket for the build status
[21:23:41.359] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:41.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:7:0) after 1m0s
[21:24:41.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:7:0)
[21:24:41.400] Timer tick, asking Buildbucket for the build status
[21:24:41.577] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:8:0) after 1m0s
[21:25:41.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:8:0)
[21:25:41.581] Timer tick, asking Buildbucket for the build status
[21:25:41.723] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:9:0) after 1m0s
[21:26:41.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:9:0)
[21:26:41.751] Timer tick, asking Buildbucket for the build status
[21:26:42.635] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:42.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:10:0) after 1m0s
[21:27:42.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:10:0)
[21:27:42.730] Timer tick, asking Buildbucket for the build status
[21:27:42.785] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:11:0) after 1m0s
[21:28:42.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:11:0)
[21:28:42.867] Timer tick, asking Buildbucket for the build status
[21:28:42.937] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:42.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:12:0) after 1m0s
[21:29:43.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:12:0)
[21:29:43.051] Timer tick, asking Buildbucket for the build status
[21:29:43.669] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:43.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:13:0) after 1m0s
[21:30:43.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:13:0)
[21:30:43.750] Timer tick, asking Buildbucket for the build status
[21:30:43.826] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:43.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:14:0) after 1m0s
[21:31:43.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:14:0)
[21:31:43.906] Timer tick, asking Buildbucket for the build status
[21:31:43.989] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:43.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:15:0) after 1m0s
[21:32:43.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:15:0)
[21:32:43.987] Timer tick, asking Buildbucket for the build status
[21:32:44.130] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:44.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:16:0) after 1m0s
[21:33:44.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:16:0)
[21:33:44.181] Timer tick, asking Buildbucket for the build status
[21:33:44.321] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:44.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:17:0) after 1m0s
[21:34:44.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:17:0)
[21:34:44.369] Timer tick, asking Buildbucket for the build status
[21:34:44.535] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:44.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:18:0) after 1m0s
[21:35:44.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:18:0)
[21:35:44.579] Timer tick, asking Buildbucket for the build status
[21:35:44.648] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:44.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:19:0) after 1m0s
[21:36:44.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:19:0)
[21:36:44.798] Timer tick, asking Buildbucket for the build status
[21:36:44.887] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:44.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:20:0) after 1m0s
[21:37:45.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:20:0)
[21:37:45.003] Timer tick, asking Buildbucket for the build status
[21:37:45.072] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:45.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:21:0) after 1m0s
[21:38:45.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:21:0)
[21:38:45.154] Timer tick, asking Buildbucket for the build status
[21:38:45.238] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:45.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:22:0) after 1m0s
[21:39:45.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:22:0)
[21:39:45.295] Timer tick, asking Buildbucket for the build status
[21:39:45.470] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:45.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:23:0) after 1m0s
[21:40:45.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:23:0)
[21:40:45.457] Timer tick, asking Buildbucket for the build status
[21:40:45.539] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:45.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:24:0) after 1m0s
[21:41:45.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:24:0)
[21:41:45.562] Timer tick, asking Buildbucket for the build status
[21:41:45.619] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:45.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:25:0) after 1m0s
[21:42:45.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:25:0)
[21:42:45.600] Timer tick, asking Buildbucket for the build status
[21:42:45.921] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:45.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:26:0) after 1m0s
[21:43:45.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:26:0)
[21:43:45.942] Timer tick, asking Buildbucket for the build status
[21:43:46.022] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:46.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:27:0) after 1m0s
[21:44:46.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:27:0)
[21:44:46.068] Timer tick, asking Buildbucket for the build status
[21:44:46.190] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:46.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:28:0) after 1m0s
[21:45:46.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:28:0)
[21:45:46.234] Timer tick, asking Buildbucket for the build status
[21:45:46.420] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:46.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:29:0) after 1m0s
[21:46:46.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:29:0)
[21:46:46.538] Timer tick, asking Buildbucket for the build status
[21:46:46.609] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:46.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:30:0) after 1m0s
[21:47:46.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:30:0)
[21:47:46.673] Timer tick, asking Buildbucket for the build status
[21:47:46.911] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:46.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:31:0) after 1m0s
[21:48:46.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:31:0)
[21:48:46.959] Timer tick, asking Buildbucket for the build status
[21:48:47.025] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:47.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:32:0) after 1m0s
[21:49:47.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:32:0)
[21:49:47.053] Timer tick, asking Buildbucket for the build status
[21:49:47.299] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:47.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:33:0) after 1m0s
[21:50:47.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:33:0)
[21:50:47.308] Timer tick, asking Buildbucket for the build status
[21:50:47.390] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:47.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:34:0) after 1m0s
[21:51:47.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:34:0)
[21:51:47.472] Timer tick, asking Buildbucket for the build status
[21:51:47.570] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:47.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:35:0) after 1m0s
[21:52:47.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:35:0)
[21:52:47.641] Timer tick, asking Buildbucket for the build status
[21:52:47.704] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:36:0) after 1m0s
[21:53:47.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:36:0)
[21:53:47.741] Timer tick, asking Buildbucket for the build status
[21:53:47.793] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:37:0) after 1m0s
[21:54:47.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:37:0)
[21:54:47.885] Timer tick, asking Buildbucket for the build status
[21:54:48.147] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:48.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:38:0) after 1m0s
[21:55:48.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:38:0)
[21:55:48.173] Timer tick, asking Buildbucket for the build status
[21:55:48.242] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:48.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:39:0) after 1m0s
[21:56:48.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:39:0)
[21:56:48.761] Timer tick, asking Buildbucket for the build status
[21:56:48.840] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:48.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:40:0) after 1m0s
[21:57:48.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:40:0)
[21:57:48.967] Timer tick, asking Buildbucket for the build status
[21:57:49.067] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:41:0) after 1m0s
[21:58:49.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:41:0)
[21:58:49.183] Timer tick, asking Buildbucket for the build status
[21:58:49.272] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:49.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:42:0) after 1m0s
[21:59:49.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:42:0)
[21:59:49.293] Timer tick, asking Buildbucket for the build status
[21:59:49.412] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:49.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:43:0) after 1m0s
[22:00:49.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:43:0)
[22:00:49.608] Timer tick, asking Buildbucket for the build status
[22:00:49.720] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:44:0) after 1m0s
[22:01:49.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:44:0)
[22:01:49.814] Timer tick, asking Buildbucket for the build status
[22:01:49.887] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:49.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:45:0) after 1m0s
[22:02:49.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:45:0)
[22:02:49.980] Timer tick, asking Buildbucket for the build status
[22:02:50.052] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:50.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:46:0) after 1m0s
[22:03:50.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:46:0)
[22:03:50.146] Timer tick, asking Buildbucket for the build status
[22:03:50.226] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:50.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:47:0) after 1m0s
[22:04:50.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:47:0)
[22:04:50.269] Timer tick, asking Buildbucket for the build status
[22:04:50.631] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:50.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:48:0) after 1m0s
[22:05:50.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:48:0)
[22:05:50.975] Timer tick, asking Buildbucket for the build status
[22:05:51.038] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:51.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:49:0) after 1m0s
[22:06:51.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:49:0)
[22:06:51.115] Timer tick, asking Buildbucket for the build status
[22:06:51.403] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:51.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:50:0) after 1m0s
[22:07:51.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:50:0)
[22:07:51.445] Timer tick, asking Buildbucket for the build status
[22:07:51.617] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:51:0) after 1m0s
[22:08:51.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:51:0)
[22:08:51.636] Timer tick, asking Buildbucket for the build status
[22:08:51.735] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:51.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:52:0) after 1m0s
[22:09:51.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:52:0)
[22:09:51.779] Timer tick, asking Buildbucket for the build status
[22:09:51.884] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:51.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:53:0) after 1m0s
[22:10:51.887] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:53:0)
[22:10:51.887] Timer tick, asking Buildbucket for the build status
[22:10:51.994] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:54:0) after 1m0s
[22:11:52.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:54:0)
[22:11:52.025] Timer tick, asking Buildbucket for the build status
[22:11:52.103] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:52.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:55:0) after 1m0s
[22:12:52.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:55:0)
[22:12:52.105] Timer tick, asking Buildbucket for the build status
[22:12:52.857] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:52.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:56:0) after 1m0s
[22:13:52.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:56:0)
[22:13:52.924] Timer tick, asking Buildbucket for the build status
[22:13:53.027] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:57:0) after 1m0s
[22:14:53.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:57:0)
[22:14:53.096] Timer tick, asking Buildbucket for the build status
[22:14:53.233] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:58:0) after 1m0s
[22:15:53.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:58:0)
[22:15:53.264] Timer tick, asking Buildbucket for the build status
[22:15:53.425] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:53.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:59:0) after 1m0s
[22:16:53.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:59:0)
[22:16:53.455] Timer tick, asking Buildbucket for the build status
[22:16:53.703] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:53.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:60:0) after 1m0s
[22:17:53.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:60:0)
[22:17:53.753] Timer tick, asking Buildbucket for the build status
[22:17:54.248] Build 8858366947718419712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:54.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023797009945767392:61:0) after 1m0s
[22:18:45.035] Received PubSub notification, asking Buildbucket for the build status
[22:18:45.195] Build 8858366947718419712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:18:45.195] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610403523527523",
"created_by": "project:chromium",
"created_ts": "1610399978866492",
"id": "8858366947718419712",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\"}}",
"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\": \"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\", \"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-114-4u65\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179541, \"got_angle_revision\": \"49d291065feeea710cf05c522c815091e1728aad\", \"got_dawn_revision\": \"99c3a691c23dbd75075eb852d2f6a1c569148826\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\", \"got_revision_cp\": \"refs/heads/master@{#842174}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"6a59d064a9754156c622fa3a9b93e326dbb304f8\", \"got_v8_revision\": \"271bd5240efa7d2743483df5a2c867c92aa03b42\", \"got_v8_revision_cp\": \"refs/heads/8.9.236@{#1}\", \"got_webrtc_revision\": \"ad0be281a41cc402c247c23206eba81be73ab401\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32937}\", \"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\": \"12c756d2e051b6d9aeb5bf03e00fec28ade6979b\", \"swarm_hashes_refs/heads/master(at){#842174}_without_patch\": {\"absl_hardening_tests\": \"fc3fe6d699ea407e64d2d96cfbb7201e6fbb829f\", \"accessibility_unittests\": \"6cd51907f13176e91cb59fbc94d19842df9e4a58\", \"angle_unittests\": \"a179b24ad63341105a7c410d5c652576eb78eef3\", \"app_shell_unittests\": \"548acc99b7e1c28eae86cefb11276ea0e65bf73a\", \"aura_unittests\": \"c263fc774e70474cca3d9a1acb91ebb03dccc8a4\", \"base_unittests\": \"b42dfc95f5fe351fa2bcf79a4b8963e03348717a\", \"base_util_unittests\": \"68d56b7ee8497a325e8e758bd645691bbbc3fd9e\", \"blink_common_unittests\": \"cf27e845242293c9ace0911629a6d171757fd440\", \"blink_fuzzer_unittests\": \"616b65978b62c43f8af742bc0c2455f88c685731\", \"blink_heap_unittests\": \"cb542d047aa3636332927a287169e9ffe03613e2\", \"blink_platform_unittests\": \"4a9e49aa71793ba185e97a7c6c0419c2e77023d2\", \"blink_python_tests\": \"cef69d0cf37778299f88b73d9148a1c38dd0eae1\", \"blink_unittests\": \"4b152fa52626981e44c3a0f3c8eb4dbdfb5cf116\", \"blink_web_tests\": \"5e6760655bf133b3361358cf65e61c42d3159c41\", \"boringssl_crypto_tests\": \"cd11250e2129691af6b328b6ef50823b7dc2d3fe\", \"boringssl_ssl_tests\": \"e4632091645fab674c00538ec000c71ea73eaab7\", \"browser_tests\": \"f3ac11805770dee21e6925a39908013b8ae276ac\", \"capture_unittests\": \"8b685df3cca98f1a74be6d038f57355870a4a8c1\", \"cast_unittests\": \"c5b0b3314f8ccb6ab2342c32c81b3f1c313c9031\", \"cc_unittests\": \"4fb62626f167afeb77c392ce657cf909a9a65eb6\", \"chrome_app_unittests\": \"677e2d8254dc00d278315e9067d0b3d0904dad4b\", \"chromedriver_unittests\": \"c67c814800cb47cbb49bcc85f81c7ac70ab50401\", \"components_browsertests\": \"d49fee56907d5338df8ec528962aff8632dddb64\", \"components_unittests\": \"6a64eacf39b2e99894061f5e5c5433576e7dca59\", \"compositor_unittests\": \"5de258f3b7310ae999b73b184090d66cd52dfb3e\", \"content_browsertests\": \"539d21cb8f84815c660e38bf1e64e52fb9a6d4b7\", \"content_shell_crash_test\": \"ef43a2a45136854eee862caf86566e0afdb55877\", \"content_unittests\": \"d546767123d7366b16d6ea8a17e5ebe40dfffe7d\", \"crashpad_tests\": \"da107e2da76cddf8a812bf36d9ca8557310d7c7d\", \"cronet_tests\": \"a22138ff1b52c285b972c7f4ea18062b7dd43c02\", \"cronet_unittests\": \"6ffe822d0c8ccaa4794e6bcf9263c9605e392e5c\", \"crypto_unittests\": \"36286e2ba5647dadec96a9273be7a07602e88d64\", \"dbus_unittests\": \"39493e5863bd106bbcdc679880451ea4a90041d4\", \"device_unittests\": \"9473988fd67e6effe8c8c2467be0bcf2c90287a7\", \"display_unittests\": \"02d50c61f6c4e8858bfd09b9a89bfd738aacb114\", \"events_unittests\": \"b4708f3aaf844850f60007b88ef5791c15c021e3\", \"extensions_browsertests\": \"0c275671b0eb1a9da71e1d8370f1cba70b57253e\", \"extensions_unittests\": \"dcff861298aff5990cf049614cc08c018e44ecb7\", \"filesystem_service_unittests\": \"374ffe6689d4e610ba11b304ecd1a3cd6a7886e6\", \"flatbuffers_unittests\": \"4bfbc03ee915ceb403762a954283c8c944ac6944\", \"gcm_unit_tests\": \"397f808913f37426986a85846080a05ceff3e5e1\", \"gfx_unittests\": \"e21f773f3e8824bb8fa4970c789f0a631201fc54\", \"gin_unittests\": \"ad32a8ce6b0eb0834c406482d3d5717844c9f6c5\", \"google_apis_unittests\": \"b2d75fb9eab20a165bf16458e600ca79aee4d55e\", \"gpu_unittests\": \"c2ced68e910b5104bcfa86012630fa790c5eac75\", \"grit_python_unittests\": \"0718a5373aa0ae8758877d63c90aad8024074ace\", \"gwp_asan_unittests\": \"6fffc0e2a392adcaa49e88200ba84e71d865e520\", \"headless_browsertests\": \"275aa5b8a5c4c13183f38b769c438b79add72c18\", \"headless_unittests\": \"54563eeb8d5c90ce6d18ca90c1771fc62f7a9302\", \"interactive_ui_tests\": \"5de4efe677739c9aa62c7aef72cc79ef004a6067\", \"ipc_tests\": \"6b0098439387e91ea7cc16c9afcc77b82f2ba84e\", \"jingle_unittests\": \"8cc3f6b5f2324c9b34d390f9cc29f220c63e4875\", \"latency_unittests\": \"51fc1a2cc87a855dc2809aba48946b2a49f03c17\", \"libjingle_xmpp_unittests\": \"7bf90bcc0c3ae5c00c6ddf82957dce6384f7964b\", \"liburlpattern_unittests\": \"a9ae8f17154a9fc53cc31ba11077b9a67155a403\", \"media_blink_unittests\": \"4f772bea002bed86d3a2c6255696987d40285cb7\", \"media_unittests\": \"0b2244b902e7229dfff5c2e349a2599da67844f8\", \"message_center_unittests\": \"d3804e5f186c678e7e701fad82ceeca1ad5bf6b6\", \"metrics_python_tests\": \"119bd69ed3f83c5316ddca134ae5421b03a0c92d\", \"midi_unittests\": \"8931f9dff88f20e6d4804c2ed34773f0d9899be2\", \"mojo_core_unittests\": \"6574825c2da6958567c3c98eeec4f745161c060b\", \"mojo_unittests\": \"0a1d63dfa72560b5c8a2524141d23f46cbc29708\", \"nacl_helper_nonsfi_unittests\": \"93bbeb787e7d2ddd207583a2a6531dd85ff3aa5c\", \"nacl_loader_unittests\": \"0e80d4d66b1b5ae0d8835a0da8b87097acfbea55\", \"native_theme_unittests\": \"df70d7bce8b8a2c97b857cb1716affda5b7e8f04\", \"net_unittests\": \"f7b7a56caabe10c00e776118dfb18e760cdcacdc\", \"openscreen_unittests\": \"247cbdf2f5001fecbfc4cd9021654690ebd8c0d5\", \"pdf_unittests\": \"209b6f18992814ce4506cc9ef49e70dcd98c3587\", \"perfetto_unittests\": \"af341e0897e0eb028d7a3a1c0b829708f2f7ca61\", \"ppapi_unittests\": \"b49250d5f59f50d59701822f811df2700bfc764a\", \"printing_unittests\": \"7ca5ddc682c17d2876ce179d7cd5dcc498b37c43\", \"remoting_unittests\": \"e4111b6b2d532333ad544ada169d21963b924a04\", \"sandbox_linux_unittests\": \"7c9d8acea25806cdf7b477df1c88be6e82d79b6c\", \"service_manager_unittests\": \"2c27aa7b6ff98c2afd5a4b5e7e39c8e57eb21e1f\", \"services_unittests\": \"32bf8438c3b59a326178d21c552397009d530bad\", \"shell_dialogs_unittests\": \"15624f566bdb1cd531d67d21cefbb78614861d87\", \"skia_unittests\": \"c464966e9e75a3d2e86d70d187e800724df0461d\", \"snapshot_unittests\": \"8e268f86065c25c4a93ba1b8fdcc6b640d031612\", \"sql_unittests\": \"bbd503f09ed144736de24bd3e0baad7556750259\", \"storage_unittests\": \"651d6f6bc87d4cd3e4ebd57fbfb5cb7f7954343a\", \"sync_integration_tests\": \"0d54e6a42aba78d8f0b44968928daaa95509c992\", \"telemetry_gpu_unittests\": \"468f4f2e19f6df0473e3f599585b88868c40695c\", \"telemetry_perf_unittests\": \"0c2e2b4ee8c56d493451aa7be96a280ed55315e8\", \"telemetry_unittests\": \"e42e139a402f37f7253ca08d34189601e2ec1017\", \"traffic_annotation_auditor_unittests\": \"e2eef3b9b827f5ca5cf1df5c5ee9e270c7be945b\", \"ui_base_unittests\": \"d8d4f98b34e1e4e5a2d7c4143cdbfc17c289f8f0\", \"ui_touch_selection_unittests\": \"598f6773feda07a7d41e912e090cb62102a33481\", \"unit_tests\": \"7bf8a53527df88e12f72d3c8b8ce5c228ae051fd\", \"url_unittests\": \"367131969843e8b63dce3912775b5a1a67db8494\", \"views_perftests\": \"22142d0db8d1a8bb3dbb7c0d16c76f7180cb650e\", \"views_unittests\": \"f5c9c08a9c3f129e4254da25147e31166f1fcbe5\", \"viz_unittests\": \"75ef9f28d2d683045157184e8575a0bed46adf25\", \"vr_common_unittests\": \"cc2f481290a7966ae1be321cf71ce986d4dc2d1c\", \"vr_pixeltests\": \"6e5239a73a69fc80b4e2a8c33fb24333ae9c92f0\", \"webdriver_wpt_tests\": \"27d447d1798e188e916c04e184353bfa31880b77\", \"weblayer_browsertests\": \"be6b12b6cb22a698c82e357a5dbc5bebd904b2ef\", \"weblayer_unittests\": \"b1fd287d4f83b148e5c6efe55213575f8b10b8ce\", \"wm_unittests\": \"b4b2cd532c2a3cda5baf852af717667ef56fb3e0\", \"wtf_unittests\": \"f30048dad864c00405a74339db02b19e18abb154\", \"x11_unittests\": \"9c37bab94378a802a4bc80e9e94d42a4cbf838eb\", \"xr_browser_tests\": \"e8353226b54245339ca2c363c1c93f82129200bc\", \"zlib_unittests\": \"ce6b915f7b24b342d25a9c83d5d4157f5aa7a574\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51fbd57b92446336655ba5d71606939b5bf22f086edf809f01e3703848d966de_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_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-114-4u65\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610399994410030",
"status": "COMPLETED",
"status_changed_ts": "1610403523992763",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179541",
"builder:Linux Builder (dbg)",
"buildset:commit/git/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/12c756d2e051b6d9aeb5bf03e00fec28ade6979b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023797009945767392",
"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/8858366947718419712/+/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:510c232116391110",
"user_agent:luci-scheduler"
],
"updated_ts": "1610403524024887",
"url": "https://ci.chromium.org/b/8858366947718419712",
"utcnow_ts": "1610403525162216"
}
}
[22:18:45.195] Invocation finished in 59m7.835642811s with status SUCCEEDED