[17:58:07.148] New invocation is queued and will start shortly
[17:58:08.360] Starting the invocation (attempt 1)
[17:58:08.394] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/27dec9bd1708c07407edf9e8c8517bcd23a17aa5"
[17:58:08.394] Popped gitiles commit info from properties and tags
[17:58:08.394] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:58:08.394] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:58:08.394] Buildbucket request:
{
"requestId": "9016833721055214592",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "27dec9bd1708c07407edf9e8c8517bcd23a17aa5",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9016833721055214592"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:58:09.283] Scheduled build:
{
"id": "8851403658991745792",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 10205,
"createdBy": "project:chromium",
"createTime": "2021-03-29T17:58:08.483965Z",
"updateTime": "2021-03-29T17:58:09.199970Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "27dec9bd1708c07407edf9e8c8517bcd23a17aa5",
"ref": "refs/heads/master"
}
}
}
[17:58:09.283] Task URL: https://cr-buildbucket.appspot.com/build/8851403658991745792
[17:58:09.283] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:2:0) after 5m16s
[18:03:25.307] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:2:0)
[18:03:25.332] Build status: SCHEDULED
[18:03:25.332] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:3:0) after 2m58s
[18:06:23.465] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:3:0)
[18:06:23.502] Build status: SCHEDULED
[18:06:23.502] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:4:0) after 9m6s
[18:15:29.587] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:4:0)
[18:15:29.668] Build status: SCHEDULED
[18:15:29.668] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:5:0) after 5m4s
[18:20:33.921] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:5:0)
[18:20:33.953] Build status: SCHEDULED
[18:20:33.953] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:6:0) after 2m18s
[18:22:52.032] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:6:0)
[18:22:52.065] Build status: SCHEDULED
[18:22:52.065] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:7:0) after 1m49s
[18:24:41.174] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:7:0)
[18:24:41.207] Build status: SCHEDULED
[18:24:41.207] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:8:0) after 2m31s
[18:27:12.225] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:8:0)
[18:27:12.251] Build status: SCHEDULED
[18:27:12.251] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:9:0) after 8m46s
[18:35:58.268] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:9:0)
[18:35:58.296] Build status: SCHEDULED
[18:35:58.296] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:10:0) after 5m40s
[18:41:39.129] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:10:0)
[18:41:39.162] Build status: SCHEDULED
[18:41:39.163] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:11:0) after 2m21s
[18:44:00.290] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:11:0)
[18:44:00.335] Build status: SCHEDULED
[18:44:00.335] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:12:0) after 2m29s
[18:46:29.426] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:12:0)
[18:46:29.479] Build status: SCHEDULED
[18:46:29.479] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:13:0) after 1m23s
[18:47:53.029] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:13:0)
[18:47:53.219] Build status: SCHEDULED
[18:47:53.219] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:14:0) after 7m27s
[18:55:20.225] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:14:0)
[18:55:20.320] Build status: SCHEDULED
[18:55:20.320] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:15:0) after 6m49s
[19:02:09.823] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:15:0)
[19:02:09.855] Build status: SCHEDULED
[19:02:09.855] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:16:0) after 5m2s
[19:07:11.930] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:16:0)
[19:07:11.961] Build status: SCHEDULED
[19:07:11.961] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:17:0) after 1m19s
[19:08:31.040] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:17:0)
[19:08:31.070] Build status: SCHEDULED
[19:08:31.070] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:18:0) after 4m50s
[19:13:21.087] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:18:0)
[19:13:21.116] Build status: SCHEDULED
[19:13:21.116] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:19:0) after 6m56s
[19:20:17.144] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:19:0)
[19:20:17.170] Build status: SCHEDULED
[19:20:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:20:0) after 4m42s
[19:24:59.242] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:20:0)
[19:24:59.274] Build status: SCHEDULED
[19:24:59.274] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:21:0) after 9m39s
[19:34:39.797] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:21:0)
[19:34:39.826] Build status: SCHEDULED
[19:34:39.826] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:22:0) after 7m45s
[19:42:25.044] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:22:0)
[19:42:25.076] Build status: SCHEDULED
[19:42:25.076] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:23:0) after 8m28s
[19:50:53.442] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:23:0)
[19:50:53.473] Build status: SCHEDULED
[19:50:53.473] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:24:0) after 4m18s
[19:55:11.491] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:24:0)
[19:55:11.542] Build status: SCHEDULED
[19:55:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:25:0) after 4m28s
[19:59:39.770] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:25:0)
[19:59:39.807] Build status: SCHEDULED
[19:59:39.807] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:26:0) after 6m42s
[20:06:21.840] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:26:0)
[20:06:21.865] Build status: SCHEDULED
[20:06:21.865] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:27:0) after 5m16s
[20:11:37.909] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:27:0)
[20:11:37.937] Build status: SCHEDULED
[20:11:37.937] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:28:0) after 2m26s
[20:14:03.950] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:28:0)
[20:14:03.979] Build status: SCHEDULED
[20:14:03.979] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:29:0) after 9m24s
[20:23:28.122] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:29:0)
[20:23:28.155] Build status: SCHEDULED
[20:23:28.155] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:30:0) after 6m37s
[20:30:05.174] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:30:0)
[20:30:05.203] Build status: SCHEDULED
[20:30:05.203] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:31:0) after 8m18s
[20:38:23.520] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:31:0)
[20:38:23.547] Build status: SCHEDULED
[20:38:23.547] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:32:0) after 4m9s
[20:42:32.570] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:32:0)
[20:42:32.596] Build status: SCHEDULED
[20:42:32.596] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:33:0) after 6m8s
[20:48:40.720] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:33:0)
[20:48:40.747] Build status: SCHEDULED
[20:48:40.747] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:34:0) after 3m37s
[20:52:17.740] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:34:0)
[20:52:17.787] Build status: SCHEDULED
[20:52:17.787] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:35:0) after 2m25s
[20:54:42.805] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:35:0)
[20:54:42.836] Build status: SCHEDULED
[20:54:42.836] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:36:0) after 2m14s
[20:56:19.429] Received PubSub notification, asking Buildbucket for the build status
[20:56:19.478] Build status: STARTED
[20:56:56.959] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:36:0)
[20:56:56.991] Build status: STARTED
[20:56:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:38:0) after 2m34s
[20:59:31.340] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:38:0)
[20:59:31.376] Build status: STARTED
[20:59:31.376] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:39:0) after 2m35s
[21:02:06.396] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:39:0)
[21:02:06.432] Build status: STARTED
[21:02:06.432] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:40:0) after 2m27s
[21:04:33.453] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:40:0)
[21:04:33.480] Build status: STARTED
[21:04:33.480] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:41:0) after 9m24s
[21:13:57.634] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:41:0)
[21:13:57.691] Build status: STARTED
[21:13:57.691] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:42:0) after 6m14s
[21:20:11.725] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:42:0)
[21:20:11.753] Build status: STARTED
[21:20:11.753] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:43:0) after 3m26s
[21:23:37.805] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:43:0)
[21:23:37.836] Build status: STARTED
[21:23:37.836] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:44:0) after 3m11s
[21:26:48.880] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:44:0)
[21:26:48.909] Build status: STARTED
[21:26:48.909] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:45:0) after 8m51s
[21:35:39.927] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:45:0)
[21:35:39.956] Build status: STARTED
[21:35:39.956] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:46:0) after 3m12s
[21:38:52.063] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:46:0)
[21:38:52.088] Build status: STARTED
[21:38:52.088] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:47:0) after 5m17s
[21:44:09.137] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:47:0)
[21:44:09.165] Build status: STARTED
[21:44:09.165] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:48:0) after 4m6s
[21:48:15.189] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:48:0)
[21:48:15.230] Build status: STARTED
[21:48:15.230] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:49:0) after 1m36s
[21:49:51.647] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:49:0)
[21:49:51.674] Build status: STARTED
[21:49:51.674] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:50:0) after 4m23s
[21:54:14.789] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:50:0)
[21:54:14.817] Build status: STARTED
[21:54:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:51:0) after 7m3s
[22:01:17.787] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:51:0)
[22:01:17.816] Build status: STARTED
[22:01:17.816] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:52:0) after 9m37s
[22:10:54.832] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:52:0)
[22:10:54.857] Build status: STARTED
[22:10:54.857] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:53:0) after 3m37s
[22:14:31.874] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:53:0)
[22:14:31.904] Build status: STARTED
[22:14:31.904] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:54:0) after 6m29s
[22:21:01.653] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:54:0)
[22:21:01.695] Build status: STARTED
[22:21:01.695] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:55:0) after 7m33s
[22:28:34.719] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:55:0)
[22:28:34.746] Build status: STARTED
[22:28:34.746] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:56:0) after 5m20s
[22:33:54.833] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:56:0)
[22:33:54.862] Build status: STARTED
[22:33:54.862] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:57:0) after 2m7s
[22:36:02.128] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:57:0)
[22:36:02.163] Build status: STARTED
[22:36:02.163] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:58:0) after 1m0s
[22:37:02.400] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:58:0)
[22:37:02.486] Build status: STARTED
[22:37:02.487] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:59:0) after 5m52s
[22:42:55.014] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:59:0)
[22:42:55.041] Build status: STARTED
[22:42:55.041] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:60:0) after 3m56s
[22:46:51.075] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:60:0)
[22:46:51.119] Build status: STARTED
[22:46:51.119] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:61:0) after 1m35s
[22:48:26.199] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:61:0)
[22:48:26.230] Build status: STARTED
[22:48:26.230] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:62:0) after 9m46s
[22:58:12.249] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:62:0)
[22:58:12.278] Build status: STARTED
[22:58:12.278] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:63:0) after 3m20s
[23:01:32.329] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:63:0)
[23:01:32.355] Build status: STARTED
[23:01:32.355] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:64:0) after 5m50s
[23:07:22.379] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:64:0)
[23:07:22.410] Build status: STARTED
[23:07:22.410] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:65:0) after 6m49s
[23:14:11.645] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:65:0)
[23:14:11.672] Build status: STARTED
[23:14:11.672] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:66:0) after 4m54s
[23:19:05.823] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:66:0)
[23:19:05.852] Build status: STARTED
[23:19:05.852] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:67:0) after 7m31s
[23:26:36.871] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:67:0)
[23:26:36.901] Build status: STARTED
[23:26:36.901] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:68:0) after 3m40s
[23:30:17.180] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:68:0)
[23:30:17.221] Build status: STARTED
[23:30:17.221] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:69:0) after 1m38s
[23:31:55.244] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:69:0)
[23:31:55.283] Build status: STARTED
[23:31:55.283] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:70:0) after 2m48s
[23:34:43.567] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:70:0)
[23:34:43.600] Build status: STARTED
[23:34:43.600] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:71:0) after 4m24s
[23:39:08.039] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:71:0)
[23:39:08.064] Build status: STARTED
[23:39:08.064] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:72:0) after 6m56s
[23:46:04.415] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:72:0)
[23:46:04.448] Build status: STARTED
[23:46:04.448] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:73:0) after 4m54s
[23:50:58.617] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:73:0)
[23:50:58.651] Build status: STARTED
[23:50:58.651] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:74:0) after 5m50s
[23:56:48.672] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:74:0)
[23:56:48.761] Build status: STARTED
[23:56:48.761] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:75:0) after 3m12s
[00:00:00.840] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:75:0)
[00:00:00.870] Build status: STARTED
[00:00:00.870] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:76:0) after 6m46s
[00:06:46.852] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:76:0)
[00:06:46.882] Build status: STARTED
[00:06:46.882] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:77:0) after 1m15s
[00:08:02.081] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:77:0)
[00:08:02.116] Build status: STARTED
[00:08:02.116] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:78:0) after 7m15s
[00:15:17.275] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:78:0)
[00:15:17.304] Build status: STARTED
[00:15:17.304] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:79:0) after 1m51s
[00:17:08.321] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:79:0)
[00:17:08.348] Build status: STARTED
[00:17:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:80:0) after 2m17s
[00:19:25.384] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:80:0)
[00:19:25.412] Build status: STARTED
[00:19:25.412] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:81:0) after 4m35s
[00:24:00.432] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:81:0)
[00:24:00.458] Build status: STARTED
[00:24:00.458] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:82:0) after 8m23s
[00:32:23.653] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:82:0)
[00:32:23.682] Build status: STARTED
[00:32:23.682] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:83:0) after 3m18s
[00:35:41.816] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:83:0)
[00:35:41.848] Build status: STARTED
[00:35:41.848] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:84:0) after 6m52s
[00:42:33.964] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:84:0)
[00:42:33.991] Build status: STARTED
[00:42:33.991] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:85:0) after 1m42s
[00:44:16.515] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:85:0)
[00:44:16.542] Build status: STARTED
[00:44:16.542] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:86:0) after 7m57s
[00:52:14.033] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:86:0)
[00:52:14.076] Build status: STARTED
[00:52:14.076] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:87:0) after 3m41s
[00:55:55.773] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:87:0)
[00:55:55.804] Build status: STARTED
[00:55:55.804] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:88:0) after 4m37s
[01:00:32.975] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:88:0)
[01:00:33.042] Build status: STARTED
[01:00:33.042] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:89:0) after 5m1s
[01:05:34.092] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:89:0)
[01:05:34.131] Build status: STARTED
[01:05:34.131] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:90:0) after 5m41s
[01:11:15.160] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:90:0)
[01:11:15.189] Build status: STARTED
[01:11:15.189] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:91:0) after 9m1s
[01:20:16.401] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:91:0)
[01:20:16.433] Build status: STARTED
[01:20:16.433] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:92:0) after 6m54s
[01:27:11.052] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:92:0)
[01:27:11.090] Build status: STARTED
[01:27:11.090] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:93:0) after 9m26s
[01:36:37.305] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:93:0)
[01:36:37.331] Build status: STARTED
[01:36:37.332] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:94:0) after 1m22s
[01:37:59.404] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:94:0)
[01:37:59.445] Build status: STARTED
[01:37:59.445] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:95:0) after 3m56s
[01:41:55.740] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:95:0)
[01:41:55.860] Build status: STARTED
[01:41:55.860] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:96:0) after 5m45s
[01:47:40.906] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:96:0)
[01:47:40.938] Build status: STARTED
[01:47:40.938] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:97:0) after 8m48s
[01:56:28.935] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:97:0)
[01:56:28.961] Build status: STARTED
[01:56:28.961] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:98:0) after 3m38s
[02:00:06.999] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:98:0)
[02:00:07.031] Build status: STARTED
[02:00:07.031] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:99:0) after 8m10s
[02:08:17.250] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:99:0)
[02:08:17.288] Build status: STARTED
[02:08:17.288] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:100:0) after 4m41s
[02:12:58.429] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:100:0)
[02:12:58.457] Build status: STARTED
[02:12:58.457] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:101:0) after 4m19s
[02:17:17.475] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:101:0)
[02:17:17.508] Build status: STARTED
[02:17:17.508] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:102:0) after 5m33s
[02:22:50.817] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:102:0)
[02:22:50.844] Build status: STARTED
[02:22:50.844] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:103:0) after 6m21s
[02:29:11.970] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:103:0)
[02:29:11.997] Build status: STARTED
[02:29:11.997] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:104:0) after 9m19s
[02:38:31.019] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:104:0)
[02:38:31.045] Build status: STARTED
[02:38:31.045] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:105:0) after 5m15s
[02:43:46.096] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:105:0)
[02:43:46.123] Build status: STARTED
[02:43:46.123] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:106:0) after 5m15s
[02:49:01.781] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:106:0)
[02:49:01.812] Build status: STARTED
[02:49:01.812] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:107:0) after 2m16s
[02:51:17.857] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:107:0)
[02:51:17.883] Build status: STARTED
[02:51:17.883] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:108:0) after 6m50s
[02:58:08.012] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:108:0)
[02:58:08.043] Build status: STARTED
[02:58:08.043] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:109:0) after 1m28s
[02:59:36.068] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:109:0)
[02:59:36.098] Build status: STARTED
[02:59:36.098] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:110:0) after 2m46s
[03:02:22.285] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:110:0)
[03:02:22.325] Build status: STARTED
[03:02:22.325] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:111:0) after 9m52s
[03:12:14.358] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:111:0)
[03:12:14.388] Build status: STARTED
[03:12:14.388] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:112:0) after 6m8s
[03:18:22.581] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:112:0)
[03:18:22.619] Build status: STARTED
[03:18:22.619] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:113:0) after 4m40s
[03:23:02.669] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:113:0)
[03:23:02.726] Build status: STARTED
[03:23:02.726] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:114:0) after 1m13s
[03:24:15.944] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:114:0)
[03:24:15.994] Build status: STARTED
[03:24:15.994] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:115:0) after 7m45s
[03:32:01.657] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:115:0)
[03:32:01.683] Build status: STARTED
[03:32:01.683] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:116:0) after 3m7s
[03:35:08.709] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:116:0)
[03:35:08.744] Build status: STARTED
[03:35:08.744] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:117:0) after 5m56s
[03:41:04.762] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:117:0)
[03:41:04.787] Build status: STARTED
[03:41:04.787] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:118:0) after 8m46s
[03:49:50.810] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:118:0)
[03:49:50.840] Build status: STARTED
[03:49:50.840] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:119:0) after 6m16s
[03:56:06.866] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:119:0)
[03:56:06.897] Build status: STARTED
[03:56:06.897] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:120:0) after 7m54s
[04:04:01.429] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:120:0)
[04:04:01.460] Build status: STARTED
[04:04:01.460] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:121:0) after 9m52s
[04:13:53.482] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:121:0)
[04:13:53.535] Build status: STARTED
[04:13:53.535] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:122:0) after 4m31s
[04:18:24.516] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:122:0)
[04:18:24.545] Build status: STARTED
[04:18:24.545] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:123:0) after 5m0s
[04:23:24.643] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:123:0)
[04:23:24.675] Build status: STARTED
[04:23:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:124:0) after 5m1s
[04:28:25.794] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:124:0)
[04:28:25.824] Build status: STARTED
[04:28:25.824] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:125:0) after 5m25s
[04:33:51.072] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:125:0)
[04:33:51.098] Build status: STARTED
[04:33:51.098] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:126:0) after 1m44s
[04:35:35.560] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:126:0)
[04:35:35.589] Build status: STARTED
[04:35:35.589] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:127:0) after 9m37s
[04:45:12.615] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:127:0)
[04:45:12.647] Build status: STARTED
[04:45:12.647] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:9016833721055214592:128:0) after 7m41s
[04:49:56.702] Received PubSub notification, asking Buildbucket for the build status
[04:49:56.728] Build:
{
"id": "8851403658991745792",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 10205,
"createdBy": "project:chromium",
"createTime": "2021-03-29T17:58:08.483965Z",
"startTime": "2021-03-29T20:56:18.744578Z",
"endTime": "2021-03-30T04:49:56.093745857Z",
"updateTime": "2021-03-30T04:49:56.094091707Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "27dec9bd1708c07407edf9e8c8517bcd23a17aa5",
"ref": "refs/heads/master"
}
}
}
[04:49:56.729] Invocation finished in 10h51m49.597077741s with status FAILED