[16:49:04.142] New invocation is queued and will start shortly
[16:49:05.301] Starting the invocation (attempt 1)
[16:49:05.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:49:05.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:49:05.337] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051536703443800240",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53444bb9dd91debe31aef4c1e29f3694454aebb9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051536703443800240",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"gitiles_ref:refs/heads/master"
]
}
[16:49:06.143] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583945345460338",
"id": "8886106641397097120",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53444bb9dd91debe31aef4c1e29f3694454aebb9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583945345985066",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169616",
"builder:Linux Builder (dbg)",
"buildset:commit/git/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051536703443800240",
"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/8886106641397097120/+/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": "1583945345985194",
"url": "https://ci.chromium.org/b/8886106641397097120",
"utcnow_ts": "1583945346131979"
}
}
[16:49:06.143] Task URL: https://ci.chromium.org/b/8886106641397097120
[16:49:06.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:2:0) after 1m0s
[16:50:06.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:2:0)
[16:50:06.187] Timer tick, asking Buildbucket for the build status
[16:50:06.328] Build 8886106641397097120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:06.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:3:0) after 1m0s
[16:51:06.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:3:0)
[16:51:06.467] Timer tick, asking Buildbucket for the build status
[16:51:06.686] Build 8886106641397097120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:06.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:4:0) after 1m0s
[16:52:06.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:4:0)
[16:52:06.732] Timer tick, asking Buildbucket for the build status
[16:52:06.825] Build 8886106641397097120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:5:0) after 1m0s
[16:53:06.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:5:0)
[16:53:06.913] Timer tick, asking Buildbucket for the build status
[16:53:07.061] Build 8886106641397097120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:07.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:6:0) after 1m0s
[16:54:07.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:6:0)
[16:54:07.147] Timer tick, asking Buildbucket for the build status
[16:54:07.353] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:07.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:7:0) after 1m0s
[16:54:08.197] Received PubSub notification, asking Buildbucket for the build status
[16:54:09.648] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:07.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:7:0)
[16:55:07.438] Timer tick, asking Buildbucket for the build status
[16:55:07.553] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:07.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:9:0) after 1m0s
[16:56:07.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:9:0)
[16:56:07.715] Timer tick, asking Buildbucket for the build status
[16:56:07.894] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:10:0) after 1m0s
[16:57:07.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:10:0)
[16:57:07.954] Timer tick, asking Buildbucket for the build status
[16:57:08.156] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:08.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:11:0) after 1m0s
[16:58:08.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:11:0)
[16:58:08.176] Timer tick, asking Buildbucket for the build status
[16:58:08.455] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:08.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:12:0) after 1m0s
[16:59:08.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:12:0)
[16:59:08.510] Timer tick, asking Buildbucket for the build status
[16:59:08.745] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:08.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:13:0) after 1m0s
[17:00:08.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:13:0)
[17:00:08.830] Timer tick, asking Buildbucket for the build status
[17:00:08.941] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:08.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:14:0) after 1m0s
[17:01:09.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:14:0)
[17:01:09.049] Timer tick, asking Buildbucket for the build status
[17:01:09.138] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:09.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:15:0) after 1m0s
[17:02:09.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:15:0)
[17:02:09.205] Timer tick, asking Buildbucket for the build status
[17:02:09.319] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:16:0) after 1m0s
[17:03:09.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:16:0)
[17:03:09.337] Timer tick, asking Buildbucket for the build status
[17:03:09.521] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:09.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:17:0) after 1m0s
[17:04:09.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:17:0)
[17:04:09.578] Timer tick, asking Buildbucket for the build status
[17:04:09.780] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:09.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:18:0) after 1m0s
[17:05:09.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:18:0)
[17:05:09.783] Timer tick, asking Buildbucket for the build status
[17:05:10.351] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:10.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:19:0) after 1m0s
[17:06:10.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:19:0)
[17:06:10.392] Timer tick, asking Buildbucket for the build status
[17:06:10.695] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:10.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:20:0) after 1m0s
[17:07:10.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:20:0)
[17:07:10.779] Timer tick, asking Buildbucket for the build status
[17:07:11.006] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:11.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:21:0) after 1m0s
[17:08:11.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:21:0)
[17:08:11.046] Timer tick, asking Buildbucket for the build status
[17:08:11.355] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:11.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:22:0) after 1m0s
[17:09:11.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:22:0)
[17:09:11.485] Timer tick, asking Buildbucket for the build status
[17:09:11.600] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:11.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:23:0) after 1m0s
[17:10:11.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:23:0)
[17:10:11.667] Timer tick, asking Buildbucket for the build status
[17:10:11.978] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:11.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:24:0) after 1m0s
[17:11:12.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:24:0)
[17:11:12.037] Timer tick, asking Buildbucket for the build status
[17:11:12.279] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:12.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:25:0) after 1m0s
[17:12:12.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:25:0)
[17:12:12.387] Timer tick, asking Buildbucket for the build status
[17:12:12.496] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:12.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:26:0) after 1m0s
[17:13:12.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:26:0)
[17:13:12.616] Timer tick, asking Buildbucket for the build status
[17:13:12.906] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:12.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:27:0) after 1m0s
[17:14:13.103] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:27:0)
[17:14:13.103] Timer tick, asking Buildbucket for the build status
[17:14:13.227] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:13.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:28:0) after 1m0s
[17:15:13.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:28:0)
[17:15:13.289] Timer tick, asking Buildbucket for the build status
[17:15:13.647] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:13.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:29:0) after 1m0s
[17:16:13.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:29:0)
[17:16:13.975] Timer tick, asking Buildbucket for the build status
[17:16:14.093] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:14.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:30:0) after 1m0s
[17:17:14.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:30:0)
[17:17:14.344] Timer tick, asking Buildbucket for the build status
[17:17:14.711] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:14.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:31:0) after 1m0s
[17:18:14.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:31:0)
[17:18:14.832] Timer tick, asking Buildbucket for the build status
[17:18:15.002] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:15.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:32:0) after 1m0s
[17:19:15.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:32:0)
[17:19:15.265] Timer tick, asking Buildbucket for the build status
[17:19:15.443] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:15.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:33:0) after 1m0s
[17:20:15.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:33:0)
[17:20:15.448] Timer tick, asking Buildbucket for the build status
[17:20:15.583] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:15.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:34:0) after 1m0s
[17:21:15.647] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:34:0)
[17:21:15.647] Timer tick, asking Buildbucket for the build status
[17:21:15.828] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:15.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:35:0) after 1m0s
[17:22:15.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:35:0)
[17:22:15.938] Timer tick, asking Buildbucket for the build status
[17:22:16.063] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:16.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:36:0) after 1m0s
[17:23:16.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:36:0)
[17:23:16.088] Timer tick, asking Buildbucket for the build status
[17:23:16.310] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:16.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:37:0) after 1m0s
[17:24:16.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:37:0)
[17:24:16.329] Timer tick, asking Buildbucket for the build status
[17:24:16.402] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:16.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:38:0) after 1m0s
[17:25:16.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:38:0)
[17:25:16.561] Timer tick, asking Buildbucket for the build status
[17:25:16.794] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:16.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:39:0) after 1m0s
[17:26:16.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:39:0)
[17:26:16.946] Timer tick, asking Buildbucket for the build status
[17:26:17.031] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:17.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:40:0) after 1m0s
[17:27:17.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:40:0)
[17:27:17.205] Timer tick, asking Buildbucket for the build status
[17:27:17.364] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:17.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:41:0) after 1m0s
[17:28:17.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:41:0)
[17:28:17.379] Timer tick, asking Buildbucket for the build status
[17:28:17.539] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:17.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:42:0) after 1m0s
[17:29:17.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:42:0)
[17:29:17.663] Timer tick, asking Buildbucket for the build status
[17:29:17.809] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:17.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:43:0) after 1m0s
[17:30:17.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:43:0)
[17:30:17.980] Timer tick, asking Buildbucket for the build status
[17:30:18.054] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:18.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:44:0) after 1m0s
[17:31:18.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:44:0)
[17:31:18.154] Timer tick, asking Buildbucket for the build status
[17:31:18.342] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:18.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:45:0) after 1m0s
[17:32:18.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:45:0)
[17:32:18.424] Timer tick, asking Buildbucket for the build status
[17:32:18.753] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:18.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:46:0) after 1m0s
[17:33:18.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:46:0)
[17:33:18.857] Timer tick, asking Buildbucket for the build status
[17:33:19.018] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:19.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:47:0) after 1m0s
[17:34:19.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:47:0)
[17:34:19.194] Timer tick, asking Buildbucket for the build status
[17:34:19.362] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:19.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:48:0) after 1m0s
[17:35:19.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:48:0)
[17:35:19.465] Timer tick, asking Buildbucket for the build status
[17:35:19.711] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:19.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:49:0) after 1m0s
[17:36:19.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:49:0)
[17:36:19.774] Timer tick, asking Buildbucket for the build status
[17:36:20.254] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:20.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:50:0) after 1m0s
[17:37:20.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:50:0)
[17:37:20.404] Timer tick, asking Buildbucket for the build status
[17:37:20.569] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:20.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:51:0) after 1m0s
[17:38:20.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:51:0)
[17:38:20.673] Timer tick, asking Buildbucket for the build status
[17:38:20.782] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:20.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:52:0) after 1m0s
[17:39:20.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:52:0)
[17:39:20.846] Timer tick, asking Buildbucket for the build status
[17:39:20.982] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:20.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:53:0) after 1m0s
[17:40:21.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:53:0)
[17:40:21.122] Timer tick, asking Buildbucket for the build status
[17:40:21.190] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:21.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:54:0) after 1m0s
[17:41:21.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:54:0)
[17:41:21.232] Timer tick, asking Buildbucket for the build status
[17:41:21.584] Build 8886106641397097120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:21.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051536703443800240:55:0) after 1m0s
[17:41:56.542] Received PubSub notification, asking Buildbucket for the build status
[17:41:56.644] Build 8886106641397097120: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:41:56.644] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583948515900141",
"created_by": "project:chromium",
"created_ts": "1583945345460338",
"id": "8886106641397097120",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53444bb9dd91debe31aef4c1e29f3694454aebb9\"}}",
"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-central1-b-8-76-o60e\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169616, \"got_angle_revision\": \"d0748eb038be66dfd05c05773d1edbfd3bdacbc8\", \"got_dawn_revision\": \"421684f9438d2c847b1c6571055074272d15c089\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"53444bb9dd91debe31aef4c1e29f3694454aebb9\", \"got_revision_cp\": \"refs/heads/master@{#749207}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"ca10816d6c22094dab7022349fc2e2e9f21da6e6\", \"got_v8_revision\": \"83b2817d8edb5b18f82a57b2500f76e4b6e43849\", \"got_v8_revision_cp\": \"refs/heads/8.2.292@{#1}\", \"got_webrtc_revision\": \"78964c1e0afa60d8e628f4cac304ae550ee92490\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30755}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53444bb9dd91debe31aef4c1e29f3694454aebb9\", \"swarm_hashes_refs/heads/master(at){#749207}_without_patch\": {\"accessibility_unittests\": \"f411b69f39467443e40f796963403322f42ce7f9\", \"angle_unittests\": \"1642c0f14d2b373947c7134665aa34e7522e5a3f\", \"app_shell_unittests\": \"35d134f587bcb49527b29a4b2006e566a0b4ea0d\", \"aura_unittests\": \"377211b0921ecfb568db74bd84deb7533e90b072\", \"base_unittests\": \"1a967ecd48f35c864bd993d44e5d8682c7fa9fd5\", \"base_util_unittests\": \"12ee9c01ae1af21b974806b14f6fb9da1853b084\", \"blink_common_unittests\": \"12c2105919fdf2f0c4e1a2c11d2d98ca01a82654\", \"blink_fuzzer_unittests\": \"c8e5c1f947bdde6bc7d4e7b7dea2836dabc599c2\", \"blink_heap_unittests\": \"5c705a46f478a1852c106921340cc45a276a5310\", \"blink_platform_unittests\": \"b403420b544a91af822b64a43be0c2fc1fd6e68b\", \"blink_python_tests\": \"cb1c1adad0668ec201a89ef8f63219793dc49a89\", \"blink_unittests\": \"2472e2d853fda02b150871472738c603ee46a7e1\", \"blink_web_tests\": \"b4d17a003e1b5d4151aad10b14bdd03b91a35c08\", \"boringssl_crypto_tests\": \"3bdcc1e1e2e63bba1792ff52620ffd2d60294e45\", \"boringssl_ssl_tests\": \"917efc34b3f2fb0c8956adb2bd9569f00efd420b\", \"browser_tests\": \"8f38ced50720ecd29c7c80e751c648a97db971d6\", \"cacheinvalidation_unittests\": \"9d68df94a3a9d0b42d1d4944debdeb7238bb6c89\", \"capture_unittests\": \"0c417f257180e8ec9c0e7e8a4fe28f06409b62f8\", \"cast_unittests\": \"627a0eea2b7c696f339d3359e0acd69986ed2c5f\", \"cc_unittests\": \"40ed71fae59ed127aebbdab97ced73522ece207f\", \"chrome_app_unittests\": \"2959df4a46337713d989476172f1f87003a0a6d5\", \"chromedriver_unittests\": \"f364acc30dd72c305b771ead2d5264e1fe6d2ce7\", \"components_browsertests\": \"be21effeb43cd300bdcd535f3325f3270d9c2f13\", \"components_unittests\": \"ef63311c16ad25aea585944b36aa984b4d787f3d\", \"compositor_unittests\": \"17ed011cf4cdde691b2f20d700a0dd1434849b7d\", \"content_browsertests\": \"4a432d78ab21af667b18cf70fc67fa557c1d1daa\", \"content_shell_crash_test\": \"d5da71d127a228a6c4f71925a914a22d4b5ecc3a\", \"content_unittests\": \"77aedb9a53468c2f2e2be431dc6f3899442c4d3c\", \"crashpad_tests\": \"af51d4b97e838de6e68102cdacd9a86986b2fc44\", \"cronet_tests\": \"2bb517490c245271b187b57a9fc9f8ee478a39a7\", \"cronet_unittests\": \"c62055c0cb37cc9bf22b572d7b03bba0b0330c96\", \"crypto_unittests\": \"c9b313b6be839b0a35e2cbd28b64bb85590beaf2\", \"dbus_unittests\": \"c52199cbac3c4690d6598fd620816f5c963e10b2\", \"device_unittests\": \"f6e85d65b1a3d1eada02b06e71a22e25913653c4\", \"display_unittests\": \"beab956f3d09a28a97b567b51ea02417657b8d7b\", \"events_unittests\": \"d0a3a69c2c86e7e655402f896cbd5ff0d89ef91e\", \"extensions_browsertests\": \"90d8240067c79208bd44fa1ffc0903fef9f2d734\", \"extensions_unittests\": \"468607ed908b5cab6528273d36837e253646584a\", \"filesystem_service_unittests\": \"1a53be55f26db719f6680fe4748d585dca9bacfd\", \"flatbuffers_unittests\": \"7206c7d74730b3f7e6216aef1cd1832766848674\", \"gcm_unit_tests\": \"400cc5b70244ff87b6c5876165f2a5a635ff26b7\", \"gfx_unittests\": \"f24905da4e6cee8fd95db0b0f71a9a5b7f96ef3b\", \"gin_unittests\": \"f410910f33410b2dfa880f01f8d2c8d264917625\", \"google_apis_unittests\": \"a7c965db3b2a0ff2961cd6045bdcae0e9a66aef0\", \"gpu_unittests\": \"86e4415d6a43ee7290401c3f9bca616822f2cf1f\", \"grit_python_unittests\": \"b9f32300fa0db051f758e05df6b99d5d2819e58f\", \"gwp_asan_unittests\": \"ab32ea010996266edf878bead0f1a7f64117cf58\", \"headless_browsertests\": \"5ed78ad1b91b370b666bafffbb7ab6d1c89db5e2\", \"headless_unittests\": \"65bf4ccdb2813e6e3f643a507d9fdf795a56e88a\", \"interactive_ui_tests\": \"f222023efbef70f2f602d3074e82f5570a051d1b\", \"ipc_tests\": \"0516572196feebfcd4deeeb53afbd361954fd474\", \"jingle_unittests\": \"5d12d59c3a6db98547b1b2243466a3508fb1534b\", \"latency_unittests\": \"81dfb0a45d35880579f54a8de0e996eb4a9c2c8e\", \"libjingle_xmpp_unittests\": \"d8be4b086bff77ba2c6b1f985f8cdc9548313c06\", \"media_blink_unittests\": \"2079768be17ef374619b9dc5e8e1b2ad1073863d\", \"media_service_unittests\": \"a6fad135d7d9808b90c9c783d1e8fde18d299685\", \"media_unittests\": \"22152e3d3329a65276837a4fad044d44ec35f349\", \"message_center_unittests\": \"3a93f172fc501de39cd4617f24cf590edf8f32d5\", \"metrics_python_tests\": \"471d8669e61029f2f5ccdc6ced9201c5ff504936\", \"midi_unittests\": \"09739fc1681cb579197b744f09d96e7bcf00a32c\", \"mojo_core_unittests\": \"4f44521d545905cac6a3e263859db2e4c13b1556\", \"mojo_unittests\": \"6f0e165459d941647e9566f9254d64c4d157bf8f\", \"nacl_helper_nonsfi_unittests\": \"fb7966ed89df4c1de5e8d4dd508b06964b2eb4dc\", \"nacl_loader_unittests\": \"f7f3535cc9cfa00f3d51edb3986cc4dc0062c42a\", \"native_theme_unittests\": \"86273c1e651a69a30bda4077cf607709c438266c\", \"net_unittests\": \"8ad4b634b5abe8eb58ec13c77020093b74d831cb\", \"pdf_unittests\": \"0dd8f24d751235e823f82b21e8defc86d75884a9\", \"perfetto_unittests\": \"7d280960fb689c67186403e13e5224b0ae451e7e\", \"ppapi_unittests\": \"788a1e43765e7c68f4f0ff12de3d41b391292a82\", \"printing_unittests\": \"bc873aee45cefdf19842357897abbe798aeca5c8\", \"remoting_unittests\": \"ae16a0006d3f6500a1bbdbd4b1a23e6c7226afb2\", \"sandbox_linux_unittests\": \"f1386b3aedd1035484c493e19528fdf6eb20d4b6\", \"service_manager_unittests\": \"d4c9044ff36631b1673d925f842655b398ca4ce3\", \"services_unittests\": \"5f9659cba0387f831e992a63fe4025d7bfe6994f\", \"shell_dialogs_unittests\": \"c736ecbfbe84c25569b41bcdbf735ea616df867d\", \"skia_unittests\": \"d8d4ceb1a71bfe6d1bfdd15291b1a42d02751bb8\", \"snapshot_unittests\": \"837e59d8999553991056923cf943d002de199e9a\", \"sql_unittests\": \"1a9f565dd8f69948ac53a6e26d40dea5d2fe8161\", \"storage_unittests\": \"24b500709cfa0e553cc30a24879bf4ebf8cd8fa4\", \"sync_integration_tests\": \"3c756a8b212646feb54f66a5ff35b29f911d8f26\", \"telemetry_gpu_unittests\": \"f708f5eb3841ca0e4620c2838c281898000986f1\", \"telemetry_perf_unittests\": \"13b952c0963d5d0e4d9935e042c41b2e729e606c\", \"telemetry_unittests\": \"5fa1b447b706b6eceacac6f60c7db2991c31bac1\", \"traffic_annotation_auditor_unittests\": \"d00e3f7ab6a5874d5b3052f5a1fc4f39ba5f1a5a\", \"ui_base_unittests\": \"1ddd38660a7e8a583caa1e4fcb2c486e389d87fa\", \"ui_touch_selection_unittests\": \"18a94ba21388ce200f6730f6f0c65493f80fae78\", \"unit_tests\": \"67326e6cd1175eaa684e4d547fe98ed0ec9a4a49\", \"url_unittests\": \"0580e175387ec633cab3091707f8682dd58d603b\", \"views_perftests\": \"7b92618626af47f0be392da2ed6239a1a61e99ea\", \"views_unittests\": \"19630884b71f69566866972968d9855328a07826\", \"viz_unittests\": \"9ed864f5899a208823dff7684c4aa3718df10e60\", \"vr_common_unittests\": \"1aa89345249bfc0c114d39ad61c5a502df8b260a\", \"vr_pixeltests\": \"46db769ef9a5da8aa9d4281a523e561bcb0d33d6\", \"webdriver_wpt_tests\": \"f9d075bc19ff1d5b9e7fad44c15f9a8f4698095d\", \"weblayer_browsertests\": \"c26bd3cbbd9498a47bd2735c99491bff9033f9f0\", \"wm_unittests\": \"0913bbc883ff8151c5af34d02e4b6b1c3855719a\", \"wtf_unittests\": \"40096a299b3d786aa82b6857e11ba47ccbc37213\", \"xr_browser_tests\": \"924db28d3ca56aa897d390d771b37fb70e1e4961\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_9b311965bcdd39b39aa4e18428ed38a374d2d5d9f2ab24593845b266390676f3_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_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-central1-b-8-76-o60e\"], \"image\": [\"chrome-xenial-20030800-300841f894e\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583945646074359",
"status": "COMPLETED",
"status_changed_ts": "1583948516182327",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169616",
"builder:Linux Builder (dbg)",
"buildset:commit/git/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53444bb9dd91debe31aef4c1e29f3694454aebb9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051536703443800240",
"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/8886106641397097120/+/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:4ae35174e9fe3510",
"user_agent:luci-scheduler"
],
"updated_ts": "1583948516233434",
"url": "https://ci.chromium.org/b/8886106641397097120",
"utcnow_ts": "1583948516636033"
}
}
[17:41:56.644] Invocation finished in 52m52.518821808s with status SUCCEEDED