[10:29:12.222] New invocation is queued and will start shortly
[10:29:13.327] Starting the invocation (attempt 1)
[10:29:13.372] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ff0c7554332f3a2f5985b6a1bb4a1d4b0ef70395"
[10:29:13.372] Popped gitiles commit info from properties and tags
[10:29:13.372] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:29:13.372] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:29:13.372] Buildbucket request:
{
"requestId": "9004540776940665264",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ff0c7554332f3a2f5985b6a1bb4a1d4b0ef70395",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9004540776940665264"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMacASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:29:14.007] Scheduled build:
{
"id": "8839110714914104368",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 25373,
"createdBy": "project:chromium",
"createTime": "2021-08-12T10:29:13.523566Z",
"updateTime": "2021-08-12T10:29:13.944769Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ff0c7554332f3a2f5985b6a1bb4a1d4b0ef70395",
"ref": "refs/heads/main"
}
}
}
[10:29:14.007] Task URL: https://cr-buildbucket.appspot.com/build/8839110714914104368
[10:29:14.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:2:0) after 9m4s
[10:33:18.635] Received PubSub notification, asking Buildbucket for the build status
[10:33:18.670] Build status: STARTED
[10:38:18.208] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:2:0)
[10:38:18.257] Build status: STARTED
[10:38:18.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:4:0) after 4m39s
[10:42:57.302] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:4:0)
[10:42:57.332] Build status: STARTED
[10:42:57.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:5:0) after 8m41s
[10:51:38.359] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:5:0)
[10:51:38.385] Build status: STARTED
[10:51:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:6:0) after 7m8s
[10:58:46.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:6:0)
[10:58:46.458] Build status: STARTED
[10:58:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:7:0) after 1m59s
[11:00:45.581] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:7:0)
[11:00:45.610] Build status: STARTED
[11:00:45.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:8:0) after 1m21s
[11:02:06.802] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:8:0)
[11:02:06.853] Build status: STARTED
[11:02:06.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:9:0) after 3m24s
[11:05:31.282] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:9:0)
[11:05:31.381] Build status: STARTED
[11:05:31.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:10:0) after 5m55s
[11:11:26.544] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:10:0)
[11:11:26.572] Build status: STARTED
[11:11:26.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:11:0) after 3m3s
[11:14:29.749] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:11:0)
[11:14:29.787] Build status: STARTED
[11:14:29.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:12:0) after 7m44s
[11:22:13.901] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:12:0)
[11:22:13.954] Build status: STARTED
[11:22:13.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:13:0) after 5m38s
[11:27:52.047] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:13:0)
[11:27:52.080] Build status: STARTED
[11:27:52.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:14:0) after 9m58s
[11:37:50.115] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:14:0)
[11:37:50.143] Build status: STARTED
[11:37:50.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:15:0) after 7m13s
[11:45:03.176] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:15:0)
[11:45:03.214] Build status: STARTED
[11:45:03.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:16:0) after 9m43s
[11:54:46.367] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:16:0)
[11:54:46.395] Build status: STARTED
[11:54:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:17:0) after 9m38s
[12:04:24.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:17:0)
[12:04:24.452] Build status: STARTED
[12:04:24.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:18:0) after 5m56s
[12:10:20.526] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:18:0)
[12:10:20.560] Build status: STARTED
[12:10:20.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:19:0) after 2m42s
[12:13:02.793] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:19:0)
[12:13:02.851] Build status: STARTED
[12:13:02.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:20:0) after 3m31s
[12:16:33.883] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:20:0)
[12:16:33.919] Build status: STARTED
[12:16:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:21:0) after 1m52s
[12:18:26.099] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:21:0)
[12:18:26.130] Build status: STARTED
[12:18:26.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:22:0) after 5m50s
[12:24:16.155] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:22:0)
[12:24:16.194] Build status: STARTED
[12:24:16.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:23:0) after 1m42s
[12:25:58.302] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:23:0)
[12:25:58.332] Build status: STARTED
[12:25:58.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:24:0) after 9m16s
[12:35:14.375] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:24:0)
[12:35:14.404] Build status: STARTED
[12:35:14.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:25:0) after 2m14s
[12:37:28.463] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:25:0)
[12:37:28.490] Build status: STARTED
[12:37:28.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:26:0) after 9m7s
[12:46:35.518] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:26:0)
[12:46:35.593] Build status: STARTED
[12:46:35.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:27:0) after 4m0s
[12:50:35.777] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:27:0)
[12:50:35.804] Build status: STARTED
[12:50:35.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:28:0) after 2m15s
[12:52:50.842] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:28:0)
[12:52:50.900] Build status: STARTED
[12:52:50.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:29:0) after 6m39s
[12:59:29.940] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:29:0)
[12:59:29.969] Build status: STARTED
[12:59:29.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:30:0) after 5m48s
[13:05:17.971] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:30:0)
[13:05:17.998] Build status: STARTED
[13:05:17.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:31:0) after 7m25s
[13:12:43.110] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:31:0)
[13:12:43.166] Build status: STARTED
[13:12:43.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:32:0) after 7m22s
[13:20:05.189] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:32:0)
[13:20:05.216] Build status: STARTED
[13:20:05.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:33:0) after 7m0s
[13:27:05.465] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:33:0)
[13:27:05.495] Build status: STARTED
[13:27:05.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:34:0) after 7m3s
[13:34:08.522] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:34:0)
[13:34:08.692] Build status: STARTED
[13:34:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:35:0) after 3m38s
[13:37:46.730] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:35:0)
[13:37:46.760] Build status: STARTED
[13:37:46.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:36:0) after 6m7s
[13:43:53.821] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:36:0)
[13:43:53.880] Build status: STARTED
[13:43:53.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:37:0) after 1m40s
[13:45:34.034] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:37:0)
[13:45:34.147] Build status: STARTED
[13:45:34.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:38:0) after 9m41s
[13:55:15.220] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:38:0)
[13:55:15.257] Build status: STARTED
[13:55:15.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:39:0) after 2m7s
[13:57:22.326] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:39:0)
[13:57:22.355] Build status: STARTED
[13:57:22.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:40:0) after 8m39s
[14:06:01.418] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:40:0)
[14:06:01.451] Build status: STARTED
[14:06:01.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:41:0) after 9m2s
[14:15:03.479] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:41:0)
[14:15:03.515] Build status: STARTED
[14:15:03.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:42:0) after 4m13s
[14:19:16.538] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:42:0)
[14:19:16.587] Build status: STARTED
[14:19:16.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:43:0) after 2m13s
[14:21:29.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:43:0)
[14:21:29.769] Build status: STARTED
[14:21:29.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:44:0) after 5m40s
[14:27:09.926] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:44:0)
[14:27:09.959] Build status: STARTED
[14:27:09.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:45:0) after 6m5s
[14:33:15.085] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:45:0)
[14:33:15.114] Build status: STARTED
[14:33:15.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:46:0) after 7m57s
[14:41:12.135] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:46:0)
[14:41:12.167] Build status: STARTED
[14:41:12.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:47:0) after 6m50s
[14:48:02.306] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:47:0)
[14:48:02.342] Build status: STARTED
[14:48:02.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:48:0) after 8m46s
[14:56:48.375] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:48:0)
[14:56:48.467] Build status: STARTED
[14:56:48.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:49:0) after 6m2s
[15:02:50.690] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:49:0)
[15:02:50.770] Build status: STARTED
[15:02:50.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:50:0) after 1m13s
[15:04:03.868] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:50:0)
[15:04:03.922] Build status: STARTED
[15:04:03.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:51:0) after 2m3s
[15:06:06.967] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:51:0)
[15:06:06.996] Build status: STARTED
[15:06:06.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:52:0) after 4m43s
[15:10:50.041] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:52:0)
[15:10:50.073] Build status: STARTED
[15:10:50.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:53:0) after 5m42s
[15:16:32.098] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:53:0)
[15:16:32.131] Build status: STARTED
[15:16:32.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:54:0) after 2m2s
[15:18:34.519] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:54:0)
[15:18:34.547] Build status: STARTED
[15:18:34.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:55:0) after 5m45s
[15:24:19.913] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:55:0)
[15:24:19.958] Build status: STARTED
[15:24:19.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:56:0) after 9m48s
[15:34:07.991] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:56:0)
[15:34:08.024] Build status: STARTED
[15:34:08.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:57:0) after 3m52s
[15:38:00.028] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:57:0)
[15:38:00.066] Build status: STARTED
[15:38:00.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:58:0) after 7m42s
[15:45:42.111] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:58:0)
[15:45:42.157] Build status: STARTED
[15:45:42.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:59:0) after 2m6s
[15:47:48.495] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:59:0)
[15:47:48.525] Build status: STARTED
[15:47:48.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:60:0) after 3m8s
[15:50:56.692] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:60:0)
[15:50:56.722] Build status: STARTED
[15:50:56.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:61:0) after 3m34s
[15:54:30.804] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:61:0)
[15:54:30.984] Build status: STARTED
[15:54:30.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:62:0) after 5m7s
[15:59:37.986] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:62:0)
[15:59:38.026] Build status: STARTED
[15:59:38.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:63:0) after 7m44s
[16:07:22.233] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:63:0)
[16:07:22.265] Build status: STARTED
[16:07:22.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:64:0) after 5m42s
[16:13:04.417] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:64:0)
[16:13:04.451] Build status: STARTED
[16:13:04.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:65:0) after 8m39s
[16:21:43.556] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:65:0)
[16:21:43.585] Build status: STARTED
[16:21:43.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:66:0) after 9m58s
[16:31:41.622] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:66:0)
[16:31:41.653] Build status: STARTED
[16:31:41.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:67:0) after 1m10s
[16:32:51.738] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:67:0)
[16:32:51.768] Build status: STARTED
[16:32:51.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:68:0) after 3m11s
[16:36:02.848] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:68:0)
[16:36:02.878] Build status: STARTED
[16:36:02.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:69:0) after 3m8s
[16:39:11.023] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:69:0)
[16:39:11.070] Build status: STARTED
[16:39:11.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:70:0) after 6m15s
[16:45:26.095] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:70:0)
[16:45:26.129] Build status: STARTED
[16:45:26.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:71:0) after 1m19s
[16:46:45.164] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:71:0)
[16:46:45.200] Build status: STARTED
[16:46:45.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:72:0) after 9m55s
[16:56:40.226] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:72:0)
[16:56:40.256] Build status: STARTED
[16:56:40.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:73:0) after 1m47s
[16:58:27.338] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:73:0)
[16:58:27.368] Build status: STARTED
[16:58:27.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:74:0) after 4m36s
[17:03:03.409] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:74:0)
[17:03:03.440] Build status: STARTED
[17:03:03.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:75:0) after 9m32s
[17:12:35.468] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:75:0)
[17:12:35.512] Build status: STARTED
[17:12:35.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:76:0) after 6m28s
[17:19:03.580] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:76:0)
[17:19:03.621] Build status: STARTED
[17:19:03.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:77:0) after 3m13s
[17:22:16.861] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:77:0)
[17:22:16.894] Build status: STARTED
[17:22:16.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:78:0) after 8m59s
[17:31:16.238] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:78:0)
[17:31:16.266] Build status: STARTED
[17:31:16.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:79:0) after 9m8s
[17:40:24.301] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:79:0)
[17:40:24.329] Build status: STARTED
[17:40:24.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:80:0) after 7m48s
[17:48:12.376] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:80:0)
[17:48:12.404] Build status: STARTED
[17:48:12.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:81:0) after 1m15s
[17:49:27.496] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:81:0)
[17:49:27.536] Build status: STARTED
[17:49:27.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:82:0) after 3m29s
[17:52:56.545] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:82:0)
[17:52:56.577] Build status: STARTED
[17:52:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:83:0) after 2m9s
[17:55:05.658] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:83:0)
[17:55:05.687] Build status: STARTED
[17:55:05.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:84:0) after 5m56s
[18:01:01.718] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:84:0)
[18:01:01.760] Build status: STARTED
[18:01:01.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:85:0) after 4m5s
[18:05:06.785] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:85:0)
[18:05:06.814] Build status: STARTED
[18:05:06.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:86:0) after 8m42s
[18:13:48.907] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:86:0)
[18:13:48.987] Build status: STARTED
[18:13:48.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:87:0) after 8m32s
[18:22:21.251] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:87:0)
[18:22:21.284] Build status: STARTED
[18:22:21.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:88:0) after 7m53s
[18:30:14.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:88:0)
[18:30:14.353] Build status: STARTED
[18:30:14.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:89:0) after 8m11s
[18:38:25.615] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:89:0)
[18:38:25.643] Build status: STARTED
[18:38:25.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:90:0) after 8m33s
[18:46:59.683] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:90:0)
[18:46:59.707] Build status: STARTED
[18:46:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:91:0) after 9m30s
[18:56:29.762] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:91:0)
[18:56:29.793] Build status: STARTED
[18:56:29.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:92:0) after 3m12s
[18:59:41.820] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:92:0)
[18:59:41.902] Build status: STARTED
[18:59:41.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:93:0) after 6m27s
[19:06:08.964] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:93:0)
[19:06:09.004] Build status: STARTED
[19:06:09.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:94:0) after 7m28s
[19:13:37.084] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:94:0)
[19:13:37.134] Build status: STARTED
[19:13:37.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:95:0) after 1m52s
[19:15:29.423] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:95:0)
[19:15:29.462] Build status: STARTED
[19:15:29.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:96:0) after 2m33s
[19:18:02.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:96:0)
[19:18:02.536] Build status: STARTED
[19:18:02.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:97:0) after 2m11s
[19:20:13.585] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:97:0)
[19:20:13.638] Build status: STARTED
[19:20:13.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:98:0) after 2m17s
[19:22:30.919] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:98:0)
[19:22:30.948] Build status: STARTED
[19:22:30.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:99:0) after 8m56s
[19:31:26.985] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:99:0)
[19:31:27.015] Build status: STARTED
[19:31:27.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:100:0) after 9m59s
[19:41:26.115] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:100:0)
[19:41:26.144] Build status: STARTED
[19:41:26.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:101:0) after 8m29s
[19:49:55.360] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:101:0)
[19:49:55.388] Build status: STARTED
[19:49:55.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:102:0) after 4m51s
[19:54:46.392] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:102:0)
[19:54:46.427] Build status: STARTED
[19:54:46.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:103:0) after 6m4s
[20:00:50.580] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:103:0)
[20:00:50.616] Build status: STARTED
[20:00:50.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:104:0) after 8m22s
[20:09:12.765] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:104:0)
[20:09:12.803] Build status: STARTED
[20:09:12.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:105:0) after 2m21s
[20:11:34.059] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:105:0)
[20:11:34.091] Build status: STARTED
[20:11:34.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:106:0) after 7m20s
[20:18:54.138] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:106:0)
[20:18:54.173] Build status: STARTED
[20:18:54.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:107:0) after 1m4s
[20:19:58.199] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:107:0)
[20:19:58.229] Build status: STARTED
[20:19:58.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:108:0) after 9m1s
[20:28:59.501] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:108:0)
[20:28:59.532] Build status: STARTED
[20:28:59.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:109:0) after 8m7s
[20:37:06.577] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:109:0)
[20:37:06.606] Build status: STARTED
[20:37:06.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:110:0) after 5m46s
[20:42:52.867] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:110:0)
[20:42:52.897] Build status: STARTED
[20:42:52.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:111:0) after 4m3s
[20:46:56.025] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:111:0)
[20:46:56.057] Build status: STARTED
[20:46:56.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9004540776940665264:112:0) after 8m36s
[20:55:14.488] Received PubSub notification, asking Buildbucket for the build status
[20:55:14.516] Build:
{
"id": "8839110714914104368",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 25373,
"createdBy": "project:chromium",
"createTime": "2021-08-12T10:29:13.523566Z",
"startTime": "2021-08-12T10:33:18.142997Z",
"endTime": "2021-08-12T20:55:13.926909916Z",
"updateTime": "2021-08-12T20:55:13.927245202Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ff0c7554332f3a2f5985b6a1bb4a1d4b0ef70395",
"ref": "refs/heads/main"
}
}
}
[20:55:14.516] Invocation finished in 10h26m2.310411974s with status FAILED