[06:21:19.368] New invocation is queued and will start shortly
[06:21:20.543] Starting the invocation (attempt 1)
[06:21:20.576] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf77c7c5436f73efa42361562ade2fe6afb43e9c"
[06:21:20.576] Popped gitiles commit info from properties and tags
[06:21:20.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:21:20.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:21:20.576] Buildbucket request:
{
"requestId": "9017692932384820864",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux CFI"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bf77c7c5436f73efa42361562ade2fe6afb43e9c",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017692932384820864"
},
{
"key": "scheduler_job_id",
"value": "chromium/Linux CFI"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:21:21.281] Scheduled build:
{
"id": "8852262870373712560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux CFI"
},
"number": 19958,
"createdBy": "project:chromium",
"createTime": "2021-03-20T06:21:20.655656Z",
"updateTime": "2021-03-20T06:21:21.154499Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bf77c7c5436f73efa42361562ade2fe6afb43e9c",
"ref": "refs/heads/master"
}
}
}
[06:21:21.281] Task URL: https://cr-buildbucket.appspot.com/build/8852262870373712560
[06:21:21.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:2:0) after 5m2s
[06:21:24.407] Received PubSub notification, asking Buildbucket for the build status
[06:21:24.436] Build status: STARTED
[06:26:23.374] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:2:0)
[06:26:23.402] Build status: STARTED
[06:26:23.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:4:0) after 6m28s
[06:32:51.451] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:4:0)
[06:32:51.521] Build status: STARTED
[06:32:51.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:5:0) after 2m33s
[06:35:24.535] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:5:0)
[06:35:24.563] Build status: STARTED
[06:35:24.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:6:0) after 2m54s
[06:38:19.308] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:6:0)
[06:38:19.308] Timer tick, asking Buildbucket for the build status
[06:38:19.380] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:19.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:7:0) after 1m0s
[06:39:19.395] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:7:0)
[06:39:19.420] Build status: STARTED
[06:39:19.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:8:0) after 2m37s
[06:41:56.775] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:8:0)
[06:41:56.775] Timer tick, asking Buildbucket for the build status
[06:41:56.870] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:56.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:9:0) after 1m0s
[06:42:57.065] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:9:0)
[06:42:57.065] Timer tick, asking Buildbucket for the build status
[06:42:57.131] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:57.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:10:0) after 1m0s
[06:43:57.179] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:10:0)
[06:43:57.179] Timer tick, asking Buildbucket for the build status
[06:43:57.269] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:57.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:11:0) after 1m0s
[06:44:57.447] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:11:0)
[06:44:57.447] Timer tick, asking Buildbucket for the build status
[06:44:57.595] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:57.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:12:0) after 1m0s
[06:45:57.604] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:12:0)
[06:45:57.604] Timer tick, asking Buildbucket for the build status
[06:45:57.758] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:57.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:13:0) after 1m0s
[06:46:57.847] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:13:0)
[06:46:57.847] Timer tick, asking Buildbucket for the build status
[06:46:57.918] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:57.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:14:0) after 1m0s
[06:47:57.936] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:14:0)
[06:47:57.960] Build status: STARTED
[06:47:57.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:15:0) after 2m56s
[06:50:54.076] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:15:0)
[06:50:54.164] Build status: STARTED
[06:50:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:16:0) after 8m6s
[06:59:00.427] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:16:0)
[06:59:00.427] Timer tick, asking Buildbucket for the build status
[06:59:00.751] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:00.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:17:0) after 1m0s
[07:00:00.865] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:17:0)
[07:00:00.947] Build status: STARTED
[07:00:00.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:18:0) after 5m7s
[07:05:07.965] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:18:0)
[07:05:07.965] Timer tick, asking Buildbucket for the build status
[07:05:08.053] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:08.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:19:0) after 1m0s
[07:06:08.094] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:19:0)
[07:06:08.094] Timer tick, asking Buildbucket for the build status
[07:06:08.611] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:20:0) after 1m0s
[07:07:09.320] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:20:0)
[07:07:09.348] Build status: STARTED
[07:07:09.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:21:0) after 4m47s
[07:11:56.367] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:21:0)
[07:11:56.418] Build status: STARTED
[07:11:56.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:22:0) after 1m18s
[07:13:14.436] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:22:0)
[07:13:14.436] Timer tick, asking Buildbucket for the build status
[07:13:14.523] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:14.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:23:0) after 1m0s
[07:14:14.846] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:23:0)
[07:14:14.846] Timer tick, asking Buildbucket for the build status
[07:14:14.929] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:14.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:24:0) after 1m0s
[07:15:15.258] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:24:0)
[07:15:15.285] Build status: STARTED
[07:15:15.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:25:0) after 5m44s
[07:20:59.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:25:0)
[07:20:59.384] Build status: STARTED
[07:20:59.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:26:0) after 6m51s
[07:27:50.514] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:26:0)
[07:27:50.540] Build status: STARTED
[07:27:50.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:27:0) after 6m13s
[07:34:03.574] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:27:0)
[07:34:03.574] Timer tick, asking Buildbucket for the build status
[07:34:03.657] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:03.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:28:0) after 1m0s
[07:35:03.672] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:28:0)
[07:35:03.702] Build status: STARTED
[07:35:03.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:29:0) after 3m33s
[07:38:36.760] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:29:0)
[07:38:36.760] Timer tick, asking Buildbucket for the build status
[07:38:37.039] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:37.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:30:0) after 1m0s
[07:39:37.066] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:30:0)
[07:39:37.066] Timer tick, asking Buildbucket for the build status
[07:39:37.148] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:37.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:31:0) after 1m0s
[07:40:37.189] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:31:0)
[07:40:37.189] Timer tick, asking Buildbucket for the build status
[07:40:37.325] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:37.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:32:0) after 1m0s
[07:41:37.540] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:32:0)
[07:41:37.540] Timer tick, asking Buildbucket for the build status
[07:41:37.630] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:37.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:33:0) after 1m0s
[07:42:37.666] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:33:0)
[07:42:37.666] Timer tick, asking Buildbucket for the build status
[07:42:37.789] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:37.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:34:0) after 1m0s
[07:43:38.055] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:34:0)
[07:43:38.055] Timer tick, asking Buildbucket for the build status
[07:43:38.198] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:38.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:35:0) after 1m0s
[07:44:38.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:35:0)
[07:44:38.303] Timer tick, asking Buildbucket for the build status
[07:44:38.400] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:38.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:36:0) after 1m0s
[07:45:38.419] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:36:0)
[07:45:38.419] Timer tick, asking Buildbucket for the build status
[07:45:38.489] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:38.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:37:0) after 1m0s
[07:46:38.579] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:37:0)
[07:46:38.604] Build status: STARTED
[07:46:38.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:38:0) after 4m4s
[07:50:42.808] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:38:0)
[07:50:42.808] Timer tick, asking Buildbucket for the build status
[07:50:42.905] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:42.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:39:0) after 1m0s
[07:51:42.932] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:39:0)
[07:51:42.932] Timer tick, asking Buildbucket for the build status
[07:51:43.003] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:43.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:40:0) after 1m0s
[07:52:42.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:40:0)
[07:52:43.025] Build status: STARTED
[07:52:43.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:41:0) after 1m7s
[07:53:50.054] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:41:0)
[07:53:50.080] Build status: STARTED
[07:53:50.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:42:0) after 5m48s
[07:59:38.108] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:42:0)
[07:59:38.108] Timer tick, asking Buildbucket for the build status
[07:59:38.398] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:38.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:43:0) after 1m0s
[08:00:38.428] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:43:0)
[08:00:38.428] Timer tick, asking Buildbucket for the build status
[08:00:39.078] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:39.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:44:0) after 1m0s
[08:01:39.220] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:44:0)
[08:01:39.220] Timer tick, asking Buildbucket for the build status
[08:01:39.375] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:39.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:45:0) after 1m0s
[08:02:39.492] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:45:0)
[08:02:39.492] Timer tick, asking Buildbucket for the build status
[08:02:39.602] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:39.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:46:0) after 1m0s
[08:03:39.629] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:46:0)
[08:03:39.671] Build status: STARTED
[08:03:39.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:47:0) after 6m14s
[08:09:53.690] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:47:0)
[08:09:53.720] Build status: STARTED
[08:09:53.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:48:0) after 7m7s
[08:17:01.032] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:48:0)
[08:17:01.032] Timer tick, asking Buildbucket for the build status
[08:17:01.103] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:01.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:49:0) after 1m0s
[08:18:01.350] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:49:0)
[08:18:01.350] Timer tick, asking Buildbucket for the build status
[08:18:01.418] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:01.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:50:0) after 1m0s
[08:19:01.547] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:50:0)
[08:19:01.572] Build status: STARTED
[08:19:01.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:51:0) after 4m17s
[08:23:18.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:51:0)
[08:23:18.832] Timer tick, asking Buildbucket for the build status
[08:23:18.932] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:18.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:52:0) after 1m0s
[08:24:18.949] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:52:0)
[08:24:18.949] Timer tick, asking Buildbucket for the build status
[08:24:19.212] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:19.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:53:0) after 1m0s
[08:25:19.355] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:53:0)
[08:25:19.355] Timer tick, asking Buildbucket for the build status
[08:25:19.415] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:19.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:54:0) after 1m0s
[08:26:19.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:54:0)
[08:26:19.456] Build status: STARTED
[08:26:19.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:55:0) after 4m45s
[08:31:04.599] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:55:0)
[08:31:04.627] Build status: STARTED
[08:31:04.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:56:0) after 2m14s
[08:33:18.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:56:0)
[08:33:18.703] Build status: STARTED
[08:33:18.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:57:0) after 6m47s
[08:40:05.711] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:57:0)
[08:40:05.711] Timer tick, asking Buildbucket for the build status
[08:40:05.857] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:05.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:58:0) after 1m0s
[08:41:05.881] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:58:0)
[08:41:05.881] Timer tick, asking Buildbucket for the build status
[08:41:05.968] Build 8852262870373712560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:05.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:59:0) after 1m0s
[08:42:05.986] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:59:0)
[08:42:06.011] Build status: STARTED
[08:42:06.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:60:0) after 4m18s
[08:46:24.033] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:60:0)
[08:46:24.064] Build status: STARTED
[08:46:24.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:61:0) after 8m54s
[08:55:18.222] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:61:0)
[08:55:18.249] Build status: STARTED
[08:55:18.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017692932384820864:62:0) after 4m14s
[08:58:33.279] Received PubSub notification, asking Buildbucket for the build status
[08:58:33.355] Build 8852262870373712560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:58:33.355] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616230711826211",
"created_by": "project:chromium",
"created_ts": "1616221280655656",
"id": "8852262870373712560",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {}}",
"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\": \"bf77c7c5436f73efa42361562ade2fe6afb43e9c\", \"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-32-3-6hel\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19958, \"got_angle_revision\": \"d5bc8a27abec7e86ea555f816e6dfa3947a2ffa5\", \"got_dawn_revision\": \"853b5d765e715fc11ea28c1d3754e48d38c283b1\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"bf77c7c5436f73efa42361562ade2fe6afb43e9c\", \"got_revision_cp\": \"refs/heads/master@{#864936}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"66377e9eee38ae5d2bec601ec40a6e7e792169bf\", \"got_v8_revision_cp\": \"refs/heads/9.1.169@{#1}\", \"got_webrtc_revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33510}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#864936}_without_patch\": {\"absl_hardening_tests\": \"a6cc2daa5c8a8079d0e7d9266508e8ddda732381\", \"accessibility_unittests\": \"039e160f877c0a65c59b2aeaf8a11856b201d771\", \"angle_unittests\": \"89e3af6a5ca35e39b6bedfb073beb8357a35c9b8\", \"app_shell_unittests\": \"6191427766699e42659c18439a7066864a6f5021\", \"aura_unittests\": \"ace69b48380af803a63c826ee6c142e8d48b7516\", \"base_unittests\": \"ebff90678e60cff255b63c28e3415266f9ac8a28\", \"base_util_unittests\": \"61b5894e428f0d1a38973effe2a6ca65b64a3559\", \"blink_common_unittests\": \"a17edb31fd1c6a79cf0ad8a79095181b19d97b87\", \"blink_fuzzer_unittests\": \"3cbe7bc3541a0c68b102b27d93c8fcb247727e56\", \"blink_heap_unittests\": \"b2de046b5eec283eb9557b67d426d39d53006abe\", \"blink_platform_unittests\": \"ccc42400c8a8161db577629c84c6760dc715f73c\", \"blink_unittests\": \"69095ad0a49c4cd3c1b2ec2efc250d460f7d3a07\", \"boringssl_crypto_tests\": \"4fdcd67c62f7a899664f289bbbe6918738c9afbb\", \"boringssl_ssl_tests\": \"1924bd3a5b838709bbfcd6052289114bbb05a4fd\", \"browser_tests\": \"3cea8f9a31b6698aaebba0dc4741ad9ec15a6b24\", \"capture_unittests\": \"39912eb0ee4a8a2d9580a9d34edde827a5c6deec\", \"cast_unittests\": \"962882bd266eb2c8fdeb2eb6ac8bf23137a25578\", \"cc_unittests\": \"0b5186d0d720bdd88d95269ba169781b834a0351\", \"chrome_app_unittests\": \"730d272f7fc16fc1a536432d070d38a581cb2ff0\", \"chromedriver_unittests\": \"68097263050f8aefc14848c73483194d1de24836\", \"color_unittests\": \"105d7f7440359ee9ca3eb41247bb96b4b00c2db6\", \"components_browsertests\": \"2c681b4b66b32c78065642e0bab4320e60c5cea7\", \"components_unittests\": \"f7006ad6276bf12d44407efc562ff5daa98131f5\", \"compositor_unittests\": \"512bf4948ee112c88971fbffa83bbe8bbe8d941a\", \"content_browsertests\": \"02fe8fb8897e92a68c4b57f4c25c538f018af5b1\", \"content_unittests\": \"3f1b281615de93c18692d1f1d6e37e42ca1b69f4\", \"cronet_tests\": \"dc14d324ea4195d3eb3899c39600b9f61a287ac2\", \"cronet_unittests\": \"2f62dea33a502353e0fa50ba20c98e2ca70d8689\", \"crypto_unittests\": \"b62ff38bf3e9d17dbe0a074abe2ad71fbe8ea612\", \"dbus_unittests\": \"9cc59e833674dcd38b0b00193a55b12f965824af\", \"device_unittests\": \"74064422777e99ffb6aeae8312b99dafedc196ec\", \"display_unittests\": \"ac27c691ccd790de74de1eb4db10e1cd61469e15\", \"events_unittests\": \"67631ab78bb931eea5f6f1cb671f25cf016e9db9\", \"extensions_browsertests\": \"a2fdf1a200212870a8adde01c72227c0e8dfb78b\", \"extensions_unittests\": \"8b2bc2be93c2090526834b6e26c5243e5527a885\", \"filesystem_service_unittests\": \"fe27b7ad5cdbb475c11bedac76819dbf99c6d13e\", \"gcm_unit_tests\": \"d36afa679babec7b9c010fb1182eb178ca6c1ee4\", \"gfx_unittests\": \"af69a0a0aec6e17cc617398a1e1f3cee55eb3105\", \"gin_unittests\": \"36a543e7f0c2d8cbe5cf872cda260419d7f4352a\", \"gl_tests\": \"e3d0d7e270698767cb36c91de223e73855d6a59c\", \"gl_unittests\": \"5010da6e95328eee30a61574c3d130d1b1b551e5\", \"google_apis_unittests\": \"61a9ac1bff0b51d1634ced37cc2319b150a64702\", \"gpu_unittests\": \"95cdffe6a4394bee7e1b8668037fac3c301f1336\", \"gwp_asan_unittests\": \"1c65b45f0dbdf105f877f1f5a13b3db7f89452e3\", \"headless_browsertests\": \"cf62947749d82553309c4e14a43bd79d10ec4e73\", \"headless_unittests\": \"3fd09e855188c8fc360fb22bdd120faddfa752c5\", \"interactive_ui_tests\": \"20106877f3aefd0eeada920de756d96b2f289ecf\", \"ipc_tests\": \"7a14d4c47a758ef053f0614cb02f003f0be0914a\", \"jingle_unittests\": \"28ad55487f6161590ac85a4c6decccebce25f50a\", \"latency_unittests\": \"41e89413e4d305ceb76d6fbd077331fe07c8dd12\", \"libjingle_xmpp_unittests\": \"c692971cbbb43f32b6849a87bcb5dabfcc0a113c\", \"liburlpattern_unittests\": \"6897d7f581af1d70fff49dd4f98d7066ac4cd4a9\", \"media_blink_unittests\": \"16c593996c660255801b830eb35bfbc8062458d9\", \"media_unittests\": \"d4f91247333bb936bfed8cfa79a511bcb7384e1b\", \"message_center_unittests\": \"312e8c8f0ac89df4b3a3f8a1d58e9c5a116723d3\", \"midi_unittests\": \"ef051ce8bd3f5b2686e451256158202ed5e8c111\", \"mojo_core_unittests\": \"c90b386d8dc2ff1dbb5de64ced5406ebc4f225f8\", \"mojo_unittests\": \"3456305c00d82798c6955b313f7fc168550776d2\", \"nacl_helper_nonsfi_unittests\": \"4eeaf465e0e0ea6ad05a31a0a9bbf9e2c6cdb51a\", \"nacl_loader_unittests\": \"355f022a69f1165de86504679c946a7c1c2c6bb5\", \"native_theme_unittests\": \"9999293decc23d08db99e07e4bbeeb3451268cf7\", \"net_unittests\": \"b5e10a3172323ffd93ec37156ce0f687abb71db1\", \"pdf_unittests\": \"0c2f454146cea38c9d34d93756c8e84bc7963fae\", \"perfetto_unittests\": \"0a1615552d1b1f4fecf7480122e177f2c18b2f1e\", \"ppapi_unittests\": \"5482b0488923d4e0bd41be05032db077ec192fbb\", \"printing_unittests\": \"3d2a3823da0a72a735236bbbc6882a14b4d18215\", \"remoting_unittests\": \"e74aa4146ca801c123372f02d7077db34aa737ee\", \"sandbox_linux_unittests\": \"4cd353e5cdc6c5a5a54b5a1119c646645bd86efe\", \"service_manager_unittests\": \"29a75e7ee414374c56274a0f88ecfe2188f8831a\", \"services_unittests\": \"01fb6693bd861d55e369d4be132c76eec1fa9d79\", \"shell_dialogs_unittests\": \"b88eb97a131a6ddb6e57608910c9f76dc59ca261\", \"skia_unittests\": \"a170974c98621e4ba4d37eda2da590abc54487ef\", \"snapshot_unittests\": \"ce9d22d7fc24bec85e78c20859d673c34c68d3a8\", \"sql_unittests\": \"590af73e745cbf536b5bc3e0d26f17db7e7980d2\", \"storage_unittests\": \"d802f506d49981b20c52df39e9a3f74037154861\", \"sync_integration_tests\": \"746314939c126955d040079527fca1496785c006\", \"traffic_annotation_auditor_unittests\": \"65e9aed28b66b92e1e2ce4d97d40a379789e518e\", \"ui_base_unittests\": \"31ad4fc54a669de985df288f2384b68754cdfcdb\", \"ui_touch_selection_unittests\": \"caa34c6bdc1af7185dfc8f6d2de376ea08034050\", \"unit_tests\": \"52cfaae96b140d80abd76d99b7992334b9141771\", \"url_unittests\": \"f2702fc2c92566a001c46b7a41ce4af97f0fe1ad\", \"views_unittests\": \"de042df2e901608f08bcceb8d350fdd0336ccd3b\", \"viz_unittests\": \"72a7063636e40ce8a9ad1339ea760f6d1375d847\", \"vr_common_unittests\": \"57121ff14ceec9e23dc3c78ae48512f23fe890e4\", \"vr_pixeltests\": \"f4695af8a1f9f86bd15cb6726bd526b2e02ce426\", \"weblayer_browsertests\": \"9313da0f2cbcfcd89a22103552c0d1f6e6b1505e\", \"weblayer_unittests\": \"f51b59320edf6aa5f699048f23f28943b4b09c3f\", \"wm_unittests\": \"f8023d8aaeb4835ae5cf49b3b735b6c0c0960211\", \"wtf_unittests\": \"f5b526497771c33faf1cbf53f0386d33dd71a856\", \"x11_unittests\": \"dc79e02101434a6219cfa2f17b6119c7127bacfe\", \"xr_browser_tests\": \"7ac6582c1697ed4fc37fb8f1951a556802808bc6\", \"zlib_unittests\": \"385273ef7059507ba42480e0761a2db5ea58d1a5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3805b8ba4abc77de369f5d4399a0a76b312e2fd8c5f804cd390624b9118dfa64_v2\", \"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_61e4d25dfd74628f421fe7d90da475349672e571b4dfd9a5326b66319dc94b9e_v2\", \"builder_80447164fd9128f57b299ad64704e89447e5656f4886183701c68086f26508e5_v2\", \"builder_abdad654d32c0904ec528c85d62eedf165d853d59ca684a9604e4daa5dc8955e_v2\", \"builder_d3d2610b5230a0e8818d022113159013c6345fba0843daf9ae715f6a2f1da36d_v2\", \"builder_dcfcb66b8d57b27a65bec4794b95b0b7d35e8289f8160d11b4e7f1c01ad595f0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-3-6hel\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616221283707135",
"status": "COMPLETED",
"status_changed_ts": "1616230712548430",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19958",
"builder:Linux CFI",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf77c7c5436f73efa42361562ade2fe6afb43e9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017692932384820864",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852262870373712560/+/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:52671d2497f18410",
"user_agent:luci-scheduler"
],
"updated_ts": "1616230712552636",
"url": "https://ci.chromium.org/b/8852262870373712560",
"utcnow_ts": "1616230713348227"
}
}
[08:58:33.355] Invocation finished in 2h37m14.001565735s with status SUCCEEDED