[03:00:27.251] New invocation is queued and will start shortly
[03:00:28.335] Starting the invocation (attempt 1)
[03:00:28.371] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:28.371] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:28.371] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022507209180344192",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022507209180344192",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"gitiles_ref:refs/heads/master"
]
}
[03:00:29.139] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611630028470636",
"id": "8857077147225079024",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611630028991028",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179979",
"builder:Linux Builder (dbg)",
"buildset:commit/git/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022507209180344192",
"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/8857077147225079024/+/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": "1611630028991183",
"url": "https://ci.chromium.org/b/8857077147225079024",
"utcnow_ts": "1611630029129180"
}
}
[03:00:29.139] Task URL: https://ci.chromium.org/b/8857077147225079024
[03:00:29.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:2:0) after 1m0s
[03:00:41.669] Received PubSub notification, asking Buildbucket for the build status
[03:00:41.830] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:2:0)
[03:01:29.166] Timer tick, asking Buildbucket for the build status
[03:01:29.417] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:4:0) after 1m0s
[03:02:29.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:4:0)
[03:02:29.512] Timer tick, asking Buildbucket for the build status
[03:02:29.877] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:29.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:5:0) after 1m0s
[03:03:29.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:5:0)
[03:03:29.926] Timer tick, asking Buildbucket for the build status
[03:03:30.028] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:6:0) after 1m0s
[03:04:30.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:6:0)
[03:04:30.045] Timer tick, asking Buildbucket for the build status
[03:04:30.177] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:30.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:7:0) after 1m0s
[03:05:30.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:7:0)
[03:05:30.349] Timer tick, asking Buildbucket for the build status
[03:05:30.519] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:30.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:8:0) after 1m0s
[03:06:30.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:8:0)
[03:06:30.650] Timer tick, asking Buildbucket for the build status
[03:06:30.752] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:30.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:9:0) after 1m0s
[03:07:30.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:9:0)
[03:07:30.776] Timer tick, asking Buildbucket for the build status
[03:07:30.906] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:10:0) after 1m0s
[03:08:30.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:10:0)
[03:08:30.975] Timer tick, asking Buildbucket for the build status
[03:08:31.402] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:11:0) after 1m0s
[03:09:31.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:11:0)
[03:09:31.497] Timer tick, asking Buildbucket for the build status
[03:09:31.554] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:31.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:12:0) after 1m0s
[03:10:31.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:12:0)
[03:10:31.670] Timer tick, asking Buildbucket for the build status
[03:10:31.806] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:31.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:13:0) after 1m0s
[03:11:31.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:13:0)
[03:11:31.851] Timer tick, asking Buildbucket for the build status
[03:11:31.930] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:31.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:14:0) after 1m0s
[03:12:31.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:14:0)
[03:12:31.948] Timer tick, asking Buildbucket for the build status
[03:12:32.554] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:32.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:15:0) after 1m0s
[03:13:32.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:15:0)
[03:13:32.613] Timer tick, asking Buildbucket for the build status
[03:13:32.787] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:32.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:16:0) after 1m0s
[03:14:32.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:16:0)
[03:14:32.890] Timer tick, asking Buildbucket for the build status
[03:14:32.973] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:32.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:17:0) after 1m0s
[03:15:33.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:17:0)
[03:15:33.066] Timer tick, asking Buildbucket for the build status
[03:15:34.022] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:34.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:18:0) after 1m0s
[03:16:34.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:18:0)
[03:16:34.067] Timer tick, asking Buildbucket for the build status
[03:16:34.136] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:34.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:19:0) after 1m0s
[03:17:34.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:19:0)
[03:17:34.123] Timer tick, asking Buildbucket for the build status
[03:17:34.188] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:34.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:20:0) after 1m0s
[03:18:34.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:20:0)
[03:18:34.203] Timer tick, asking Buildbucket for the build status
[03:18:34.274] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:34.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:21:0) after 1m0s
[03:19:34.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:21:0)
[03:19:34.262] Timer tick, asking Buildbucket for the build status
[03:19:34.333] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:34.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:22:0) after 1m0s
[03:20:34.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:22:0)
[03:20:34.354] Timer tick, asking Buildbucket for the build status
[03:20:34.451] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:34.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:23:0) after 1m0s
[03:21:34.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:23:0)
[03:21:34.477] Timer tick, asking Buildbucket for the build status
[03:21:34.570] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:34.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:24:0) after 1m0s
[03:22:34.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:24:0)
[03:22:34.553] Timer tick, asking Buildbucket for the build status
[03:22:34.793] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:34.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:25:0) after 1m0s
[03:23:34.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:25:0)
[03:23:34.826] Timer tick, asking Buildbucket for the build status
[03:23:34.893] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:34.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:26:0) after 1m0s
[03:24:34.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:26:0)
[03:24:34.922] Timer tick, asking Buildbucket for the build status
[03:24:35.042] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:35.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:27:0) after 1m0s
[03:25:35.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:27:0)
[03:25:35.153] Timer tick, asking Buildbucket for the build status
[03:25:35.624] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:35.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:28:0) after 1m0s
[03:26:35.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:28:0)
[03:26:35.717] Timer tick, asking Buildbucket for the build status
[03:26:35.771] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:35.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:29:0) after 1m0s
[03:27:35.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:29:0)
[03:27:35.909] Timer tick, asking Buildbucket for the build status
[03:27:36.027] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:30:0) after 1m0s
[03:28:36.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:30:0)
[03:28:36.360] Timer tick, asking Buildbucket for the build status
[03:28:36.446] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:36.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:31:0) after 1m0s
[03:29:36.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:31:0)
[03:29:36.495] Timer tick, asking Buildbucket for the build status
[03:29:36.731] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:36.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:32:0) after 1m0s
[03:30:36.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:32:0)
[03:30:36.847] Timer tick, asking Buildbucket for the build status
[03:30:36.962] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:36.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:33:0) after 1m0s
[03:31:37.026] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:33:0)
[03:31:37.026] Timer tick, asking Buildbucket for the build status
[03:31:37.084] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:37.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:34:0) after 1m0s
[03:32:37.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:34:0)
[03:32:37.196] Timer tick, asking Buildbucket for the build status
[03:32:37.250] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:37.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:35:0) after 1m0s
[03:33:37.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:35:0)
[03:33:37.328] Timer tick, asking Buildbucket for the build status
[03:33:37.477] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:37.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:36:0) after 1m0s
[03:34:37.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:36:0)
[03:34:37.551] Timer tick, asking Buildbucket for the build status
[03:34:37.610] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:37.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:37:0) after 1m0s
[03:35:37.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:37:0)
[03:35:37.648] Timer tick, asking Buildbucket for the build status
[03:35:37.772] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:37.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:38:0) after 1m0s
[03:36:37.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:38:0)
[03:36:37.819] Timer tick, asking Buildbucket for the build status
[03:36:37.976] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:37.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:39:0) after 1m0s
[03:37:38.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:39:0)
[03:37:38.028] Timer tick, asking Buildbucket for the build status
[03:37:38.167] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:38.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:40:0) after 1m0s
[03:38:38.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:40:0)
[03:38:38.242] Timer tick, asking Buildbucket for the build status
[03:38:38.334] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:38.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:41:0) after 1m0s
[03:39:38.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:41:0)
[03:39:38.373] Timer tick, asking Buildbucket for the build status
[03:39:38.461] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:38.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:42:0) after 1m0s
[03:40:38.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:42:0)
[03:40:38.480] Timer tick, asking Buildbucket for the build status
[03:40:38.592] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:38.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:43:0) after 1m0s
[03:41:38.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:43:0)
[03:41:38.654] Timer tick, asking Buildbucket for the build status
[03:41:38.854] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:38.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:44:0) after 1m0s
[03:42:39.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:44:0)
[03:42:39.052] Timer tick, asking Buildbucket for the build status
[03:42:39.137] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:39.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:45:0) after 1m0s
[03:43:39.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:45:0)
[03:43:39.212] Timer tick, asking Buildbucket for the build status
[03:43:39.285] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:39.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:46:0) after 1m0s
[03:44:39.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:46:0)
[03:44:39.294] Timer tick, asking Buildbucket for the build status
[03:44:39.375] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:39.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:47:0) after 1m0s
[03:45:39.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:47:0)
[03:45:39.402] Timer tick, asking Buildbucket for the build status
[03:45:39.508] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:39.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:48:0) after 1m0s
[03:46:39.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:48:0)
[03:46:39.527] Timer tick, asking Buildbucket for the build status
[03:46:39.591] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:39.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:49:0) after 1m0s
[03:47:39.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:49:0)
[03:47:39.624] Timer tick, asking Buildbucket for the build status
[03:47:39.898] Build 8857077147225079024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:39.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022507209180344192:50:0) after 1m0s
[03:47:41.088] Received PubSub notification, asking Buildbucket for the build status
[03:47:41.195] Build 8857077147225079024: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:47:41.195] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611632860337329",
"created_by": "project:chromium",
"created_ts": "1611630028470636",
"id": "8857077147225079024",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-45-90gc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179979, \"got_angle_revision\": \"6689a54d8a046063fad176ffc0fcc1c2cfbe02e8\", \"got_dawn_revision\": \"73668344d656e4bad2f6a1dd75c85ffae1e56973\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\", \"got_revision_cp\": \"refs/heads/master@{#847025}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"99e54b1c5caf06a25f76faa4c20c9ab1b31bdb61\", \"got_v8_revision\": \"d6d0f46aa6da8d55541ad02aee1099a3a81a59f7\", \"got_v8_revision_cp\": \"refs/heads/9.0.64@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"746d78b8fd8367bc4355e48e61b72af49bb8e8d3\", \"swarm_hashes_refs/heads/master(at){#847025}_without_patch\": {\"absl_hardening_tests\": \"9684ab6be75b01321415f2c40b6a1c4749998cd6\", \"accessibility_unittests\": \"91e695e74961232155168c19416e7a618dc5f1cf\", \"angle_unittests\": \"6ce5764b5a36223d21474438e5dbb6d74a5630ff\", \"app_shell_unittests\": \"5c9b2bae0148eac17eda8cf49db055ebc2d924e2\", \"aura_unittests\": \"aa4971dcae3cea35a2e4b3cc1b3abb32911e76ac\", \"base_unittests\": \"91af9de40e58124e604cafe9703bb4b563febca3\", \"base_util_unittests\": \"fc0826f314dd4aa18bf62096dd67007af726ad25\", \"blink_common_unittests\": \"d94e4d341a92aef47e82c5caa222b123548bef1b\", \"blink_fuzzer_unittests\": \"7bf20ced08890cf3f57de6334a08b5475afd4fef\", \"blink_heap_unittests\": \"2f380b171329167cf58e9a62dd2751f1ceee47d6\", \"blink_platform_unittests\": \"a63c14f280ebd8487e16c6f71ce82ff2acffa083\", \"blink_python_tests\": \"02f0db03f496e72a86db0d267dad0e0a66b4a4f6\", \"blink_unittests\": \"bbbebc4c735ba8316726abb9cf612b88281cb943\", \"blink_web_tests\": \"d59c70fdab3f936436985e0c1e6a00ab2737e919\", \"boringssl_crypto_tests\": \"9948359f2c735f08e04485668af93ca3b8af7cfb\", \"boringssl_ssl_tests\": \"1b85ce8a490860b1e4e498e9ece8188f07cac535\", \"browser_tests\": \"ca10284ca6552192763383aff02952a51fceb463\", \"capture_unittests\": \"d7581047126e39a3a7257079c3fb43824ce0efc6\", \"cast_unittests\": \"677747ef897d67a9672f0cc072206157fc774930\", \"cc_unittests\": \"21008b61a0fcc587efd43a325c8207d34d435607\", \"chrome_app_unittests\": \"122149e6c1f686493504f107e375186eba33b9ef\", \"chromedriver_unittests\": \"efe938d111b7437bf2cedb3c3442247585d1ef4a\", \"components_browsertests\": \"8aeadd64773d3176a27ed2bfc915af8805ac57a3\", \"components_unittests\": \"9b14cc6f42db5429c28cfdb65de8a80389e54572\", \"compositor_unittests\": \"bd13de80e8aa5d64b2aeef191644997f11254738\", \"content_browsertests\": \"58df49b2b1c9923c0119467799432ebabcefc35d\", \"content_shell_crash_test\": \"da5a2eca6f1ca87e509a36eb40d7d4d120a5ef16\", \"content_unittests\": \"3b27c0a4f440437ea9583bf8bf717b4d3c00ca22\", \"crashpad_tests\": \"c5bb6982151a66ef585d3e07dab5345f12243904\", \"cronet_tests\": \"f5d2116b9c51430ba22c8f17c0ebade2679d2a51\", \"cronet_unittests\": \"065105a4636c53b6c8fbf1b0f833e42131735469\", \"crypto_unittests\": \"d541b6b5300bef7a15657040a1dffbf206615736\", \"dbus_unittests\": \"380ee42d7bf2c1b5d3662f61bb06403f705cc16f\", \"device_unittests\": \"d345e14d6390ec70d71e3922005ba1bd4fb9b876\", \"display_unittests\": \"63e681bf672d3ece43984f6a69c1c9a34f444d6f\", \"events_unittests\": \"a84fa86e84dd659441b16a4319672c8431dbef7d\", \"extensions_browsertests\": \"689d6f41ad03e2a9df16aaaa74bab7d4c417e2d9\", \"extensions_unittests\": \"2157899456287339f9e4949da2371c000c9e2dd9\", \"filesystem_service_unittests\": \"599f6e1c1db6e6ee57a6b83644fa2aa0fdc2c881\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"32dacf580f6bdc869f14c677ac092ea10dbfa991\", \"gfx_unittests\": \"bd0276a183ec846508d4d5e04b6960d98fe315f9\", \"gin_unittests\": \"297aee5bc165589ad6e48a00f40c950c99eb5c19\", \"google_apis_unittests\": \"c8d198364d1f4b3ba774a79d04e0d215f69de32f\", \"gpu_unittests\": \"58bf6721da852c4ccb9493efae2604945f19c15f\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"66793ccf34155e6bab10e7069a46bc05f533cb66\", \"headless_browsertests\": \"3137da3b0e995e6c541ae6691889e09b52a5eba8\", \"headless_unittests\": \"f2a29ff42b6933d91b8503090acd217848702e98\", \"interactive_ui_tests\": \"069feb6860873572ece3f804df3d20e3e80b20dd\", \"ipc_tests\": \"7d945e9ef0203b5868d9a690b2a6fc21b0212c1a\", \"jingle_unittests\": \"906e85441d39732446e8fb5e78a6c801d797b08b\", \"latency_unittests\": \"ff979f2b7ea0877970aaaa5b47c7db490636c121\", \"libjingle_xmpp_unittests\": \"d16efb5a3ef73b6b06425cf37c13da5cbc0ac39e\", \"liburlpattern_unittests\": \"dcba2436ddd9d30f215149650fc524ffc3f3c53c\", \"media_blink_unittests\": \"c2dbb7d8da8ab09ae3f6ab2d65516c7fa834c863\", \"media_unittests\": \"a4955061c6506c74cb1c8c0f71dfb32ef0709938\", \"message_center_unittests\": \"65aacf6b14ca0c6fcd964774cc36a5efa27c122a\", \"metrics_python_tests\": \"d4d1dbe0ed85406f1196eebcaf38f6537c8f9984\", \"midi_unittests\": \"e469e5a10728644a38c1d9a3dfedc6f956b344a3\", \"mojo_core_unittests\": \"92cb00258ff355894722dd97c979971cdb9bc1e3\", \"mojo_unittests\": \"af6a01abc76e2203a05151e5c5157a5db543d074\", \"nacl_helper_nonsfi_unittests\": \"7cdce20f8a7aa808cdb69040964a7434a5a583a9\", \"nacl_loader_unittests\": \"b03ab5a93dde4a6d2c7fb9457f6cccc1ada8fbb8\", \"native_theme_unittests\": \"54856e6c1c78f2c6b50bbe64a87a37b66edea191\", \"net_unittests\": \"060cb52096e2ed24ef4e234c950a1efa1f103567\", \"openscreen_unittests\": \"65aad1afa1c64ab0c7db630158877bd3e548ccf8\", \"pdf_unittests\": \"5447861bb03d09f0b9ca794439246787cf470c35\", \"perfetto_unittests\": \"60f8f1ec64b83228e3621d17372766d88cb43579\", \"ppapi_unittests\": \"af452f45c5575d965aca0fde4e6da5152d67ea77\", \"printing_unittests\": \"a14d5f8a77cd1322d0e8c599ab45cc86ca250482\", \"remoting_unittests\": \"90cb066ab2fea94889e9bc7e55c78baefe241912\", \"sandbox_linux_unittests\": \"427f1b12cfbd98bff817c7457344655fdfa12fe7\", \"service_manager_unittests\": \"bc593e727dd932635902d163ea490915d9260b3a\", \"services_unittests\": \"5d9db7f22b48493a1d544431535b4be8caa861f3\", \"shell_dialogs_unittests\": \"c1f97f179b454ce7a64d2a470fdb0bf3c7f63a2b\", \"skia_unittests\": \"5ac4998e3e9c7d68f58cafa427cb07b371db3000\", \"snapshot_unittests\": \"dcb4aa9116fff991759ba3e34b66afb47f83a967\", \"sql_unittests\": \"2743d6a6b1b50a331ede7683b108eb93484fabb8\", \"storage_unittests\": \"6fa0027c41c6aacd2837d25540c3fd7ef88f22c5\", \"sync_integration_tests\": \"b66bce59ecc6bcccc5764a114470c730c17fb2d1\", \"telemetry_gpu_unittests\": \"ab9b685ff620a13edc6a98fd33c18ea99c144b59\", \"telemetry_perf_unittests\": \"809fd26d5d6a5b910322a1aaa85a07144bf3a40c\", \"telemetry_unittests\": \"2687bc920187fabb941e2ecea3c29cd4f33acd83\", \"traffic_annotation_auditor_unittests\": \"a181d9c20238ba98d6ea4c4350ce699fc247f765\", \"ui_base_unittests\": \"981c9a89fb76b8abbad46e66e88fef65b3b14858\", \"ui_touch_selection_unittests\": \"b5b6b05bd7cbbb9955c02aaa2ae3c00a85563327\", \"unit_tests\": \"1a40c14f29f6d3578d13542af37dd02dfcee1d28\", \"url_unittests\": \"6020f36696737b0125ba7cd2dca9a22240acdae4\", \"views_perftests\": \"5a71730dd5588a1e5b9bfd7293b120aba629e323\", \"views_unittests\": \"1bdd37acf5da779ffebd79a7f5f22667fef95724\", \"viz_unittests\": \"7449a7d44d7f78059104ab80d833a122530bb4d7\", \"vr_common_unittests\": \"2b668703a8490f9a5ff79707d0a8f4bf9c95eb15\", \"vr_pixeltests\": \"cc4daf70903b51170ff51077f720728ecee7df01\", \"webdriver_wpt_tests\": \"7dd15d1cd728185e7b055f46199c1541ad2e12dd\", \"weblayer_browsertests\": \"20b388e7503409cce7867cd3540594c0224da3ed\", \"weblayer_unittests\": \"99802d6df43ebce99d65828d64b71e2157065fe9\", \"wm_unittests\": \"6ff963e1fd75bf21fcf5b24808e96e54893db06f\", \"wtf_unittests\": \"7c1ddfab9b525209458bc28a7a4a22ee3046805e\", \"x11_unittests\": \"7fb27c3d64b77432762ac87a4aead674d6772d62\", \"xr_browser_tests\": \"06d40199b5691b1bf4b2ea36c67c144cf31d3d31\", \"zlib_unittests\": \"8a110fd9bef3a4af13d585c66591c7e06f2a7217\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1baf36be136c6e37e5283db20727ce1fca753922b4729c01ac3834cd33897d7d_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-45-90gc\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611630039708536",
"status": "COMPLETED",
"status_changed_ts": "1611632860871018",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179979",
"builder:Linux Builder (dbg)",
"buildset:commit/git/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/746d78b8fd8367bc4355e48e61b72af49bb8e8d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022507209180344192",
"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/8857077147225079024/+/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:515574335dd0d410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611632860877721",
"url": "https://ci.chromium.org/b/8857077147225079024",
"utcnow_ts": "1611632861179907"
}
}
[03:47:41.195] Invocation finished in 47m13.972274597s with status SUCCEEDED