[23:43:36.772] New invocation is queued and will start shortly
[23:43:38.144] Starting the invocation (attempt 1)
[23:43:38.198] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:43:38.198] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:43:38.198] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050151668153274448",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5d23438763af908c25c53165436daab62a49496c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050151668153274448",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/5d23438763af908c25c53165436daab62a49496c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d23438763af908c25c53165436daab62a49496c",
"gitiles_ref:refs/heads/master"
]
}
[23:43:39.042] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585266218303808",
"id": "8884721605834454272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d23438763af908c25c53165436daab62a49496c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585266218717600",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5d23438763af908c25c53165436daab62a49496c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d23438763af908c25c53165436daab62a49496c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050151668153274448",
"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/8884721605834454272/+/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": "1585266218717716",
"url": "https://ci.chromium.org/b/8884721605834454272",
"utcnow_ts": "1585266218994864"
}
}
[23:43:39.042] Task URL: https://ci.chromium.org/b/8884721605834454272
[23:43:39.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:2:0) after 1m0s
[23:44:39.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:2:0)
[23:44:39.208] Timer tick, asking Buildbucket for the build status
[23:44:39.691] Build 8884721605834454272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:39.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:3:0) after 1m0s
[23:45:39.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:3:0)
[23:45:39.782] Timer tick, asking Buildbucket for the build status
[23:45:39.975] Build 8884721605834454272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:39.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:4:0) after 1m0s
[23:46:40.030] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:4:0)
[23:46:40.030] Timer tick, asking Buildbucket for the build status
[23:46:40.234] Build 8884721605834454272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:40.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:5:0) after 1m0s
[23:47:40.340] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:5:0)
[23:47:40.340] Timer tick, asking Buildbucket for the build status
[23:47:40.770] Build 8884721605834454272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:40.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:6:0) after 1m0s
[23:48:10.187] Received PubSub notification, asking Buildbucket for the build status
[23:48:10.322] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:40.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:6:0)
[23:48:40.869] Timer tick, asking Buildbucket for the build status
[23:48:41.036] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:41.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:8:0) after 1m0s
[23:49:41.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:8:0)
[23:49:41.251] Timer tick, asking Buildbucket for the build status
[23:49:50.200] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:50.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:9:0) after 1m0s
[23:50:50.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:9:0)
[23:50:50.293] Timer tick, asking Buildbucket for the build status
[23:50:50.444] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:50.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:10:0) after 1m0s
[23:51:50.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:10:0)
[23:51:50.562] Timer tick, asking Buildbucket for the build status
[23:51:50.873] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:50.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:11:0) after 1m0s
[23:52:50.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:11:0)
[23:52:50.926] Timer tick, asking Buildbucket for the build status
[23:52:51.125] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:51.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:12:0) after 1m0s
[23:53:51.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:12:0)
[23:53:51.164] Timer tick, asking Buildbucket for the build status
[23:53:51.366] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:51.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:13:0) after 1m0s
[23:54:51.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:13:0)
[23:54:51.510] Timer tick, asking Buildbucket for the build status
[23:54:52.064] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:52.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:14:0) after 1m0s
[23:55:52.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:14:0)
[23:55:52.222] Timer tick, asking Buildbucket for the build status
[23:55:52.473] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:52.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:15:0) after 1m0s
[23:56:52.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:15:0)
[23:56:52.552] Timer tick, asking Buildbucket for the build status
[23:56:52.672] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:52.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:16:0) after 1m0s
[23:57:52.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:16:0)
[23:57:52.753] Timer tick, asking Buildbucket for the build status
[23:57:53.176] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:53.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:17:0) after 1m0s
[23:58:53.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:17:0)
[23:58:53.327] Timer tick, asking Buildbucket for the build status
[23:58:53.751] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:53.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:18:0) after 1m0s
[23:59:54.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:18:0)
[23:59:54.374] Timer tick, asking Buildbucket for the build status
[23:59:54.511] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:54.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:19:0) after 1m0s
[00:00:54.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:19:0)
[00:00:54.619] Timer tick, asking Buildbucket for the build status
[00:00:55.068] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:55.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:20:0) after 1m0s
[00:01:55.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:20:0)
[00:01:55.098] Timer tick, asking Buildbucket for the build status
[00:01:55.185] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:55.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:21:0) after 1m0s
[00:02:55.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:21:0)
[00:02:55.321] Timer tick, asking Buildbucket for the build status
[00:02:55.494] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:55.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:22:0) after 1m0s
[00:03:55.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:22:0)
[00:03:55.581] Timer tick, asking Buildbucket for the build status
[00:03:55.819] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:55.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:23:0) after 1m0s
[00:04:55.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:23:0)
[00:04:55.870] Timer tick, asking Buildbucket for the build status
[00:04:57.036] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:57.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:24:0) after 1m0s
[00:05:57.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:24:0)
[00:05:57.059] Timer tick, asking Buildbucket for the build status
[00:05:57.532] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:57.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:25:0) after 1m0s
[00:06:57.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:25:0)
[00:06:57.633] Timer tick, asking Buildbucket for the build status
[00:06:58.012] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:26:0) after 1m0s
[00:07:58.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:26:0)
[00:07:58.036] Timer tick, asking Buildbucket for the build status
[00:07:58.659] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:58.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:27:0) after 1m0s
[00:08:58.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:27:0)
[00:08:58.677] Timer tick, asking Buildbucket for the build status
[00:08:58.961] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:58.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:28:0) after 1m0s
[00:09:59.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:28:0)
[00:09:59.016] Timer tick, asking Buildbucket for the build status
[00:09:59.188] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:59.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:29:0) after 1m0s
[00:10:59.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:29:0)
[00:10:59.260] Timer tick, asking Buildbucket for the build status
[00:10:59.568] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:30:0) after 1m0s
[00:11:59.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:30:0)
[00:11:59.553] Timer tick, asking Buildbucket for the build status
[00:11:59.935] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:59.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:31:0) after 1m0s
[00:12:59.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:31:0)
[00:12:59.948] Timer tick, asking Buildbucket for the build status
[00:13:00.097] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:00.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:32:0) after 1m0s
[00:14:00.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:32:0)
[00:14:00.096] Timer tick, asking Buildbucket for the build status
[00:14:01.413] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:01.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:33:0) after 1m0s
[00:15:01.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:33:0)
[00:15:01.447] Timer tick, asking Buildbucket for the build status
[00:15:01.714] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:01.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:34:0) after 1m0s
[00:16:01.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:34:0)
[00:16:01.717] Timer tick, asking Buildbucket for the build status
[00:16:01.926] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:01.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:35:0) after 1m0s
[00:17:01.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:35:0)
[00:17:01.987] Timer tick, asking Buildbucket for the build status
[00:17:02.103] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:02.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:36:0) after 1m0s
[00:18:02.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:36:0)
[00:18:02.543] Timer tick, asking Buildbucket for the build status
[00:18:02.810] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:02.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:37:0) after 1m0s
[00:19:03.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:37:0)
[00:19:03.074] Timer tick, asking Buildbucket for the build status
[00:19:03.365] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:03.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:38:0) after 1m0s
[00:20:03.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:38:0)
[00:20:03.442] Timer tick, asking Buildbucket for the build status
[00:20:03.681] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:03.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:39:0) after 1m0s
[00:21:03.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:39:0)
[00:21:03.897] Timer tick, asking Buildbucket for the build status
[00:21:04.185] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:04.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:40:0) after 1m0s
[00:22:04.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:40:0)
[00:22:04.307] Timer tick, asking Buildbucket for the build status
[00:22:04.418] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:04.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:41:0) after 1m0s
[00:23:04.501] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:41:0)
[00:23:04.501] Timer tick, asking Buildbucket for the build status
[00:23:04.729] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:04.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:42:0) after 1m0s
[00:24:04.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:42:0)
[00:24:04.786] Timer tick, asking Buildbucket for the build status
[00:24:04.871] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:04.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:43:0) after 1m0s
[00:25:04.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:43:0)
[00:25:04.945] Timer tick, asking Buildbucket for the build status
[00:25:05.240] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:05.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:44:0) after 1m0s
[00:26:05.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:44:0)
[00:26:05.407] Timer tick, asking Buildbucket for the build status
[00:26:06.099] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:06.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:45:0) after 1m0s
[00:27:06.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:45:0)
[00:27:06.120] Timer tick, asking Buildbucket for the build status
[00:27:06.358] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:06.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:46:0) after 1m0s
[00:28:06.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:46:0)
[00:28:06.442] Timer tick, asking Buildbucket for the build status
[00:28:06.602] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:06.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:47:0) after 1m0s
[00:29:06.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:47:0)
[00:29:06.630] Timer tick, asking Buildbucket for the build status
[00:29:06.758] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:06.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:48:0) after 1m0s
[00:30:06.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:48:0)
[00:30:06.783] Timer tick, asking Buildbucket for the build status
[00:30:08.600] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:49:0) after 1m0s
[00:31:08.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:49:0)
[00:31:08.627] Timer tick, asking Buildbucket for the build status
[00:31:08.802] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:08.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:50:0) after 1m0s
[00:32:08.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:50:0)
[00:32:08.811] Timer tick, asking Buildbucket for the build status
[00:32:09.186] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:09.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:51:0) after 1m0s
[00:33:09.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:51:0)
[00:33:09.192] Timer tick, asking Buildbucket for the build status
[00:33:09.701] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:52:0) after 1m0s
[00:34:09.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:52:0)
[00:34:09.706] Timer tick, asking Buildbucket for the build status
[00:34:10.255] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:10.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:53:0) after 1m0s
[00:35:10.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:53:0)
[00:35:10.292] Timer tick, asking Buildbucket for the build status
[00:35:10.669] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:10.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:54:0) after 1m0s
[00:36:10.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:54:0)
[00:36:10.656] Timer tick, asking Buildbucket for the build status
[00:36:10.927] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:10.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:55:0) after 1m0s
[00:37:11.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:55:0)
[00:37:11.045] Timer tick, asking Buildbucket for the build status
[00:37:11.310] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:11.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:56:0) after 1m0s
[00:38:11.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:56:0)
[00:38:11.416] Timer tick, asking Buildbucket for the build status
[00:38:11.764] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:11.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:57:0) after 1m0s
[00:39:11.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:57:0)
[00:39:11.845] Timer tick, asking Buildbucket for the build status
[00:39:13.726] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:13.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:58:0) after 1m0s
[00:40:13.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:58:0)
[00:40:13.772] Timer tick, asking Buildbucket for the build status
[00:40:14.000] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:14.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:59:0) after 1m0s
[00:41:14.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:59:0)
[00:41:14.174] Timer tick, asking Buildbucket for the build status
[00:41:14.609] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:14.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:60:0) after 1m0s
[00:42:14.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:60:0)
[00:42:14.707] Timer tick, asking Buildbucket for the build status
[00:42:15.128] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:15.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:61:0) after 1m0s
[00:43:15.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:61:0)
[00:43:15.364] Timer tick, asking Buildbucket for the build status
[00:43:15.877] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:15.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:62:0) after 1m0s
[00:44:15.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:62:0)
[00:44:15.976] Timer tick, asking Buildbucket for the build status
[00:44:16.290] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:16.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:63:0) after 1m0s
[00:45:16.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:63:0)
[00:45:16.284] Timer tick, asking Buildbucket for the build status
[00:45:16.457] Build 8884721605834454272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:16.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050151668153274448:64:0) after 1m0s
[00:45:46.027] Received PubSub notification, asking Buildbucket for the build status
[00:45:46.231] Build 8884721605834454272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:45:46.235] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585269944975987",
"created_by": "project:chromium",
"created_ts": "1585266218303808",
"id": "8884721605834454272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d23438763af908c25c53165436daab62a49496c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$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-23-u593\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170235, \"got_angle_revision\": \"bf6b8d4a16ae13243fee8718e98c8658f4fab218\", \"got_dawn_revision\": \"0847cb4637366d15efdb09c57d9b53ea720587fb\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"5d23438763af908c25c53165436daab62a49496c\", \"got_revision_cp\": \"refs/heads/master@{#753821}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"9f2dd0d07c99cc7c274287b408960cca53678bee\", \"got_v8_revision\": \"319db21221510c873cc3cea12869e0f675c5ec0f\", \"got_v8_revision_cp\": \"refs/heads/8.3.87@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d23438763af908c25c53165436daab62a49496c\", \"swarm_hashes_refs/heads/master(at){#753821}_without_patch\": {\"accessibility_unittests\": \"d807ecfd150854f07c9a38cec586eaab53608838\", \"angle_unittests\": \"8df497ea839df3b44af8d6e145533ec4d0b80f32\", \"app_shell_unittests\": \"01f080f40a1665a96664792b0e4d4864555b552c\", \"aura_unittests\": \"09a2977fe35f92db2e60d14a91b93f22b4ec66a4\", \"base_unittests\": \"0c0a4fca849bc6b413b00ad3d4b78fdac600fb76\", \"base_util_unittests\": \"00574fc5337fcc5ef83aedc6af81fda409b0ed00\", \"blink_common_unittests\": \"7d5cdc963f1160028dd1e2c92e8bebff222fb688\", \"blink_fuzzer_unittests\": \"2a4ef3f37081da554dc3bd06d9dba107e53d91c7\", \"blink_heap_unittests\": \"1ad613331911edb3efbbca6a1bc0c61b01169772\", \"blink_platform_unittests\": \"de640c9cce1233e4481e22964dc48854de030ac4\", \"blink_python_tests\": \"dd0fd2a9dfa86f1b4b65551f14f8901b9b031315\", \"blink_unittests\": \"55fe9dd286dc8780c9aa0cacbef48b07867d41ed\", \"blink_web_tests\": \"193d8d9c018bfefb012fb7744f32b6a14881c7c4\", \"boringssl_crypto_tests\": \"ee386c9dcc705b0f8b05aa21506236b305556115\", \"boringssl_ssl_tests\": \"c5233719412a73a445c3e5b3efaa626f01f7eb5a\", \"browser_tests\": \"dff4bc57c94514bcec75c7bc2eea2f3cae42aebd\", \"cacheinvalidation_unittests\": \"627f859ddd277f99cec100feaf1e62c7e3d870ff\", \"capture_unittests\": \"86ad83c13a7ea366ff08f4b18447d1bc314f6643\", \"cast_unittests\": \"9ad15da783fe1e6ed79bf874d4bd7fa91229ac5e\", \"cc_unittests\": \"21b7ba6c8206308e0a5b957861ab2a2c5490ff53\", \"chrome_app_unittests\": \"d186338e73ffe552056ce26aea60991e696547b5\", \"chromedriver_unittests\": \"2bd6f0ce093a92571561ada5354dd275b17bfda1\", \"components_browsertests\": \"7fb1f8257a3d7db118abd1ea3abbaf27d351848a\", \"components_unittests\": \"3d1a0c511bc7ee3705b63352b045fb3c92167b30\", \"compositor_unittests\": \"184a008547dc8f477a92f523f5791410a83ccc44\", \"content_browsertests\": \"07ef1b46ab9598d4d20a3b5831b3fbee50d4fd42\", \"content_shell_crash_test\": \"a352b9264d96962ee7476448f9ffe5e25b1a28c4\", \"content_unittests\": \"2b5d4afa4bd657400762febebb8de5949e5a7a16\", \"crashpad_tests\": \"547da4391211b699057e03d5e44bb3d7341b2953\", \"cronet_tests\": \"c5251c56592e48ba6f3b4d6309528c5347bd6f8e\", \"cronet_unittests\": \"0dd4c4e16423effb7f9238b235a3675d96cd201c\", \"crypto_unittests\": \"7f3c7cfe36c8488dda6b5905927f85477c4828fb\", \"dbus_unittests\": \"f27e48af4d2a685b43b0397534fc5f6ab712c5d1\", \"device_unittests\": \"f5a3d186868e5a050d5f6565198f5cf8eab9ef8c\", \"display_unittests\": \"11e411cffcbbce856bbe45f0b9a45e5f9c82f627\", \"events_unittests\": \"18b4dd75b92fca47536b9134951e57aac8890def\", \"extensions_browsertests\": \"f28fe24b3e6ad8661f1bcb54801b54ffa4c351f1\", \"extensions_unittests\": \"b13553b626bd9117a750041d90ac4d46b9fdc8a6\", \"filesystem_service_unittests\": \"a1077af6a93f76bc80e6ef685aac997dd2f136fa\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"f55a124784dd079e8a61276aea05ba7d267284e3\", \"gfx_unittests\": \"641ddda0f7cfaf99a8c1524019090b4aceadacaa\", \"gin_unittests\": \"8e3d05d111b8a0433d1b0b7effc9024d8597ac76\", \"google_apis_unittests\": \"8a81cfb6a04336b54404c866c9511568ca30ea46\", \"gpu_unittests\": \"5b09cffd9d128b3e9b56cb1ca8bec445889e72c3\", \"grit_python_unittests\": \"920c6b3d7ae5f4f6a7545c1f01eb545d63387104\", \"gwp_asan_unittests\": \"52ffca03f6940d8e51d5115bc8ebef9572a55c25\", \"headless_browsertests\": \"db72711b79e635cb48b608b4522cb1ac241cdca4\", \"headless_unittests\": \"9ad838e668c0b34ab1e7b7f4f16d42ed06366e47\", \"interactive_ui_tests\": \"e3d2660ff9ff3734c3d38f8d955021753fd5caaf\", \"ipc_tests\": \"9f2c819c5010d14101ba5044f4079231b70dd689\", \"jingle_unittests\": \"37552bdef52d631e4da5a71126daeca2da4bafb2\", \"latency_unittests\": \"4fd922f7f7be4ea54eb633270bec5a959e898599\", \"libjingle_xmpp_unittests\": \"85a8a458eff6a4aed3c235a63ba0520440f115b0\", \"media_blink_unittests\": \"ff936b7f0fce9d261a97464bc4a20bde2db13398\", \"media_service_unittests\": \"58c8dd4c322b296267725cf22aace58952d7b836\", \"media_unittests\": \"209a8dc211214360edb8a1b9b398f6f37efa78c3\", \"message_center_unittests\": \"529e9d9255f326131a30f0a088aceac4d5ee9d54\", \"metrics_python_tests\": \"847cde3ef873e1a9470c1e0606b18a97ff9c6559\", \"midi_unittests\": \"1417f7caa4fc82c9686239bffbd176e0f1c86b0c\", \"mojo_core_unittests\": \"ba227fe9f04f90db96552614ed4e922eae15355c\", \"mojo_unittests\": \"36447f73e70d8e6540e9b36a54ea36aa1ff08eaf\", \"nacl_helper_nonsfi_unittests\": \"675bcfdfd0721864e885c90c9396d5d98c8bcfaa\", \"nacl_loader_unittests\": \"d105d48f81640e4a181242ff15b69bbc4342e9bc\", \"native_theme_unittests\": \"c6fd0e17d9b086910f79239b784e5fd9515b8269\", \"net_unittests\": \"fd8c8253c89f53a0554e60d625fedf72d966b1e4\", \"pdf_unittests\": \"026be6863822cb9128c34aad5f732f7b3aaee3c1\", \"perfetto_unittests\": \"d1c0af38cf449dff3ff2744833bc546ddc364725\", \"ppapi_unittests\": \"a9727672c0ac77e9b02fd1542e4a79d394f63213\", \"printing_unittests\": \"0351493b4c602442c90065884010a3b98ab1d5a7\", \"remoting_unittests\": \"5ab027e77eddb0fd434e1ed012a780e2323c06f4\", \"sandbox_linux_unittests\": \"49fbd5738697264211883cd69e6fc86226c015f2\", \"service_manager_unittests\": \"938cd8179a405391a4d99acceba28eb0cdcdea3c\", \"services_unittests\": \"a79e52cf4b2af86ea56ea27aa362ee9c6428895b\", \"shell_dialogs_unittests\": \"a3b68cb77763890e44dadf73ee678a48c71e55b2\", \"skia_unittests\": \"60d43265eb99c7c3c2343d5097195a1da3c9e520\", \"snapshot_unittests\": \"cd05926cc1ae38371e07a56222499d9759645424\", \"sql_unittests\": \"5462511eb9ae2a2dc96f2a987274f78cfdc49781\", \"storage_unittests\": \"774f199d4f997ce326538840c3597c8b12d02dec\", \"sync_integration_tests\": \"a5ef063cf5c535f4d6b611fc03ade64e29444dcd\", \"telemetry_gpu_unittests\": \"3cda712d64f384bf318ee196796d3e955bcacb07\", \"telemetry_perf_unittests\": \"d35be35988336e059ce77386bb4f297c1bfb2550\", \"telemetry_unittests\": \"05489e46785043f4f7b5bca9db0c0cbb387416fe\", \"traffic_annotation_auditor_unittests\": \"488f2bb5443e80c41ca5c27d5e734b9026dc4afd\", \"ui_base_unittests\": \"fd7f26ccd2c010cefa3bec013535021b238b80a9\", \"ui_touch_selection_unittests\": \"bef68215ea0a94e72fdbfa700f7d523109e027ff\", \"unit_tests\": \"d5c7cf09115fe792e8438495ea3c9dd65b3be063\", \"url_unittests\": \"ff3a7e2d1975b66e19663f30f43ea0ebc2ec6537\", \"views_perftests\": \"3d341761083b9418ca2d251bb54b955be50a5604\", \"views_unittests\": \"b1eb09df9595dd460f02a3261eb963a2e859aed9\", \"viz_unittests\": \"394e150e72fe855a831817955c95a256e94e798c\", \"vr_common_unittests\": \"96fdef3138a59738e0612bea6719521370bb9590\", \"vr_pixeltests\": \"8539bb43760595e140de96cfc685405d9a2deacc\", \"webdriver_wpt_tests\": \"a0417ec9d173b60d026d1682d8d75557ab261ff8\", \"weblayer_browsertests\": \"54d98dbf9a7d37ead6217a5eaac8ed8eb12b45b8\", \"wm_unittests\": \"c73dd9fb9a078f34514f2ca09bd0c57379cbfbe9\", \"wtf_unittests\": \"28616b779efa11a8399e2e337ea196cf89c8891e\", \"xr_browser_tests\": \"699f27b97483ead7b8a41de5c8e83bd774b5c75c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_93045653dd8238f9b5a16956c3abf0c7402036195ded7f89ac6ed546092c13e3_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_c38832248eaa59248ebe0e5d5ae62a6bc955f53f6a99a9c0e5cded93d679f9bc_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-23-u593\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"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\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585266489177474",
"status": "COMPLETED",
"status_changed_ts": "1585269945349218",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170235",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5d23438763af908c25c53165436daab62a49496c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d23438763af908c25c53165436daab62a49496c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050151668153274448",
"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/8884721605834454272/+/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:4b320c8c39c42b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585269945430262",
"url": "https://ci.chromium.org/b/8884721605834454272",
"utcnow_ts": "1585269946222518"
}
}
[00:45:46.235] Invocation finished in 1h2m9.525689522s with status SUCCEEDED