[00:12:56.280] New invocation is queued and will start shortly
[00:12:57.360] Starting the invocation (attempt 1)
[00:12:57.401] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4512e1e38ec44635b0a9dbdcb6a6e12d41a694fe"
[00:12:57.401] Popped gitiles commit info from properties and tags
[00:12:57.401] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:12:57.401] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:12:57.401] Buildbucket request:
{
"requestId": "8907550198025032736",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4512e1e38ec44635b0a9dbdcb6a6e12d41a694fe",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907550198025032736"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64PGO"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:12:57.979] Scheduled build:
{
"id": "8742120136098082881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 9519,
"createdBy": "project:chromium",
"createTime": "2024-07-18T00:12:57.473076962Z",
"updateTime": "2024-07-18T00:12:57.473076962Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4512e1e38ec44635b0a9dbdcb6a6e12d41a694fe",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:12:57.979] Task URL: https://cr-buildbucket.appspot.com/build/8742120136098082881
[00:12:57.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:2:0) after 8m37s
[00:12:58.958] Received PubSub notification, asking Buildbucket for the build status
[00:12:58.983] Build status: SCHEDULED
[00:13:19.432] Received PubSub notification, asking Buildbucket for the build status
[00:13:19.501] Build status: STARTED
[00:21:35.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:2:0)
[00:21:35.022] Build status: STARTED
[00:21:35.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:5:0) after 4m51s
[00:26:26.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:5:0)
[00:26:26.066] Build status: STARTED
[00:26:26.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:6:0) after 8m56s
[00:35:22.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:6:0)
[00:35:22.146] Build status: STARTED
[00:35:22.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:7:0) after 9m25s
[00:44:47.244] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:7:0)
[00:44:47.261] Build status: STARTED
[00:44:47.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:8:0) after 3m25s
[00:48:12.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:8:0)
[00:48:12.308] Build status: STARTED
[00:48:12.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:9:0) after 5m56s
[00:54:08.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:9:0)
[00:54:08.354] Build status: STARTED
[00:54:08.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:10:0) after 2m40s
[00:56:48.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:10:0)
[00:56:48.557] Build status: STARTED
[00:56:48.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:11:0) after 3m1s
[00:59:49.613] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:11:0)
[00:59:49.655] Build status: STARTED
[00:59:49.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:12:0) after 7m8s
[01:06:57.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:12:0)
[01:06:57.767] Build status: STARTED
[01:06:57.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:13:0) after 4m9s
[01:11:06.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:13:0)
[01:11:06.900] Build status: STARTED
[01:11:06.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:14:0) after 4m24s
[01:15:30.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:14:0)
[01:15:30.997] Build status: STARTED
[01:15:30.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:15:0) after 4m34s
[01:20:05.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:15:0)
[01:20:05.087] Build status: STARTED
[01:20:05.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:16:0) after 8m34s
[01:28:39.131] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:16:0)
[01:28:39.152] Build status: STARTED
[01:28:39.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:17:0) after 7m18s
[01:35:57.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:17:0)
[01:35:57.205] Build status: STARTED
[01:35:57.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:18:0) after 4m56s
[01:40:53.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:18:0)
[01:40:53.249] Build status: STARTED
[01:40:53.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:19:0) after 6m38s
[01:47:31.346] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:19:0)
[01:47:31.362] Build status: STARTED
[01:47:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:20:0) after 2m12s
[01:49:43.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:20:0)
[01:49:43.414] Build status: STARTED
[01:49:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:21:0) after 3m23s
[01:53:06.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:21:0)
[01:53:06.495] Build status: STARTED
[01:53:06.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:22:0) after 5m25s
[01:58:31.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:22:0)
[01:58:31.772] Build status: STARTED
[01:58:31.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:23:0) after 4m37s
[02:03:08.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:23:0)
[02:03:08.966] Build status: STARTED
[02:03:08.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:24:0) after 9m23s
[02:12:32.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:24:0)
[02:12:32.064] Build status: STARTED
[02:12:32.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:25:0) after 3m0s
[02:15:32.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:25:0)
[02:15:32.189] Build status: STARTED
[02:15:32.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:26:0) after 7m41s
[02:23:13.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:26:0)
[02:23:13.308] Build status: STARTED
[02:23:13.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:27:0) after 5m31s
[02:28:44.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:27:0)
[02:28:44.405] Build status: STARTED
[02:28:44.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:28:0) after 9m52s
[02:38:36.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:28:0)
[02:38:36.449] Build status: STARTED
[02:38:36.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:29:0) after 2m33s
[02:41:09.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:29:0)
[02:41:09.553] Build status: STARTED
[02:41:09.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:30:0) after 6m10s
[02:47:19.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:30:0)
[02:47:19.857] Build status: STARTED
[02:47:19.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:31:0) after 2m44s
[02:50:03.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:31:0)
[02:50:03.929] Build status: STARTED
[02:50:03.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:32:0) after 1m24s
[02:51:27.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:32:0)
[02:51:27.977] Build status: STARTED
[02:51:27.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:33:0) after 9m53s
[03:01:21.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:33:0)
[03:01:21.232] Build status: STARTED
[03:01:21.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:34:0) after 6m15s
[03:07:36.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:34:0)
[03:07:36.278] Build status: STARTED
[03:07:36.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:35:0) after 4m31s
[03:12:07.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:35:0)
[03:12:07.381] Build status: STARTED
[03:12:07.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:36:0) after 8m13s
[03:20:20.421] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:36:0)
[03:20:20.441] Build status: STARTED
[03:20:20.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:37:0) after 9m20s
[03:29:40.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:37:0)
[03:29:40.620] Build status: STARTED
[03:29:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:38:0) after 6m7s
[03:35:47.756] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:38:0)
[03:35:47.775] Build status: STARTED
[03:35:47.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:39:0) after 4m30s
[03:40:17.818] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:39:0)
[03:40:17.896] Build status: STARTED
[03:40:17.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:40:0) after 2m46s
[03:43:03.926] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:40:0)
[03:43:04.090] Build status: STARTED
[03:43:04.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:41:0) after 5m4s
[03:48:08.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:41:0)
[03:48:08.193] Build status: STARTED
[03:48:08.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:42:0) after 1m56s
[03:50:04.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:42:0)
[03:50:04.285] Build status: STARTED
[03:50:04.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:43:0) after 7m34s
[03:57:38.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:43:0)
[03:57:38.385] Build status: STARTED
[03:57:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:44:0) after 8m11s
[04:05:49.533] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:44:0)
[04:05:49.613] Build status: STARTED
[04:05:49.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:45:0) after 9m13s
[04:15:02.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:45:0)
[04:15:02.679] Build status: STARTED
[04:15:02.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:46:0) after 9m53s
[04:24:55.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:46:0)
[04:24:55.788] Build status: STARTED
[04:24:55.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:47:0) after 9m33s
[04:34:28.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:47:0)
[04:34:28.850] Build status: STARTED
[04:34:28.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:48:0) after 7m36s
[04:42:04.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:48:0)
[04:42:04.910] Build status: STARTED
[04:42:04.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:49:0) after 9m34s
[04:51:38.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:49:0)
[04:51:38.994] Build status: STARTED
[04:51:38.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:50:0) after 5m8s
[04:56:47.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:50:0)
[04:56:47.044] Build status: STARTED
[04:56:47.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:51:0) after 3m43s
[05:00:30.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:51:0)
[05:00:30.137] Build status: STARTED
[05:00:30.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:52:0) after 1m10s
[05:01:40.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:52:0)
[05:01:40.264] Build status: STARTED
[05:01:40.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:53:0) after 3m45s
[05:05:25.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:53:0)
[05:05:25.354] Build status: STARTED
[05:05:25.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:54:0) after 6m2s
[05:11:27.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:54:0)
[05:11:27.404] Build status: STARTED
[05:11:27.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:55:0) after 7m41s
[05:19:08.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:55:0)
[05:19:08.565] Build status: STARTED
[05:19:08.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:56:0) after 8m9s
[05:27:17.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:56:0)
[05:27:17.614] Build status: STARTED
[05:27:17.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:57:0) after 2m8s
[05:29:25.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:57:0)
[05:29:25.654] Build status: STARTED
[05:29:25.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:58:0) after 8m6s
[05:37:31.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:58:0)
[05:37:31.713] Build status: STARTED
[05:37:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:59:0) after 6m55s
[05:44:26.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:59:0)
[05:44:26.812] Build status: STARTED
[05:44:26.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:60:0) after 1m33s
[05:45:59.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:60:0)
[05:45:59.952] Build status: STARTED
[05:45:59.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:61:0) after 1m10s
[05:47:09.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:61:0)
[05:47:10.059] Build status: STARTED
[05:47:10.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:62:0) after 3m18s
[05:50:28.067] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:62:0)
[05:50:28.132] Build status: STARTED
[05:50:28.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:63:0) after 8m25s
[05:58:53.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:63:0)
[05:58:53.200] Build status: STARTED
[05:58:53.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:64:0) after 7m43s
[06:06:36.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:64:0)
[06:06:36.336] Build status: STARTED
[06:06:36.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:65:0) after 1m55s
[06:08:31.330] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:65:0)
[06:08:31.373] Build status: STARTED
[06:08:31.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:66:0) after 9m29s
[06:18:00.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:66:0)
[06:18:00.592] Build status: STARTED
[06:18:00.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:67:0) after 6m43s
[06:24:43.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:67:0)
[06:24:43.720] Build status: STARTED
[06:24:43.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:68:0) after 6m26s
[06:31:10.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:68:0)
[06:31:10.252] Build status: STARTED
[06:31:10.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:69:0) after 9m30s
[06:40:40.285] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:69:0)
[06:40:40.365] Build status: STARTED
[06:40:40.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:70:0) after 3m11s
[06:43:51.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:70:0)
[06:43:51.547] Build status: STARTED
[06:43:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:71:0) after 2m4s
[06:45:55.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:71:0)
[06:45:55.644] Build status: STARTED
[06:45:55.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:72:0) after 5m23s
[06:51:18.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:72:0)
[06:51:18.760] Build status: STARTED
[06:51:18.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:73:0) after 6m30s
[06:57:48.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:73:0)
[06:57:48.899] Build status: STARTED
[06:57:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:74:0) after 4m35s
[07:02:24.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:74:0)
[07:02:24.053] Build status: STARTED
[07:02:24.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:75:0) after 5m9s
[07:07:33.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:75:0)
[07:07:33.224] Build status: STARTED
[07:07:33.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:76:0) after 9m32s
[07:17:05.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:76:0)
[07:17:05.230] Build status: STARTED
[07:17:05.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:77:0) after 3m23s
[07:20:28.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:77:0)
[07:20:28.297] Build status: STARTED
[07:20:28.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:78:0) after 9m43s
[07:30:11.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:78:0)
[07:30:11.385] Build status: STARTED
[07:30:11.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:79:0) after 7m22s
[07:37:33.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:79:0)
[07:37:33.480] Build status: STARTED
[07:37:33.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:80:0) after 7m31s
[07:45:04.571] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:80:0)
[07:45:04.616] Build status: STARTED
[07:45:04.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:81:0) after 7m26s
[07:52:30.914] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:81:0)
[07:52:31.019] Build status: STARTED
[07:52:31.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:82:0) after 3m22s
[07:55:53.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:82:0)
[07:55:53.119] Build status: STARTED
[07:55:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:83:0) after 6m29s
[08:02:22.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:83:0)
[08:02:22.181] Build status: STARTED
[08:02:22.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:84:0) after 4m16s
[08:06:38.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:84:0)
[08:06:38.283] Build status: STARTED
[08:06:38.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:85:0) after 3m11s
[08:09:49.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:85:0)
[08:09:49.416] Build status: STARTED
[08:09:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:86:0) after 7m25s
[08:17:14.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:86:0)
[08:17:14.473] Build status: STARTED
[08:17:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:87:0) after 6m11s
[08:23:25.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:87:0)
[08:23:25.544] Build status: STARTED
[08:23:25.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:88:0) after 6m24s
[08:29:49.602] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:88:0)
[08:29:49.622] Build status: STARTED
[08:29:49.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:89:0) after 6m32s
[08:36:21.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:89:0)
[08:36:21.803] Build status: STARTED
[08:36:21.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:90:0) after 6m15s
[08:42:36.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:90:0)
[08:42:36.902] Build status: STARTED
[08:42:36.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:91:0) after 7m9s
[08:49:46.259] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:91:0)
[08:49:46.278] Build status: STARTED
[08:49:46.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:92:0) after 7m36s
[08:57:22.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:92:0)
[08:57:22.674] Build status: STARTED
[08:57:22.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:93:0) after 2m7s
[08:59:30.053] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:93:0)
[08:59:30.070] Build status: STARTED
[08:59:30.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:94:0) after 7m33s
[09:07:03.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:94:0)
[09:07:03.206] Build status: STARTED
[09:07:03.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:95:0) after 6m37s
[09:13:40.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:95:0)
[09:13:40.282] Build status: STARTED
[09:13:40.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:96:0) after 3m32s
[09:17:13.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:96:0)
[09:17:13.035] Build status: STARTED
[09:17:13.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:97:0) after 7m37s
[09:24:50.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:97:0)
[09:24:50.189] Build status: STARTED
[09:24:50.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:98:0) after 9m50s
[09:34:40.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:98:0)
[09:34:40.274] Build status: STARTED
[09:34:40.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:99:0) after 3m11s
[09:37:51.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:99:0)
[09:37:51.400] Build status: STARTED
[09:37:51.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:100:0) after 1m36s
[09:39:27.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:100:0)
[09:39:27.464] Build status: STARTED
[09:39:27.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:101:0) after 7m14s
[09:46:41.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:101:0)
[09:46:41.897] Build status: STARTED
[09:46:41.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:102:0) after 2m59s
[09:49:41.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:102:0)
[09:49:41.232] Build status: STARTED
[09:49:41.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:103:0) after 1m38s
[09:51:19.265] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:103:0)
[09:51:19.280] Build status: STARTED
[09:51:19.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:104:0) after 5m28s
[09:56:47.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:104:0)
[09:56:47.326] Build status: STARTED
[09:56:47.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:105:0) after 7m2s
[10:03:49.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:105:0)
[10:03:49.392] Build status: STARTED
[10:03:49.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:106:0) after 4m40s
[10:08:29.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:106:0)
[10:08:29.458] Build status: STARTED
[10:08:29.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:107:0) after 7m9s
[10:15:38.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:107:0)
[10:15:38.508] Build status: STARTED
[10:15:38.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:108:0) after 6m26s
[10:22:04.676] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:108:0)
[10:22:04.700] Build status: STARTED
[10:22:04.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:109:0) after 4m8s
[10:26:12.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:109:0)
[10:26:12.866] Build status: STARTED
[10:26:12.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:110:0) after 9m10s
[10:35:22.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:110:0)
[10:35:22.955] Build status: STARTED
[10:35:22.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:111:0) after 1m29s
[10:36:52.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:111:0)
[10:36:52.053] Build status: STARTED
[10:36:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:112:0) after 4m2s
[10:40:54.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:112:0)
[10:40:54.100] Build status: STARTED
[10:40:54.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:113:0) after 3m16s
[10:44:10.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:113:0)
[10:44:10.220] Build status: STARTED
[10:44:10.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:114:0) after 5m55s
[10:50:05.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:114:0)
[10:50:05.343] Build status: STARTED
[10:50:05.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:115:0) after 9m25s
[10:59:30.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:115:0)
[10:59:30.429] Build status: STARTED
[10:59:30.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64PGO:8907550198025032736:116:0) after 8m24s
[11:03:46.376] Received PubSub notification, asking Buildbucket for the build status
[11:03:46.403] Build:
{
"id": "8742120136098082881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64PGO"
},
"number": 9519,
"createdBy": "project:chromium",
"createTime": "2024-07-18T00:12:57.473076962Z",
"startTime": "2024-07-18T00:13:19.228067782Z",
"endTime": "2024-07-18T11:03:46.174830764Z",
"updateTime": "2024-07-18T11:03:46.174830764Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4512e1e38ec44635b0a9dbdcb6a6e12d41a694fe",
"ref": "refs/heads/main"
}
},
"canary": true
}
[11:03:46.403] Invocation finished in 10h50m50.15095949s with status SUCCEEDED