[16:29:42.662] New invocation is queued and will start shortly
[16:29:43.809] Starting the invocation (attempt 1)
[16:29:43.845] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:29:43.845] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:29:43.845] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052896875839817968",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"021cb257bd4b26d1b581d9e5d97d537aa795a922\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052896875839817968",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"gitiles_ref:refs/heads/master"
]
}
[16:29:44.477] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582648183918491",
"id": "8887466813858662464",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"021cb257bd4b26d1b581d9e5d97d537aa795a922\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582648184308423",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169014",
"builder:Linux Builder (dbg)",
"buildset:commit/git/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052896875839817968",
"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/8887466813858662464/+/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": "1582648184308582",
"url": "https://ci.chromium.org/b/8887466813858662464",
"utcnow_ts": "1582648184470207"
}
}
[16:29:44.477] Task URL: https://ci.chromium.org/b/8887466813858662464
[16:29:44.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:2:0) after 1m0s
[16:30:44.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:2:0)
[16:30:44.510] Timer tick, asking Buildbucket for the build status
[16:30:44.605] Build 8887466813858662464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:30:44.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:3:0) after 1m0s
[16:31:44.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:3:0)
[16:31:44.624] Timer tick, asking Buildbucket for the build status
[16:31:44.694] Build 8887466813858662464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:44.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:4:0) after 1m0s
[16:32:44.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:4:0)
[16:32:44.843] Timer tick, asking Buildbucket for the build status
[16:32:44.975] Build 8887466813858662464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:44.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:5:0) after 1m0s
[16:33:45.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:5:0)
[16:33:45.028] Timer tick, asking Buildbucket for the build status
[16:33:45.405] Build 8887466813858662464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:45.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:6:0) after 1m0s
[16:34:03.778] Received PubSub notification, asking Buildbucket for the build status
[16:34:03.985] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:45.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:6:0)
[16:34:45.425] Timer tick, asking Buildbucket for the build status
[16:34:45.766] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:45.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:8:0) after 1m0s
[16:35:45.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:8:0)
[16:35:45.753] Timer tick, asking Buildbucket for the build status
[16:35:45.914] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:45.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:9:0) after 1m0s
[16:36:45.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:9:0)
[16:36:45.962] Timer tick, asking Buildbucket for the build status
[16:36:46.064] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:10:0) after 1m0s
[16:37:46.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:10:0)
[16:37:46.088] Timer tick, asking Buildbucket for the build status
[16:37:46.186] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:46.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:11:0) after 1m0s
[16:38:46.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:11:0)
[16:38:46.224] Timer tick, asking Buildbucket for the build status
[16:38:46.340] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:46.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:12:0) after 1m0s
[16:39:46.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:12:0)
[16:39:46.357] Timer tick, asking Buildbucket for the build status
[16:39:46.729] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:46.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:13:0) after 1m0s
[16:40:46.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:13:0)
[16:40:46.724] Timer tick, asking Buildbucket for the build status
[16:40:46.929] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:46.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:14:0) after 1m0s
[16:41:47.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:14:0)
[16:41:47.000] Timer tick, asking Buildbucket for the build status
[16:41:47.451] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:15:0) after 1m0s
[16:42:47.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:15:0)
[16:42:47.473] Timer tick, asking Buildbucket for the build status
[16:42:47.709] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:47.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:16:0) after 1m0s
[16:43:47.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:16:0)
[16:43:47.701] Timer tick, asking Buildbucket for the build status
[16:43:47.778] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:47.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:17:0) after 1m0s
[16:44:47.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:17:0)
[16:44:47.789] Timer tick, asking Buildbucket for the build status
[16:44:47.880] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:47.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:18:0) after 1m0s
[16:45:47.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:18:0)
[16:45:47.915] Timer tick, asking Buildbucket for the build status
[16:45:48.062] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:48.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:19:0) after 1m0s
[16:46:48.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:19:0)
[16:46:48.118] Timer tick, asking Buildbucket for the build status
[16:46:48.363] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:48.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:20:0) after 1m0s
[16:47:48.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:20:0)
[16:47:48.428] Timer tick, asking Buildbucket for the build status
[16:47:48.535] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:21:0) after 1m0s
[16:48:48.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:21:0)
[16:48:48.621] Timer tick, asking Buildbucket for the build status
[16:48:48.704] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:48.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:22:0) after 1m0s
[16:49:48.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:22:0)
[16:49:48.834] Timer tick, asking Buildbucket for the build status
[16:49:48.931] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:48.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:23:0) after 1m0s
[16:50:49.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:23:0)
[16:50:49.014] Timer tick, asking Buildbucket for the build status
[16:50:49.244] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:24:0) after 1m0s
[16:51:49.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:24:0)
[16:51:49.295] Timer tick, asking Buildbucket for the build status
[16:51:49.395] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:49.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:25:0) after 1m0s
[16:52:49.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:25:0)
[16:52:49.427] Timer tick, asking Buildbucket for the build status
[16:52:50.952] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:26:0) after 1m0s
[16:53:51.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:26:0)
[16:53:51.020] Timer tick, asking Buildbucket for the build status
[16:53:51.353] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:51.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:27:0) after 1m0s
[16:54:51.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:27:0)
[16:54:51.380] Timer tick, asking Buildbucket for the build status
[16:54:51.902] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:51.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:28:0) after 1m0s
[16:55:51.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:28:0)
[16:55:51.927] Timer tick, asking Buildbucket for the build status
[16:55:52.213] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:52.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:29:0) after 1m0s
[16:56:52.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:29:0)
[16:56:52.375] Timer tick, asking Buildbucket for the build status
[16:56:52.803] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:52.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:30:0) after 1m0s
[16:57:52.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:30:0)
[16:57:52.832] Timer tick, asking Buildbucket for the build status
[16:57:53.449] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:53.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:31:0) after 1m0s
[16:58:53.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:31:0)
[16:58:53.470] Timer tick, asking Buildbucket for the build status
[16:58:53.616] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:53.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:32:0) after 1m0s
[16:59:53.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:32:0)
[16:59:53.646] Timer tick, asking Buildbucket for the build status
[16:59:53.742] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:53.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:33:0) after 1m0s
[17:00:53.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:33:0)
[17:00:53.792] Timer tick, asking Buildbucket for the build status
[17:00:53.984] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:53.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:34:0) after 1m0s
[17:01:54.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:34:0)
[17:01:54.099] Timer tick, asking Buildbucket for the build status
[17:01:54.241] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:54.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:35:0) after 1m0s
[17:02:54.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:35:0)
[17:02:54.259] Timer tick, asking Buildbucket for the build status
[17:02:54.459] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:54.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:36:0) after 1m0s
[17:03:54.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:36:0)
[17:03:54.482] Timer tick, asking Buildbucket for the build status
[17:03:54.576] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:37:0) after 1m0s
[17:04:54.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:37:0)
[17:04:54.600] Timer tick, asking Buildbucket for the build status
[17:04:54.986] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:54.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:38:0) after 1m0s
[17:05:55.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:38:0)
[17:05:55.036] Timer tick, asking Buildbucket for the build status
[17:05:55.209] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:55.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:39:0) after 1m0s
[17:06:55.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:39:0)
[17:06:55.247] Timer tick, asking Buildbucket for the build status
[17:06:55.490] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:55.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:40:0) after 1m0s
[17:07:55.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:40:0)
[17:07:55.506] Timer tick, asking Buildbucket for the build status
[17:07:55.611] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:55.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:41:0) after 1m0s
[17:08:55.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:41:0)
[17:08:55.736] Timer tick, asking Buildbucket for the build status
[17:08:55.873] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:55.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:42:0) after 1m0s
[17:09:55.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:42:0)
[17:09:55.896] Timer tick, asking Buildbucket for the build status
[17:09:55.964] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:55.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:43:0) after 1m0s
[17:10:56.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:43:0)
[17:10:56.041] Timer tick, asking Buildbucket for the build status
[17:10:56.154] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:56.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:44:0) after 1m0s
[17:11:56.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:44:0)
[17:11:56.147] Timer tick, asking Buildbucket for the build status
[17:11:56.374] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:56.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:45:0) after 1m0s
[17:12:56.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:45:0)
[17:12:56.415] Timer tick, asking Buildbucket for the build status
[17:12:56.710] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:56.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:46:0) after 1m0s
[17:13:56.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:46:0)
[17:13:56.724] Timer tick, asking Buildbucket for the build status
[17:13:56.986] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:56.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:47:0) after 1m0s
[17:14:57.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:47:0)
[17:14:57.044] Timer tick, asking Buildbucket for the build status
[17:14:57.266] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:57.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:48:0) after 1m0s
[17:15:57.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:48:0)
[17:15:57.296] Timer tick, asking Buildbucket for the build status
[17:15:57.468] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:57.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:49:0) after 1m0s
[17:16:57.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:49:0)
[17:16:57.515] Timer tick, asking Buildbucket for the build status
[17:16:57.889] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:57.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:50:0) after 1m0s
[17:17:57.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:50:0)
[17:17:57.921] Timer tick, asking Buildbucket for the build status
[17:17:58.186] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:58.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:51:0) after 1m0s
[17:18:58.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:51:0)
[17:18:58.241] Timer tick, asking Buildbucket for the build status
[17:18:58.367] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:58.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:52:0) after 1m0s
[17:19:58.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:52:0)
[17:19:58.389] Timer tick, asking Buildbucket for the build status
[17:19:58.471] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:58.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:53:0) after 1m0s
[17:20:58.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:53:0)
[17:20:58.534] Timer tick, asking Buildbucket for the build status
[17:20:58.724] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:58.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:54:0) after 1m0s
[17:21:58.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:54:0)
[17:21:58.746] Timer tick, asking Buildbucket for the build status
[17:21:59.319] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:59.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:55:0) after 1m0s
[17:22:59.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:55:0)
[17:22:59.395] Timer tick, asking Buildbucket for the build status
[17:22:59.565] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:59.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:56:0) after 1m0s
[17:23:59.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:56:0)
[17:23:59.585] Timer tick, asking Buildbucket for the build status
[17:23:59.750] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:59.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:57:0) after 1m0s
[17:24:59.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:57:0)
[17:24:59.778] Timer tick, asking Buildbucket for the build status
[17:25:00.171] Build 8887466813858662464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:00.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052896875839817968:58:0) after 1m0s
[17:25:06.250] Received PubSub notification, asking Buildbucket for the build status
[17:25:06.477] Build 8887466813858662464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:25:06.477] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582651505560634",
"created_by": "project:chromium",
"created_ts": "1582648183918491",
"id": "8887466813858662464",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"021cb257bd4b26d1b581d9e5d97d537aa795a922\"}}",
"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\"}, \"$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-52-g7sc\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169014, \"got_angle_revision\": \"aa09ca69e4173cb14261e39be3b7bdf56bbd3840\", \"got_dawn_revision\": \"5a921f8fadbaef0660024f6ac2fe3b4f9bdb02ea\", \"got_nacl_revision\": \"530e1f0dae34020864c81e5cd52be54d9c656690\", \"got_revision\": \"021cb257bd4b26d1b581d9e5d97d537aa795a922\", \"got_revision_cp\": \"refs/heads/master@{#744278}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"e162b023f53956b05b26972e9ecb75985b2f2c27\", \"got_v8_revision\": \"aec8893e95194cf4e76debe80697a48b1d6db840\", \"got_v8_revision_cp\": \"refs/heads/8.2.170@{#1}\", \"got_webrtc_revision\": \"1dea1ea412021819bddbc9400dcca7d9dd2eba74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30581}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"021cb257bd4b26d1b581d9e5d97d537aa795a922\", \"swarm_hashes_refs/heads/master(at){#744278}_without_patch\": {\"accessibility_unittests\": \"b9fad8860d739fcb5bdb1ec41706aced4eadf74d\", \"angle_unittests\": \"52f32c105573e22aca44421c03d3033e7ae070ea\", \"app_shell_unittests\": \"d594ec8b0a1a8427d4748b20329b60220c8fe34a\", \"aura_unittests\": \"f5bcce6ec2cafc3ddc66ca72267bf6bfa5708b15\", \"base_unittests\": \"4d10b2e155cc3701d9ef7e36c3926e7e2406e681\", \"base_util_unittests\": \"b6008aadd938e6fc966a6c857adfb985cc68234c\", \"blink_common_unittests\": \"f96d992e4461ae2adcd52b4fd6f0af9081f706f8\", \"blink_fuzzer_unittests\": \"12def0246feec4fc60b5640f5281fa5e41a5c9a7\", \"blink_heap_unittests\": \"d807c15d857ddd998cce5b58befb0e20c14c5005\", \"blink_platform_unittests\": \"bf5bf78778440135ccfaeaef5821eaad0b5b0324\", \"blink_python_tests\": \"38198d1d0d9239958dee0d458b7d2cde225e00c8\", \"blink_unittests\": \"9c7866ddab6a4b4a18d8cd150081e8fce1bb222f\", \"blink_web_tests\": \"1546b426a9f4e030a00d25af84757b25d4d43a27\", \"boringssl_crypto_tests\": \"1fb99229fe54080ef848f70ebb8888d71364f007\", \"boringssl_ssl_tests\": \"1dd30eb402b2fc2a4ccd7461cd13aff9a9b38d13\", \"browser_tests\": \"7223f6aba91e08c053e3aa72dd2cd0c890e41b3f\", \"cacheinvalidation_unittests\": \"8fb6ae8fce556ca2c25699bddd650768258b81ab\", \"capture_unittests\": \"3990f7f00b17ab349ba9df26e4e127ce39bbfe46\", \"cast_unittests\": \"702cb14629821dc564f792b22e8803dbfbb7ad36\", \"cc_unittests\": \"d4a03466203aeda467a23c96ece82f09ec5cd1da\", \"chrome_app_unittests\": \"9f60233e04d7e373b96da0eef1155f5531645982\", \"chromedriver_unittests\": \"3c68430999f61cb0c820fa5e3b7ea7b4a92a1332\", \"components_browsertests\": \"fcd8ca681b3e4003997761861f4c6b26c55192d5\", \"components_unittests\": \"5bed53277f1417614277a4befadce581e986d482\", \"compositor_unittests\": \"6ae28b679046fe8eef92259072e4ec69f8f62175\", \"content_browsertests\": \"648256bf6a5e2cd890c14b51ec8bf033583df76e\", \"content_shell_crash_test\": \"f60ef4d5430570e86ca1101a78e336744afb840f\", \"content_unittests\": \"3b78b839c52ed1fe32801c60a6927804f7176122\", \"crashpad_tests\": \"d916bbb255b64fd72ce381600ab86025b3e3323c\", \"cronet_tests\": \"bfdbc1ed45fbe40e18a021968ecbd31dd7af15ba\", \"cronet_unittests\": \"689e1fd61b0afbc5fbf94948d146d8618725c09c\", \"crypto_unittests\": \"fd6b6e703e57ba45d92aa53273147708188047df\", \"dbus_unittests\": \"1c254b26dd59bad9670f40d5dbd9022d45c449f6\", \"device_unittests\": \"9fe554d49312438a8723b413a1e14dd4d8eefdce\", \"display_unittests\": \"d354cce54dd3b17a0fe029d7b15d1534f44d0608\", \"events_unittests\": \"6c96fe8b4170902d104f734ba67b6bf9fbbc2be0\", \"extensions_browsertests\": \"3b8c81e1797792e83202e9786fc01e7b992ab0c8\", \"extensions_unittests\": \"bba7b6106e71cfce018caff7a00e64617d318696\", \"filesystem_service_unittests\": \"0fca3ed1c056e129922ab62f5ec416baebdcd4be\", \"flatbuffers_unittests\": \"fddfee5d9c5c5357203fa42dff8f3c357607bc22\", \"gcm_unit_tests\": \"e1ab4e2ca6f9fa9b8ead502119c13cfb11bf079e\", \"gfx_unittests\": \"7a2dc5b881d0c85840d36a10b9917dbe266867e0\", \"gin_unittests\": \"0ffb7ccd390247235fc512daf1c4adbddf2e7e3e\", \"google_apis_unittests\": \"693ab31796eac200ee7e1c9d2b8bf13cce613748\", \"gpu_unittests\": \"b281cb12497497481e7900ac257c3c354d1a9846\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"e0521d1f80a51726f22ac9fe30a8043ae000d11e\", \"headless_browsertests\": \"4001d2b4b417f317666b31fcd8b64e24dd4a2641\", \"headless_unittests\": \"f796b4768241373bca6c4ca2dd1ffe58cf58d45e\", \"interactive_ui_tests\": \"f514822073193c503801f8ebd94811d28c56e6e9\", \"ipc_tests\": \"7d8dee20d7deb33177a1e29de8fee293f7f506d5\", \"jingle_unittests\": \"efa477f8ec95dc05a83c35450ec67bed53fab815\", \"latency_unittests\": \"4def4c57045fb8dedcd0dd3cd6926e1e9ce05a65\", \"libjingle_xmpp_unittests\": \"52789749bba7ab1665c734a2270bcb4e79a045a6\", \"media_blink_unittests\": \"2e396b5fadb59acaaddfaec1756ec50ec7ab660d\", \"media_service_unittests\": \"fef03e84d583d93e471e7a45d98fd33de7083b93\", \"media_unittests\": \"9a3df7bbe879d5374c30e7a457be15fd16278a4f\", \"message_center_unittests\": \"b5b697d72fd2f7a717e17fb94f7acd0937bbda9e\", \"metrics_python_tests\": \"b6ae10708371bfb84cabe013c04e5e598f86178b\", \"midi_unittests\": \"552717e250e52f66ec49d29980294c2d5b973e82\", \"mojo_core_unittests\": \"a275845952a8cbddaa5c54d603a1d2c7c53cfbdc\", \"mojo_unittests\": \"584aae6442f77c009452bf7d3a0231f037592636\", \"nacl_helper_nonsfi_unittests\": \"c5c189d6874c46a1ee133f93821af98f064d3baa\", \"nacl_loader_unittests\": \"8ad972c1f0358bb248f8e7362f88372914cbcd85\", \"native_theme_unittests\": \"56b6117834926610a4fe3953977d6ecca5b412af\", \"net_unittests\": \"4af615ac3743e664084bdb9d74b3f3dc8e65498d\", \"pdf_unittests\": \"de5b59b98fd022705b0ce206fbffa2b4a3c427ca\", \"perfetto_unittests\": \"9cc1746fb1da2e0aa0ba86fb2dcad07a663cc4b6\", \"ppapi_unittests\": \"0eae8338963e2ba2b6d3573da3ce60654cddbaa6\", \"printing_unittests\": \"e5ce5d3b4585f271938d3d409de0d4197e9137c7\", \"remoting_unittests\": \"3c423a37b3d147d0dba92ec564b06905d4d8f9f8\", \"sandbox_linux_unittests\": \"af8f782e5629c817ce0dbbc5eabb0b9d67a9b343\", \"service_manager_unittests\": \"2f4e49a0d47d2ccadc045f67496413aabc05c147\", \"services_unittests\": \"8c1db94c00b99f3ed6f2070243ad7a7bdef3348f\", \"shell_dialogs_unittests\": \"6664ef7e5efadfe82d13b8f042ff7da086d8961b\", \"skia_unittests\": \"aa0a0551b284f929ef7087274f4b1ff1689965f6\", \"snapshot_unittests\": \"f708511247096e1ae5f6e6f9ddcf806679b97ce8\", \"sql_unittests\": \"ed709721771464d53eb23e113f044f1fc8498d0c\", \"storage_unittests\": \"cb0510eb22c4988b881595a8a44f11d186fca0eb\", \"sync_integration_tests\": \"00b20f89a85e0a01277ef7dfe79086acce0088cf\", \"telemetry_gpu_unittests\": \"c4f8ef9771bfea03d2ffa49f9d38485e6dce5499\", \"telemetry_perf_unittests\": \"5da5155791ea5242d2758a919934b973c528aa25\", \"telemetry_unittests\": \"fe9e646301432e685dbaf6f1991769535f5bff7f\", \"traffic_annotation_auditor_unittests\": \"5b10615903b89b655bebf36884cc1b973c4acd2d\", \"ui_base_unittests\": \"7562fa85f24d7b2f1850af37a52e3b97054927e5\", \"ui_touch_selection_unittests\": \"6e1fc5fb94c07982ddf5861259e56f361d3f1d6b\", \"unit_tests\": \"602e79b5a1e5bdfd302acff29bc1978dde2d10ad\", \"url_unittests\": \"de83ee60a6d38bcdb056fed6b7821f81f0fd03b6\", \"views_perftests\": \"ace5b90b6580e8809ecdc308ed57d3aab58ca693\", \"views_unittests\": \"4f3c17c5687cf15f2f3914a5c076effb2d606348\", \"viz_unittests\": \"015e5dd71a43964ffbc5b1ae1f10bb1d26d58c0f\", \"vr_common_unittests\": \"cecc477cef7c6ee90b52d5196c03176df31f5ace\", \"vr_pixeltests\": \"60a8221140ac34ff7578d868a06bb724541cc3e2\", \"webdriver_wpt_tests\": \"bee7d68ccf9a580f9749661573e42693a602a754\", \"weblayer_browsertests\": \"f21d01fbd2a58325fd38a5c0b797aa8232aa038b\", \"wm_unittests\": \"6aa291c427c48a66f01708086fa0578e24f451b9\", \"wtf_unittests\": \"e67ed4fc17bd7e67b0d224102618daec2582333b\", \"xr_browser_tests\": \"0d1c32210c63a168d6efb2800a094b41ba3b0f5d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_43913798ffe4aacc9db317de63924a4a199b83672551513d069405cf6f3bc584_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-52-g7sc\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4825-3d129d6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582648442628506",
"status": "COMPLETED",
"status_changed_ts": "1582651505823907",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169014",
"builder:Linux Builder (dbg)",
"buildset:commit/git/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/021cb257bd4b26d1b581d9e5d97d537aa795a922",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052896875839817968",
"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/8887466813858662464/+/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:4a96005e32ba5110",
"user_agent:luci-scheduler"
],
"updated_ts": "1582651505827751",
"url": "https://ci.chromium.org/b/8887466813858662464",
"utcnow_ts": "1582651506459138"
}
}
[17:25:06.477] Invocation finished in 55m23.832227126s with status SUCCEEDED