[23:14:41.122] New invocation is queued and will start shortly
[23:14:42.395] Starting the invocation (attempt 1)
[23:14:42.450] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/387feacbf4dc4ca94e4a764a32a7c1dd45d913f2"
[23:14:42.450] Popped gitiles commit info from properties and tags
[23:14:42.450] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:14:42.450] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:14:42.451] Buildbucket request:
{
"requestId": "9007029332059408368",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387feacbf4dc4ca94e4a764a32a7c1dd45d913f2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9007029332059408368"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:14:43.484] Scheduled build:
{
"id": "8841599269747497424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26852,
"createdBy": "project:chromium",
"createTime": "2021-07-15T23:14:42.693367Z",
"updateTime": "2021-07-15T23:14:43.362339Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387feacbf4dc4ca94e4a764a32a7c1dd45d913f2",
"ref": "refs/heads/main"
}
}
}
[23:14:43.484] Task URL: https://cr-buildbucket.appspot.com/build/8841599269747497424
[23:14:43.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:2:0) after 4m2s
[23:18:45.628] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:2:0)
[23:18:45.832] Build status: SCHEDULED
[23:18:45.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:3:0) after 1m13s
[23:19:40.626] Received PubSub notification, asking Buildbucket for the build status
[23:19:40.654] Build status: STARTED
[23:19:58.949] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:3:0)
[23:19:58.976] Build status: STARTED
[23:19:58.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:5:0) after 1m15s
[23:21:14.003] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:5:0)
[23:21:14.043] Build status: STARTED
[23:21:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:6:0) after 1m3s
[23:22:17.165] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:6:0)
[23:22:17.206] Build status: STARTED
[23:22:17.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:7:0) after 7m37s
[23:29:54.276] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:7:0)
[23:29:54.308] Build status: STARTED
[23:29:54.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:8:0) after 1m20s
[23:31:14.608] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:8:0)
[23:31:14.642] Build status: STARTED
[23:31:14.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:9:0) after 3m12s
[23:34:26.809] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:9:0)
[23:34:26.840] Build status: STARTED
[23:34:26.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:10:0) after 6m44s
[23:41:10.866] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:10:0)
[23:41:10.896] Build status: STARTED
[23:41:10.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:11:0) after 9m18s
[23:50:28.966] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:11:0)
[23:50:28.995] Build status: STARTED
[23:50:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:12:0) after 7m43s
[23:58:12.093] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:12:0)
[23:58:12.121] Build status: STARTED
[23:58:12.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:13:0) after 9m41s
[00:07:53.147] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:13:0)
[00:07:53.176] Build status: STARTED
[00:07:53.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:14:0) after 5m46s
[00:13:39.743] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:14:0)
[00:13:39.770] Build status: STARTED
[00:13:39.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:15:0) after 3m34s
[00:17:13.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:15:0)
[00:17:13.974] Build status: STARTED
[00:17:13.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:16:0) after 1m49s
[00:19:03.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:16:0)
[00:19:03.357] Build status: STARTED
[00:19:03.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:17:0) after 1m15s
[00:20:18.353] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:17:0)
[00:20:18.382] Build status: STARTED
[00:20:18.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:18:0) after 4m57s
[00:25:15.555] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:18:0)
[00:25:15.609] Build status: STARTED
[00:25:15.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:19:0) after 2m22s
[00:27:37.779] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:19:0)
[00:27:37.806] Build status: STARTED
[00:27:37.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:20:0) after 7m42s
[00:35:20.299] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:20:0)
[00:35:20.328] Build status: STARTED
[00:35:20.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:21:0) after 9m13s
[00:44:33.473] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:21:0)
[00:44:33.501] Build status: STARTED
[00:44:33.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:22:0) after 2m31s
[00:47:05.477] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:22:0)
[00:47:05.509] Build status: STARTED
[00:47:05.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:23:0) after 3m4s
[00:50:09.538] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:23:0)
[00:50:09.577] Build status: STARTED
[00:50:09.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:24:0) after 4m7s
[00:54:16.943] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:24:0)
[00:54:16.973] Build status: STARTED
[00:54:16.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:25:0) after 3m12s
[00:57:29.010] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:25:0)
[00:57:29.040] Build status: STARTED
[00:57:29.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:26:0) after 8m26s
[01:05:55.350] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:26:0)
[01:05:55.376] Build status: STARTED
[01:05:55.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:27:0) after 8m36s
[01:14:31.397] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:27:0)
[01:14:31.426] Build status: STARTED
[01:14:31.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:28:0) after 7m4s
[01:21:35.398] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:28:0)
[01:21:35.425] Build status: STARTED
[01:21:35.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:29:0) after 2m11s
[01:23:46.408] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:29:0)
[01:23:46.452] Build status: STARTED
[01:23:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:30:0) after 5m44s
[01:29:30.475] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:30:0)
[01:29:30.503] Build status: STARTED
[01:29:30.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:31:0) after 3m57s
[01:33:27.630] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:31:0)
[01:33:27.660] Build status: STARTED
[01:33:27.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:32:0) after 6m43s
[01:40:10.789] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:32:0)
[01:40:10.829] Build status: STARTED
[01:40:10.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:33:0) after 6m32s
[01:46:42.957] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:33:0)
[01:46:42.985] Build status: STARTED
[01:46:42.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:34:0) after 3m49s
[01:50:32.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:34:0)
[01:50:32.168] Build status: STARTED
[01:50:32.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:35:0) after 4m21s
[01:54:53.274] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:35:0)
[01:54:53.305] Build status: STARTED
[01:54:53.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:36:0) after 1m14s
[01:56:07.367] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:36:0)
[01:56:07.406] Build status: STARTED
[01:56:07.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:37:0) after 3m56s
[02:00:03.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:37:0)
[02:00:03.472] Build status: STARTED
[02:00:03.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:38:0) after 3m50s
[02:03:53.533] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:38:0)
[02:03:53.565] Build status: STARTED
[02:03:53.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:39:0) after 7m48s
[02:11:41.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:39:0)
[02:11:41.782] Build status: STARTED
[02:11:41.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:40:0) after 1m54s
[02:13:35.810] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:40:0)
[02:13:35.903] Build status: STARTED
[02:13:35.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:41:0) after 4m5s
[02:17:40.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:41:0)
[02:17:41.002] Build status: STARTED
[02:17:41.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:42:0) after 2m26s
[02:20:07.066] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:42:0)
[02:20:07.156] Build status: STARTED
[02:20:07.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:43:0) after 5m47s
[02:25:54.178] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:43:0)
[02:25:54.210] Build status: STARTED
[02:25:54.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:44:0) after 9m47s
[02:35:41.234] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:44:0)
[02:35:41.271] Build status: STARTED
[02:35:41.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:45:0) after 4m28s
[02:40:09.500] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:45:0)
[02:40:09.537] Build status: STARTED
[02:40:09.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:46:0) after 6m48s
[02:46:57.638] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:46:0)
[02:46:57.670] Build status: STARTED
[02:46:57.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:47:0) after 6m56s
[02:53:53.879] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:47:0)
[02:53:53.906] Build status: STARTED
[02:53:53.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:48:0) after 5m2s
[02:58:55.987] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:48:0)
[02:58:56.021] Build status: STARTED
[02:58:56.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:49:0) after 3m0s
[03:01:56.197] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:49:0)
[03:01:56.258] Build status: STARTED
[03:01:56.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:50:0) after 8m41s
[03:10:37.387] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:50:0)
[03:10:37.427] Build status: STARTED
[03:10:37.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:51:0) after 8m44s
[03:19:21.473] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:51:0)
[03:19:21.504] Build status: STARTED
[03:19:21.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:52:0) after 6m49s
[03:26:10.552] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:52:0)
[03:26:10.653] Build status: STARTED
[03:26:10.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:53:0) after 9m54s
[03:36:04.780] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:53:0)
[03:36:04.809] Build status: STARTED
[03:36:04.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:54:0) after 5m11s
[03:41:15.832] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:54:0)
[03:41:15.858] Build status: STARTED
[03:41:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:55:0) after 3m55s
[03:45:10.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:55:0)
[03:45:11.001] Build status: STARTED
[03:45:11.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:56:0) after 6m56s
[03:52:07.166] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:56:0)
[03:52:07.244] Build status: STARTED
[03:52:07.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:57:0) after 1m35s
[03:53:42.361] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:57:0)
[03:53:42.390] Build status: STARTED
[03:53:42.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:58:0) after 5m14s
[03:58:56.418] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:58:0)
[03:58:56.454] Build status: STARTED
[03:58:56.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:59:0) after 2m2s
[04:00:58.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:59:0)
[04:00:58.521] Build status: STARTED
[04:00:58.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:60:0) after 9m51s
[04:10:49.759] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:60:0)
[04:10:49.791] Build status: STARTED
[04:10:49.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:61:0) after 6m36s
[04:17:25.948] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:61:0)
[04:17:25.977] Build status: STARTED
[04:17:25.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:62:0) after 9m18s
[04:26:44.113] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:62:0)
[04:26:44.143] Build status: STARTED
[04:26:44.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:63:0) after 5m54s
[04:32:38.246] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:63:0)
[04:32:38.287] Build status: STARTED
[04:32:38.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:64:0) after 2m22s
[04:35:00.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:64:0)
[04:35:00.357] Build status: STARTED
[04:35:00.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:65:0) after 7m30s
[04:42:30.373] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:65:0)
[04:42:30.398] Build status: STARTED
[04:42:30.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:66:0) after 4m37s
[04:47:07.428] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:66:0)
[04:47:07.471] Build status: STARTED
[04:47:07.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:67:0) after 2m4s
[04:49:11.495] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:67:0)
[04:49:11.528] Build status: STARTED
[04:49:11.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:68:0) after 3m52s
[04:53:03.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:68:0)
[04:53:03.703] Build status: STARTED
[04:53:03.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:69:0) after 5m42s
[04:58:45.725] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:69:0)
[04:58:45.766] Build status: STARTED
[04:58:45.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:70:0) after 7m35s
[05:06:20.803] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:70:0)
[05:06:20.830] Build status: STARTED
[05:06:20.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:71:0) after 3m9s
[05:09:30.072] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:71:0)
[05:09:30.096] Build status: STARTED
[05:09:30.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:72:0) after 1m27s
[05:10:57.247] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:72:0)
[05:10:57.278] Build status: STARTED
[05:10:57.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:73:0) after 6m34s
[05:17:31.354] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:73:0)
[05:17:31.403] Build status: STARTED
[05:17:31.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:74:0) after 7m52s
[05:25:23.523] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:74:0)
[05:25:23.551] Build status: STARTED
[05:25:23.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:75:0) after 8m6s
[05:33:29.618] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:75:0)
[05:33:29.660] Build status: STARTED
[05:33:29.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:76:0) after 3m32s
[05:37:01.907] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:76:0)
[05:37:01.946] Build status: STARTED
[05:37:01.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:77:0) after 2m22s
[05:39:23.972] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:77:0)
[05:39:24.000] Build status: STARTED
[05:39:24.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:78:0) after 2m41s
[05:42:05.022] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:78:0)
[05:42:05.055] Build status: STARTED
[05:42:05.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:79:0) after 1m26s
[05:43:31.094] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:79:0)
[05:43:31.126] Build status: STARTED
[05:43:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:80:0) after 8m26s
[05:51:57.385] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:80:0)
[05:51:57.448] Build status: STARTED
[05:51:57.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:81:0) after 4m47s
[05:56:44.541] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:81:0)
[05:56:44.589] Build status: STARTED
[05:56:44.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:82:0) after 9m27s
[06:06:11.692] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:82:0)
[06:06:11.770] Build status: STARTED
[06:06:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:83:0) after 7m22s
[06:13:33.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:83:0)
[06:13:33.838] Build status: STARTED
[06:13:33.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:84:0) after 2m5s
[06:15:38.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:84:0)
[06:15:38.915] Build status: STARTED
[06:15:38.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:85:0) after 3m14s
[06:18:52.940] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:85:0)
[06:18:52.979] Build status: STARTED
[06:18:52.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:86:0) after 4m22s
[06:23:15.196] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:86:0)
[06:23:15.222] Build status: STARTED
[06:23:15.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:87:0) after 6m40s
[06:29:55.339] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:87:0)
[06:29:55.365] Build status: STARTED
[06:29:55.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:88:0) after 4m15s
[06:34:10.389] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:88:0)
[06:34:10.478] Build status: STARTED
[06:34:10.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:89:0) after 3m34s
[06:37:44.567] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:89:0)
[06:37:44.601] Build status: STARTED
[06:37:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:90:0) after 6m12s
[06:43:56.702] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:90:0)
[06:43:56.745] Build status: STARTED
[06:43:56.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:91:0) after 6m54s
[06:50:50.917] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:91:0)
[06:50:50.946] Build status: STARTED
[06:50:50.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:92:0) after 6m58s
[06:57:49.179] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:92:0)
[06:57:49.214] Build status: STARTED
[06:57:49.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:93:0) after 8m59s
[07:06:48.253] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:93:0)
[07:06:48.302] Build status: STARTED
[07:06:48.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:94:0) after 5m26s
[07:12:14.335] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:94:0)
[07:12:14.466] Build status: STARTED
[07:12:14.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:95:0) after 1m47s
[07:14:01.591] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:95:0)
[07:14:01.617] Build status: STARTED
[07:14:01.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:96:0) after 6m43s
[07:20:44.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:96:0)
[07:20:44.791] Build status: STARTED
[07:20:44.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:97:0) after 6m7s
[07:26:51.890] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:97:0)
[07:26:51.926] Build status: STARTED
[07:26:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:98:0) after 8m0s
[07:34:51.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:98:0)
[07:34:52.019] Build status: STARTED
[07:34:52.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:99:0) after 1m38s
[07:36:30.060] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:99:0)
[07:36:30.093] Build status: STARTED
[07:36:30.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:100:0) after 3m20s
[07:39:50.206] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:100:0)
[07:39:50.234] Build status: STARTED
[07:39:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:101:0) after 2m31s
[07:42:21.461] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:101:0)
[07:42:21.492] Build status: STARTED
[07:42:21.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:102:0) after 1m8s
[07:43:29.552] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:102:0)
[07:43:29.579] Build status: STARTED
[07:43:29.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:103:0) after 9m46s
[07:53:15.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:103:0)
[07:53:15.638] Build status: STARTED
[07:53:15.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:104:0) after 4m15s
[07:57:30.765] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:104:0)
[07:57:30.792] Build status: STARTED
[07:57:30.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:105:0) after 6m33s
[08:04:03.824] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:105:0)
[08:04:03.858] Build status: STARTED
[08:04:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:106:0) after 9m33s
[08:13:36.999] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:106:0)
[08:13:37.026] Build status: STARTED
[08:13:37.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:107:0) after 6m10s
[08:19:47.157] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:107:0)
[08:19:47.191] Build status: STARTED
[08:19:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9007029332059408368:108:0) after 1m39s
[08:20:01.387] Received PubSub notification, asking Buildbucket for the build status
[08:20:01.415] Build:
{
"id": "8841599269747497424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26852,
"createdBy": "project:chromium",
"createTime": "2021-07-15T23:14:42.693367Z",
"startTime": "2021-07-15T23:19:30.729090Z",
"endTime": "2021-07-16T08:20:00.991200922Z",
"updateTime": "2021-07-16T08:20:00.991600229Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "387feacbf4dc4ca94e4a764a32a7c1dd45d913f2",
"ref": "refs/heads/main"
}
}
}
[08:20:01.415] Invocation finished in 9h5m20.309855506s with status FAILED