[17:10:45.097] New invocation is queued and will start shortly
[17:10:46.937] Starting the invocation (attempt 1)
[17:10:46.975] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:10:46.975] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:10:46.975] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053709666485787936",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"08c26f010b21cfe41f3511c795451f40c962d0a9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053709666485787936",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/08c26f010b21cfe41f3511c795451f40c962d0a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08c26f010b21cfe41f3511c795451f40c962d0a9",
"gitiles_ref:refs/heads/master"
]
}
[17:10:47.981] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581873047088499",
"id": "8888279603734612736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08c26f010b21cfe41f3511c795451f40c962d0a9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581873047729062",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168673",
"builder:Linux Builder (dbg)",
"buildset:commit/git/08c26f010b21cfe41f3511c795451f40c962d0a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08c26f010b21cfe41f3511c795451f40c962d0a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053709666485787936",
"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/8888279603734612736/+/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": "1581873047729168",
"url": "https://ci.chromium.org/b/8888279603734612736",
"utcnow_ts": "1581873047964715"
}
}
[17:10:47.981] Task URL: https://ci.chromium.org/b/8888279603734612736
[17:10:47.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:2:0) after 1m0s
[17:11:55.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:2:0)
[17:11:55.449] Timer tick, asking Buildbucket for the build status
[17:11:55.531] Build 8888279603734612736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:55.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:3:0) after 1m0s
[17:12:55.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:3:0)
[17:12:55.652] Timer tick, asking Buildbucket for the build status
[17:12:55.854] Build 8888279603734612736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:4:0) after 1m0s
[17:13:55.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:4:0)
[17:13:55.838] Timer tick, asking Buildbucket for the build status
[17:13:55.928] Build 8888279603734612736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:55.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:5:0) after 1m0s
[17:14:56.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:5:0)
[17:14:56.002] Timer tick, asking Buildbucket for the build status
[17:14:56.274] Build 8888279603734612736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:56.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:6:0) after 1m0s
[17:15:06.173] Received PubSub notification, asking Buildbucket for the build status
[17:15:06.234] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:56.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:6:0)
[17:15:56.352] Timer tick, asking Buildbucket for the build status
[17:15:56.541] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:56.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:8:0) after 1m0s
[17:16:56.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:8:0)
[17:16:56.624] Timer tick, asking Buildbucket for the build status
[17:16:56.895] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:56.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:9:0) after 1m0s
[17:17:56.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:9:0)
[17:17:56.913] Timer tick, asking Buildbucket for the build status
[17:17:57.089] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:57.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:10:0) after 1m0s
[17:18:57.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:10:0)
[17:18:57.110] Timer tick, asking Buildbucket for the build status
[17:18:57.367] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:57.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:11:0) after 1m0s
[17:19:57.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:11:0)
[17:19:57.396] Timer tick, asking Buildbucket for the build status
[17:19:57.554] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:57.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:12:0) after 1m0s
[17:20:57.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:12:0)
[17:20:57.689] Timer tick, asking Buildbucket for the build status
[17:20:58.025] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:58.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:13:0) after 1m0s
[17:21:58.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:13:0)
[17:21:58.045] Timer tick, asking Buildbucket for the build status
[17:21:58.403] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:58.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:14:0) after 1m0s
[17:22:58.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:14:0)
[17:22:58.453] Timer tick, asking Buildbucket for the build status
[17:22:58.677] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:58.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:15:0) after 1m0s
[17:23:58.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:15:0)
[17:23:58.677] Timer tick, asking Buildbucket for the build status
[17:23:58.794] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:58.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:16:0) after 1m0s
[17:24:58.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:16:0)
[17:24:58.822] Timer tick, asking Buildbucket for the build status
[17:24:59.282] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:59.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:17:0) after 1m0s
[17:25:59.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:17:0)
[17:25:59.436] Timer tick, asking Buildbucket for the build status
[17:25:59.559] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:59.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:18:0) after 1m0s
[17:26:59.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:18:0)
[17:26:59.533] Timer tick, asking Buildbucket for the build status
[17:26:59.631] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:19:0) after 1m0s
[17:27:59.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:19:0)
[17:27:59.746] Timer tick, asking Buildbucket for the build status
[17:27:59.854] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:59.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:20:0) after 1m0s
[17:28:59.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:20:0)
[17:28:59.882] Timer tick, asking Buildbucket for the build status
[17:29:00.284] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:00.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:21:0) after 1m0s
[17:30:00.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:21:0)
[17:30:00.327] Timer tick, asking Buildbucket for the build status
[17:30:00.412] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:00.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:22:0) after 1m0s
[17:31:00.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:22:0)
[17:31:00.479] Timer tick, asking Buildbucket for the build status
[17:31:00.569] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:00.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:23:0) after 1m0s
[17:32:00.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:23:0)
[17:32:00.565] Timer tick, asking Buildbucket for the build status
[17:32:00.850] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:00.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:24:0) after 1m0s
[17:33:00.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:24:0)
[17:33:00.873] Timer tick, asking Buildbucket for the build status
[17:33:01.073] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:01.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:25:0) after 1m0s
[17:34:01.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:25:0)
[17:34:01.187] Timer tick, asking Buildbucket for the build status
[17:34:01.572] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:01.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:26:0) after 1m0s
[17:35:01.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:26:0)
[17:35:01.696] Timer tick, asking Buildbucket for the build status
[17:35:01.807] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:01.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:27:0) after 1m0s
[17:36:01.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:27:0)
[17:36:01.787] Timer tick, asking Buildbucket for the build status
[17:36:01.930] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:01.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:28:0) after 1m0s
[17:37:01.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:28:0)
[17:37:01.947] Timer tick, asking Buildbucket for the build status
[17:37:02.124] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:02.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:29:0) after 1m0s
[17:38:02.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:29:0)
[17:38:02.146] Timer tick, asking Buildbucket for the build status
[17:38:02.234] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:02.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:30:0) after 1m0s
[17:39:02.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:30:0)
[17:39:02.257] Timer tick, asking Buildbucket for the build status
[17:39:02.538] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:02.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:31:0) after 1m0s
[17:40:02.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:31:0)
[17:40:02.587] Timer tick, asking Buildbucket for the build status
[17:40:02.721] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:02.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:32:0) after 1m0s
[17:41:02.718] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:32:0)
[17:41:02.718] Timer tick, asking Buildbucket for the build status
[17:41:03.019] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:03.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:33:0) after 1m0s
[17:42:03.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:33:0)
[17:42:03.085] Timer tick, asking Buildbucket for the build status
[17:42:04.438] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:34:0) after 1m0s
[17:43:04.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:34:0)
[17:43:04.527] Timer tick, asking Buildbucket for the build status
[17:43:04.883] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:04.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:35:0) after 1m0s
[17:44:04.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:35:0)
[17:44:04.950] Timer tick, asking Buildbucket for the build status
[17:44:05.127] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:05.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:36:0) after 1m0s
[17:45:05.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:36:0)
[17:45:05.237] Timer tick, asking Buildbucket for the build status
[17:45:05.383] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:05.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:37:0) after 1m0s
[17:46:05.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:37:0)
[17:46:05.512] Timer tick, asking Buildbucket for the build status
[17:46:05.671] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:38:0) after 1m0s
[17:47:05.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:38:0)
[17:47:05.695] Timer tick, asking Buildbucket for the build status
[17:47:05.937] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:05.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:39:0) after 1m0s
[17:48:06.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:39:0)
[17:48:06.026] Timer tick, asking Buildbucket for the build status
[17:48:06.256] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:06.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:40:0) after 1m0s
[17:49:06.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:40:0)
[17:49:06.296] Timer tick, asking Buildbucket for the build status
[17:49:06.427] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:06.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:41:0) after 1m0s
[17:50:06.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:41:0)
[17:50:06.498] Timer tick, asking Buildbucket for the build status
[17:50:06.778] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:06.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:42:0) after 1m0s
[17:51:06.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:42:0)
[17:51:06.796] Timer tick, asking Buildbucket for the build status
[17:51:06.961] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:06.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:43:0) after 1m0s
[17:52:07.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:43:0)
[17:52:07.024] Timer tick, asking Buildbucket for the build status
[17:52:07.186] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:07.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:44:0) after 1m0s
[17:53:07.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:44:0)
[17:53:07.241] Timer tick, asking Buildbucket for the build status
[17:53:07.339] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:45:0) after 1m0s
[17:54:07.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:45:0)
[17:54:07.322] Timer tick, asking Buildbucket for the build status
[17:54:07.428] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:07.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:46:0) after 1m0s
[17:55:07.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:46:0)
[17:55:07.486] Timer tick, asking Buildbucket for the build status
[17:55:07.613] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:07.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:47:0) after 1m0s
[17:56:07.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:47:0)
[17:56:07.632] Timer tick, asking Buildbucket for the build status
[17:56:07.931] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:07.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:48:0) after 1m0s
[17:57:08.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:48:0)
[17:57:08.004] Timer tick, asking Buildbucket for the build status
[17:57:08.606] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:08.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:49:0) after 1m0s
[17:58:08.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:49:0)
[17:58:08.686] Timer tick, asking Buildbucket for the build status
[17:58:08.876] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:08.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:50:0) after 1m0s
[17:59:08.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:50:0)
[17:59:08.982] Timer tick, asking Buildbucket for the build status
[17:59:09.557] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:09.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:51:0) after 1m0s
[18:00:09.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:51:0)
[18:00:09.695] Timer tick, asking Buildbucket for the build status
[18:00:09.805] Build 8888279603734612736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:09.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053709666485787936:52:0) after 1m0s
[18:00:41.721] Received PubSub notification, asking Buildbucket for the build status
[18:00:41.865] Build 8888279603734612736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:00:41.865] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581876041083127",
"created_by": "project:chromium",
"created_ts": "1581873047088499",
"id": "8888279603734612736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08c26f010b21cfe41f3511c795451f40c962d0a9\"}}",
"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-103-btod\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168673, \"got_angle_revision\": \"2dd40d7fa75c9e68c352b16dcf3b06d2e5a1a406\", \"got_dawn_revision\": \"215b5370bc4fa9dc5eb0004a0a21b9245296d04b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"08c26f010b21cfe41f3511c795451f40c962d0a9\", \"got_revision_cp\": \"refs/heads/master@{#741779}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"481daed34f15a118d6897d719e70230117f19cfa\", \"got_v8_revision\": \"676acee7ecba80849a77ca869458f7313b06d50b\", \"got_v8_revision_cp\": \"refs/heads/8.2.86@{#1}\", \"got_webrtc_revision\": \"966bcc4bd5cc7aee5963e784ddf0caf668b2d6e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30527}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08c26f010b21cfe41f3511c795451f40c962d0a9\", \"swarm_hashes_refs/heads/master(at){#741779}_without_patch\": {\"accessibility_unittests\": \"77f31d13a21915d34cce5f125441c93543a76857\", \"angle_unittests\": \"9ed62a4a8b8530e0c4720ebd29bb3cad97e142fa\", \"app_shell_unittests\": \"59f8537b90ac61c626dfb889c193be3ae04f7082\", \"aura_unittests\": \"a2f154028a9873d7b9573ec445c05bb6b1ca8355\", \"base_unittests\": \"8eb1eb8ed9a765d7e089a49026a7408755c4c57f\", \"base_util_unittests\": \"247f2b6d2d1a520255b8a462ea858437da74837c\", \"blink_common_unittests\": \"3e671b4ebf580e5013ad33cfacd254f59708e70b\", \"blink_fuzzer_unittests\": \"3c1d3f96be8ce410b69b85a8d6cee16c39ea5264\", \"blink_heap_unittests\": \"060d1cb6fbd4e123ab4b25fff51d402510b75316\", \"blink_platform_unittests\": \"6ced63b980ddbda37747f59b47e5f13ed29fc15f\", \"blink_python_tests\": \"7b17598446ecdbff429bb6275e9c34ec5fc4f2a9\", \"blink_unittests\": \"7a87d871a5af9dd1b7ccac014fc806fda48be058\", \"blink_web_tests\": \"957f94c0955ca8ad63aba1f5cfc03c7a7997354e\", \"boringssl_crypto_tests\": \"9927cc1e99d1487b4ad37293c25e076ff7dfb475\", \"boringssl_ssl_tests\": \"ca8450965b384932401dd32fb1a196c1b8f2b90a\", \"browser_tests\": \"8e468b039b71549a3bf34e3cffa6e071f00585b1\", \"cacheinvalidation_unittests\": \"615294346db7f37481d645ada108521ba69a3225\", \"capture_unittests\": \"bc32766bc553d3b20e6600704ff49ccef4494b75\", \"cast_unittests\": \"51fcd482e505d923e12f8a7f7b414bd566067504\", \"cc_unittests\": \"fab1d4cf91766c3dbc7735ba663f7b6784e2d77e\", \"chrome_app_unittests\": \"2ef8ca92335c2d2fd0b67f3f732e4e8141ceddf0\", \"chromedriver_unittests\": \"4b3baec1c80db96520501ff9ef680ede72a8b3a5\", \"components_browsertests\": \"7dff03425e490c4b0778ca1918bd6bf8c4e3c392\", \"components_unittests\": \"e9fd8e0296be6977c3a391b462215df742b5eb81\", \"compositor_unittests\": \"13648386e50a1947ec6f1e2f6971afbe1ead0244\", \"content_browsertests\": \"982371da1fda2f5c8af3eac59bc5899b6e80c611\", \"content_shell_crash_test\": \"e409f0b0b78309987cbeb8e66fe0260f8e7aa1bf\", \"content_unittests\": \"9f6010b969d252c36e52d371fbdaac034e4cd730\", \"crashpad_tests\": \"74b7448adf864686aa5ad81e0e2497db9295d792\", \"cronet_tests\": \"18826e7bb774d61ad334e23933e338831a24f36d\", \"cronet_unittests\": \"0f8b0f73e1ab7be315aa322d5a2a2d22168b74cc\", \"crypto_unittests\": \"df8d2afb2c55ec3ac22f88365f9e38b2b1578b07\", \"dbus_unittests\": \"3bcdbd2351dd00b87692f6e6150f8bcb2cdbef74\", \"device_unittests\": \"431ba309fe09daf3d199642f60fafddf8a798d29\", \"display_unittests\": \"db85482de36f9b12643c98f79d28e652a34f762f\", \"events_unittests\": \"f1c46f29c6565b193bb5cc06d7f5f7f4504fa970\", \"extensions_browsertests\": \"5884e407ac87ea3c99846b9b295b39bef6064157\", \"extensions_unittests\": \"9918877f36f3c10baa198680bc3e4a423b84c1ce\", \"filesystem_service_unittests\": \"e95918791b8dd508398bda1de160c6ad624e4843\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"4a8316e98a497493d4f5afea5731b9d4ff609d6e\", \"gfx_unittests\": \"951662f7f78051b4b181d732fb014e50a0239870\", \"gin_unittests\": \"bfb909627fdade08190b14682d33f6f781bea916\", \"google_apis_unittests\": \"7bd7dc7cee94cb4b20cbdf2d3f84ddbd112d9135\", \"gpu_unittests\": \"ee78d782700e5d5cd02126077d7dbf88a714f542\", \"grit_python_unittests\": \"314a136826c68f2b20f2d52ddf6f5e567311beb1\", \"gwp_asan_unittests\": \"124524fe994b7cf83203041ef7d85f9b2523d970\", \"headless_browsertests\": \"9c37fd9129b979c00b3a0aeff22d0b17b20ec1fb\", \"headless_unittests\": \"1aa87c875f450733928d1734a376389433e6559e\", \"interactive_ui_tests\": \"ea0ccddb5bb9ccdec158d8dcc1b933b9d04bd103\", \"ipc_tests\": \"b2641cdfd05932498994338d1c92801f074ed0b0\", \"jingle_unittests\": \"896b69794e13a796a49bae0122bb94bea171c6f5\", \"latency_unittests\": \"680e2c8e5a3f9303d2f5d4184fcfe2e536c4fcb8\", \"libjingle_xmpp_unittests\": \"d548ae016dec854d620ada57e917df0c5f3c8b46\", \"media_blink_unittests\": \"03ccbba3d94eccc324a50ed3b0f0292c1b5079a9\", \"media_service_unittests\": \"b14d0fb9d8ba78abddd724a873faa15cee1e6fa6\", \"media_unittests\": \"d52fc4b1481a26d7a3ef832702b27e700fc6b634\", \"message_center_unittests\": \"a5a026cd5365e656bb7faaeff284ff3ded6a6df8\", \"metrics_python_tests\": \"356c310f65550be9987153365523bb6de7aaed3e\", \"midi_unittests\": \"602b03c886e8c1eb8af7fd073a7451b3abb0014e\", \"mojo_core_unittests\": \"5555951f1e9cc8037fb4c89c2acaba5eadcc3994\", \"mojo_unittests\": \"1c16d187754566692cf471c1989008bd234507da\", \"nacl_helper_nonsfi_unittests\": \"5e4b43366c70b90f228749aac4817bfcc3e0aa8c\", \"nacl_loader_unittests\": \"21afffe0e7799fc95935e361ad7373d9c1755e5a\", \"native_theme_unittests\": \"207c2a9522cc621b1b517e823d42b626853a12d0\", \"net_unittests\": \"9c84c7ebc4c272b96990715a4774197b9c9df6b0\", \"pdf_unittests\": \"4a761ce60a5b2f472a2f9cbd5f27772edc3e6732\", \"perfetto_unittests\": \"ee178ab6d40074fa5e8504c77795b842ae9a5618\", \"ppapi_unittests\": \"2484c5d1723ee12e5b8b449c5aec3ebef26266ea\", \"printing_unittests\": \"66a1c0c8c2d1fd346a01f046f5a2b919cde5fd16\", \"remoting_unittests\": \"b7a16e1f67944ea16e570aabbdf4b9152337cd0d\", \"sandbox_linux_unittests\": \"2f14b75e6fc90c0eaaff009c54bd8e45911915ad\", \"service_manager_unittests\": \"20c90934f634faa97ad791c13d5ac75a88d5b55e\", \"services_unittests\": \"7899abba90b77380c1458b668bc1553839a3f7c4\", \"shell_dialogs_unittests\": \"ccbdbd861855f646cf7adb498092da625efce940\", \"skia_unittests\": \"80a499d54159fbb2a7266c78c379d17795acce9f\", \"snapshot_unittests\": \"cc56e4f11789110175c3b2dbfbf6d3c244d0568f\", \"sql_unittests\": \"004333257e2f8309f6b70416273ba520965cfe8e\", \"storage_unittests\": \"1d624343dd8f7af3249f1227976cd786d98dd7c0\", \"sync_integration_tests\": \"b9b8149be608f5e21278b794801288412ee0f6e9\", \"telemetry_gpu_unittests\": \"eaff5c128543042fb3d1c5600b013fbce3b1fca9\", \"telemetry_perf_unittests\": \"2a1200070c8c99d3ec45b16401c738e4e9f9bc70\", \"telemetry_unittests\": \"5a27f1dc8e84ebf669810a73793d18786f25f216\", \"traffic_annotation_auditor_unittests\": \"4a97d93f399f3637f41143ffd0e8401d7126e9e7\", \"ui_base_unittests\": \"063eb41cf77b3a6d0fb03318cc9e4097cfe96991\", \"ui_touch_selection_unittests\": \"63f51ddfe51784a71d25d5ea0581c1ae937fde69\", \"unit_tests\": \"a73114d7a5bdbcc46fe594b33ac51f7feddab96f\", \"url_unittests\": \"0afbd11e9906b7444a9383e662e319e0f718f68d\", \"views_perftests\": \"1bd2830bf1208483d7376ae23c1a608fefffd2ce\", \"views_unittests\": \"40349ff9273791f6dfc5477063bf7c9252f0ad4d\", \"viz_unittests\": \"809f80c89df78c00c49dddd68aa83f1b69afba56\", \"vr_common_unittests\": \"d60fee9117ab76e611c55e0d676114bfb42155fd\", \"vr_pixeltests\": \"943e0998097bd5e5c73fd962286eaaec1f3d8750\", \"webdriver_wpt_tests\": \"9ee1d8d72e2b1899254a6060d1c8f2dc5e446ec5\", \"weblayer_browsertests\": \"8890264865bfb9ad0514608fafe9db1a26274528\", \"wm_unittests\": \"b45df3e164dfcae114cec54f60cb220e6fcc2fbd\", \"wtf_unittests\": \"88d7bc3827636331ef1d12395e9691f4e6b78c2e\", \"xr_browser_tests\": \"2fcf4ac346f49baf8c24c704bc3a7008c7870351\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_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-103-btod\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581873305653910",
"status": "COMPLETED",
"status_changed_ts": "1581876041379517",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168673",
"builder:Linux Builder (dbg)",
"buildset:commit/git/08c26f010b21cfe41f3511c795451f40c962d0a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08c26f010b21cfe41f3511c795451f40c962d0a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053709666485787936",
"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/8888279603734612736/+/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:4a67ccb216972d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581876041384425",
"url": "https://ci.chromium.org/b/8888279603734612736",
"utcnow_ts": "1581876041855027"
}
}
[18:00:41.865] Invocation finished in 49m56.78405923s with status SUCCEEDED