[23:32:06.885] New invocation is queued and will start shortly
[23:32:08.191] Starting the invocation (attempt 1)
[23:32:08.262] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b16e405de9a511784cbf723fe76d43f65ee5b0c0"
[23:32:08.262] Popped gitiles commit info from properties and tags
[23:32:08.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:32:08.262] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:32:08.262] Buildbucket request:
{
"requestId": "9014910171592531488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b16e405de9a511784cbf723fe76d43f65ee5b0c0",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9014910171592531488"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:32:08.976] Scheduled build:
{
"id": "8849480109269292960",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 6993,
"createdBy": "project:chromium",
"createTime": "2021-04-19T23:32:08.449357Z",
"updateTime": "2021-04-19T23:32:08.895951Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b16e405de9a511784cbf723fe76d43f65ee5b0c0",
"ref": "refs/heads/master"
}
}
}
[23:32:08.976] Task URL: https://cr-buildbucket.appspot.com/build/8849480109269292960
[23:32:08.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:2:0) after 8m17s
[23:32:41.887] Received PubSub notification, asking Buildbucket for the build status
[23:32:41.915] Build status: STARTED
[23:40:26.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:2:0)
[23:40:26.578] Build status: STARTED
[23:40:26.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:4:0) after 8m47s
[23:49:13.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:4:0)
[23:49:13.902] Build status: STARTED
[23:49:13.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:5:0) after 9m36s
[23:58:50.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:5:0)
[23:58:50.029] Build status: STARTED
[23:58:50.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:6:0) after 6m56s
[00:05:46.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:6:0)
[00:05:46.194] Build status: STARTED
[00:05:46.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:7:0) after 7m31s
[00:13:17.227] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:7:0)
[00:13:17.259] Build status: STARTED
[00:13:17.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:8:0) after 5m6s
[00:18:23.356] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:8:0)
[00:18:23.395] Build status: STARTED
[00:18:23.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:9:0) after 2m50s
[00:21:13.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:9:0)
[00:21:13.828] Build status: STARTED
[00:21:13.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:10:0) after 3m0s
[00:24:13.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:10:0)
[00:24:13.990] Build status: STARTED
[00:24:13.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:11:0) after 2m11s
[00:26:25.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:11:0)
[00:26:25.123] Build status: STARTED
[00:26:25.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:12:0) after 9m6s
[00:35:31.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:12:0)
[00:35:31.176] Build status: STARTED
[00:35:31.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:13:0) after 2m56s
[00:38:27.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:13:0)
[00:38:27.410] Build status: STARTED
[00:38:27.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:14:0) after 5m1s
[00:43:28.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:14:0)
[00:43:28.716] Build status: STARTED
[00:43:28.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:15:0) after 7m21s
[00:50:50.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:15:0)
[00:50:50.140] Build status: STARTED
[00:50:50.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:16:0) after 9m38s
[01:00:28.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:16:0)
[01:00:28.498] Build status: STARTED
[01:00:28.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:17:0) after 7m23s
[01:07:51.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:17:0)
[01:07:51.574] Build status: STARTED
[01:07:51.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:18:0) after 1m8s
[01:08:59.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:18:0)
[01:08:59.666] Build status: STARTED
[01:08:59.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:19:0) after 6m48s
[01:15:47.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:19:0)
[01:15:47.818] Build status: STARTED
[01:15:47.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:20:0) after 9m27s
[01:25:14.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:20:0)
[01:25:14.991] Build status: STARTED
[01:25:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:21:0) after 7m31s
[01:32:46.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:21:0)
[01:32:46.052] Build status: STARTED
[01:32:46.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:22:0) after 8m40s
[01:41:26.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:22:0)
[01:41:26.205] Build status: STARTED
[01:41:26.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:23:0) after 9m54s
[01:51:20.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:23:0)
[01:51:20.280] Build status: STARTED
[01:51:20.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:24:0) after 6m21s
[01:57:41.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:24:0)
[01:57:41.350] Build status: STARTED
[01:57:41.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:25:0) after 8m26s
[02:06:07.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:25:0)
[02:06:07.478] Build status: STARTED
[02:06:07.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:26:0) after 2m56s
[02:09:03.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:26:0)
[02:09:03.616] Build status: STARTED
[02:09:03.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:27:0) after 8m25s
[02:17:28.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:27:0)
[02:17:28.669] Build status: STARTED
[02:17:28.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:28:0) after 7m25s
[02:24:53.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:28:0)
[02:24:54.027] Build status: STARTED
[02:24:54.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:29:0) after 4m11s
[02:29:05.145] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:29:0)
[02:29:05.178] Build status: STARTED
[02:29:05.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:30:0) after 2m8s
[02:31:13.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:30:0)
[02:31:13.300] Build status: STARTED
[02:31:13.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:31:0) after 5m3s
[02:36:16.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:31:0)
[02:36:16.361] Build status: STARTED
[02:36:16.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:32:0) after 3m34s
[02:39:50.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:32:0)
[02:39:50.465] Build status: STARTED
[02:39:50.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:33:0) after 8m39s
[02:48:29.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:33:0)
[02:48:29.520] Build status: STARTED
[02:48:29.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:34:0) after 6m22s
[02:54:51.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:34:0)
[02:54:51.797] Build status: STARTED
[02:54:51.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:35:0) after 3m12s
[02:58:03.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:35:0)
[02:58:03.867] Build status: STARTED
[02:58:03.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:36:0) after 4m43s
[03:02:46.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:36:0)
[03:02:47.048] Build status: STARTED
[03:02:47.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:37:0) after 6m45s
[03:09:32.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:37:0)
[03:09:32.234] Build status: STARTED
[03:09:32.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:38:0) after 5m1s
[03:14:33.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:38:0)
[03:14:33.393] Build status: STARTED
[03:14:33.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:39:0) after 2m7s
[03:16:40.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:39:0)
[03:16:40.562] Build status: STARTED
[03:16:40.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:40:0) after 8m44s
[03:25:24.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:40:0)
[03:25:24.655] Build status: STARTED
[03:25:24.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:41:0) after 9m3s
[03:34:27.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:41:0)
[03:34:27.722] Build status: STARTED
[03:34:27.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:42:0) after 9m0s
[03:43:27.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:42:0)
[03:43:27.945] Build status: STARTED
[03:43:27.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:43:0) after 3m55s
[03:47:23.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:43:0)
[03:47:23.207] Build status: STARTED
[03:47:23.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:44:0) after 1m37s
[03:49:00.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:44:0)
[03:49:00.268] Build status: STARTED
[03:49:00.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:45:0) after 2m10s
[03:51:10.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:45:0)
[03:51:10.346] Build status: STARTED
[03:51:10.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:46:0) after 2m26s
[03:53:36.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:46:0)
[03:53:36.541] Build status: STARTED
[03:53:36.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:47:0) after 8m1s
[04:01:37.571] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:47:0)
[04:01:37.620] Build status: STARTED
[04:01:37.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:48:0) after 8m46s
[04:10:23.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:48:0)
[04:10:23.690] Build status: STARTED
[04:10:23.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:49:0) after 1m45s
[04:12:08.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:49:0)
[04:12:08.720] Build status: STARTED
[04:12:08.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:50:0) after 1m23s
[04:13:31.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:50:0)
[04:13:31.907] Build status: STARTED
[04:13:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:51:0) after 8m34s
[04:22:05.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:51:0)
[04:22:05.961] Build status: STARTED
[04:22:05.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:52:0) after 6m46s
[04:28:52.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:52:0)
[04:28:52.154] Build status: STARTED
[04:28:52.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:53:0) after 3m16s
[04:32:08.197] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:53:0)
[04:32:08.224] Build status: STARTED
[04:32:08.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:54:0) after 7m22s
[04:39:30.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:54:0)
[04:39:30.577] Build status: STARTED
[04:39:30.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:55:0) after 3m47s
[04:43:17.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:55:0)
[04:43:17.634] Build status: STARTED
[04:43:17.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:56:0) after 3m59s
[04:47:16.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:56:0)
[04:47:16.717] Build status: STARTED
[04:47:16.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:57:0) after 9m21s
[04:56:37.943] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:57:0)
[04:56:37.969] Build status: STARTED
[04:56:37.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:58:0) after 9m48s
[05:06:26.356] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:58:0)
[05:06:26.396] Build status: STARTED
[05:06:26.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:59:0) after 5m39s
[05:12:05.486] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:59:0)
[05:12:05.513] Build status: STARTED
[05:12:05.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:60:0) after 3m48s
[05:15:53.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:60:0)
[05:15:53.567] Build status: STARTED
[05:15:53.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:61:0) after 8m30s
[05:24:23.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:61:0)
[05:24:23.627] Build status: STARTED
[05:24:23.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:62:0) after 5m17s
[05:29:40.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:62:0)
[05:29:40.658] Build status: STARTED
[05:29:40.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:63:0) after 4m54s
[05:34:34.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:63:0)
[05:34:34.724] Build status: STARTED
[05:34:34.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:64:0) after 8m52s
[05:43:26.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:64:0)
[05:43:26.749] Build status: STARTED
[05:43:26.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:65:0) after 1m15s
[05:44:41.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:65:0)
[05:44:41.811] Build status: STARTED
[05:44:41.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:66:0) after 3m32s
[05:48:13.842] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:66:0)
[05:48:13.869] Build status: STARTED
[05:48:13.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:67:0) after 7m21s
[05:55:34.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:67:0)
[05:55:34.931] Build status: STARTED
[05:55:34.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:68:0) after 1m23s
[05:56:58.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:68:0)
[05:56:58.412] Build status: STARTED
[05:56:58.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:69:0) after 3m33s
[06:00:31.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:69:0)
[06:00:31.465] Build status: STARTED
[06:00:31.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:70:0) after 1m34s
[06:02:05.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:70:0)
[06:02:05.605] Build status: STARTED
[06:02:05.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:71:0) after 2m1s
[06:04:06.952] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:71:0)
[06:04:07.002] Build status: STARTED
[06:04:07.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:72:0) after 4m26s
[06:08:33.052] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:72:0)
[06:08:33.090] Build status: STARTED
[06:08:33.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:73:0) after 9m48s
[06:18:21.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:73:0)
[06:18:21.153] Build status: STARTED
[06:18:21.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:74:0) after 9m21s
[06:27:42.197] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:74:0)
[06:27:42.227] Build status: STARTED
[06:27:42.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:75:0) after 9m36s
[06:37:18.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:75:0)
[06:37:18.414] Build status: STARTED
[06:37:18.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:76:0) after 7m18s
[06:44:36.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:76:0)
[06:44:36.468] Build status: STARTED
[06:44:36.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:77:0) after 7m47s
[06:52:23.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:77:0)
[06:52:23.594] Build status: STARTED
[06:52:23.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:78:0) after 6m49s
[06:59:12.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:78:0)
[06:59:12.995] Build status: STARTED
[06:59:12.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:79:0) after 2m48s
[07:02:01.541] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:79:0)
[07:02:01.587] Build status: STARTED
[07:02:01.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:80:0) after 2m50s
[07:04:51.614] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:80:0)
[07:04:51.644] Build status: STARTED
[07:04:51.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:81:0) after 8m38s
[07:13:29.675] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:81:0)
[07:13:29.705] Build status: STARTED
[07:13:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:82:0) after 1m50s
[07:15:19.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:82:0)
[07:15:19.900] Build status: STARTED
[07:15:19.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:83:0) after 4m29s
[07:19:48.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:83:0)
[07:19:48.974] Build status: STARTED
[07:19:48.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:84:0) after 1m52s
[07:21:41.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:84:0)
[07:21:41.091] Build status: STARTED
[07:21:41.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:85:0) after 5m43s
[07:27:24.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:85:0)
[07:27:24.334] Build status: STARTED
[07:27:24.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:86:0) after 2m8s
[07:29:32.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:86:0)
[07:29:32.456] Build status: STARTED
[07:29:32.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:87:0) after 3m44s
[07:33:16.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:87:0)
[07:33:16.803] Build status: STARTED
[07:33:16.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:88:0) after 8m35s
[07:41:51.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:88:0)
[07:41:51.858] Build status: STARTED
[07:41:51.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:89:0) after 2m37s
[07:44:29.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:89:0)
[07:44:29.039] Build status: STARTED
[07:44:29.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:90:0) after 3m28s
[07:47:57.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:90:0)
[07:47:57.172] Build status: STARTED
[07:47:57.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:91:0) after 7m28s
[07:55:25.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:91:0)
[07:55:25.288] Build status: STARTED
[07:55:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:92:0) after 7m44s
[08:03:09.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:92:0)
[08:03:09.359] Build status: STARTED
[08:03:09.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:93:0) after 5m48s
[08:08:57.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:93:0)
[08:08:57.597] Build status: STARTED
[08:08:57.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:94:0) after 4m17s
[08:13:14.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:94:0)
[08:13:14.691] Build status: STARTED
[08:13:14.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:95:0) after 7m18s
[08:20:32.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:95:0)
[08:20:32.785] Build status: STARTED
[08:20:32.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:96:0) after 2m48s
[08:23:20.842] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:96:0)
[08:23:20.934] Build status: STARTED
[08:23:20.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:97:0) after 1m21s
[08:24:42.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:97:0)
[08:24:42.056] Build status: STARTED
[08:24:42.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:98:0) after 5m14s
[08:29:56.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:98:0)
[08:29:56.145] Build status: STARTED
[08:29:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:99:0) after 5m11s
[08:35:07.170] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:99:0)
[08:35:07.199] Build status: STARTED
[08:35:07.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:100:0) after 5m3s
[08:40:10.327] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:100:0)
[08:40:10.360] Build status: STARTED
[08:40:10.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:101:0) after 6m12s
[08:46:22.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:101:0)
[08:46:22.454] Build status: STARTED
[08:46:22.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:102:0) after 3m15s
[08:49:37.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:102:0)
[08:49:37.541] Build status: STARTED
[08:49:37.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:103:0) after 4m7s
[08:53:44.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:103:0)
[08:53:44.689] Build status: STARTED
[08:53:44.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:104:0) after 5m31s
[08:59:15.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:104:0)
[08:59:15.857] Build status: STARTED
[08:59:15.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:105:0) after 4m35s
[09:03:50.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:105:0)
[09:03:50.986] Build status: STARTED
[09:03:50.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:106:0) after 7m54s
[09:11:45.084] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:106:0)
[09:11:45.123] Build status: STARTED
[09:11:45.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:107:0) after 1m20s
[09:13:05.160] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:107:0)
[09:13:05.192] Build status: STARTED
[09:13:05.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:108:0) after 9m4s
[09:22:09.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:108:0)
[09:22:09.321] Build status: STARTED
[09:22:09.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9014910171592531488:109:0) after 7m30s
[09:25:40.509] Received PubSub notification, asking Buildbucket for the build status
[09:25:40.539] Build:
{
"id": "8849480109269292960",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 6993,
"createdBy": "project:chromium",
"createTime": "2021-04-19T23:32:08.449357Z",
"startTime": "2021-04-19T23:32:41.002167Z",
"endTime": "2021-04-20T09:25:40.131134319Z",
"updateTime": "2021-04-20T09:25:40.131595110Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b16e405de9a511784cbf723fe76d43f65ee5b0c0",
"ref": "refs/heads/master"
}
}
}
[09:25:40.539] Invocation finished in 9h53m33.689039084s with status FAILED