[22:56:30.579] New invocation is queued and will start shortly
[22:56:31.737] Starting the invocation (attempt 1)
[22:56:31.775] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52904b3ac5f2f26e5119678d22e6747682e12bf5"
[22:56:31.775] Popped gitiles commit info from properties and tags
[22:56:31.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:56:31.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:56:31.775] Buildbucket request:
{
"requestId": "9013372263224486224",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52904b3ac5f2f26e5119678d22e6747682e12bf5",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9013372263224486224"
},
{
"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"
}
}
[22:56:32.569] Scheduled build:
{
"id": "8847942201207823824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 24939,
"createdBy": "project:chromium",
"createTime": "2021-05-06T22:56:31.869126Z",
"updateTime": "2021-05-06T22:56:32.422022Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52904b3ac5f2f26e5119678d22e6747682e12bf5",
"ref": "refs/heads/master"
}
}
}
[22:56:32.569] Task URL: https://cr-buildbucket.appspot.com/build/8847942201207823824
[22:56:32.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:2:0) after 3m10s
[22:57:54.084] Received PubSub notification, asking Buildbucket for the build status
[22:57:54.117] Build status: STARTED
[22:59:42.685] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:2:0)
[22:59:42.711] Build status: STARTED
[22:59:42.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:4:0) after 9m35s
[23:09:17.829] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:4:0)
[23:09:17.866] Build status: STARTED
[23:09:17.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:5:0) after 7m3s
[23:16:20.892] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:5:0)
[23:16:21.028] Build status: STARTED
[23:16:21.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:6:0) after 3m32s
[23:19:53.225] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:6:0)
[23:19:53.259] Build status: STARTED
[23:19:53.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:7:0) after 5m39s
[23:25:32.339] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:7:0)
[23:25:32.372] Build status: STARTED
[23:25:32.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:8:0) after 4m56s
[23:30:28.443] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:8:0)
[23:30:28.471] Build status: STARTED
[23:30:28.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:9:0) after 7m57s
[23:38:25.510] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:9:0)
[23:38:25.540] Build status: STARTED
[23:38:25.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:10:0) after 6m34s
[23:44:59.573] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:10:0)
[23:44:59.615] Build status: STARTED
[23:44:59.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:11:0) after 5m1s
[23:50:00.649] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:11:0)
[23:50:00.677] Build status: STARTED
[23:50:00.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:12:0) after 7m13s
[23:57:13.888] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:12:0)
[23:57:13.947] Build status: STARTED
[23:57:13.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:13:0) after 5m38s
[00:02:52.234] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:13:0)
[00:02:52.279] Build status: STARTED
[00:02:52.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:14:0) after 6m59s
[00:09:51.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:14:0)
[00:09:51.356] Build status: STARTED
[00:09:51.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:15:0) after 3m6s
[00:12:57.400] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:15:0)
[00:12:57.439] Build status: STARTED
[00:12:57.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:16:0) after 3m10s
[00:16:07.790] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:16:0)
[00:16:07.818] Build status: STARTED
[00:16:07.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:17:0) after 5m35s
[00:21:43.284] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:17:0)
[00:21:43.366] Build status: STARTED
[00:21:43.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:18:0) after 4m16s
[00:25:59.527] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:18:0)
[00:25:59.559] Build status: STARTED
[00:25:59.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:19:0) after 4m9s
[00:30:08.657] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:19:0)
[00:30:08.688] Build status: STARTED
[00:30:08.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:20:0) after 3m16s
[00:33:24.874] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:20:0)
[00:33:24.912] Build status: STARTED
[00:33:24.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:21:0) after 9m30s
[00:42:55.044] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:21:0)
[00:42:55.080] Build status: STARTED
[00:42:55.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:22:0) after 5m39s
[00:48:34.338] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:22:0)
[00:48:34.369] Build status: STARTED
[00:48:34.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:23:0) after 4m7s
[00:52:41.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:23:0)
[00:52:41.483] Build status: STARTED
[00:52:41.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:24:0) after 2m1s
[00:54:42.576] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:24:0)
[00:54:42.608] Build status: STARTED
[00:54:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:25:0) after 4m58s
[00:59:40.635] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:25:0)
[00:59:40.666] Build status: STARTED
[00:59:40.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:26:0) after 6m9s
[01:05:49.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:26:0)
[01:05:49.732] Build status: STARTED
[01:05:49.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:27:0) after 5m35s
[01:11:24.831] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:27:0)
[01:11:24.861] Build status: STARTED
[01:11:24.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:28:0) after 4m39s
[01:16:03.893] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:28:0)
[01:16:03.933] Build status: STARTED
[01:16:03.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:29:0) after 3m22s
[01:19:25.964] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:29:0)
[01:19:25.993] Build status: STARTED
[01:19:25.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:30:0) after 9m19s
[01:28:45.151] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:30:0)
[01:28:45.181] Build status: STARTED
[01:28:45.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:31:0) after 2m18s
[01:31:03.345] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:31:0)
[01:31:03.376] Build status: STARTED
[01:31:03.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:32:0) after 9m41s
[01:40:44.483] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:32:0)
[01:40:44.510] Build status: STARTED
[01:40:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:33:0) after 7m49s
[01:48:33.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:33:0)
[01:48:33.588] Build status: STARTED
[01:48:33.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:34:0) after 7m55s
[01:56:28.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:34:0)
[01:56:28.662] Build status: STARTED
[01:56:28.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:35:0) after 7m2s
[02:03:31.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:35:0)
[02:03:31.052] Build status: STARTED
[02:03:31.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:36:0) after 9m6s
[02:12:37.588] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:36:0)
[02:12:37.617] Build status: STARTED
[02:12:37.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:37:0) after 8m14s
[02:20:51.645] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:37:0)
[02:20:51.740] Build status: STARTED
[02:20:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:38:0) after 7m27s
[02:28:18.848] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:38:0)
[02:28:18.874] Build status: STARTED
[02:28:18.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:39:0) after 1m9s
[02:29:27.918] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:39:0)
[02:29:27.947] Build status: STARTED
[02:29:27.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:40:0) after 4m2s
[02:33:29.983] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:40:0)
[02:33:30.014] Build status: STARTED
[02:33:30.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:41:0) after 5m7s
[02:38:37.083] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:41:0)
[02:38:37.115] Build status: STARTED
[02:38:37.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:42:0) after 2m11s
[02:40:48.148] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:42:0)
[02:40:48.174] Build status: STARTED
[02:40:48.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:43:0) after 2m46s
[02:43:34.219] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:43:0)
[02:43:34.267] Build status: STARTED
[02:43:34.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:44:0) after 6m31s
[02:50:05.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:44:0)
[02:50:05.804] Build status: STARTED
[02:50:05.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:45:0) after 3m31s
[02:53:36.990] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:45:0)
[02:53:37.019] Build status: STARTED
[02:53:37.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:46:0) after 3m5s
[02:56:42.153] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:46:0)
[02:56:42.185] Build status: STARTED
[02:56:42.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:47:0) after 3m51s
[03:00:33.360] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:47:0)
[03:00:33.397] Build status: STARTED
[03:00:33.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:48:0) after 1m17s
[03:01:50.442] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:48:0)
[03:01:50.469] Build status: STARTED
[03:01:50.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:49:0) after 9m18s
[03:11:08.748] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:49:0)
[03:11:08.780] Build status: STARTED
[03:11:08.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:50:0) after 2m10s
[03:13:18.808] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:50:0)
[03:13:18.842] Build status: STARTED
[03:13:18.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:51:0) after 5m27s
[03:18:46.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:51:0)
[03:18:46.092] Build status: STARTED
[03:18:46.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:52:0) after 4m55s
[03:23:41.127] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:52:0)
[03:23:41.155] Build status: STARTED
[03:23:41.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:53:0) after 6m43s
[03:30:24.288] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:53:0)
[03:30:24.331] Build status: STARTED
[03:30:24.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:54:0) after 1m53s
[03:32:17.470] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:54:0)
[03:32:17.496] Build status: STARTED
[03:32:17.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:55:0) after 1m49s
[03:34:07.061] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:55:0)
[03:34:07.111] Build status: STARTED
[03:34:07.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:56:0) after 2m34s
[03:36:41.253] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:56:0)
[03:36:41.281] Build status: STARTED
[03:36:41.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:57:0) after 6m38s
[03:43:19.529] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:57:0)
[03:43:19.572] Build status: STARTED
[03:43:19.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:58:0) after 2m52s
[03:46:11.722] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:58:0)
[03:46:11.822] Build status: STARTED
[03:46:11.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:59:0) after 9m38s
[03:55:49.953] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:59:0)
[03:55:49.987] Build status: STARTED
[03:55:49.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:60:0) after 1m8s
[03:56:58.198] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:60:0)
[03:56:58.226] Build status: STARTED
[03:56:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:61:0) after 5m51s
[04:02:49.269] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:61:0)
[04:02:49.302] Build status: STARTED
[04:02:49.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:62:0) after 8m20s
[04:11:09.726] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:62:0)
[04:11:09.756] Build status: STARTED
[04:11:09.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:63:0) after 2m53s
[04:14:03.235] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:63:0)
[04:14:03.265] Build status: STARTED
[04:14:03.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:64:0) after 5m33s
[04:19:36.308] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:64:0)
[04:19:36.334] Build status: STARTED
[04:19:36.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:65:0) after 2m11s
[04:21:47.379] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:65:0)
[04:21:47.417] Build status: STARTED
[04:21:47.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:66:0) after 7m39s
[04:29:26.488] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:66:0)
[04:29:26.515] Build status: STARTED
[04:29:26.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:67:0) after 4m51s
[04:34:17.553] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:67:0)
[04:34:17.579] Build status: STARTED
[04:34:17.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:68:0) after 6m30s
[04:40:47.790] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:68:0)
[04:40:47.838] Build status: STARTED
[04:40:47.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:69:0) after 5m39s
[04:46:26.970] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:69:0)
[04:46:27.002] Build status: STARTED
[04:46:27.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:70:0) after 4m39s
[04:51:06.062] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:70:0)
[04:51:06.109] Build status: STARTED
[04:51:06.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:71:0) after 4m36s
[04:55:42.225] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:71:0)
[04:55:42.259] Build status: STARTED
[04:55:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:72:0) after 7m37s
[05:03:19.292] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:72:0)
[05:03:19.325] Build status: STARTED
[05:03:19.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:73:0) after 6m52s
[05:10:11.417] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:73:0)
[05:10:11.453] Build status: STARTED
[05:10:11.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:74:0) after 1m2s
[05:11:13.483] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:74:0)
[05:11:13.522] Build status: STARTED
[05:11:13.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:75:0) after 2m28s
[05:13:41.526] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:75:0)
[05:13:41.560] Build status: STARTED
[05:13:41.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:76:0) after 9m57s
[05:23:38.644] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:76:0)
[05:23:38.674] Build status: STARTED
[05:23:38.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:77:0) after 3m47s
[05:27:25.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:77:0)
[05:27:25.744] Build status: STARTED
[05:27:25.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:78:0) after 7m19s
[05:34:44.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:78:0)
[05:34:44.804] Build status: STARTED
[05:34:44.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:79:0) after 1m6s
[05:35:50.850] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:79:0)
[05:35:50.890] Build status: STARTED
[05:35:50.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:80:0) after 2m24s
[05:38:14.927] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:80:0)
[05:38:14.953] Build status: STARTED
[05:38:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:81:0) after 8m37s
[05:46:52.030] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:81:0)
[05:46:52.064] Build status: STARTED
[05:46:52.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:82:0) after 1m0s
[05:47:52.222] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:82:0)
[05:47:52.255] Build status: STARTED
[05:47:52.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:83:0) after 8m47s
[05:56:39.315] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:83:0)
[05:56:39.346] Build status: STARTED
[05:56:39.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:84:0) after 1m59s
[05:58:38.406] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:84:0)
[05:58:38.435] Build status: STARTED
[05:58:38.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:85:0) after 7m0s
[06:05:38.563] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:85:0)
[06:05:38.609] Build status: STARTED
[06:05:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:86:0) after 1m21s
[06:06:59.701] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:86:0)
[06:06:59.728] Build status: STARTED
[06:06:59.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:87:0) after 1m20s
[06:08:19.955] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:87:0)
[06:08:19.985] Build status: STARTED
[06:08:19.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:88:0) after 3m47s
[06:12:07.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:88:0)
[06:12:07.041] Build status: STARTED
[06:12:07.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:89:0) after 4m28s
[06:16:35.185] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:89:0)
[06:16:35.214] Build status: STARTED
[06:16:35.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:90:0) after 1m4s
[06:17:39.282] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:90:0)
[06:17:39.318] Build status: STARTED
[06:17:39.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:91:0) after 7m50s
[06:25:29.349] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:91:0)
[06:25:29.379] Build status: STARTED
[06:25:29.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:92:0) after 4m52s
[06:30:21.548] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:92:0)
[06:30:21.578] Build status: STARTED
[06:30:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:93:0) after 1m50s
[06:32:11.608] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:93:0)
[06:32:11.639] Build status: STARTED
[06:32:11.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:94:0) after 3m40s
[06:35:52.145] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:94:0)
[06:35:52.178] Build status: STARTED
[06:35:52.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:95:0) after 5m28s
[06:41:20.252] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:95:0)
[06:41:20.279] Build status: STARTED
[06:41:20.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:96:0) after 9m0s
[06:50:20.449] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:96:0)
[06:50:20.507] Build status: STARTED
[06:50:20.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:97:0) after 9m33s
[06:59:53.669] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:97:0)
[06:59:53.696] Build status: STARTED
[06:59:53.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:98:0) after 5m55s
[07:05:48.727] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:98:0)
[07:05:48.941] Build status: STARTED
[07:05:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:99:0) after 1m50s
[07:07:38.994] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:99:0)
[07:07:39.033] Build status: STARTED
[07:07:39.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:100:0) after 9m40s
[07:17:19.169] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:100:0)
[07:17:19.199] Build status: STARTED
[07:17:19.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:101:0) after 6m8s
[07:23:27.237] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:101:0)
[07:23:27.270] Build status: STARTED
[07:23:27.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:102:0) after 2m31s
[07:25:58.321] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:102:0)
[07:25:58.362] Build status: STARTED
[07:25:58.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:103:0) after 6m17s
[07:32:15.468] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:103:0)
[07:32:15.497] Build status: STARTED
[07:32:15.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:104:0) after 1m30s
[07:33:45.559] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:104:0)
[07:33:45.585] Build status: STARTED
[07:33:45.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:105:0) after 8m4s
[07:41:49.941] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:105:0)
[07:41:49.970] Build status: STARTED
[07:41:49.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:106:0) after 1m40s
[07:43:30.300] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:106:0)
[07:43:30.331] Build status: STARTED
[07:43:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:107:0) after 6m9s
[07:49:39.399] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:107:0)
[07:49:39.428] Build status: STARTED
[07:49:39.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:108:0) after 3m39s
[07:53:18.478] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:108:0)
[07:53:18.573] Build status: STARTED
[07:53:18.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:109:0) after 7m14s
[08:00:32.627] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:109:0)
[08:00:32.658] Build status: STARTED
[08:00:32.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:110:0) after 4m59s
[08:05:31.790] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:110:0)
[08:05:31.814] Build status: STARTED
[08:05:31.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:111:0) after 4m23s
[08:09:54.848] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:111:0)
[08:09:54.883] Build status: STARTED
[08:09:54.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:112:0) after 7m41s
[08:17:35.920] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:112:0)
[08:17:35.951] Build status: STARTED
[08:17:35.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:113:0) after 6m59s
[08:24:34.984] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:113:0)
[08:24:35.010] Build status: STARTED
[08:24:35.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:114:0) after 1m50s
[08:26:25.046] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:114:0)
[08:26:25.074] Build status: STARTED
[08:26:25.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:115:0) after 5m58s
[08:32:23.187] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:115:0)
[08:32:23.214] Build status: STARTED
[08:32:23.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:116:0) after 3m27s
[08:35:50.260] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:116:0)
[08:35:50.284] Build status: STARTED
[08:35:50.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:117:0) after 5m26s
[08:41:16.402] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:117:0)
[08:41:16.444] Build status: STARTED
[08:41:16.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:118:0) after 1m51s
[08:43:07.471] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:118:0)
[08:43:07.510] Build status: STARTED
[08:43:07.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:119:0) after 1m56s
[08:45:03.520] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:119:0)
[08:45:03.554] Build status: STARTED
[08:45:03.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:120:0) after 1m14s
[08:46:17.628] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:120:0)
[08:46:17.661] Build status: STARTED
[08:46:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:121:0) after 6m34s
[08:52:51.788] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:121:0)
[08:52:51.814] Build status: STARTED
[08:52:51.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:122:0) after 6m29s
[08:59:20.903] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:122:0)
[08:59:20.933] Build status: STARTED
[08:59:20.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:123:0) after 2m22s
[09:01:43.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:123:0)
[09:01:43.102] Build status: STARTED
[09:01:43.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:124:0) after 1m29s
[09:03:12.246] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:124:0)
[09:03:12.274] Build status: STARTED
[09:03:12.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:125:0) after 7m17s
[09:10:29.436] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:125:0)
[09:10:29.465] Build status: STARTED
[09:10:29.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:126:0) after 7m51s
[09:18:20.530] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:126:0)
[09:18:20.558] Build status: STARTED
[09:18:20.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:127:0) after 1m20s
[09:19:40.595] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:127:0)
[09:19:40.621] Build status: STARTED
[09:19:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:128:0) after 7m15s
[09:26:55.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:128:0)
[09:26:55.917] Build status: STARTED
[09:26:55.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:129:0) after 6m7s
[09:33:03.031] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:129:0)
[09:33:03.055] Build status: STARTED
[09:33:03.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:130:0) after 1m31s
[09:34:34.112] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:130:0)
[09:34:34.139] Build status: STARTED
[09:34:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:131:0) after 8m42s
[09:43:16.270] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:131:0)
[09:43:16.298] Build status: STARTED
[09:43:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:132:0) after 4m16s
[09:47:32.413] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:132:0)
[09:47:32.442] Build status: STARTED
[09:47:32.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:133:0) after 2m43s
[09:50:15.503] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:133:0)
[09:50:15.534] Build status: STARTED
[09:50:15.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:134:0) after 9m47s
[10:00:02.596] Handling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:134:0)
[10:00:02.623] Build status: STARTED
[10:00:02.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacASan:9013372263224486224:135:0) after 7m31s
[10:04:12.013] Received PubSub notification, asking Buildbucket for the build status
[10:04:12.042] Build:
{
"id": "8847942201207823824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacASan"
},
"number": 24939,
"createdBy": "project:chromium",
"createTime": "2021-05-06T22:56:31.869126Z",
"startTime": "2021-05-06T22:57:51.192443Z",
"endTime": "2021-05-07T10:04:11.659156472Z",
"updateTime": "2021-05-07T10:04:11.659536403Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52904b3ac5f2f26e5119678d22e6747682e12bf5",
"ref": "refs/heads/master"
}
}
}
[10:04:12.042] Invocation finished in 11h7m41.48057616s with status FAILED