[14:18:30.301] New invocation is queued and will start shortly
[14:18:31.428] Starting the invocation (attempt 1)
[14:18:31.461] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:18:31.461] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:18:31.461] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019746640904444048",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4d1eacad252409cfc6ede47a2858262f17310ed2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019746640904444048",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/4d1eacad252409cfc6ede47a2858262f17310ed2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d1eacad252409cfc6ede47a2858262f17310ed2",
"gitiles_ref:refs/heads/master"
]
}
[14:18:33.159] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614262711570702",
"id": "8854316578910985664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d1eacad252409cfc6ede47a2858262f17310ed2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614262712826626",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180925",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4d1eacad252409cfc6ede47a2858262f17310ed2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d1eacad252409cfc6ede47a2858262f17310ed2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019746640904444048",
"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/8854316578910985664/+/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": "1614262712826802",
"url": "https://ci.chromium.org/b/8854316578910985664",
"utcnow_ts": "1614262713086042"
}
}
[14:18:33.159] Task URL: https://ci.chromium.org/b/8854316578910985664
[14:18:33.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:2:0) after 1m0s
[14:19:33.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:2:0)
[14:19:33.214] Timer tick, asking Buildbucket for the build status
[14:19:33.304] Build 8854316578910985664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:33.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:3:0) after 1m0s
[14:20:33.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:3:0)
[14:20:33.366] Timer tick, asking Buildbucket for the build status
[14:20:33.442] Build 8854316578910985664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:33.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:4:0) after 1m0s
[14:20:55.103] Received PubSub notification, asking Buildbucket for the build status
[14:20:55.199] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:33.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:4:0)
[14:21:33.460] Timer tick, asking Buildbucket for the build status
[14:21:33.540] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:33.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:6:0) after 1m0s
[14:22:33.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:6:0)
[14:22:33.626] Timer tick, asking Buildbucket for the build status
[14:22:33.711] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:33.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:7:0) after 1m0s
[14:23:33.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:7:0)
[14:23:33.803] Timer tick, asking Buildbucket for the build status
[14:23:33.875] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:33.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:8:0) after 1m0s
[14:24:33.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:8:0)
[14:24:33.870] Timer tick, asking Buildbucket for the build status
[14:24:33.960] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:33.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:9:0) after 1m0s
[14:25:34.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:9:0)
[14:25:34.047] Timer tick, asking Buildbucket for the build status
[14:25:34.208] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:10:0) after 1m0s
[14:26:34.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:10:0)
[14:26:34.228] Timer tick, asking Buildbucket for the build status
[14:26:36.098] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:36.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:11:0) after 1m0s
[14:27:36.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:11:0)
[14:27:36.116] Timer tick, asking Buildbucket for the build status
[14:27:36.197] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:36.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:12:0) after 1m0s
[14:28:36.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:12:0)
[14:28:36.228] Timer tick, asking Buildbucket for the build status
[14:28:36.470] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:36.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:13:0) after 1m0s
[14:29:36.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:13:0)
[14:29:36.528] Timer tick, asking Buildbucket for the build status
[14:29:36.645] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:36.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:14:0) after 1m0s
[14:30:36.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:14:0)
[14:30:36.614] Timer tick, asking Buildbucket for the build status
[14:30:36.818] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:36.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:15:0) after 1m0s
[14:31:36.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:15:0)
[14:31:36.809] Timer tick, asking Buildbucket for the build status
[14:31:36.882] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:36.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:16:0) after 1m0s
[14:32:36.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:16:0)
[14:32:36.951] Timer tick, asking Buildbucket for the build status
[14:32:37.103] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:37.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:17:0) after 1m0s
[14:33:37.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:17:0)
[14:33:37.178] Timer tick, asking Buildbucket for the build status
[14:33:37.247] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:37.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:18:0) after 1m0s
[14:34:37.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:18:0)
[14:34:37.324] Timer tick, asking Buildbucket for the build status
[14:34:37.413] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:37.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:19:0) after 1m0s
[14:35:37.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:19:0)
[14:35:37.523] Timer tick, asking Buildbucket for the build status
[14:35:37.612] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:37.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:20:0) after 1m0s
[14:36:37.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:20:0)
[14:36:37.638] Timer tick, asking Buildbucket for the build status
[14:36:37.711] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:37.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:21:0) after 1m0s
[14:37:37.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:21:0)
[14:37:37.805] Timer tick, asking Buildbucket for the build status
[14:37:37.881] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:37.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:22:0) after 1m0s
[14:38:37.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:22:0)
[14:38:37.874] Timer tick, asking Buildbucket for the build status
[14:38:37.945] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:23:0) after 1m0s
[14:39:38.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:23:0)
[14:39:38.002] Timer tick, asking Buildbucket for the build status
[14:39:38.452] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:38.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:24:0) after 1m0s
[14:40:38.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:24:0)
[14:40:38.472] Timer tick, asking Buildbucket for the build status
[14:40:38.546] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:38.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:25:0) after 1m0s
[14:41:38.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:25:0)
[14:41:38.558] Timer tick, asking Buildbucket for the build status
[14:41:38.647] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:38.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:26:0) after 1m0s
[14:42:38.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:26:0)
[14:42:38.748] Timer tick, asking Buildbucket for the build status
[14:42:38.823] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:38.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:27:0) after 1m0s
[14:43:38.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:27:0)
[14:43:38.883] Timer tick, asking Buildbucket for the build status
[14:43:38.960] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:38.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:28:0) after 1m0s
[14:44:38.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:28:0)
[14:44:38.970] Timer tick, asking Buildbucket for the build status
[14:44:39.099] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:39.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:29:0) after 1m0s
[14:45:39.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:29:0)
[14:45:39.170] Timer tick, asking Buildbucket for the build status
[14:45:39.254] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:39.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:30:0) after 1m0s
[14:46:39.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:30:0)
[14:46:39.309] Timer tick, asking Buildbucket for the build status
[14:46:39.411] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:39.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:31:0) after 1m0s
[14:47:39.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:31:0)
[14:47:39.533] Timer tick, asking Buildbucket for the build status
[14:47:39.647] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:39.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:32:0) after 1m0s
[14:48:39.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:32:0)
[14:48:39.730] Timer tick, asking Buildbucket for the build status
[14:48:39.861] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:39.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:33:0) after 1m0s
[14:49:40.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:33:0)
[14:49:40.315] Timer tick, asking Buildbucket for the build status
[14:49:40.486] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:40.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:34:0) after 1m0s
[14:50:40.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:34:0)
[14:50:40.788] Timer tick, asking Buildbucket for the build status
[14:50:40.889] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:40.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:35:0) after 1m0s
[14:51:41.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:35:0)
[14:51:41.082] Timer tick, asking Buildbucket for the build status
[14:51:41.163] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:41.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:36:0) after 1m0s
[14:52:41.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:36:0)
[14:52:41.333] Timer tick, asking Buildbucket for the build status
[14:52:41.528] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:41.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:37:0) after 1m0s
[14:53:44.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:37:0)
[14:53:44.380] Timer tick, asking Buildbucket for the build status
[14:53:44.667] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:38:0) after 1m0s
[14:54:44.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:38:0)
[14:54:44.726] Timer tick, asking Buildbucket for the build status
[14:54:44.825] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:44.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:39:0) after 1m0s
[14:55:44.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:39:0)
[14:55:44.917] Timer tick, asking Buildbucket for the build status
[14:55:45.246] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:45.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:40:0) after 1m0s
[14:56:45.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:40:0)
[14:56:45.261] Timer tick, asking Buildbucket for the build status
[14:56:45.355] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:45.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:41:0) after 1m0s
[14:57:45.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:41:0)
[14:57:45.356] Timer tick, asking Buildbucket for the build status
[14:57:45.504] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:45.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:42:0) after 1m0s
[14:58:45.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:42:0)
[14:58:45.560] Timer tick, asking Buildbucket for the build status
[14:58:45.637] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:45.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:43:0) after 1m0s
[14:59:45.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:43:0)
[14:59:45.680] Timer tick, asking Buildbucket for the build status
[14:59:45.759] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:45.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:44:0) after 1m0s
[15:00:45.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:44:0)
[15:00:45.805] Timer tick, asking Buildbucket for the build status
[15:00:45.907] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:45.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:45:0) after 1m0s
[15:01:46.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:45:0)
[15:01:46.008] Timer tick, asking Buildbucket for the build status
[15:01:46.411] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:46.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:46:0) after 1m0s
[15:02:46.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:46:0)
[15:02:46.442] Timer tick, asking Buildbucket for the build status
[15:02:46.703] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:46.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:47:0) after 1m0s
[15:03:46.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:47:0)
[15:03:46.788] Timer tick, asking Buildbucket for the build status
[15:03:46.888] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:46.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:48:0) after 1m0s
[15:04:46.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:48:0)
[15:04:46.899] Timer tick, asking Buildbucket for the build status
[15:04:47.121] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:47.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:49:0) after 1m0s
[15:05:47.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:49:0)
[15:05:47.241] Timer tick, asking Buildbucket for the build status
[15:05:47.681] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:50:0) after 1m0s
[15:06:47.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:50:0)
[15:06:47.731] Timer tick, asking Buildbucket for the build status
[15:06:47.841] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:47.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:51:0) after 1m0s
[15:07:47.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:51:0)
[15:07:47.861] Timer tick, asking Buildbucket for the build status
[15:07:47.948] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:47.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:52:0) after 1m0s
[15:08:48.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:52:0)
[15:08:48.006] Timer tick, asking Buildbucket for the build status
[15:08:48.100] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:48.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:53:0) after 1m0s
[15:09:48.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:53:0)
[15:09:48.164] Timer tick, asking Buildbucket for the build status
[15:09:48.255] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:48.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:54:0) after 1m0s
[15:10:48.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:54:0)
[15:10:48.257] Timer tick, asking Buildbucket for the build status
[15:10:48.493] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:48.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:55:0) after 1m0s
[15:11:48.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:55:0)
[15:11:48.516] Timer tick, asking Buildbucket for the build status
[15:11:48.624] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:48.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:56:0) after 1m0s
[15:12:48.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:56:0)
[15:12:48.635] Timer tick, asking Buildbucket for the build status
[15:12:48.726] Build 8854316578910985664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:48.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019746640904444048:57:0) after 1m0s
[15:13:37.611] Received PubSub notification, asking Buildbucket for the build status
[15:13:37.736] Build 8854316578910985664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:13:37.736] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614266016864105",
"created_by": "project:chromium",
"created_ts": "1614262711570702",
"id": "8854316578910985664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d1eacad252409cfc6ede47a2858262f17310ed2\"}}",
"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\": \"4d1eacad252409cfc6ede47a2858262f17310ed2\", \"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-80-a3xm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180925, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"5eb496b863da5b40dc5c9a713c8ca1e413811f35\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"4d1eacad252409cfc6ede47a2858262f17310ed2\", \"got_revision_cp\": \"refs/heads/master@{#857655}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"cd5127b11e04b7f49031b2412625c36e4a86c3da\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33340}\", \"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\": \"4d1eacad252409cfc6ede47a2858262f17310ed2\", \"swarm_hashes_refs/heads/master(at){#857655}_without_patch\": {\"absl_hardening_tests\": \"a9cd666400c1a6c837840b34ca845d272e07e145\", \"accessibility_unittests\": \"83abe7154cf6514b986796adeeb75c1f9103b5b4\", \"angle_unittests\": \"000a14dad58b4345ec1a201f705f6c58716c76c9\", \"app_shell_unittests\": \"8d0a576baab1866233251b8e20428f4a6877f1af\", \"aura_unittests\": \"4fc4354aa23dfbe38467771a1952da1b947b79e2\", \"base_unittests\": \"eb074464ad9c58c9ed933d4ab2b70ecc549c6583\", \"base_util_unittests\": \"d3a21997171451bb3e2d71d7e99ecf0d69ab2672\", \"blink_common_unittests\": \"52e61633a039d6e0be12de093c908bf158d6a408\", \"blink_fuzzer_unittests\": \"fecbb6b091d4cac32e80d0de6cfe54b0d988ecff\", \"blink_heap_unittests\": \"afebdb201bebada3d1879f80bc330176e1ab18ff\", \"blink_platform_unittests\": \"cd9d32b4db4c12d9f2d8e0df47dc12a88bcfb894\", \"blink_python_tests\": \"4466b68fabbc13dd5dbf3207a2103c43ae32b9e5\", \"blink_unittests\": \"96d2a40f09590929da638d2e03215d8ed16b72d2\", \"blink_web_tests\": \"d0a044983b47224a62ddf21387ec0096f4d71543\", \"boringssl_crypto_tests\": \"66b9f208f6ab596cf41a80eac54065c8818f4425\", \"boringssl_ssl_tests\": \"7bf4dcefbb85ef961a427424259bd53f3bd758a4\", \"browser_tests\": \"bc87b00eba4191cf91d47924b2c4e3d402ad4bc2\", \"capture_unittests\": \"a71b87192a6dcdc7837e130be7f865b73aa13713\", \"cast_unittests\": \"580b2603ca7282073b8e3095dd06c556967f78b2\", \"cc_unittests\": \"47ec70855413be95b3832db9c345b059d39d3a2e\", \"chrome_app_unittests\": \"b7b4aa55d3f0b236f6bb23940d2d1bd850640930\", \"chromedriver_unittests\": \"5d2bd2b850e235732eff025c479d9eb125512839\", \"color_unittests\": \"6ce29591143f4dcfcf029146b302babec7ec45fd\", \"components_browsertests\": \"451637e1bc054fc09c50a5b2b49f5c2b47c8384a\", \"components_unittests\": \"491f0faac319743380f443048a7d06c90ccff13c\", \"compositor_unittests\": \"74b8adabce72c976e19546615bce344cd3d10b3c\", \"content_browsertests\": \"63fcdb811f7ba81839908bac5c822ea50121bc60\", \"content_shell_crash_test\": \"d352eb9c49d19bf99c7c96dce3aae41be4faec2c\", \"content_unittests\": \"45d9bb6d484ca5b9ccfbfb7c3b1f870ea21fe5fb\", \"crashpad_tests\": \"9840ce0e27f6123533e66ab4e003185896e4d0fd\", \"cronet_tests\": \"a416c320f9f37908ea65d1e929fbe25b41511528\", \"cronet_unittests\": \"4146a8aad2603f33f575226b254ff55649c88519\", \"crypto_unittests\": \"da6394044af97a9115cce353c617c62c2ca49530\", \"dbus_unittests\": \"5d7f4719e0211d4b2177db5ae398cbc3f1d83f6f\", \"device_unittests\": \"d0c022636155996cf83e592fa9cede3dc3e5b186\", \"display_unittests\": \"35db92d5af1d297ef97c74fce8a97e052d2fb50d\", \"events_unittests\": \"e9bf6ebddb3ea733e1339e5ea6905df469f8425c\", \"extensions_browsertests\": \"e7f186ce93d173542127953a73fe1f861ec3daf2\", \"extensions_unittests\": \"243e8028a3503fe331d8295fa8f0d6b347913e09\", \"filesystem_service_unittests\": \"af95999066eaa918399afa11221e60e501cf6287\", \"flatbuffers_unittests\": \"3e3b6c7bf0c1182740cf5cce7088efe0220a77b5\", \"gcm_unit_tests\": \"647ac6ff51265a8e745ec9c825cc63f7c80e5b5e\", \"gfx_unittests\": \"822d8c820f14c076310b8fb1c64b2c67117bd7b7\", \"gin_unittests\": \"a2b885babd6009216f881795c5dbe6faea4a7d2a\", \"google_apis_unittests\": \"65a60f620814237cc48575a1583c34eca13191da\", \"gpu_unittests\": \"f7d437f7192c13546d0182f71fef88fdb435cfe5\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"2d1999a2a1107f3f888eaf7e7626ee949a3ab2f1\", \"headless_browsertests\": \"101f9d52b8cf590c142c474e9d2cba4415402912\", \"headless_unittests\": \"39e830e339ad4df780a5a7f5abd06252bbcbd86f\", \"interactive_ui_tests\": \"a764dba695b377b4bc8c62f6ff43f2356ab1f7c7\", \"ipc_tests\": \"45bb55723d6431d21ba6fc338c2bc5c34aa0c3be\", \"jingle_unittests\": \"9b76951fa234e460ea89957cf7fdb4110fb2f080\", \"latency_unittests\": \"0167022f1219571dbce934ef465f2bfcef093a56\", \"libjingle_xmpp_unittests\": \"8c6870122a97b5e130d13b26804b7cefb41083a4\", \"liburlpattern_unittests\": \"70274b3414dee501820d388d77e31e5f92b51398\", \"media_blink_unittests\": \"d46ccfd500f746761ad30f499b81753e19e5ee92\", \"media_unittests\": \"db109534fb343a9e66020d34ffb1c691ec8643d1\", \"message_center_unittests\": \"ea5b11c637000f4a0e8de9951763cf56bd1d547d\", \"metrics_python_tests\": \"2ad433c057ddd0fefdd03499b916545fdb8a25db\", \"midi_unittests\": \"392ac59848ad23d9305610dd2927859aeb04d9fa\", \"mojo_core_unittests\": \"8dfd9c5eeba9be48cb1dc13e55e30b9d9ff4f71a\", \"mojo_unittests\": \"cf57492d5da730da0aa2bda33985c213b14385b4\", \"nacl_helper_nonsfi_unittests\": \"9d58b46562acbbf7fdec7b761805a65c82b08c21\", \"nacl_loader_unittests\": \"b5ebb62b0d65be4b931346efff33878028238850\", \"native_theme_unittests\": \"b0375e8d9ca88a48dcdf37db71a63c722c6c56d5\", \"net_unittests\": \"7b3c0317f839170dcbe44ff89616569f28d88396\", \"openscreen_unittests\": \"c5ce5864e7bb41c1c380170a7317fb153efb1363\", \"pdf_unittests\": \"d349f4e4e0faa3290fd244a014e84b2c1585e580\", \"perfetto_unittests\": \"75237f389bd99897f5fa41ee929d620cf5793e1e\", \"ppapi_unittests\": \"f18a2e01d8a91f6073e101446a3b920d86197616\", \"printing_unittests\": \"7eb1407eef3837c7d7e4fbcb7c1269d3879ac523\", \"remoting_unittests\": \"4d02c0deb8f4010b759b8f720e528d9eab73b5d3\", \"sandbox_linux_unittests\": \"97de6738f9bf4b4e41c9839a0101210ec1cd8b56\", \"service_manager_unittests\": \"5933f92a83d74732c4e70957aaee42415fc15e5b\", \"services_unittests\": \"8f1c1d1f94a7115aea4dd7459228d25f49489d3c\", \"shell_dialogs_unittests\": \"79bf09c9cf6037833127c0aa73808a12a87e85b3\", \"skia_unittests\": \"3b8ac1107c96da3928ca01b814558acf421a4eb4\", \"snapshot_unittests\": \"763980595c4c5cf8247389bf3b295645950359c9\", \"sql_unittests\": \"1b4de3258fa47f4324b680fa18e65f1dc17b65f4\", \"storage_unittests\": \"f6933af763525002f9cf4c2a0d7903a076be4c0d\", \"sync_integration_tests\": \"0bb8f7f9ae4b2318e2face73cf8290bc6a5205bc\", \"telemetry_gpu_unittests\": \"dc22d428ae17296a18c5c9b5c3e6c90dc1ae8760\", \"telemetry_perf_unittests\": \"e6558a7eca4f3bf262afe9a82060a586a1743467\", \"telemetry_unittests\": \"7fe1e192f679a08a5432ece819c7e9f51e170873\", \"traffic_annotation_auditor_unittests\": \"0316007fd59b558ae6de7d549aa8297dc6757a58\", \"ui_base_unittests\": \"1518bfff1adb2b51fc2d16a609a200b0dac7c1b5\", \"ui_touch_selection_unittests\": \"908aa9719b535437babe2c41e7e7ac1f8a993570\", \"unit_tests\": \"496649707548a4cb9c92d2af22373324fbe6e75e\", \"url_unittests\": \"3095dc251a51dec67306d32350e8a1ca68ebd69c\", \"views_perftests\": \"7bc4902d8927b4497801a71c549ed59b7409ca5c\", \"views_unittests\": \"b0d5a75a56185a08c4fc8c0a9ac552ca66a23c0c\", \"viz_unittests\": \"0993b725345599ab81c3db57377dddbc93b8b532\", \"vr_common_unittests\": \"9d8f19200a81c2093cba0111d1619c19ec523472\", \"vr_pixeltests\": \"1e8c2e31f3b4f04f3068290588c36861d1c866f7\", \"webdriver_wpt_tests\": \"e0cb18882ae394e94232331cc126bc659d246a40\", \"weblayer_browsertests\": \"21e71abd85df113c83930a1262b1f32d32069984\", \"weblayer_unittests\": \"df1543b23fdc31a3e21e454149b4bf506a6bf5f3\", \"wm_unittests\": \"c2dba2a5ed27780497ca6a37a36b7863042030e0\", \"wtf_unittests\": \"1b5e55396cd90b1a10424e379ac863947f760c74\", \"x11_unittests\": \"4eadf1e7fa757747cb78cce0f5366d970448749d\", \"xr_browser_tests\": \"8885fa743a26d91b31d887c449919cc205b0b089\", \"zlib_unittests\": \"17ba515bc75c0bfb7c9994bfe5200d7304b8d21a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_7ddc1ece4c938056809d45345930c5d8ea6799936d2255389af4f16219f397ac_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fb646d86e88bda56572dff3378a9fa669f47f3a45e650c7783bf21742e524b22_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-80-a3xm\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614262854137444",
"status": "COMPLETED",
"status_changed_ts": "1614266017351624",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180925",
"builder:Linux Builder (dbg)",
"buildset:commit/git/4d1eacad252409cfc6ede47a2858262f17310ed2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d1eacad252409cfc6ede47a2858262f17310ed2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019746640904444048",
"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/8854316578910985664/+/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:51f25fc375dafe10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614266017356214",
"url": "https://ci.chromium.org/b/8854316578910985664",
"utcnow_ts": "1614266017723585"
}
}
[15:13:37.736] Invocation finished in 55m7.451019792s with status SUCCEEDED