[08:44:10.644] New invocation is queued and will start shortly
[08:44:11.723] Starting the invocation (attempt 1)
[08:44:11.756] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/715bfc84c0938fe48f1cd4f6a0a741604688aa54"
[08:44:11.756] Popped gitiles commit info from properties and tags
[08:44:11.756] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:44:11.756] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:44:11.756] Buildbucket request:
{
"requestId": "8987696348872769072",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "715bfc84c0938fe48f1cd4f6a0a741604688aa54",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8987696348872769072"
},
{
"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"
}
}
[08:44:12.254] Scheduled build:
{
"id": "8822266286977903409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 26529,
"createdBy": "project:chromium",
"createTime": "2022-02-14T08:44:11.820722657Z",
"updateTime": "2022-02-14T08:44:11.820722657Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "715bfc84c0938fe48f1cd4f6a0a741604688aa54",
"ref": "refs/heads/main"
}
}
}
[08:44:12.254] Task URL: https://cr-buildbucket.appspot.com/build/8822266286977903409
[08:44:12.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:2:0) after 7m25s
[08:51:37.272] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:2:0)
[08:51:37.290] Build status: SCHEDULED
[08:51:37.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:3:0) after 3m11s
[08:54:48.408] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:3:0)
[08:54:48.427] Build status: SCHEDULED
[08:54:48.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:4:0) after 2m22s
[08:57:10.545] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:4:0)
[08:57:10.571] Build status: SCHEDULED
[08:57:10.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:5:0) after 7m32s
[09:04:42.691] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:5:0)
[09:04:42.764] Build status: SCHEDULED
[09:04:42.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:6:0) after 7m32s
[09:12:14.884] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:6:0)
[09:12:14.906] Build status: SCHEDULED
[09:12:14.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:7:0) after 9m29s
[09:15:51.747] Received PubSub notification, asking Buildbucket for the build status
[09:15:51.767] Build status: STARTED
[09:21:44.003] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:7:0)
[09:21:44.037] Build status: STARTED
[09:21:44.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:9:0) after 6m6s
[09:27:50.104] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:9:0)
[09:27:50.130] Build status: STARTED
[09:27:50.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:10:0) after 5m9s
[09:32:59.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:10:0)
[09:32:59.346] Build status: STARTED
[09:32:59.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:11:0) after 5m20s
[09:38:19.378] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:11:0)
[09:38:19.400] Build status: STARTED
[09:38:19.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:12:0) after 8m45s
[09:47:04.432] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:12:0)
[09:47:04.463] Build status: STARTED
[09:47:04.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:13:0) after 6m37s
[09:53:41.474] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:13:0)
[09:53:41.494] Build status: STARTED
[09:53:41.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:14:0) after 5m40s
[09:59:21.515] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:14:0)
[09:59:21.534] Build status: STARTED
[09:59:21.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:15:0) after 6m59s
[10:06:20.572] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:15:0)
[10:06:20.595] Build status: STARTED
[10:06:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:16:0) after 1m33s
[10:07:53.729] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:16:0)
[10:07:53.753] Build status: STARTED
[10:07:53.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:17:0) after 9m21s
[10:17:14.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:17:0)
[10:17:14.816] Build status: STARTED
[10:17:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:18:0) after 1m50s
[10:19:04.788] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:18:0)
[10:19:04.820] Build status: STARTED
[10:19:04.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:19:0) after 8m43s
[10:27:48.064] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:19:0)
[10:27:48.084] Build status: STARTED
[10:27:48.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:20:0) after 4m57s
[10:32:45.102] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:20:0)
[10:32:45.121] Build status: STARTED
[10:32:45.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:21:0) after 3m36s
[10:36:21.224] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:21:0)
[10:36:21.247] Build status: STARTED
[10:36:21.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:22:0) after 2m48s
[10:39:09.346] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:22:0)
[10:39:09.367] Build status: STARTED
[10:39:09.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:23:0) after 9m39s
[10:48:48.430] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:23:0)
[10:48:48.460] Build status: STARTED
[10:48:48.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:24:0) after 9m35s
[10:58:23.562] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:24:0)
[10:58:23.584] Build status: STARTED
[10:58:23.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:25:0) after 9m20s
[11:07:43.784] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:25:0)
[11:07:43.807] Build status: STARTED
[11:07:43.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:26:0) after 1m53s
[11:09:36.830] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:26:0)
[11:09:36.849] Build status: STARTED
[11:09:36.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:27:0) after 8m42s
[11:18:18.871] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:27:0)
[11:18:18.910] Build status: STARTED
[11:18:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:28:0) after 1m13s
[11:19:32.066] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:28:0)
[11:19:32.118] Build status: STARTED
[11:19:32.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:29:0) after 2m36s
[11:22:08.245] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:29:0)
[11:22:08.266] Build status: STARTED
[11:22:08.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:30:0) after 7m56s
[11:30:04.387] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:30:0)
[11:30:04.420] Build status: STARTED
[11:30:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:31:0) after 1m59s
[11:32:03.457] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:31:0)
[11:32:03.476] Build status: STARTED
[11:32:03.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:32:0) after 1m35s
[11:33:38.495] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:32:0)
[11:33:38.518] Build status: STARTED
[11:33:38.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:33:0) after 1m21s
[11:34:59.630] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:33:0)
[11:34:59.705] Build status: STARTED
[11:34:59.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:34:0) after 5m10s
[11:40:09.834] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:34:0)
[11:40:09.877] Build status: STARTED
[11:40:09.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:35:0) after 4m50s
[11:44:59.856] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:35:0)
[11:44:59.995] Build status: STARTED
[11:44:59.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:36:0) after 7m52s
[11:52:52.016] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:36:0)
[11:52:52.064] Build status: STARTED
[11:52:52.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:37:0) after 6m23s
[11:59:15.185] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:37:0)
[11:59:15.214] Build status: STARTED
[11:59:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:38:0) after 1m47s
[12:01:02.349] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:38:0)
[12:01:02.372] Build status: STARTED
[12:01:02.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:39:0) after 2m14s
[12:03:16.922] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:39:0)
[12:03:16.954] Build status: STARTED
[12:03:16.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:40:0) after 9m31s
[12:12:48.086] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:40:0)
[12:12:48.108] Build status: STARTED
[12:12:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:41:0) after 6m20s
[12:19:08.299] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:41:0)
[12:19:08.316] Build status: STARTED
[12:19:08.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:42:0) after 5m48s
[12:24:56.432] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:42:0)
[12:24:56.462] Build status: STARTED
[12:24:56.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:43:0) after 3m5s
[12:28:01.937] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:43:0)
[12:28:01.967] Build status: STARTED
[12:28:01.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:44:0) after 6m0s
[12:34:02.138] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:44:0)
[12:34:02.162] Build status: STARTED
[12:34:02.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:45:0) after 6m16s
[12:40:18.174] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:45:0)
[12:40:18.196] Build status: STARTED
[12:40:18.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:46:0) after 4m48s
[12:45:06.221] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:46:0)
[12:45:06.242] Build status: STARTED
[12:45:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:47:0) after 7m48s
[12:52:54.352] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:47:0)
[12:52:54.436] Build status: STARTED
[12:52:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:48:0) after 2m42s
[12:55:36.457] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:48:0)
[12:55:36.489] Build status: STARTED
[12:55:36.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:49:0) after 8m51s
[13:04:27.577] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:49:0)
[13:04:27.609] Build status: STARTED
[13:04:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:50:0) after 9m5s
[13:13:32.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:50:0)
[13:13:32.913] Build status: STARTED
[13:13:32.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:51:0) after 4m58s
[13:18:30.926] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:51:0)
[13:18:31.006] Build status: STARTED
[13:18:31.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:52:0) after 9m57s
[13:28:28.019] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:52:0)
[13:28:28.121] Build status: STARTED
[13:28:28.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:53:0) after 1m58s
[13:30:26.207] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:53:0)
[13:30:26.227] Build status: STARTED
[13:30:26.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:54:0) after 1m41s
[13:32:07.251] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:54:0)
[13:32:07.274] Build status: STARTED
[13:32:07.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:55:0) after 3m52s
[13:35:59.303] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:55:0)
[13:35:59.320] Build status: STARTED
[13:35:59.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:56:0) after 8m8s
[13:44:07.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:56:0)
[13:44:07.436] Build status: STARTED
[13:44:07.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:57:0) after 4m29s
[13:48:36.468] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:57:0)
[13:48:36.487] Build status: STARTED
[13:48:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:58:0) after 4m21s
[13:52:57.609] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:58:0)
[13:52:57.626] Build status: STARTED
[13:52:57.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:59:0) after 6m7s
[13:59:04.646] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:59:0)
[13:59:04.676] Build status: STARTED
[13:59:04.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:60:0) after 7m25s
[14:06:29.872] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:60:0)
[14:06:29.980] Build status: STARTED
[14:06:29.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:61:0) after 4m54s
[14:11:24.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:61:0)
[14:11:24.027] Build status: STARTED
[14:11:24.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:62:0) after 9m38s
[14:21:02.150] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:62:0)
[14:21:02.186] Build status: STARTED
[14:21:02.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:63:0) after 9m21s
[14:30:23.214] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:63:0)
[14:30:23.236] Build status: STARTED
[14:30:23.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:64:0) after 9m30s
[14:39:53.263] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:64:0)
[14:39:53.301] Build status: STARTED
[14:39:53.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:65:0) after 1m35s
[14:41:28.323] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:65:0)
[14:41:28.343] Build status: STARTED
[14:41:28.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:66:0) after 5m43s
[14:47:11.370] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:66:0)
[14:47:11.390] Build status: STARTED
[14:47:11.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:67:0) after 5m36s
[14:52:47.414] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:67:0)
[14:52:47.434] Build status: STARTED
[14:52:47.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:68:0) after 8m53s
[15:01:40.538] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:68:0)
[15:01:40.573] Build status: STARTED
[15:01:40.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:69:0) after 1m33s
[15:03:13.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:69:0)
[15:03:13.620] Build status: STARTED
[15:03:13.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:70:0) after 2m56s
[15:06:09.660] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:70:0)
[15:06:09.698] Build status: STARTED
[15:06:09.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:71:0) after 5m47s
[15:11:56.720] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:71:0)
[15:11:56.766] Build status: STARTED
[15:11:56.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:72:0) after 9m10s
[15:21:06.792] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:72:0)
[15:21:06.812] Build status: STARTED
[15:21:06.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:73:0) after 2m57s
[15:24:03.867] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:73:0)
[15:24:03.887] Build status: STARTED
[15:24:03.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:74:0) after 1m58s
[15:26:01.912] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:74:0)
[15:26:01.945] Build status: STARTED
[15:26:01.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:75:0) after 3m42s
[15:29:44.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:75:0)
[15:29:44.087] Build status: STARTED
[15:29:44.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:76:0) after 4m16s
[15:34:00.125] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:76:0)
[15:34:00.147] Build status: STARTED
[15:34:00.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:77:0) after 7m24s
[15:41:24.170] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:77:0)
[15:41:24.193] Build status: STARTED
[15:41:24.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:78:0) after 8m32s
[15:49:56.228] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:78:0)
[15:49:56.251] Build status: STARTED
[15:49:56.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:79:0) after 3m28s
[15:53:24.308] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:79:0)
[15:53:24.366] Build status: STARTED
[15:53:24.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:80:0) after 2m44s
[15:56:08.428] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:80:0)
[15:56:08.446] Build status: STARTED
[15:56:08.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:81:0) after 4m35s
[16:00:43.542] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:81:0)
[16:00:43.586] Build status: STARTED
[16:00:43.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:82:0) after 2m36s
[16:03:19.612] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:82:0)
[16:03:19.635] Build status: STARTED
[16:03:19.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:83:0) after 9m7s
[16:12:26.863] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:83:0)
[16:12:26.901] Build status: STARTED
[16:12:26.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:84:0) after 7m46s
[16:20:12.991] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:84:0)
[16:20:13.014] Build status: STARTED
[16:20:13.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:85:0) after 3m0s
[16:23:13.087] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:85:0)
[16:23:13.150] Build status: STARTED
[16:23:13.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:86:0) after 2m16s
[16:25:29.179] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:86:0)
[16:25:29.200] Build status: STARTED
[16:25:29.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:87:0) after 5m43s
[16:31:12.234] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:87:0)
[16:31:12.254] Build status: STARTED
[16:31:12.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:88:0) after 5m27s
[16:36:39.443] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:88:0)
[16:36:39.546] Build status: STARTED
[16:36:39.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:89:0) after 8m1s
[16:44:40.604] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:89:0)
[16:44:40.629] Build status: STARTED
[16:44:40.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:90:0) after 3m10s
[16:47:50.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:90:0)
[16:47:50.714] Build status: STARTED
[16:47:50.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:91:0) after 2m8s
[16:49:58.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:91:0)
[16:49:58.841] Build status: STARTED
[16:49:58.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:92:0) after 8m23s
[16:58:21.864] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:92:0)
[16:58:21.885] Build status: STARTED
[16:58:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:93:0) after 3m37s
[17:01:58.951] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:93:0)
[17:01:58.972] Build status: STARTED
[17:01:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:94:0) after 1m21s
[17:03:20.390] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:94:0)
[17:03:20.446] Build status: STARTED
[17:03:20.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:95:0) after 2m16s
[17:05:36.476] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:95:0)
[17:05:36.574] Build status: STARTED
[17:05:36.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:96:0) after 5m33s
[17:11:09.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:96:0)
[17:11:09.631] Build status: STARTED
[17:11:09.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:97:0) after 1m32s
[17:12:41.873] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:97:0)
[17:12:41.892] Build status: STARTED
[17:12:41.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:98:0) after 2m46s
[17:15:28.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:98:0)
[17:15:28.059] Build status: STARTED
[17:15:28.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:99:0) after 4m32s
[17:20:00.084] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:99:0)
[17:20:00.104] Build status: STARTED
[17:20:00.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:100:0) after 2m54s
[17:22:54.205] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:100:0)
[17:22:54.225] Build status: STARTED
[17:22:54.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:101:0) after 4m57s
[17:27:51.537] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:101:0)
[17:27:51.561] Build status: STARTED
[17:27:51.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:102:0) after 1m42s
[17:29:33.623] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:102:0)
[17:29:33.643] Build status: STARTED
[17:29:33.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:103:0) after 7m15s
[17:36:48.915] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:103:0)
[17:36:48.999] Build status: STARTED
[17:36:48.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:104:0) after 7m38s
[17:44:27.041] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:104:0)
[17:44:27.072] Build status: STARTED
[17:44:27.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:105:0) after 9m56s
[17:54:23.362] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:105:0)
[17:54:23.393] Build status: STARTED
[17:54:23.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:106:0) after 1m24s
[17:55:47.655] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:106:0)
[17:55:47.675] Build status: STARTED
[17:55:47.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:107:0) after 1m54s
[17:57:41.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:107:0)
[17:57:41.719] Build status: STARTED
[17:57:41.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:108:0) after 8m13s
[18:05:54.742] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:108:0)
[18:05:54.765] Build status: STARTED
[18:05:54.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:109:0) after 2m11s
[18:08:05.847] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:109:0)
[18:08:05.893] Build status: STARTED
[18:08:05.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:110:0) after 3m54s
[18:11:59.921] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:110:0)
[18:11:59.940] Build status: STARTED
[18:11:59.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:111:0) after 3m6s
[18:15:05.963] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:111:0)
[18:15:06.020] Build status: STARTED
[18:15:06.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:112:0) after 3m2s
[18:18:08.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:112:0)
[18:18:08.088] Build status: STARTED
[18:18:08.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:113:0) after 3m42s
[18:21:50.063] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:113:0)
[18:21:50.094] Build status: STARTED
[18:21:50.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:114:0) after 7m32s
[18:29:22.118] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:114:0)
[18:29:22.158] Build status: STARTED
[18:29:22.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:115:0) after 6m44s
[18:36:06.238] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:115:0)
[18:36:06.263] Build status: STARTED
[18:36:06.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:116:0) after 2m14s
[18:38:20.296] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:116:0)
[18:38:20.394] Build status: STARTED
[18:38:20.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:117:0) after 1m13s
[18:39:33.448] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:117:0)
[18:39:33.484] Build status: STARTED
[18:39:33.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:118:0) after 6m49s
[18:46:22.510] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:118:0)
[18:46:22.541] Build status: STARTED
[18:46:22.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:119:0) after 1m16s
[18:47:38.801] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:119:0)
[18:47:38.824] Build status: STARTED
[18:47:38.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:120:0) after 9m31s
[18:57:10.101] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:120:0)
[18:57:10.125] Build status: STARTED
[18:57:10.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:121:0) after 9m38s
[19:06:48.282] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:121:0)
[19:06:48.303] Build status: STARTED
[19:06:48.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:122:0) after 8m33s
[19:15:21.330] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:122:0)
[19:15:21.350] Build status: STARTED
[19:15:21.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:123:0) after 7m27s
[19:22:48.454] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:123:0)
[19:22:48.476] Build status: STARTED
[19:22:48.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:124:0) after 1m26s
[19:24:14.540] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:124:0)
[19:24:14.562] Build status: STARTED
[19:24:14.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:125:0) after 8m12s
[19:32:26.609] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:125:0)
[19:32:26.632] Build status: STARTED
[19:32:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:126:0) after 2m34s
[19:35:00.652] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:126:0)
[19:35:00.761] Build status: STARTED
[19:35:00.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:127:0) after 8m44s
[19:43:44.797] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:127:0)
[19:43:44.821] Build status: STARTED
[19:43:44.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:128:0) after 2m48s
[19:46:32.973] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:128:0)
[19:46:32.994] Build status: STARTED
[19:46:32.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:129:0) after 8m31s
[19:55:04.057] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:129:0)
[19:55:04.092] Build status: STARTED
[19:55:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:8987696348872769072:130:0) after 9m1s
[20:01:30.895] Received PubSub notification, asking Buildbucket for the build status
[20:01:30.913] Build:
{
"id": "8822266286977903409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 26529,
"createdBy": "project:chromium",
"createTime": "2022-02-14T08:44:11.820722657Z",
"startTime": "2022-02-14T09:15:51.213878Z",
"endTime": "2022-02-14T20:01:30.047336638Z",
"updateTime": "2022-02-14T20:01:30.047336638Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "715bfc84c0938fe48f1cd4f6a0a741604688aa54",
"ref": "refs/heads/main"
}
}
}
[20:01:30.913] Invocation finished in 11h17m20.28381369s with status FAILED