[23:00:38.978] New invocation is queued and will start shortly
[23:00:43.606] Starting the invocation (attempt 1)
[23:00:43.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:00:43.698] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:00:43.698] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054050040671438192",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6c1374edc111c8f885bd12db1afffde77b8c4a76\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054050040671438192",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"gitiles_ref:refs/heads/master"
]
}
[23:00:44.447] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581548443830122",
"id": "8888619974920719376",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c1374edc111c8f885bd12db1afffde77b8c4a76\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581548444322843",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168533",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054050040671438192",
"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/8888619974920719376/+/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": "1581548444323022",
"url": "https://ci.chromium.org/b/8888619974920719376",
"utcnow_ts": "1581548444436705"
}
}
[23:00:44.447] Task URL: https://ci.chromium.org/b/8888619974920719376
[23:00:44.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:2:0) after 1m0s
[23:01:44.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:2:0)
[23:01:44.487] Timer tick, asking Buildbucket for the build status
[23:01:44.649] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:44.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:3:0) after 1m0s
[23:02:44.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:3:0)
[23:02:44.697] Timer tick, asking Buildbucket for the build status
[23:02:45.101] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:45.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:4:0) after 1m0s
[23:03:45.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:4:0)
[23:03:45.073] Timer tick, asking Buildbucket for the build status
[23:03:45.473] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:45.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:5:0) after 1m0s
[23:04:45.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:5:0)
[23:04:45.489] Timer tick, asking Buildbucket for the build status
[23:04:45.681] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:45.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:6:0) after 1m0s
[23:05:45.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:6:0)
[23:05:45.730] Timer tick, asking Buildbucket for the build status
[23:05:46.376] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:46.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:7:0) after 1m0s
[23:06:46.367] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:7:0)
[23:06:46.367] Timer tick, asking Buildbucket for the build status
[23:06:46.531] Build 8888619974920719376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:8:0) after 1m0s
[23:06:52.182] Received PubSub notification, asking Buildbucket for the build status
[23:06:52.524] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:46.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:8:0)
[23:07:46.618] Timer tick, asking Buildbucket for the build status
[23:07:46.901] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:46.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:10:0) after 1m0s
[23:08:46.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:10:0)
[23:08:46.924] Timer tick, asking Buildbucket for the build status
[23:08:47.524] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:47.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:11:0) after 1m0s
[23:09:47.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:11:0)
[23:09:47.539] Timer tick, asking Buildbucket for the build status
[23:09:48.037] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:48.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:12:0) after 1m0s
[23:10:48.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:12:0)
[23:10:48.076] Timer tick, asking Buildbucket for the build status
[23:10:48.584] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:48.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:13:0) after 1m0s
[23:11:48.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:13:0)
[23:11:48.632] Timer tick, asking Buildbucket for the build status
[23:11:48.755] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:48.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:14:0) after 1m0s
[23:12:48.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:14:0)
[23:12:48.868] Timer tick, asking Buildbucket for the build status
[23:12:49.593] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:49.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:15:0) after 1m0s
[23:13:49.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:15:0)
[23:13:49.636] Timer tick, asking Buildbucket for the build status
[23:13:49.792] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:49.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:16:0) after 1m0s
[23:14:49.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:16:0)
[23:14:49.809] Timer tick, asking Buildbucket for the build status
[23:14:50.035] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:50.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:17:0) after 1m0s
[23:15:50.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:17:0)
[23:15:50.066] Timer tick, asking Buildbucket for the build status
[23:15:50.285] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:50.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:18:0) after 1m0s
[23:16:50.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:18:0)
[23:16:50.305] Timer tick, asking Buildbucket for the build status
[23:16:54.795] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:54.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:19:0) after 1m0s
[23:17:55.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:19:0)
[23:17:55.136] Timer tick, asking Buildbucket for the build status
[23:17:58.493] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:58.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:20:0) after 1m0s
[23:18:59.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:20:0)
[23:18:59.156] Timer tick, asking Buildbucket for the build status
[23:18:59.396] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:59.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:21:0) after 1m0s
[23:19:59.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:21:0)
[23:19:59.708] Timer tick, asking Buildbucket for the build status
[23:19:59.931] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:22:0) after 1m0s
[23:21:00.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:22:0)
[23:21:00.027] Timer tick, asking Buildbucket for the build status
[23:21:01.069] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:01.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:23:0) after 1m0s
[23:22:01.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:23:0)
[23:22:01.318] Timer tick, asking Buildbucket for the build status
[23:22:01.549] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:01.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:24:0) after 1m0s
[23:23:01.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:24:0)
[23:23:01.878] Timer tick, asking Buildbucket for the build status
[23:23:02.083] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:02.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:25:0) after 1m0s
[23:24:02.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:25:0)
[23:24:02.503] Timer tick, asking Buildbucket for the build status
[23:24:03.105] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:03.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:26:0) after 1m0s
[23:25:03.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:26:0)
[23:25:03.578] Timer tick, asking Buildbucket for the build status
[23:25:04.197] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:04.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:27:0) after 1m0s
[23:26:04.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:27:0)
[23:26:04.605] Timer tick, asking Buildbucket for the build status
[23:26:05.143] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:05.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:28:0) after 1m0s
[23:27:05.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:28:0)
[23:27:05.407] Timer tick, asking Buildbucket for the build status
[23:27:05.570] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:05.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:29:0) after 1m0s
[23:28:05.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:29:0)
[23:28:05.718] Timer tick, asking Buildbucket for the build status
[23:28:06.016] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:06.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:30:0) after 1m0s
[23:29:06.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:30:0)
[23:29:06.506] Timer tick, asking Buildbucket for the build status
[23:29:07.612] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:07.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:31:0) after 1m0s
[23:30:07.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:31:0)
[23:30:07.721] Timer tick, asking Buildbucket for the build status
[23:30:08.160] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:08.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:32:0) after 1m0s
[23:31:08.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:32:0)
[23:31:08.271] Timer tick, asking Buildbucket for the build status
[23:31:08.928] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:08.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:33:0) after 1m0s
[23:32:09.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:33:0)
[23:32:09.015] Timer tick, asking Buildbucket for the build status
[23:32:09.160] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:09.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:34:0) after 1m0s
[23:33:09.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:34:0)
[23:33:09.262] Timer tick, asking Buildbucket for the build status
[23:33:09.424] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:35:0) after 1m0s
[23:34:09.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:35:0)
[23:34:09.547] Timer tick, asking Buildbucket for the build status
[23:34:09.755] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:36:0) after 1m0s
[23:35:09.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:36:0)
[23:35:09.830] Timer tick, asking Buildbucket for the build status
[23:35:11.173] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:11.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:37:0) after 1m0s
[23:36:11.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:37:0)
[23:36:11.193] Timer tick, asking Buildbucket for the build status
[23:36:12.616] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:12.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:38:0) after 1m0s
[23:37:12.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:38:0)
[23:37:12.685] Timer tick, asking Buildbucket for the build status
[23:37:13.184] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:13.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:39:0) after 1m0s
[23:38:13.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:39:0)
[23:38:13.345] Timer tick, asking Buildbucket for the build status
[23:38:13.698] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:13.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:40:0) after 1m0s
[23:39:13.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:40:0)
[23:39:13.727] Timer tick, asking Buildbucket for the build status
[23:39:16.871] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:16.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:41:0) after 1m0s
[23:40:16.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:41:0)
[23:40:16.930] Timer tick, asking Buildbucket for the build status
[23:40:17.796] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:17.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:42:0) after 1m0s
[23:41:17.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:42:0)
[23:41:17.919] Timer tick, asking Buildbucket for the build status
[23:41:19.192] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:43:0) after 1m0s
[23:42:19.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:43:0)
[23:42:19.198] Timer tick, asking Buildbucket for the build status
[23:42:22.904] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:44:0) after 1m0s
[23:43:23.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:44:0)
[23:43:23.019] Timer tick, asking Buildbucket for the build status
[23:43:23.318] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:23.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:45:0) after 1m0s
[23:44:23.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:45:0)
[23:44:23.481] Timer tick, asking Buildbucket for the build status
[23:44:23.741] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:23.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:46:0) after 1m0s
[23:45:23.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:46:0)
[23:45:23.951] Timer tick, asking Buildbucket for the build status
[23:45:25.560] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:25.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:47:0) after 1m0s
[23:46:25.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:47:0)
[23:46:25.650] Timer tick, asking Buildbucket for the build status
[23:46:26.250] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:26.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:48:0) after 1m0s
[23:47:26.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:48:0)
[23:47:26.369] Timer tick, asking Buildbucket for the build status
[23:47:26.530] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:26.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:49:0) after 1m0s
[23:48:26.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:49:0)
[23:48:26.588] Timer tick, asking Buildbucket for the build status
[23:48:26.982] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:26.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:50:0) after 1m0s
[23:49:27.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:50:0)
[23:49:27.124] Timer tick, asking Buildbucket for the build status
[23:49:27.312] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:27.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:51:0) after 1m0s
[23:50:27.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:51:0)
[23:50:27.311] Timer tick, asking Buildbucket for the build status
[23:50:28.230] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:28.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:52:0) after 1m0s
[23:51:28.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:52:0)
[23:51:28.277] Timer tick, asking Buildbucket for the build status
[23:51:28.721] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:28.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:53:0) after 1m0s
[23:52:28.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:53:0)
[23:52:28.726] Timer tick, asking Buildbucket for the build status
[23:52:29.157] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:29.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:54:0) after 1m0s
[23:53:29.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:54:0)
[23:53:29.179] Timer tick, asking Buildbucket for the build status
[23:53:29.740] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:29.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:55:0) after 1m0s
[23:54:29.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:55:0)
[23:54:29.787] Timer tick, asking Buildbucket for the build status
[23:54:30.531] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:30.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:56:0) after 1m0s
[23:55:30.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:56:0)
[23:55:30.537] Timer tick, asking Buildbucket for the build status
[23:55:31.001] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:57:0) after 1m0s
[23:56:31.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:57:0)
[23:56:31.048] Timer tick, asking Buildbucket for the build status
[23:56:32.877] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:32.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:58:0) after 1m0s
[23:57:32.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:58:0)
[23:57:32.940] Timer tick, asking Buildbucket for the build status
[23:57:35.114] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:35.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:59:0) after 1m0s
[23:58:35.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:59:0)
[23:58:35.312] Timer tick, asking Buildbucket for the build status
[23:58:35.590] Build 8888619974920719376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:35.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054050040671438192:60:0) after 1m0s
[23:59:03.407] Received PubSub notification, asking Buildbucket for the build status
[23:59:03.629] Build 8888619974920719376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:59:03.629] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581551892791528",
"created_by": "project:chromium",
"created_ts": "1581548443830122",
"id": "8888619974920719376",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c1374edc111c8f885bd12db1afffde77b8c4a76\"}}",
"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-54-dk1p\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168533, \"got_angle_revision\": \"92b00ca882637cfaff897e689dcc50fa20c31143\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"6c1374edc111c8f885bd12db1afffde77b8c4a76\", \"got_revision_cp\": \"refs/heads/master@{#740858}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"ac4e1d236088f90e3bc97aa67002ffe56042e4f2\", \"got_v8_revision\": \"33c3ae2bf3ad955e232fb2480aff7b422f4b46e1\", \"got_v8_revision_cp\": \"refs/heads/8.2.66@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c1374edc111c8f885bd12db1afffde77b8c4a76\", \"swarm_hashes_refs/heads/master(at){#740858}_without_patch\": {\"accessibility_unittests\": \"da7108d56d08ac9e2991ba9f15f25b1584771bde\", \"angle_unittests\": \"0ebe7fc89622fc4b196b64af25b0e05617b86eaa\", \"app_shell_unittests\": \"fd4abd2c7dad245721e4e5e4a251d8e33ca745db\", \"aura_unittests\": \"9fd854d16e870f19d983080fd1e3b5fa1bc38b36\", \"base_unittests\": \"a429abb7c503c14e351aa5c48e50f6cea6c8024b\", \"base_util_unittests\": \"59b9009b26eeb3c4e649dbea09c80cfa7722faae\", \"blink_common_unittests\": \"80cb8ebe3b3ff9845e2ae6b412e0622a99394302\", \"blink_fuzzer_unittests\": \"e035f1d83da5b83e9644707cb8f1d9f2bcff8e69\", \"blink_heap_unittests\": \"5f80b99d418940d411610dc7c9124691ccb61e70\", \"blink_platform_unittests\": \"df21dc2c198824b83a16ae0c0b59f6231c7488c7\", \"blink_python_tests\": \"eda663ef3c9a609410c69e9a571f285a351c7577\", \"blink_unittests\": \"d3e3504e42884e2635957927f688d692ad83c397\", \"blink_web_tests\": \"ba5bab9921315181bda2602861160a297c1a56ba\", \"boringssl_crypto_tests\": \"f703ce7f577a925213f772a88f6a78a7bc0e2751\", \"boringssl_ssl_tests\": \"8f800d33ddccb31a9661c86bd195e44a02ad14bd\", \"browser_tests\": \"f239c480f7076bd5805c06510da90c4dabf213a1\", \"cacheinvalidation_unittests\": \"48351d79140d1bd734aa0bd16bbd575e9fd0ab2a\", \"capture_unittests\": \"82839f432be3596d5c1cf6066fefb331e1140cb1\", \"cast_unittests\": \"738e36d8d5f644bc69bc6ad83e71a3b511c8f977\", \"cc_unittests\": \"4401b0ace48bc5ab90545a288a6232958f237089\", \"chrome_app_unittests\": \"ff54216ecdc6a698aeadfdc108d91c0135f87ca9\", \"chromedriver_unittests\": \"d8569ea712cbed9a12e3a535043ec13715a3039e\", \"components_browsertests\": \"8d535783fee08714f7ce5dcbdc976405ab21bc62\", \"components_unittests\": \"99da51a6835e5c9fbc4839b4d6283278134f2a01\", \"compositor_unittests\": \"5c25503645fa63e44252679abc7e38806618cc22\", \"content_browsertests\": \"fcf748bd035878f375ac0fc4a65b38e4f7702da0\", \"content_shell_crash_test\": \"b05a3fe3b476fe63450d036e1f528cd0ec6cf68c\", \"content_unittests\": \"9735eb680186c4ad252becb445df3624dd726cbd\", \"crashpad_tests\": \"caa0dbd5a685d29388031fb42bf4e1ba6783aa06\", \"cronet_tests\": \"cdc5146c3df6042c2a99846fff6bba8fa16d749e\", \"cronet_unittests\": \"5c6a69a66a0c1ca5c40b4078ddd1059247a6d6f0\", \"crypto_unittests\": \"d64df9a1bbf9919a025f15b39f7b324b27a058e0\", \"dbus_unittests\": \"8f461e4cffcafac0971d9cb5416915b740dc903d\", \"device_unittests\": \"243b3d4918a90fb5bb281d07129dc7b222690bea\", \"display_unittests\": \"bc3c57358541b1430b95b028507a1b53abb901e5\", \"events_unittests\": \"961d9f10a7fb0e70e148efdd08ae5affbea14edf\", \"extensions_browsertests\": \"37e4aa228c0457006c563721e9dc582a295a99d0\", \"extensions_unittests\": \"b5bd067427c91da58aa292d32987eb6a4f640372\", \"filesystem_service_unittests\": \"79b6f555872fc2f651db85ca5d1e50ac90f18d82\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"f69d4293ef9814460164bc7947b12f10bec9632e\", \"gfx_unittests\": \"a217560c6432ee5a1b343516ce233f97ac3f34a5\", \"gin_unittests\": \"aefdd5c7e8927ec2ac9660ce19b456e9c506babf\", \"google_apis_unittests\": \"fd0f8717da822262f21c1e07ac7b9ccf80c180e0\", \"gpu_unittests\": \"d83ce15be364db7a2a8fb5eb96a77fe58a328574\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"de218a3c072d19b58007659c1c01048031b7fb3e\", \"headless_browsertests\": \"af3804ce8e69d7141f5e9dc492ddeff62acff80e\", \"headless_unittests\": \"ce6ad50856e5be08febb359309beeee7d8cf939d\", \"interactive_ui_tests\": \"15405e0655c45545714ddeb12bcdc56b5e4873fe\", \"ipc_tests\": \"17d267ffab5bee5385b12b5b995ffb71975719c8\", \"jingle_unittests\": \"9e3b485b7a960f636cfd9fc73b1df4883277c0da\", \"latency_unittests\": \"12ca1df724152026555f4e2629b2b2515233f270\", \"libjingle_xmpp_unittests\": \"44860300c5220f8c287b2996224a87e2314ed227\", \"media_blink_unittests\": \"dab45eac9058ee18e81f58fb457def24f3c9acc3\", \"media_service_unittests\": \"508d9bb0673c673051c2ca778cf934ac5924d9b8\", \"media_unittests\": \"c123bf77fe5a2a6c8834661b086c6b03a0b6498a\", \"message_center_unittests\": \"f59cbd28efdb32d3d41583cc652f9cf2abdff6bc\", \"metrics_python_tests\": \"d3d03b409d4c8a56289764ff548be91eaea1cec6\", \"midi_unittests\": \"8cd8800b3ac47dba6a5140bb5ec1ba1dd5e15aba\", \"mojo_core_unittests\": \"52f0424a09a325ccea826d2215a37d2af3633b9b\", \"mojo_unittests\": \"59402de11b636def22b2a81cca2d159f935991d1\", \"nacl_helper_nonsfi_unittests\": \"3bdb746df7c294e7c2de36c30c6c91a82dfd6886\", \"nacl_loader_unittests\": \"e897e149f113eebdbc92de61aa7abc88aea97baf\", \"native_theme_unittests\": \"8e5e4746bd490d7b08ef0b68e1e94a095ab53f1a\", \"net_unittests\": \"80cf9ea3da1e4a097f292e25c6477ef0c5035fb0\", \"pdf_unittests\": \"a586a8f4ee89d8b315010ee7f14a96fceaea77fa\", \"perfetto_unittests\": \"368a3a2d5d632d0f2b82f02709d3efcd85dddeb3\", \"ppapi_unittests\": \"def970ba410155562dbd7fa3537ac4919abfe2d5\", \"printing_unittests\": \"36f6b2f58236f99e007132f1effd5449d4e9ded4\", \"remoting_unittests\": \"124cb9fe37ba60e3343bd4ae702e1a177e08de7c\", \"sandbox_linux_unittests\": \"7f464a984fe04053fac5e859a13257b7b4c18c46\", \"service_manager_unittests\": \"809893c2f868b912e1143112821c4a051575ab80\", \"services_unittests\": \"abfcda4e440d901c5d55c29798048f917bb8db28\", \"shell_dialogs_unittests\": \"9e93a5857c248947c8a7151e5ddc87fc933f88b5\", \"skia_unittests\": \"17f49d5dcb6b19bd9f9a22d38848a0df38346b93\", \"snapshot_unittests\": \"525d2e99e2b039179baad1a2526de24f024dccca\", \"sql_unittests\": \"6f89da2d5b8f4c1475b351da840ae38491768012\", \"storage_unittests\": \"f0fe7408f9a9f95808c5097ff4f84f6bbd499f89\", \"sync_integration_tests\": \"47b459db4e98a3678354ba8afafa92c32e6cf116\", \"telemetry_gpu_unittests\": \"f7978585c72c10f2480c78dbf546fdc78523b0a3\", \"telemetry_perf_unittests\": \"e66168f2358cfae96a140c85aae3aac3fd773366\", \"telemetry_unittests\": \"6dc82dc51fb2d2281a4cdc2044eb37715e37c6d4\", \"traffic_annotation_auditor_unittests\": \"3570bbfcca18b2a0f91a8dbe2e3685518b2cdc55\", \"ui_base_unittests\": \"5b1c50ff1889f6d04f6288350daa465d5a3ce2ef\", \"ui_touch_selection_unittests\": \"1917b1d373ec83e64da7e26b628efd991713c042\", \"unit_tests\": \"98ce162d68a6950462d681a32feaa63f7fc4833e\", \"url_unittests\": \"e3805eaf9e6d07799dd09f6ddddc06abc5317ce9\", \"views_perftests\": \"d4980ed9529406d9b8ec2630f24753b60a9309b2\", \"views_unittests\": \"f00849d5d7a782a01c91a94be2560aabee3e2673\", \"viz_unittests\": \"87ed29f5d2bec2599c5078606c0469c01f54f7f0\", \"vr_common_unittests\": \"62d815a491439cb196c6ff3ff3d4ec2357e311fa\", \"vr_pixeltests\": \"4c3e1de7d342791fea8a9d0db8e385130b46bd5e\", \"webdriver_wpt_tests\": \"c4c6bb1f9f088afa5e71f31dd6e98e611516ed4a\", \"weblayer_browsertests\": \"04f61af9b74db2c2336fc4f50fdbf104f6acd506\", \"wm_unittests\": \"4b129139b4bedbf7dfe03014086f9d4a7108d8e3\", \"wtf_unittests\": \"1145500c55770eab683945488513f67fa4cd81d7\", \"xr_browser_tests\": \"5829fccbca7292446f7128f990167d4fbaa7961d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_5c21095a1a129131be723eb555273fa4f1dc89f7e6d0ed0ea2c09e97b0cf5fcb_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-54-dk1p\"], \"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\": [\"4812-ea7e8fc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581548755555728",
"status": "COMPLETED",
"status_changed_ts": "1581551943111567",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168533",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c1374edc111c8f885bd12db1afffde77b8c4a76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054050040671438192",
"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/8888619974920719376/+/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:4a5473a3ea3a9710",
"user_agent:luci-scheduler"
],
"updated_ts": "1581551943119495",
"url": "https://ci.chromium.org/b/8888619974920719376",
"utcnow_ts": "1581551943612589"
}
}
[23:59:03.629] Invocation finished in 58m24.667614723s with status SUCCEEDED