[02:54:13.178] New invocation is queued and will start shortly
[02:54:14.341] Starting the invocation (attempt 1)
[02:54:14.378] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:54:14.379] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:54:14.379] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019970886350532592",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019970886350532592",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"gitiles_ref:refs/heads/master"
]
}
[02:54:15.060] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614048854497197",
"id": "8854540824304745712",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614048854829500",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180835",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019970886350532592",
"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/8854540824304745712/+/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": "1614048854829608",
"url": "https://ci.chromium.org/b/8854540824304745712",
"utcnow_ts": "1614048855053370"
}
}
[02:54:15.060] Task URL: https://ci.chromium.org/b/8854540824304745712
[02:54:15.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:2:0) after 1m0s
[02:54:53.274] Received PubSub notification, asking Buildbucket for the build status
[02:54:53.452] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:15.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:2:0)
[02:55:15.101] Timer tick, asking Buildbucket for the build status
[02:55:15.350] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:15.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:4:0) after 1m0s
[02:56:15.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:4:0)
[02:56:15.367] Timer tick, asking Buildbucket for the build status
[02:56:15.532] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:15.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:5:0) after 1m0s
[02:57:15.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:5:0)
[02:57:15.575] Timer tick, asking Buildbucket for the build status
[02:57:15.715] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:15.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:6:0) after 1m0s
[02:58:15.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:6:0)
[02:58:15.728] Timer tick, asking Buildbucket for the build status
[02:58:16.004] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:16.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:7:0) after 1m0s
[02:59:16.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:7:0)
[02:59:16.018] Timer tick, asking Buildbucket for the build status
[02:59:16.089] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:16.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:8:0) after 1m0s
[03:00:16.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:8:0)
[03:00:16.117] Timer tick, asking Buildbucket for the build status
[03:00:16.195] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:16.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:9:0) after 1m0s
[03:01:16.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:9:0)
[03:01:16.240] Timer tick, asking Buildbucket for the build status
[03:01:16.530] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:10:0) after 1m0s
[03:02:16.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:10:0)
[03:02:16.500] Timer tick, asking Buildbucket for the build status
[03:02:16.577] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:16.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:11:0) after 1m0s
[03:03:16.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:11:0)
[03:03:16.617] Timer tick, asking Buildbucket for the build status
[03:03:16.796] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:16.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:12:0) after 1m0s
[03:04:16.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:12:0)
[03:04:16.797] Timer tick, asking Buildbucket for the build status
[03:04:16.904] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:16.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:13:0) after 1m0s
[03:05:16.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:13:0)
[03:05:16.956] Timer tick, asking Buildbucket for the build status
[03:05:17.334] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:17.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:14:0) after 1m0s
[03:06:17.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:14:0)
[03:06:17.370] Timer tick, asking Buildbucket for the build status
[03:06:17.486] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:17.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:15:0) after 1m0s
[03:07:17.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:15:0)
[03:07:17.541] Timer tick, asking Buildbucket for the build status
[03:07:17.755] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:17.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:16:0) after 1m0s
[03:08:17.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:16:0)
[03:08:17.727] Timer tick, asking Buildbucket for the build status
[03:08:17.813] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:17.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:17:0) after 1m0s
[03:09:17.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:17:0)
[03:09:17.879] Timer tick, asking Buildbucket for the build status
[03:09:18.099] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:18.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:18:0) after 1m0s
[03:10:18.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:18:0)
[03:10:18.197] Timer tick, asking Buildbucket for the build status
[03:10:18.288] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:18.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:19:0) after 1m0s
[03:11:18.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:19:0)
[03:11:18.328] Timer tick, asking Buildbucket for the build status
[03:11:18.425] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:18.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:20:0) after 1m0s
[03:12:18.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:20:0)
[03:12:18.431] Timer tick, asking Buildbucket for the build status
[03:12:18.521] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:21:0) after 1m0s
[03:13:18.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:21:0)
[03:13:18.529] Timer tick, asking Buildbucket for the build status
[03:13:18.669] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:18.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:22:0) after 1m0s
[03:14:18.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:22:0)
[03:14:18.682] Timer tick, asking Buildbucket for the build status
[03:14:18.806] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:18.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:23:0) after 1m0s
[03:15:18.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:23:0)
[03:15:18.829] Timer tick, asking Buildbucket for the build status
[03:15:18.918] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:18.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:24:0) after 1m0s
[03:16:18.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:24:0)
[03:16:18.973] Timer tick, asking Buildbucket for the build status
[03:16:19.223] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:19.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:25:0) after 1m0s
[03:17:19.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:25:0)
[03:17:19.219] Timer tick, asking Buildbucket for the build status
[03:17:19.305] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:19.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:26:0) after 1m0s
[03:18:19.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:26:0)
[03:18:19.304] Timer tick, asking Buildbucket for the build status
[03:18:19.439] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:19.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:27:0) after 1m0s
[03:19:19.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:27:0)
[03:19:19.415] Timer tick, asking Buildbucket for the build status
[03:19:19.516] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:28:0) after 1m0s
[03:20:19.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:28:0)
[03:20:19.532] Timer tick, asking Buildbucket for the build status
[03:20:19.789] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:19.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:29:0) after 1m0s
[03:21:19.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:29:0)
[03:21:19.765] Timer tick, asking Buildbucket for the build status
[03:21:20.266] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:30:0) after 1m0s
[03:22:20.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:30:0)
[03:22:20.298] Timer tick, asking Buildbucket for the build status
[03:22:20.374] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:20.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:31:0) after 1m0s
[03:23:20.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:31:0)
[03:23:20.400] Timer tick, asking Buildbucket for the build status
[03:23:20.475] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:20.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:32:0) after 1m0s
[03:24:20.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:32:0)
[03:24:20.519] Timer tick, asking Buildbucket for the build status
[03:24:20.894] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:20.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:33:0) after 1m0s
[03:25:20.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:33:0)
[03:25:20.870] Timer tick, asking Buildbucket for the build status
[03:25:20.946] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:34:0) after 1m0s
[03:26:20.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:34:0)
[03:26:20.990] Timer tick, asking Buildbucket for the build status
[03:26:21.060] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:21.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:35:0) after 1m0s
[03:27:21.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:35:0)
[03:27:21.077] Timer tick, asking Buildbucket for the build status
[03:27:21.269] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:21.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:36:0) after 1m0s
[03:28:21.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:36:0)
[03:28:21.269] Timer tick, asking Buildbucket for the build status
[03:28:21.529] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:21.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:37:0) after 1m0s
[03:29:21.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:37:0)
[03:29:21.553] Timer tick, asking Buildbucket for the build status
[03:29:21.658] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:21.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:38:0) after 1m0s
[03:30:21.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:38:0)
[03:30:21.639] Timer tick, asking Buildbucket for the build status
[03:30:21.714] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:21.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:39:0) after 1m0s
[03:31:21.757] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:39:0)
[03:31:21.757] Timer tick, asking Buildbucket for the build status
[03:31:22.015] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:22.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:40:0) after 1m0s
[03:32:22.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:40:0)
[03:32:22.067] Timer tick, asking Buildbucket for the build status
[03:32:22.322] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:22.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:41:0) after 1m0s
[03:33:22.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:41:0)
[03:33:22.322] Timer tick, asking Buildbucket for the build status
[03:33:22.593] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:22.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:42:0) after 1m0s
[03:34:22.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:42:0)
[03:34:22.658] Timer tick, asking Buildbucket for the build status
[03:34:22.812] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:22.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:43:0) after 1m0s
[03:35:22.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:43:0)
[03:35:22.927] Timer tick, asking Buildbucket for the build status
[03:35:23.004] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:23.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:44:0) after 1m0s
[03:36:23.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:44:0)
[03:36:23.143] Timer tick, asking Buildbucket for the build status
[03:36:23.217] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:23.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:45:0) after 1m0s
[03:37:23.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:45:0)
[03:37:23.264] Timer tick, asking Buildbucket for the build status
[03:37:23.330] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:23.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:46:0) after 1m0s
[03:38:23.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:46:0)
[03:38:23.368] Timer tick, asking Buildbucket for the build status
[03:38:23.715] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:47:0) after 1m0s
[03:39:23.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:47:0)
[03:39:23.717] Timer tick, asking Buildbucket for the build status
[03:39:24.355] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:24.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:48:0) after 1m0s
[03:40:24.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:48:0)
[03:40:24.418] Timer tick, asking Buildbucket for the build status
[03:40:24.498] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:24.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:49:0) after 1m0s
[03:41:24.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:49:0)
[03:41:24.517] Timer tick, asking Buildbucket for the build status
[03:41:24.592] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:24.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:50:0) after 1m0s
[03:42:24.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:50:0)
[03:42:24.595] Timer tick, asking Buildbucket for the build status
[03:42:24.670] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:24.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:51:0) after 1m0s
[03:43:24.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:51:0)
[03:43:24.673] Timer tick, asking Buildbucket for the build status
[03:43:24.871] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:24.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:52:0) after 1m0s
[03:44:24.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:52:0)
[03:44:24.924] Timer tick, asking Buildbucket for the build status
[03:44:25.024] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:25.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:53:0) after 1m0s
[03:45:25.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:53:0)
[03:45:25.045] Timer tick, asking Buildbucket for the build status
[03:45:25.328] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:25.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:54:0) after 1m0s
[03:46:25.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:54:0)
[03:46:25.471] Timer tick, asking Buildbucket for the build status
[03:46:25.647] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:25.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:55:0) after 1m0s
[03:47:25.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:55:0)
[03:47:25.738] Timer tick, asking Buildbucket for the build status
[03:47:25.842] Build 8854540824304745712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:25.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019970886350532592:56:0) after 1m0s
[03:48:04.563] Received PubSub notification, asking Buildbucket for the build status
[03:48:04.660] Build 8854540824304745712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:48:04.660] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614052083722187",
"created_by": "project:chromium",
"created_ts": "1614048854497197",
"id": "8854540824304745712",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\"}}",
"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\": \"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\", \"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-151-uukz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180835, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\", \"got_revision_cp\": \"refs/heads/master@{#856559}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"4120b5f2509821e8dd460b1d033708397520750a\", \"got_v8_revision_cp\": \"refs/heads/9.0.238@{#1}\", \"got_webrtc_revision\": \"6fe3fa14c6686ba9c51095b97ad2e6833a9b03e5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33319}\", \"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\": \"e7fceb4cef1c67002cbbefb9ff2b2d65958d2415\", \"swarm_hashes_refs/heads/master(at){#856559}_without_patch\": {\"absl_hardening_tests\": \"09ae2a61f97706c81a0112e9f297f8d1beddf6fe\", \"accessibility_unittests\": \"4db9986561997fd1107c1dd918fb803760fda0fd\", \"angle_unittests\": \"cb4b115c6cd4c5313d4086a4a71ee9c475e9a87f\", \"app_shell_unittests\": \"2809f4f2f879a50f01a0533db1d63c860a6c97b7\", \"aura_unittests\": \"dbf2395d4602e9ab26af8b4b05ec015b3c3db66b\", \"base_unittests\": \"612f27d35cbe30976fc88ebf3d1cd569db7ac18c\", \"base_util_unittests\": \"07f0c7fc72c1723e6b7403d976977398b29aff04\", \"blink_common_unittests\": \"00a5ef5ca98b76e7903be627519931a26c66b711\", \"blink_fuzzer_unittests\": \"b73c80e12acddf6679dd47074fd4414d62243010\", \"blink_heap_unittests\": \"83c5bff703dce54b9966764093b5586c7b741711\", \"blink_platform_unittests\": \"d4cd6c432a3cf61765ee50c97d181bfc2b4e3cfb\", \"blink_python_tests\": \"5c70098189ed7f3a0528188e3aef2f962e00e1dd\", \"blink_unittests\": \"dd3ab9f1a376f048fcc5b7173e97d8dab14a9de0\", \"blink_web_tests\": \"ea8208b46fb7d2a359365c04e489db656ed195c0\", \"boringssl_crypto_tests\": \"4f0d01cc4131157f91c5ee7b557a62228495402e\", \"boringssl_ssl_tests\": \"554a160bf84a6e15c77590296a4dc3903bc5f6c8\", \"browser_tests\": \"ec54ee9d819d5d466a1df42db3867264055c4440\", \"capture_unittests\": \"8c168e3e5615223c3142f767cc6e4d554c289428\", \"cast_unittests\": \"55b89654a7e65584116c020468b0737a5284b27f\", \"cc_unittests\": \"5850ac40195e48f0579964426abf5eb6f5b7d527\", \"chrome_app_unittests\": \"0735d05a02894badf571d212825e82edebd63a4e\", \"chromedriver_unittests\": \"a3330c5a138ef6bfa4528511dfa974d0e97dc5ab\", \"components_browsertests\": \"bd57a0205466c849020bf4b6ba2956040297291a\", \"components_unittests\": \"2bbb2e44793e02ea878b778e2a84acd8066fb720\", \"compositor_unittests\": \"90b0d1b4b91229223e5d6c1ea8c27f98c378823b\", \"content_browsertests\": \"7634e5c0fb04d394b53670eb446b01c0df32dffb\", \"content_shell_crash_test\": \"d03ca8a71e84a856f75b3be088cae82693ea6295\", \"content_unittests\": \"7ce0671fdcc1ae568a672d46ea4374ddc98961da\", \"crashpad_tests\": \"db1398e44886c55ac4a99749e43186b13ea3d762\", \"cronet_tests\": \"54a0f81b3e0f0964bddf40f398d739ce2483f2e1\", \"cronet_unittests\": \"5271fc5485a07110bef0d355449e283a5ed667bf\", \"crypto_unittests\": \"4b60ffa348c35e4efd75576511818acf7ae63e84\", \"dbus_unittests\": \"0f2724c8d78e89e3ca0c6e4c5f490c8d8811df0f\", \"device_unittests\": \"c2603bcb0d970fee4666ca2a5d9a79af54c08af2\", \"display_unittests\": \"86550f27692fa71b71c2e9524b6c510947a8ab5a\", \"events_unittests\": \"2eefb220698283a1bcdb1eddce50fca13393079b\", \"extensions_browsertests\": \"66042c02c81b83792f512e21c921d40548448785\", \"extensions_unittests\": \"9d1113bdd59646e65404cd870195244a13f562c9\", \"filesystem_service_unittests\": \"4295b14b8f898cc0e9d66e3e0aea33f66b67b5aa\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"48f4fce42412625096cbe46c7852538eaf616b16\", \"gfx_unittests\": \"c3543c637254b3c2ca24b8665423afcbc4a20dfb\", \"gin_unittests\": \"9ee30a8ea993abda0a2b4054429a3b0ce572c305\", \"google_apis_unittests\": \"790c9c624ff5ae7024c55622c497d980a2249cdb\", \"gpu_unittests\": \"d1e967981c28bffd8406db920d5a22baf140f125\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"f55256ae2b33a809cfccadb33f3ca00820f5bf49\", \"headless_browsertests\": \"2374f60706fefa1d11cef507290f0265ab3ca1fb\", \"headless_unittests\": \"ea1b8e7c8d3815a1bbcdf30f862d20540dbedcda\", \"interactive_ui_tests\": \"3020b36508a957af1a8645f002bb30b45386607c\", \"ipc_tests\": \"966d0081dde14bf1e2358160083a68cf4674fb85\", \"jingle_unittests\": \"a2a48e9f7a8095a7b0688d424d4a3c3d62416c22\", \"latency_unittests\": \"8b32df43bcf2acd1ae342ac433cc2eef31fd7131\", \"libjingle_xmpp_unittests\": \"17f69ea26b3c1c911d9862452c3be023365112d1\", \"liburlpattern_unittests\": \"c1a174f902482998497985bf05ac3e7c766fe98e\", \"media_blink_unittests\": \"c06799ea34f3e49803aca34a0709b68cdd9dd9f8\", \"media_unittests\": \"6d14bc86cecb6f510d9fb2b9caa97ee413a4a762\", \"message_center_unittests\": \"9a2dd56abe8bd176a28337faa829402d4e8f71eb\", \"metrics_python_tests\": \"2a0c970918abdedb6c86505b3603f26f26e73f39\", \"midi_unittests\": \"c3c05b0a967ced8b36d935265bbc63a872e0a0d0\", \"mojo_core_unittests\": \"eb88373c5a38f2494c19b1752f4088f807aeed04\", \"mojo_unittests\": \"29e7906e82a3f108c4b905712b5afbcf4fe259cc\", \"nacl_helper_nonsfi_unittests\": \"66018e0c144db5bb32d838565c8a32bed949be34\", \"nacl_loader_unittests\": \"3038c2f0029108cf0b2e26a2d3c7b0be3426803b\", \"native_theme_unittests\": \"c9cbec5343e9c739abc3bd282e4d6ac37eb296a5\", \"net_unittests\": \"6f404974de03a8592682d2fc6e012c571619e5de\", \"openscreen_unittests\": \"5b8de1f39d6e792d589dff3b6a560b9b5ae1f9e2\", \"pdf_unittests\": \"3e934fa533a9a4f967d3ef58265f24087f973746\", \"perfetto_unittests\": \"1d84a4077d9e912870d5a2f065eacc9d4f48d699\", \"ppapi_unittests\": \"0d8ff91b72674a00c36917eb3891fb1068aa9da4\", \"printing_unittests\": \"69aab2d4da107e848c3ef88a177ab4a9759026ba\", \"remoting_unittests\": \"c9c79dffab2784e78ea6777fd08250aeba15baf2\", \"sandbox_linux_unittests\": \"d61dbede31212ec08d5301017a125089138f19a3\", \"service_manager_unittests\": \"0efde620bc81352ecf5c59f1c9ab10dcb581909e\", \"services_unittests\": \"b168032bad0a7b58d72bf0b857f4aef7b876da91\", \"shell_dialogs_unittests\": \"58fe6aaf0c02ff2f9fe44db2c0c8e5f8a1d0431b\", \"skia_unittests\": \"becc9fcbc525865107c2daea97f2ab4ac6cb7956\", \"snapshot_unittests\": \"d7d371584347b9d04575642781708e0891a4d329\", \"sql_unittests\": \"de44d91f34a66a39e165f2c1e1297a30956ec18e\", \"storage_unittests\": \"9b56016e3841de65cab3d25b0516e479a68cc5ea\", \"sync_integration_tests\": \"f776ee0eef5dedc47061d624b40badc1c2054c00\", \"telemetry_gpu_unittests\": \"31d174ae58504e52adac49dd7d0d14a49cd6e1ac\", \"telemetry_perf_unittests\": \"57262956119d9f07cef7397ecad681b08e4e1220\", \"telemetry_unittests\": \"3a65dc34c957a93663a00880e2d99c8e8d22eaa6\", \"traffic_annotation_auditor_unittests\": \"974e481c4f26499ea8f02afb9de5a17309908091\", \"ui_base_unittests\": \"66071c8bdfe295d84099fa3b96d64ea4f704f146\", \"ui_touch_selection_unittests\": \"3f10088d0df8165f2cf2235ee7d6ce3f9d830f2f\", \"unit_tests\": \"02a6e834cfcbc8292f2b07e0b8f027687908112d\", \"url_unittests\": \"c590f817a8e8b0ee79f12c589cc8322aca854518\", \"views_perftests\": \"fed4f035db87597dba458959745c956a983ae69b\", \"views_unittests\": \"d496cff7887596b4fdbef461ddc5d9843dfe5b88\", \"viz_unittests\": \"172e885635b1f884df19325b163f95d4895ad137\", \"vr_common_unittests\": \"3689c25bf3a209859fff42dbbec8fee68beb2561\", \"vr_pixeltests\": \"4c79251195ca3d012c05869c1f0e33bfe9d73287\", \"webdriver_wpt_tests\": \"28244a709447630a93b0f51df2b04f32fcad7a65\", \"weblayer_browsertests\": \"bacd9e31270f1defbd9440f7af415834856fbee6\", \"weblayer_unittests\": \"2634d7cc20ceb7862ab7f13e571ed0c3e727c1f5\", \"wm_unittests\": \"35a3c98b534d15537767b0ff1bdf2e549eed48da\", \"wtf_unittests\": \"c42879251c4ae196afc50e926a9f46fbe068f4fd\", \"x11_unittests\": \"9847195c26cccf035cf6a9fcf998fee3338c72c0\", \"xr_browser_tests\": \"ca3b99f0a046158744a3565449ea0d84b3c22cd6\", \"zlib_unittests\": \"adf4e2445095ab6f17986f14c8a4b99a871a9bd2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_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-151-uukz\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614048890508577",
"status": "COMPLETED",
"status_changed_ts": "1614052083997896",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180835",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7fceb4cef1c67002cbbefb9ff2b2d65958d2415",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019970886350532592",
"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/8854540824304745712/+/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:51e5a08c40501e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614052084027008",
"url": "https://ci.chromium.org/b/8854540824304745712",
"utcnow_ts": "1614052084652268"
}
}
[03:48:04.660] Invocation finished in 53m51.49626285s with status SUCCEEDED