[19:45:44.676] New invocation is queued and will start shortly
[19:45:45.795] Starting the invocation (attempt 1)
[19:45:45.833] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:45:45.833] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:45:45.833] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051706781912557536",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"51f2f743ccbb723cdf8b7affbc88db6294d68057\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051706781912557536",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"gitiles_ref:refs/heads/master"
]
}
[19:45:46.593] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583783145920893",
"id": "8886276719941988736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"51f2f743ccbb723cdf8b7affbc88db6294d68057\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583783146406510",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169536",
"builder:Linux Builder (dbg)",
"buildset:commit/git/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051706781912557536",
"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/8886276719941988736/+/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": "1583783146406671",
"url": "https://ci.chromium.org/b/8886276719941988736",
"utcnow_ts": "1583783146582785"
}
}
[19:45:46.593] Task URL: https://ci.chromium.org/b/8886276719941988736
[19:45:46.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:2:0) after 1m0s
[19:46:46.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:2:0)
[19:46:46.649] Timer tick, asking Buildbucket for the build status
[19:46:46.809] Build 8886276719941988736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:46.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:3:0) after 1m0s
[19:47:46.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:3:0)
[19:47:46.842] Timer tick, asking Buildbucket for the build status
[19:47:47.015] Build 8886276719941988736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:47.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:4:0) after 1m0s
[19:48:47.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:4:0)
[19:48:47.136] Timer tick, asking Buildbucket for the build status
[19:48:47.385] Build 8886276719941988736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:47.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:5:0) after 1m0s
[19:49:47.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:5:0)
[19:49:47.434] Timer tick, asking Buildbucket for the build status
[19:49:47.515] Build 8886276719941988736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:47.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:6:0) after 1m0s
[19:50:18.951] Received PubSub notification, asking Buildbucket for the build status
[19:50:19.041] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:47.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:6:0)
[19:50:47.586] Timer tick, asking Buildbucket for the build status
[19:50:47.773] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:47.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:8:0) after 1m0s
[19:51:47.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:8:0)
[19:51:47.789] Timer tick, asking Buildbucket for the build status
[19:51:48.082] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:48.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:9:0) after 1m0s
[19:52:48.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:9:0)
[19:52:48.617] Timer tick, asking Buildbucket for the build status
[19:52:48.711] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:48.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:10:0) after 1m0s
[19:53:48.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:10:0)
[19:53:48.807] Timer tick, asking Buildbucket for the build status
[19:53:49.164] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:49.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:11:0) after 1m0s
[19:54:49.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:11:0)
[19:54:49.338] Timer tick, asking Buildbucket for the build status
[19:54:49.519] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:49.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:12:0) after 1m0s
[19:55:49.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:12:0)
[19:55:49.500] Timer tick, asking Buildbucket for the build status
[19:55:49.591] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:49.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:13:0) after 1m0s
[19:56:49.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:13:0)
[19:56:49.618] Timer tick, asking Buildbucket for the build status
[19:56:49.712] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:49.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:14:0) after 1m0s
[19:57:49.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:14:0)
[19:57:49.895] Timer tick, asking Buildbucket for the build status
[19:57:49.943] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:49.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:15:0) after 1m0s
[19:58:50.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:15:0)
[19:58:50.080] Timer tick, asking Buildbucket for the build status
[19:58:50.193] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:50.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:16:0) after 1m0s
[19:59:50.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:16:0)
[19:59:50.307] Timer tick, asking Buildbucket for the build status
[19:59:50.538] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:50.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:17:0) after 1m0s
[20:00:50.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:17:0)
[20:00:50.580] Timer tick, asking Buildbucket for the build status
[20:00:50.658] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:50.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:18:0) after 1m0s
[20:01:50.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:18:0)
[20:01:50.794] Timer tick, asking Buildbucket for the build status
[20:01:50.914] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:50.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:19:0) after 1m0s
[20:02:51.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:19:0)
[20:02:51.026] Timer tick, asking Buildbucket for the build status
[20:02:51.124] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:51.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:20:0) after 1m0s
[20:03:51.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:20:0)
[20:03:51.216] Timer tick, asking Buildbucket for the build status
[20:03:51.265] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:51.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:21:0) after 1m0s
[20:04:51.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:21:0)
[20:04:51.350] Timer tick, asking Buildbucket for the build status
[20:04:51.399] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:51.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:22:0) after 1m0s
[20:05:51.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:22:0)
[20:05:51.865] Timer tick, asking Buildbucket for the build status
[20:05:52.022] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:23:0) after 1m0s
[20:06:52.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:23:0)
[20:06:52.192] Timer tick, asking Buildbucket for the build status
[20:06:52.502] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:52.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:24:0) after 1m0s
[20:07:52.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:24:0)
[20:07:52.709] Timer tick, asking Buildbucket for the build status
[20:07:52.890] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:52.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:25:0) after 1m0s
[20:08:52.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:25:0)
[20:08:52.930] Timer tick, asking Buildbucket for the build status
[20:08:53.023] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:26:0) after 1m0s
[20:09:53.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:26:0)
[20:09:53.072] Timer tick, asking Buildbucket for the build status
[20:09:53.374] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:53.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:27:0) after 1m0s
[20:10:53.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:27:0)
[20:10:53.405] Timer tick, asking Buildbucket for the build status
[20:10:53.595] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:53.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:28:0) after 1m0s
[20:11:53.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:28:0)
[20:11:53.618] Timer tick, asking Buildbucket for the build status
[20:11:53.711] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:53.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:29:0) after 1m0s
[20:12:53.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:29:0)
[20:12:53.750] Timer tick, asking Buildbucket for the build status
[20:12:54.015] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:54.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:30:0) after 1m0s
[20:13:53.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:30:0)
[20:13:53.995] Timer tick, asking Buildbucket for the build status
[20:13:54.137] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:54.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:31:0) after 1m0s
[20:14:54.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:31:0)
[20:14:54.194] Timer tick, asking Buildbucket for the build status
[20:14:54.348] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:54.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:32:0) after 1m0s
[20:15:54.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:32:0)
[20:15:54.411] Timer tick, asking Buildbucket for the build status
[20:15:54.565] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:54.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:33:0) after 1m0s
[20:16:54.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:33:0)
[20:16:54.637] Timer tick, asking Buildbucket for the build status
[20:16:54.754] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:54.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:34:0) after 1m0s
[20:17:54.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:34:0)
[20:17:54.749] Timer tick, asking Buildbucket for the build status
[20:17:54.858] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:54.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:35:0) after 1m0s
[20:18:54.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:35:0)
[20:18:54.878] Timer tick, asking Buildbucket for the build status
[20:18:54.964] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:54.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:36:0) after 1m0s
[20:19:54.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:36:0)
[20:19:54.951] Timer tick, asking Buildbucket for the build status
[20:19:55.267] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:55.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:37:0) after 1m0s
[20:20:55.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:37:0)
[20:20:55.313] Timer tick, asking Buildbucket for the build status
[20:20:55.410] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:55.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:38:0) after 1m0s
[20:21:55.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:38:0)
[20:21:55.639] Timer tick, asking Buildbucket for the build status
[20:21:55.756] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:55.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:39:0) after 1m0s
[20:22:56.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:39:0)
[20:22:56.008] Timer tick, asking Buildbucket for the build status
[20:22:56.055] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:56.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:40:0) after 1m0s
[20:23:56.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:40:0)
[20:23:56.110] Timer tick, asking Buildbucket for the build status
[20:23:56.265] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:56.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:41:0) after 1m0s
[20:24:56.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:41:0)
[20:24:56.287] Timer tick, asking Buildbucket for the build status
[20:24:56.761] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:56.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:42:0) after 1m0s
[20:25:56.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:42:0)
[20:25:56.973] Timer tick, asking Buildbucket for the build status
[20:25:57.202] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:57.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:43:0) after 1m0s
[20:26:57.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:43:0)
[20:26:57.282] Timer tick, asking Buildbucket for the build status
[20:26:57.462] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:57.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:44:0) after 1m0s
[20:27:57.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:44:0)
[20:27:57.670] Timer tick, asking Buildbucket for the build status
[20:27:57.868] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:45:0) after 1m0s
[20:28:57.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:45:0)
[20:28:57.952] Timer tick, asking Buildbucket for the build status
[20:28:58.148] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:46:0) after 1m0s
[20:29:58.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:46:0)
[20:29:58.312] Timer tick, asking Buildbucket for the build status
[20:29:58.411] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:58.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:47:0) after 1m0s
[20:30:58.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:47:0)
[20:30:58.466] Timer tick, asking Buildbucket for the build status
[20:30:58.558] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:48:0) after 1m0s
[20:31:58.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:48:0)
[20:31:58.620] Timer tick, asking Buildbucket for the build status
[20:31:58.986] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:58.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:49:0) after 1m0s
[20:32:59.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:49:0)
[20:32:59.049] Timer tick, asking Buildbucket for the build status
[20:32:59.205] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:59.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:50:0) after 1m0s
[20:33:59.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:50:0)
[20:33:59.208] Timer tick, asking Buildbucket for the build status
[20:33:59.320] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:59.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:51:0) after 1m0s
[20:34:59.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:51:0)
[20:34:59.342] Timer tick, asking Buildbucket for the build status
[20:34:59.496] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:59.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:52:0) after 1m0s
[20:35:59.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:52:0)
[20:35:59.558] Timer tick, asking Buildbucket for the build status
[20:35:59.671] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:59.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:53:0) after 1m0s
[20:36:59.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:53:0)
[20:36:59.739] Timer tick, asking Buildbucket for the build status
[20:36:59.883] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:59.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:54:0) after 1m0s
[20:37:59.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:54:0)
[20:37:59.967] Timer tick, asking Buildbucket for the build status
[20:38:00.286] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:00.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:55:0) after 1m0s
[20:39:00.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:55:0)
[20:39:00.371] Timer tick, asking Buildbucket for the build status
[20:39:00.542] Build 8886276719941988736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:00.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051706781912557536:56:0) after 1m0s
[20:39:54.562] Received PubSub notification, asking Buildbucket for the build status
[20:39:54.712] Build 8886276719941988736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:39:54.712] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583786393700533",
"created_by": "project:chromium",
"created_ts": "1583783145920893",
"id": "8886276719941988736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"51f2f743ccbb723cdf8b7affbc88db6294d68057\"}}",
"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-81-jw8j\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169536, \"got_angle_revision\": \"1cd52d2cfe4c4dfb4ff80ef63e6ee53f4c7b2b14\", \"got_dawn_revision\": \"be6cd5188880a1f5a80e70eb240ec9bad7e05348\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"51f2f743ccbb723cdf8b7affbc88db6294d68057\", \"got_revision_cp\": \"refs/heads/master@{#748339}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8be72df6046231eedbd14d155a5a9484bda217c1\", \"got_v8_revision\": \"5bcc6fa4c98b7b11e3f05234655b75e53401d901\", \"got_v8_revision_cp\": \"refs/heads/8.2.274@{#1}\", \"got_webrtc_revision\": \"f87536c9de24ce25c398c1f7a413dc8b80208362\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30724}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"51f2f743ccbb723cdf8b7affbc88db6294d68057\", \"swarm_hashes_refs/heads/master(at){#748339}_without_patch\": {\"accessibility_unittests\": \"6736e30b348a173219d691ec7820c94c855cc383\", \"angle_unittests\": \"b2910dfec3a306787db35b09c71cf21c0559f2e7\", \"app_shell_unittests\": \"e3d4fc419dae5f8533947f43179336e133e14cb9\", \"aura_unittests\": \"cb8a2fa454c641a1dd1b620939d38ef803ff9016\", \"base_unittests\": \"a8ce7c5b85455ab0b163018cac36305c6f44c180\", \"base_util_unittests\": \"d1e8abfec817fd1252468e11a55764aa9ce19038\", \"blink_common_unittests\": \"288c7ca0e86daeb85b77327b09a61e55aded9f89\", \"blink_fuzzer_unittests\": \"5c046f687e1cc941b9fe6444580ed0e49ebb8beb\", \"blink_heap_unittests\": \"5467b77a68cc0403385a3358b26e052dd3e4fd3a\", \"blink_platform_unittests\": \"3393e8f2ce770d17952bcd1c3c09f01c224327b6\", \"blink_python_tests\": \"1f08045da84df4184dd8e12fc1c6fc8c18a8ae77\", \"blink_unittests\": \"300cf914c1d3c627be4ff906e262d13c3943475a\", \"blink_web_tests\": \"c0782c65619eda6d3ced46aca204b48083ad5491\", \"boringssl_crypto_tests\": \"d8fd1d98548abcd6eea92e26c9b328f46483c656\", \"boringssl_ssl_tests\": \"18ac8c64ead4b9984b07a3717efdc103e8e7577e\", \"browser_tests\": \"10c5b1961a854458e0074880a44561af347d1f09\", \"cacheinvalidation_unittests\": \"58369ddf2e000614d6142c7d62bda777dd1726ad\", \"capture_unittests\": \"6c338d1d2a4c33d01971fb4fa7de023d51bf1dbd\", \"cast_unittests\": \"858a59a8fc251eabed26ed5d5e213b10966b529a\", \"cc_unittests\": \"d2dfffd8bc5f1a05ecaf4fab6ec76876b599e0b2\", \"chrome_app_unittests\": \"626a0b396c89d9521c6dd5e4b433349617f5139b\", \"chromedriver_unittests\": \"dff0e7812fd9d3b9c2e5c64da666782b51bb2c74\", \"components_browsertests\": \"fe559b5d5be52202f7f597049d2ab2ce8a1ccab7\", \"components_unittests\": \"698fe59991aec06a800d342b070ad4767a461f66\", \"compositor_unittests\": \"c0b388184b3656c150d6f46c1bb5f81265c81f1e\", \"content_browsertests\": \"9de3e14f7768d5e361ab19684bed1348ddc05e23\", \"content_shell_crash_test\": \"99e6fce82e9211100a98626618ec52aee7fb4571\", \"content_unittests\": \"34e264e69532a0b9b4cc22011af4532500f90154\", \"crashpad_tests\": \"3f75bf2d1ed713ca0b910503d14f6cf5baf08dff\", \"cronet_tests\": \"6b2648284c9a069448c12405bfbd2bdb05569937\", \"cronet_unittests\": \"a96655192d227ae595abe604c567c38b6cc08b03\", \"crypto_unittests\": \"be512070d9ae9c13b8b6f99438d55c093a4b3706\", \"dbus_unittests\": \"fc36b049d8a3277bc0d60262795af238002c1f43\", \"device_unittests\": \"7b94bfa1db745b01a32eab309d4cf79f8c57a08c\", \"display_unittests\": \"9954745240393450a46a20150a38c54ecf91512e\", \"events_unittests\": \"c02f6007532d06d076b022ef418de6b714c81a22\", \"extensions_browsertests\": \"1bbaa16bfe790d2d03173def050b3f908767b611\", \"extensions_unittests\": \"8ff1e2b83de60d7a7d568c027cadc6da931d902b\", \"filesystem_service_unittests\": \"9bfd60e178aba1306cfbd7fb2ef69f065d7b398a\", \"flatbuffers_unittests\": \"050844e0d26621703adfe93dfd2f97054fb85d6c\", \"gcm_unit_tests\": \"0c775cbc9ceac3952ce54819e24400871193f2d0\", \"gfx_unittests\": \"edb04d417b36d02ef2f1e42d340bdfa6330c8df6\", \"gin_unittests\": \"b09f5114f4efd92af6c37511b51ae0a992a51234\", \"google_apis_unittests\": \"31d54145eb24eda56dfce98b74b12ed3d50183de\", \"gpu_unittests\": \"7bfb3dded987188eff6e234491351c2539c4a890\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"2fa735098a4f4332e2aee433c11a089a09296de2\", \"headless_browsertests\": \"62103d9a83046a0244620d41f9355a315c48df81\", \"headless_unittests\": \"e83528678bbf1e22e442d204bfa4875babf6a63a\", \"interactive_ui_tests\": \"e897bedf60facbf1b9973655a055bf86400d76de\", \"ipc_tests\": \"584124bdbc6a0dd2bca85142ee7b7fcd25bd094a\", \"jingle_unittests\": \"f938202745e8e9d8e3bf658f4fc25a63aa347a84\", \"latency_unittests\": \"a2d23d6682a19d3e41a1b0f2eb1172e04819d835\", \"libjingle_xmpp_unittests\": \"6f524c3007b7b93e92fa36c7601e26798e6d5112\", \"media_blink_unittests\": \"82a9ad7663b96c63631311f5ce0bd7672388efa2\", \"media_service_unittests\": \"dea460e531b54a7bc64a873adf2e5776e0adbafb\", \"media_unittests\": \"be0818f3ad39a3557cf86d6906afcba651903810\", \"message_center_unittests\": \"855e466efc9974e1c8984e4d5d26d1b1cea950e3\", \"metrics_python_tests\": \"3511bf98db1cd33aad25bf28f40668715d7e1307\", \"midi_unittests\": \"a21977be6277d1af9f8795c7f73d03fe7359662a\", \"mojo_core_unittests\": \"5cddb676170a6268e3432f328830ff89eeedc0de\", \"mojo_unittests\": \"33953003266adf880f2c9111dba443fc3878e0de\", \"nacl_helper_nonsfi_unittests\": \"56d500f2b6fcb6d06abb9240d24617aaf8d05f75\", \"nacl_loader_unittests\": \"632db54923514a4f19c8bc4940ba4f84ef07ea25\", \"native_theme_unittests\": \"14544f468a6de0ecd66b879018801029eaee71c7\", \"net_unittests\": \"e7a88e2abc878501e0e8d27b2184207f9775829f\", \"pdf_unittests\": \"d6b2843ccb2853ab6bdefc2648f08dffbeb264cf\", \"perfetto_unittests\": \"f8f8a91452d824144fcac9c43811ca27ee067303\", \"ppapi_unittests\": \"548e685fc2bb2ed85968fc44972070652be32280\", \"printing_unittests\": \"ecbcd28feaeced64c659dffa196277267175a9b0\", \"remoting_unittests\": \"64f224d3032171fcdae7fa92e615137c8957e4b9\", \"sandbox_linux_unittests\": \"36496d61bd43c286c7a27b2989c477e02860ebc1\", \"service_manager_unittests\": \"152c1bffd3b5293d299003e8cb98e722ab843650\", \"services_unittests\": \"64b2f1a3dd6eaacd73ca6779ca61103a1f795cd7\", \"shell_dialogs_unittests\": \"e14d4e933940a1bc4a86048301b880105eeba66d\", \"skia_unittests\": \"ec95c7625f908bb1c8f97123fe0f02fa169a9905\", \"snapshot_unittests\": \"0042198f3b14a4bffecc3088d1e335714dcec284\", \"sql_unittests\": \"6ea2542f55f247260649ec666d661ccbc1291eee\", \"storage_unittests\": \"5b18cf86607a2e8d1fc9975f8431336ada092881\", \"sync_integration_tests\": \"23c63ba797ac172332c01269fa2e6f2cc753755d\", \"telemetry_gpu_unittests\": \"7181812da987dba0a892a32f783641b737deabbe\", \"telemetry_perf_unittests\": \"af0a029753c218836d1645f04594f6143fd68689\", \"telemetry_unittests\": \"34cba114ce93d6530bcf449c6b2518858742b095\", \"traffic_annotation_auditor_unittests\": \"c2755bf5dfd0d18deb17497d5e6659f7d2844727\", \"ui_base_unittests\": \"bdc1e33f448b26951d4bcc5c92b25c09af2ecfd8\", \"ui_touch_selection_unittests\": \"71fe12884998879c4b835d823c77a5ad195f5641\", \"unit_tests\": \"439d43f727bd3ceb25b41f5afd3dddb7cc2bad60\", \"url_unittests\": \"47c1ab7a340a9cbb347dd074033a54e8d5de6cba\", \"views_perftests\": \"bc0bcaa3a360309f2e558087aeed781cd7c04587\", \"views_unittests\": \"010aa7f9dfdece4e73f5dc877ef6d92a3670eabf\", \"viz_unittests\": \"ce1f25ca3c27c88d7ef7fb4b3da1dcb2b919bf80\", \"vr_common_unittests\": \"dfef1e371615131ca09611828c7949fafc3b276b\", \"vr_pixeltests\": \"73fddb5d3818f923b65370be01d41c668f063631\", \"webdriver_wpt_tests\": \"e3b7da6dcc766fcb55efb6c13a57370b35cf0da5\", \"weblayer_browsertests\": \"dab8ddcc6be637b50cfdbf515ec8384f4a907966\", \"wm_unittests\": \"11f183e5420f43776c2c2cec17fb2b82c218bbd5\", \"wtf_unittests\": \"c0f55f75184af14355a059130cec5e8ae198605c\", \"xr_browser_tests\": \"89a269a59efa27eba9dfb2be657b62ba9a0d8843\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4f073cad989671df25347297d55a43b2baed7923c7c8febe8eed874750cd540a_v2\", \"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_eeb4aed1f5957a78d1f0fe1c00bdb778895591d08c1bb63c47ebb234324ef661_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-81-jw8j\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583783418153514",
"status": "COMPLETED",
"status_changed_ts": "1583786394194955",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169536",
"builder:Linux Builder (dbg)",
"buildset:commit/git/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/51f2f743ccbb723cdf8b7affbc88db6294d68057",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051706781912557536",
"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/8886276719941988736/+/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:4ad9a67de0305210",
"user_agent:luci-scheduler"
],
"updated_ts": "1583786394200212",
"url": "https://ci.chromium.org/b/8886276719941988736",
"utcnow_ts": "1583786394702110"
}
}
[20:39:54.712] Invocation finished in 54m10.055021504s with status SUCCEEDED