[132.143476] Initializing watchdogs
[132.145223]   /dev/watchdog0
[132.206243] [001/171] (960s left) i915_module_load (load)
[133.339405] Starting subtest: load
[143.868720] Subtest load: SUCCESS (10.461s)
[144.346411] [002/171] (948s left) core_auth (basic-auth)
[146.798505] Starting subtest: basic-auth
[146.809144] Subtest basic-auth: SUCCESS (0.006s)
[147.247583] [003/171] (946s left) debugfs_test (read_all_entries)
[148.574833] Starting subtest: read_all_entries
[149.293497] Subtest read_all_entries: SUCCESS (0.717s)
[150.529283] [004/171] (943s left) debugfs_test (basic-hwmon)
[151.718160] Starting subtest: basic-hwmon
[151.738476] Subtest basic-hwmon: SKIP (0.001s)
[153.047272] [005/171] (941s left) fbdev (eof)
[154.738242] Starting subtest: eof
[154.747788] Subtest eof: SUCCESS (0.003s)
[155.199876] [006/171] (939s left) fbdev (info)
[156.733231] Starting subtest: info
[156.748953] Subtest info: SUCCESS (0.000s)
[157.158670] [007/171] (937s left) fbdev (nullptr)
[158.473114] Starting subtest: nullptr
[158.482761] Subtest nullptr: SUCCESS (0.001s)
[158.841260] [008/171] (936s left) fbdev (read)
[159.952156] Starting subtest: read
[162.522629] Subtest read: SUCCESS (2.505s)
[162.869791] [009/171] (932s left) fbdev (write)
[163.957783] Starting subtest: write
[165.346833] Subtest write: SUCCESS (1.324s)
[165.696498] [010/171] (929s left) gem_basic (bad-close)
[166.780391] Starting subtest: bad-close
[166.800778] Subtest bad-close: SUCCESS (0.000s)
[167.169535] [011/171] (928s left) gem_basic (create-close)
[168.253824] Starting subtest: create-close
[168.274395] Subtest create-close: SUCCESS (0.003s)
[168.626336] [012/171] (927s left) gem_basic (create-fd-close)
[169.691390] Starting subtest: create-fd-close
[169.713158] Subtest create-fd-close: SUCCESS (0.002s)
[170.098956] [013/171] (926s left) gem_busy (busy@all-engines)
[171.493471] Starting subtest: busy
[171.504121] Starting dynamic subtest: all-engines
[171.943903] Dynamic subtest all-engines: SUCCESS (0.459s)
[171.954170] Subtest busy: SUCCESS (0.464s)
[172.829267] [014/171] (923s left) gem_close_race (basic-process)
[174.232971] Starting subtest: basic-process
[174.692163] Subtest basic-process: SUCCESS (0.476s)
[175.195182] [015/171] (921s left) gem_close_race (basic-threads)
[176.592764] Starting subtest: basic-threads
[178.323107] Subtest basic-threads: SUCCESS (1.807s)
[178.846684] [016/171] (918s left) gem_ctx_create (basic)
[180.264367] Starting subtest: basic
[180.274740] Subtest basic: SUCCESS (0.001s)
[180.759690] [017/171] (916s left) gem_ctx_create (basic-files)
[182.043138] Starting subtest: basic-files
[184.229910] Subtest basic-files: SUCCESS (2.194s)
[184.803905] [018/171] (912s left) gem_ctx_exec (basic)
[185.937252] Starting subtest: basic
[185.979502] Subtest basic: SUCCESS (0.042s)
[186.405869] [019/171] (911s left) gem_exec_basic (basic)
[187.684639] Starting subtest: basic
[187.696541] Starting dynamic subtest: rcs0-smem
[187.707197] Dynamic subtest rcs0-smem: SUCCESS (0.025s)
[187.765181] Starting dynamic subtest: bcs0-smem
[187.774714] Dynamic subtest bcs0-smem: SUCCESS (0.022s)
[187.831371] Starting dynamic subtest: vcs0-smem
[187.841402] Dynamic subtest vcs0-smem: SUCCESS (0.007s)
[188.012843] Starting dynamic subtest: vecs0-smem
[188.027251] Dynamic subtest vecs0-smem: SUCCESS (0.007s)
[188.035741] Subtest basic: SUCCESS (0.070s)
[188.311274] [020/171] (909s left) gem_exec_create (basic)
[189.717894] Starting subtest: basic
[189.727399] Starting dynamic subtest: smem
[191.885918] Dynamic subtest smem: SUCCESS (2.246s)
[191.899825] Subtest basic: SUCCESS (2.250s)
[192.427225] [021/171] (906s left) gem_exec_fence (basic-busy)
[194.008701] Starting subtest: basic-busy
[194.019414] Starting dynamic subtest: rcs0
[194.039827] Dynamic subtest rcs0: SUCCESS (0.085s)
[194.190198] Starting dynamic subtest: bcs0
[194.209952] Dynamic subtest bcs0: SUCCESS (0.066s)
[194.267999] Starting dynamic subtest: vcs0
[194.286485] Dynamic subtest vcs0: SUCCESS (0.065s)
[194.355371] Starting dynamic subtest: vecs0
[194.374156] Dynamic subtest vecs0: SUCCESS (0.061s)
[194.384947] Subtest basic-busy: SUCCESS (0.285s)
[196.817288] [022/171] (901s left) gem_exec_fence (basic-wait)
[198.353814] Starting subtest: basic-wait
[198.363530] Starting dynamic subtest: rcs0
[198.375836] Dynamic subtest rcs0: SUCCESS (0.078s)
[198.515202] Starting dynamic subtest: bcs0
[198.524204] Dynamic subtest bcs0: SUCCESS (0.074s)
[198.590492] Starting dynamic subtest: vcs0
[198.598985] Dynamic subtest vcs0: SUCCESS (0.080s)
[198.717220] Starting dynamic subtest: vecs0
[198.727617] Dynamic subtest vecs0: SUCCESS (0.064s)
[198.736947] Subtest basic-wait: SUCCESS (0.304s)
[200.739742] [023/171] (898s left) gem_exec_fence (basic-await)
[202.241601] Starting subtest: basic-await
[202.251160] Starting dynamic subtest: rcs0
[202.752673] Dynamic subtest rcs0: SUCCESS (0.495s)
[202.817297] Starting dynamic subtest: bcs0
[203.237812] Dynamic subtest bcs0: SUCCESS (0.484s)
[203.299294] Starting dynamic subtest: vcs0
[203.720245] Dynamic subtest vcs0: SUCCESS (0.488s)
[203.780943] Starting dynamic subtest: vecs0
[204.178527] Dynamic subtest vecs0: SUCCESS (0.474s)
[204.186793] Subtest basic-await: SUCCESS (1.950s)
[206.281325] [024/171] (892s left) gem_exec_fence (nb-await)
[207.758819] Starting subtest: nb-await
[207.768107] Starting dynamic subtest: rcs0
[207.937994] Dynamic subtest rcs0: SUCCESS (0.192s)
[207.997114] Starting dynamic subtest: bcs0
[208.021159] Dynamic subtest bcs0: SUCCESS (0.153s)
[208.088359] Starting dynamic subtest: vcs0
[208.233891] Dynamic subtest vcs0: SUCCESS (0.149s)
[208.295251] Starting dynamic subtest: vecs0
[208.318686] Dynamic subtest vecs0: SUCCESS (0.144s)
[208.328748] Subtest nb-await: SUCCESS (0.647s)
[210.500712] [025/171] (888s left) gem_exec_gttfill (basic)
[211.857716] Starting subtest: basic
[220.071705] Subtest basic: SKIP (8.127s)
[220.605473] [026/171] (878s left) gem_exec_parallel (engines)
[222.543461] Starting subtest: engines
[222.552956] Starting dynamic subtest: basic
[238.228587] Dynamic subtest basic: SUCCESS (15.707s)
[238.364216] Starting dynamic subtest: contexts
[259.908148] Dynamic subtest contexts: SUCCESS (21.658s)
[260.057864] Starting dynamic subtest: fds
[282.609159] Dynamic subtest fds: SUCCESS (22.694s)
[282.766230] Starting dynamic subtest: userptr
[299.061937] Dynamic subtest userptr: SUCCESS (16.525s)
[299.071986] Subtest engines: SUCCESS (76.592s)
[299.653867] [027/171] (800s left) gem_exec_store (basic)
[300.924539] Starting subtest: basic
[301.100880] Subtest basic: SUCCESS (0.201s)
[301.597682] [028/171] (798s left) gem_flink_basic (bad-flink)
[302.680462] Starting subtest: bad-flink
[302.689417] Subtest bad-flink: SUCCESS (0.000s)
[303.023613] [029/171] (797s left) gem_flink_basic (bad-open)
[304.022909] Starting subtest: bad-open
[304.034166] Subtest bad-open: SUCCESS (0.000s)
[304.401654] [030/171] (796s left) gem_flink_basic (basic)
[305.408958] Starting subtest: basic
[305.418511] Subtest basic: SUCCESS (0.001s)
[305.778608] [031/171] (795s left) gem_flink_basic (double-flink)
[306.774352] Starting subtest: double-flink
[306.785489] Subtest double-flink: SUCCESS (0.001s)
[307.178796] [032/171] (793s left) gem_flink_basic (flink-lifetime)
[308.190361] Starting subtest: flink-lifetime
[308.199889] Subtest flink-lifetime: SUCCESS (0.012s)
[308.577421] [033/171] (792s left) gem_huc_copy (huc-copy)
[309.702395] Starting subtest: huc-copy
[309.719925] Subtest huc-copy: SKIP (0.000s)
[310.072754] [034/171] (791s left) gem_linear_blits (basic)
[312.663191] Subtest basic: SKIP (0.000s)
[312.993169] [035/171] (788s left) gem_mmap (basic)
[314.682459] Starting subtest: basic
[314.730821] Subtest basic: SUCCESS (0.004s)
[315.069595] [036/171] (786s left) gem_mmap_gtt (basic)
[316.133846] Starting subtest: basic
[316.144454] Subtest basic: SUCCESS (0.007s)
[316.531579] [037/171] (785s left) gem_render_linear_blits (basic)
[317.667213] Starting subtest: basic
[318.060320] Subtest basic: SUCCESS (0.391s)
[318.438620] [038/171] (784s left) gem_render_tiled_blits (basic)
[319.608380] Starting subtest: basic
[320.059988] Subtest basic: SUCCESS (0.443s)
[320.550450] [039/171] (782s left) gem_ringfill (basic-all)
[323.256906] Starting subtest: basic-all
[325.053768] Subtest basic-all: SUCCESS (1.782s)
[325.424605] [040/171] (777s left) gem_softpin (allocator-basic)
[326.616368] Starting subtest: allocator-basic
[328.127928] Subtest allocator-basic: SUCCESS (1.426s)
[328.658187] [041/171] (774s left) gem_softpin (allocator-basic-reserve)
[329.717160] Starting subtest: allocator-basic-reserve
[331.234837] Subtest allocator-basic-reserve: SUCCESS (1.448s)
[331.749654] [042/171] (771s left) gem_softpin (safe-alignment)
[332.836430] Starting subtest: safe-alignment
[333.073387] Subtest safe-alignment: SUCCESS (0.177s)
[333.427799] [043/171] (770s left) gem_sync (basic-all)
[334.694403] Starting subtest: basic-all
[341.941126] Subtest basic-all: SUCCESS (7.236s)
[342.490656] [044/171] (761s left) gem_sync (basic-each)
[343.639524] Starting subtest: basic-each
[347.348920] Subtest basic-each: SUCCESS (3.711s)
[347.909113] [045/171] (756s left) gem_tiled_blits (basic)
[350.472238] Subtest basic: SKIP (0.000s)
[350.790174] [046/171] (753s left) gem_tiled_fence_blits (basic)
[353.939117] Starting subtest: basic
[354.002939] Subtest basic: SUCCESS (0.131s)
[354.490643] [047/171] (750s left) gem_tiled_pread_basic
[357.511239] [048/171] (747s left) gem_wait (busy@all-engines)
[358.754666] Starting subtest: busy
[358.764792] Starting dynamic subtest: all-engines
[359.429666] Dynamic subtest all-engines: SUCCESS (0.683s)
[359.439248] Subtest busy: SUCCESS (0.685s)
[360.173150] [049/171] (745s left) gem_wait (wait@all-engines)
[361.411368] Starting subtest: wait
[361.422664] Starting dynamic subtest: all-engines
[362.564863] Dynamic subtest all-engines: SUCCESS (1.139s)
[362.573779] Subtest wait: SUCCESS (1.142s)
[363.200352] [050/171] (742s left) i915_getparams_basic (basic-eu-total)
[364.255397] Starting subtest: basic-eu-total
[364.271959] Subtest basic-eu-total: SUCCESS (0.000s)
[364.629190] [051/171] (741s left) i915_getparams_basic (basic-subslice-total)
[365.603863] Starting subtest: basic-subslice-total
[365.625451] Subtest basic-subslice-total: SUCCESS (0.001s)
[365.987295] [052/171] (740s left) i915_hangman (error-state-basic)
[367.209569] Starting subtest: error-state-basic
[367.295656] Subtest error-state-basic: SUCCESS (0.074s)
[367.791760] [053/171] (738s left) i915_pciid
[369.201186] [054/171] (737s left) kms_addfb_basic (addfb25-bad-modifier)
[371.495818] Starting subtest: addfb25-bad-modifier
[371.507271] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[373.332727] [055/171] (733s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[375.082613] Starting subtest: addfb25-framebuffer-vs-set-tiling
[375.093957] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[376.919572] [056/171] (730s left) kms_addfb_basic (addfb25-modifier-no-flag)
[378.722485] Starting subtest: addfb25-modifier-no-flag
[378.732208] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[380.507831] [057/171] (726s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[382.326193] Starting subtest: addfb25-x-tiled-legacy
[382.335402] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[384.183870] [058/171] (723s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[385.963892] Starting subtest: addfb25-x-tiled-mismatch-legacy
[385.974192] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[387.771658] [059/171] (720s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[390.240564] Starting subtest: addfb25-yf-tiled-legacy
[390.250679] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[391.330510] [060/171] (716s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[393.821439] Starting subtest: addfb25-y-tiled-legacy
[393.831983] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[394.976886] [061/171] (713s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[397.461320] Starting subtest: addfb25-y-tiled-small-legacy
[397.470282] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.003s)
[398.588323] [062/171] (710s left) kms_addfb_basic (bad-pitch-0)
[399.628668] Starting subtest: bad-pitch-0
[399.639181] Subtest bad-pitch-0: SUCCESS (0.000s)
[402.252766] [063/171] (706s left) kms_addfb_basic (bad-pitch-1024)
[403.330594] Starting subtest: bad-pitch-1024
[403.340930] Subtest bad-pitch-1024: SUCCESS (0.000s)
[405.921853] [064/171] (703s left) kms_addfb_basic (bad-pitch-128)
[406.958529] Starting subtest: bad-pitch-128
[406.969475] Subtest bad-pitch-128: SUCCESS (0.000s)
[409.533633] [065/171] (700s left) kms_addfb_basic (bad-pitch-256)
[410.586169] Starting subtest: bad-pitch-256
[410.595885] Subtest bad-pitch-256: SUCCESS (0.000s)
[413.503806] [066/171] (696s left) kms_addfb_basic (bad-pitch-32)
[414.675587] Starting subtest: bad-pitch-32
[414.686465] Subtest bad-pitch-32: SUCCESS (0.000s)
[417.318857] [067/171] (692s left) kms_addfb_basic (bad-pitch-63)
[418.359721] Starting subtest: bad-pitch-63
[418.370325] Subtest bad-pitch-63: SUCCESS (0.000s)
[420.948555] [068/171] (689s left) kms_addfb_basic (bad-pitch-65536)
[422.004310] Starting subtest: bad-pitch-65536
[422.014481] Subtest bad-pitch-65536: SUCCESS (0.002s)
[424.616196] [069/171] (686s left) kms_addfb_basic (bad-pitch-999)
[425.733970] Starting subtest: bad-pitch-999
[425.742199] Subtest bad-pitch-999: SUCCESS (0.000s)
[428.268793] [070/171] (682s left) kms_addfb_basic (basic)
[429.325977] Starting subtest: basic
[429.336683] Subtest basic: SUCCESS (0.000s)
[431.826789] [071/171] (679s left) kms_addfb_basic (basic-x-tiled-legacy)
[435.043648] Starting subtest: basic-x-tiled-legacy
[435.054172] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[435.423529] [072/171] (676s left) kms_addfb_basic (basic-y-tiled-legacy)
[438.625447] Starting subtest: basic-y-tiled-legacy
[438.636885] Subtest basic-y-tiled-legacy: SUCCESS (0.003s)
[439.072571] [073/171] (672s left) kms_addfb_basic (bo-too-small)
[440.853991] Starting subtest: bo-too-small
[440.864380] Subtest bo-too-small: SUCCESS (0.003s)
[442.663981] [074/171] (669s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[444.480632] Starting subtest: bo-too-small-due-to-tiling
[444.490998] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[446.330932] [075/171] (666s left) kms_addfb_basic (clobberred-modifier)
[447.384113] Starting subtest: clobberred-modifier
[447.394425] Subtest clobberred-modifier: SUCCESS (0.001s)
[449.980603] [076/171] (662s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[453.179283] Starting subtest: framebuffer-vs-set-tiling
[453.188902] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[453.593585] [077/171] (659s left) kms_addfb_basic (invalid-get-prop)
[456.752168] Starting subtest: invalid-get-prop
[456.763997] Subtest invalid-get-prop: SUCCESS (0.001s)
[457.151791] [078/171] (656s left) kms_addfb_basic (invalid-get-prop-any)
[460.334480] Starting subtest: invalid-get-prop-any
[460.344805] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[460.794680] [079/171] (652s left) kms_addfb_basic (invalid-set-prop)
[463.980963] Starting subtest: invalid-set-prop
[463.991509] Subtest invalid-set-prop: SUCCESS (0.000s)
[464.389962] [080/171] (649s left) kms_addfb_basic (invalid-set-prop-any)
[467.591740] Starting subtest: invalid-set-prop-any
[467.602143] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[468.000713] [081/171] (646s left) kms_addfb_basic (no-handle)
[469.037864] Starting subtest: no-handle
[469.047948] Subtest no-handle: SUCCESS (0.000s)
[471.673480] [082/171] (642s left) kms_addfb_basic (size-max)
[473.444898] Starting subtest: size-max
[473.454983] Subtest size-max: SUCCESS (0.002s)
[475.345445] [083/171] (639s left) kms_addfb_basic (small-bo)
[477.112924] Starting subtest: small-bo
[477.129999] Subtest small-bo: SUCCESS (0.001s)
[479.030408] [084/171] (635s left) kms_addfb_basic (tile-pitch-mismatch)
[482.219186] Starting subtest: tile-pitch-mismatch
[482.230872] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[482.637394] [085/171] (632s left) kms_addfb_basic (too-high)
[484.390216] Starting subtest: too-high
[484.400467] Subtest too-high: SUCCESS (0.008s)
[486.252976] [086/171] (629s left) kms_addfb_basic (too-wide)
[488.004402] Starting subtest: too-wide
[488.014936] Subtest too-wide: SUCCESS (0.000s)
[489.775474] [087/171] (626s left) kms_addfb_basic (unused-handle)
[490.829874] Starting subtest: unused-handle
[490.839688] Subtest unused-handle: SUCCESS (0.001s)
[493.413684] [088/171] (622s left) kms_addfb_basic (unused-modifier)
[494.467875] Starting subtest: unused-modifier
[494.477161] Subtest unused-modifier: SUCCESS (0.002s)
[497.033990] [089/171] (619s left) kms_addfb_basic (unused-offsets)
[498.080650] Starting subtest: unused-offsets
[498.091979] Subtest unused-offsets: SUCCESS (0.001s)
[500.618486] [090/171] (616s left) kms_addfb_basic (unused-pitches)
[501.692337] Starting subtest: unused-pitches
[501.700901] Subtest unused-pitches: SUCCESS (0.001s)
[504.330635] [091/171] (612s left) kms_busy (basic)
[506.262952] Starting subtest: basic
[506.272322] Starting dynamic subtest: flip
[510.034870] Dynamic subtest flip: SUCCESS (3.756s)
[510.210430] Starting dynamic subtest: modeset
[515.037123] Dynamic subtest modeset: SUCCESS (4.997s)
[515.048330] Subtest basic: SUCCESS (8.760s)
[516.331120] [092/171] (600s left) kms_chamelium_hpd (dp-hpd-fast)
[518.652458] Subtest dp-hpd-fast: SKIP (0.000s)
[519.685792] [093/171] (597s left) kms_chamelium_edid (dp-edid-read)
[522.004603] Subtest dp-edid-read: SKIP (0.000s)
[522.994176] [094/171] (594s left) kms_chamelium_frames (dp-crc-fast)
[525.337509] Subtest dp-crc-fast: SKIP (0.000s)
[526.349854] [095/171] (591s left) kms_chamelium_hpd (hdmi-hpd-fast)
[528.618406] Subtest hdmi-hpd-fast: SKIP (0.000s)
[529.601735] [096/171] (588s left) kms_chamelium_edid (hdmi-edid-read)
[532.555768] Subtest hdmi-edid-read: SKIP (0.000s)
[533.700988] [097/171] (584s left) kms_chamelium_frames (hdmi-crc-fast)
[536.537925] Subtest hdmi-crc-fast: SKIP (0.000s)
[537.536296] [098/171] (581s left) kms_chamelium_hpd (vga-hpd-fast)
[540.383691] Subtest vga-hpd-fast: SKIP (0.000s)
[541.347694] [099/171] (577s left) kms_chamelium_edid (vga-edid-read)
[544.093871] Subtest vga-edid-read: SKIP (0.000s)
[545.111550] [100/171] (574s left) kms_prop_blob (basic)
[546.248366] Starting subtest: basic
[546.258821] Subtest basic: SUCCESS (0.000s)
[546.692157] [101/171] (572s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[549.065418] Starting subtest: basic-busy-flip-before-cursor-atomic
[549.084445] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[549.485772] [102/171] (570s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[551.394600] Starting subtest: basic-busy-flip-before-cursor-legacy
[551.414616] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s)
[551.818620] [103/171] (568s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[553.658790] Starting subtest: basic-flip-after-cursor-atomic
[555.655643] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.984s)
[556.882443] [104/171] (563s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[558.727940] Starting subtest: basic-flip-after-cursor-legacy
[560.732723] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.999s)
[561.959074] [105/171] (558s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[563.835429] Starting subtest: basic-flip-after-cursor-varying-size
[565.787882] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.963s)
[567.046608] [106/171] (553s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[568.848717] Starting subtest: basic-flip-before-cursor-atomic
[570.765553] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.919s)
[572.001212] [107/171] (549s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[573.841430] Starting subtest: basic-flip-before-cursor-legacy
[575.846332] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.002s)
[577.112902] [108/171] (544s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[578.943528] Starting subtest: basic-flip-before-cursor-varying-size
[580.868443] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.921s)
[582.124184] [109/171] (539s left) kms_flip (basic-flip-vs-dpms)
[583.531410] Starting subtest: basic-flip-vs-dpms
[583.603681] Starting dynamic subtest: A-eDP1
[587.464358] Dynamic subtest A-eDP1: SUCCESS (3.858s)
[587.644143] Starting dynamic subtest: B-eDP1
[590.334132] Dynamic subtest B-eDP1: SUCCESS (2.848s)
[590.498101] Starting dynamic subtest: C-eDP1
[593.171193] Dynamic subtest C-eDP1: SUCCESS (2.838s)
[593.249899] Subtest basic-flip-vs-dpms: SUCCESS (9.719s)
[594.436450] [110/171] (527s left) kms_flip (basic-flip-vs-modeset)
[595.875321] Starting subtest: basic-flip-vs-modeset
[595.958111] Starting dynamic subtest: A-eDP1
[599.790182] Dynamic subtest A-eDP1: SUCCESS (3.840s)
[599.955119] Starting dynamic subtest: B-eDP1
[602.526297] Dynamic subtest B-eDP1: SUCCESS (2.720s)
[602.685837] Starting dynamic subtest: C-eDP1
[605.311283] Dynamic subtest C-eDP1: SUCCESS (2.774s)
[605.380125] Subtest basic-flip-vs-modeset: SUCCESS (9.518s)
[606.560996] [111/171] (515s left) kms_flip (basic-flip-vs-wf_vblank)
[607.976198] Starting subtest: basic-flip-vs-wf_vblank
[608.051634] Starting dynamic subtest: A-eDP1
[611.147638] Dynamic subtest A-eDP1: SUCCESS (3.049s)
[611.300160] Starting dynamic subtest: B-eDP1
[613.916456] Dynamic subtest B-eDP1: SUCCESS (2.742s)
[614.071144] Starting dynamic subtest: C-eDP1
[616.709424] Dynamic subtest C-eDP1: SUCCESS (2.783s)
[616.741511] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.775s)
[618.796410] [112/171] (503s left) kms_flip (basic-plain-flip)
[620.187425] Starting subtest: basic-plain-flip
[620.352430] Starting dynamic subtest: A-eDP1
[623.138688] Dynamic subtest A-eDP1: SUCCESS (2.805s)
[623.289832] Starting dynamic subtest: B-eDP1
[625.630317] Dynamic subtest B-eDP1: SUCCESS (2.461s)
[625.792703] Starting dynamic subtest: C-eDP1
[628.048730] Dynamic subtest C-eDP1: SUCCESS (2.429s)
[628.088244] Subtest basic-plain-flip: SUCCESS (7.902s)
[630.101788] [113/171] (492s left) kms_force_connector_basic (force-connector-state)
[631.947884] Starting subtest: force-connector-state
[634.340314] Subtest force-connector-state: SUCCESS (2.368s)
[637.072950] [114/171] (486s left) kms_force_connector_basic (force-edid)
[638.805482] Starting subtest: force-edid
[639.356370] Subtest force-edid: SUCCESS (0.543s)
[641.026982] [115/171] (482s left) kms_force_connector_basic (force-load-detect)
[642.744953] Starting subtest: force-load-detect
[642.765947] Subtest force-load-detect: SKIP (0.000s)
[644.807324] [116/171] (479s left) kms_force_connector_basic (prune-stale-modes)
[646.560436] Starting subtest: prune-stale-modes
[647.255531] Subtest prune-stale-modes: SUCCESS (0.707s)
[648.908464] [117/171] (475s left) kms_frontbuffer_tracking (basic)
[650.828760] Starting subtest: basic
[660.759100] Subtest basic: SUCCESS (9.937s)
[661.605487] [118/171] (462s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[663.505999] Starting subtest: compare-crc-sanitycheck
[663.517551] Starting dynamic subtest: pipe-A-eDP-1
[664.804463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.254s)
[664.958161] Starting dynamic subtest: pipe-B-eDP-1
[666.664223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.865s)
[666.838196] Starting dynamic subtest: pipe-C-eDP-1
[668.481982] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.815s)
[668.492254] Subtest compare-crc-sanitycheck: SUCCESS (4.966s)
[669.759852] [119/171] (455s left) kms_pipe_crc_basic (hang-read-crc)
[671.565361] Starting subtest: hang-read-crc
[671.574389] Starting dynamic subtest: pipe-A-eDP-1
[675.063473] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[675.245706] Starting dynamic subtest: pipe-B-eDP-1
[679.184178] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.110s)
[679.347873] Starting dynamic subtest: pipe-C-eDP-1
[683.205616] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.992s)
[683.216754] Subtest hang-read-crc: SUCCESS (11.627s)
[684.441131] [120/171] (440s left) kms_pipe_crc_basic (nonblocking-crc)
[686.264279] Starting subtest: nonblocking-crc
[686.274694] Starting dynamic subtest: pipe-A-eDP-1
[687.746504] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.466s)
[687.975520] Starting dynamic subtest: pipe-B-eDP-1
[689.870363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.123s)
[690.029879] Starting dynamic subtest: pipe-C-eDP-1
[691.976694] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.073s)
[691.993819] Subtest nonblocking-crc: SUCCESS (5.690s)
[693.200571] [121/171] (432s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[695.032930] Starting subtest: nonblocking-crc-frame-sequence
[695.042231] Starting dynamic subtest: pipe-A-eDP-1
[696.515506] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.481s)
[696.667386] Starting dynamic subtest: pipe-B-eDP-1
[698.671990] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.140s)
[698.837629] Starting dynamic subtest: pipe-C-eDP-1
[700.781718] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.094s)
[700.792429] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.744s)
[702.012731] [122/171] (423s left) kms_pipe_crc_basic (read-crc)
[703.805411] Starting subtest: read-crc
[703.816410] Starting dynamic subtest: pipe-A-eDP-1
[705.219642] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.403s)
[705.350476] Starting dynamic subtest: pipe-B-eDP-1
[707.285611] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.050s)
[707.473392] Starting dynamic subtest: pipe-C-eDP-1
[709.314745] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.016s)
[709.326427] Subtest read-crc: SUCCESS (5.499s)
[710.584564] [123/171] (415s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[712.421994] Starting subtest: read-crc-frame-sequence
[712.430701] Starting dynamic subtest: pipe-A-eDP-1
[713.842186] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.372s)
[714.011310] Starting dynamic subtest: pipe-B-eDP-1
[715.881398] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.061s)
[716.061168] Starting dynamic subtest: pipe-C-eDP-1
[717.925516] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.034s)
[717.935809] Subtest read-crc-frame-sequence: SUCCESS (5.498s)
[719.148599] [124/171] (407s left) kms_psr (primary_page_flip)
[721.070878] Starting subtest: primary_page_flip
[723.542510] Subtest primary_page_flip: SUCCESS (2.461s)
[724.816436] [125/171] (401s left) kms_psr (cursor_plane_move)
[726.646553] Starting subtest: cursor_plane_move
[728.981170] Subtest cursor_plane_move: SUCCESS (2.351s)
[730.233452] [126/171] (396s left) kms_psr (sprite_plane_onoff)
[732.086544] Starting subtest: sprite_plane_onoff
[734.552780] Subtest sprite_plane_onoff: SUCCESS (2.485s)
[735.784655] [127/171] (391s left) kms_psr (primary_mmap_gtt)
[737.611803] Starting subtest: primary_mmap_gtt
[740.076940] Subtest primary_mmap_gtt: SUCCESS (2.442s)
[741.331384] [128/171] (386s left) kms_setmode (basic-clone-single-crtc)
[742.502182] Starting subtest: basic-clone-single-crtc
[742.529267] Subtest basic-clone-single-crtc: SKIP (0.010s)
[742.956257] [129/171] (384s left) i915_pm_backlight (basic-brightness)
[745.230495] Starting subtest: basic-brightness
[745.943781] Starting dynamic subtest: eDP-1
[746.691244] Dynamic subtest eDP-1: SUCCESS (0.794s)
[746.702510] Subtest basic-brightness: SUCCESS (1.444s)
[747.972445] [130/171] (380s left) i915_pm_rpm (basic-pci-d3-state)
[752.533153] Starting subtest: basic-pci-d3-state
[757.400541] Subtest basic-pci-d3-state: SUCCESS (4.918s)
[758.153623] [131/171] (370s left) i915_pm_rpm (basic-rte)
[759.235836] Starting subtest: basic-rte
[767.333378] Subtest basic-rte: SUCCESS (8.088s)
[773.290203] [132/171] (355s left) i915_pm_rps (basic-api)
[774.471395] Starting subtest: basic-api
[774.521976] Subtest basic-api: SUCCESS (0.051s)
[774.923633] [133/171] (354s left) prime_self_import (basic-llseek-bad)
[776.092744] Starting subtest: basic-llseek-bad
[776.103698] Subtest basic-llseek-bad: SUCCESS (0.019s)
[776.521997] [134/171] (352s left) prime_self_import (basic-llseek-size)
[777.565163] Starting subtest: basic-llseek-size
[777.601603] Subtest basic-llseek-size: SUCCESS (0.034s)
[778.004755] [135/171] (351s left) prime_self_import (basic-with_fd_dup)
[779.093444] Starting subtest: basic-with_fd_dup
[779.102990] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[779.526913] [136/171] (350s left) prime_self_import (basic-with_one_bo)
[780.590604] Starting subtest: basic-with_one_bo
[780.626277] Subtest basic-with_one_bo: SUCCESS (0.036s)
[781.069806] [137/171] (349s left) prime_self_import (basic-with_one_bo_two_files)
[782.127173] Starting subtest: basic-with_one_bo_two_files
[782.157830] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s)
[782.606630] [138/171] (347s left) prime_self_import (basic-with_two_bos)
[783.673537] Starting subtest: basic-with_two_bos
[783.706297] Subtest basic-with_two_bos: SUCCESS (0.033s)
[784.097274] [139/171] (346s left) prime_vgem (basic-fence-flip)
[785.385598] Starting subtest: basic-fence-flip
[787.467422] Subtest basic-fence-flip: SUCCESS (1.997s)
[788.130169] [140/171] (343s left) prime_vgem (basic-fence-mmap)
[789.325233] Starting subtest: basic-fence-mmap
[789.687574] Subtest basic-fence-mmap: SUCCESS (0.312s)
[790.077348] [141/171] (341s left) prime_vgem (basic-fence-read)
[791.422780] Starting subtest: basic-fence-read
[792.059564] Subtest basic-fence-read: SUCCESS (0.560s)
[792.403349] [142/171] (339s left) prime_vgem (basic-gtt)
[793.543503] Starting subtest: basic-gtt
[793.733859] Subtest basic-gtt: SUCCESS (0.154s)
[794.130556] [143/171] (337s left) prime_vgem (basic-read)
[795.321870] Starting subtest: basic-read
[795.663484] Subtest basic-read: SUCCESS (0.282s)
[796.055786] [144/171] (336s left) prime_vgem (basic-write)
[797.227315] Starting subtest: basic-write
[797.620521] Subtest basic-write: SUCCESS (0.321s)
[797.974832] [145/171] (334s left) prime_vgem (basic-userptr)
[799.143953] Starting subtest: basic-userptr
[799.224222] Subtest basic-userptr: SKIP (0.090s)
[799.740521] [146/171] (333s left) vgem_basic (setversion)
[800.864991] Starting subtest: setversion
[800.885916] Subtest setversion: SUCCESS (0.000s)
[801.245404] [147/171] (331s left) vgem_basic (create)
[802.335606] Starting subtest: create
[802.345807] Subtest create: SUCCESS (0.003s)
[802.729228] [148/171] (330s left) vgem_basic (debugfs)
[803.799433] Starting subtest: debugfs
[803.809892] Subtest debugfs: SUCCESS (0.006s)
[804.164938] [149/171] (329s left) vgem_basic (dmabuf-export)
[805.270776] Starting subtest: dmabuf-export
[805.300103] Subtest dmabuf-export: SUCCESS (0.017s)
[805.698241] [150/171] (328s left) vgem_basic (dmabuf-fence)
[806.833882] Starting subtest: dmabuf-fence
[806.845136] Subtest dmabuf-fence: SUCCESS (0.008s)
[807.242588] [151/171] (327s left) vgem_basic (dmabuf-fence-before)
[808.340833] Starting subtest: dmabuf-fence-before
[808.351243] Subtest dmabuf-fence-before: SUCCESS (0.005s)
[808.752756] [152/171] (326s left) vgem_basic (dmabuf-mmap)
[809.824633] Starting subtest: dmabuf-mmap
[810.079673] Subtest dmabuf-mmap: SUCCESS (0.191s)
[810.403777] [153/171] (324s left) vgem_basic (mmap)
[811.494191] Starting subtest: mmap
[811.695549] Subtest mmap: SUCCESS (0.130s)
[811.941391] [154/171] (323s left) vgem_basic (second-client)
[813.020844] Starting subtest: second-client
[813.105688] Subtest second-client: SUCCESS (0.088s)
[813.518485] [155/171] (322s left) vgem_basic (sysfs)
[814.639531] Starting subtest: sysfs
[814.650435] Subtest sysfs: SUCCESS (0.009s)
[815.025245] [156/171] (320s left) core_hotunplug (unbind-rebind)
[816.366921] Starting subtest: unbind-rebind
[825.242291] Subtest unbind-rebind: SUCCESS (8.867s)
[825.717422] [157/171] (310s left) vgem_basic (unload)
[827.281110] Starting subtest: unload
[857.637154] Subtest unload: SUCCESS (30.273s)
[858.317798] [158/171] (278s left) i915_module_load (reload)
[859.509358] Starting subtest: reload
[874.138442] Subtest reload: SUCCESS (14.562s)
[874.727621] [159/171] (262s left) gem_lmem_swapping (basic)
[876.564383] Subtest basic: SKIP (0.000s)
[876.905895] [160/171] (260s left) gem_lmem_swapping (parallel-random-engines)
[878.065496] Subtest parallel-random-engines: SKIP (0.000s)
[878.444168] [161/171] (259s left) gem_lmem_swapping (random-engines)
[879.762942] Subtest random-engines: SKIP (0.000s)
[880.102399] [162/171] (257s left) gem_lmem_swapping (verify-random)
[881.238898] Subtest verify-random: SKIP (0.000s)
[881.577896] [163/171] (256s left) i915_pm_rpm (module-reload)
[886.671523] Starting subtest: module-reload
[923.649927] Subtest module-reload: SUCCESS (36.928s)
[923.832432] [164/171] (214s left) i915_selftest (live)
[925.160138] Starting subtest: live
[925.170704] Starting dynamic subtest: sanitycheck
[932.139543] Dynamic subtest sanitycheck: SUCCESS (6.979s)
[932.288120] Starting dynamic subtest: uncore
[938.807288] Dynamic subtest uncore: SUCCESS (6.658s)
[938.934204] Starting dynamic subtest: workarounds
[946.715854] Dynamic subtest workarounds: SUCCESS (7.895s)
[946.870979] Starting dynamic subtest: gt_engines
[953.930133] Dynamic subtest gt_engines: SUCCESS (7.207s)
[954.076295] Starting dynamic subtest: gt_timelines
[1036.374480] Dynamic subtest gt_timelines: SUCCESS (82.440s)
[1036.527655] Starting dynamic subtest: gt_contexts
[1043.631772] Dynamic subtest gt_contexts: SUCCESS (7.245s)
[1043.790163] Starting dynamic subtest: gt_lrc
[1055.414392] Dynamic subtest gt_lrc: SUCCESS (11.775s)
[1055.559615] Starting dynamic subtest: gt_mocs
[1062.417462] Dynamic subtest gt_mocs: SUCCESS (6.993s)
[1062.569326] Starting dynamic subtest: gt_pm
[1075.596615] Dynamic subtest gt_pm: FAIL (10.911s)
[1075.752251] Starting dynamic subtest: gt_heartbeat
[1080.752753] Dynamic subtest gt_heartbeat: SUCCESS (7.404s)
[1080.901889] Starting dynamic subtest: requests
[1095.784554] Dynamic subtest requests: SUCCESS (15.023s)
[1095.924956] Starting dynamic subtest: migrate
[1110.455670] Dynamic subtest migrate: SUCCESS (14.660s)
[1110.607665] Starting dynamic subtest: active
[1117.294407] Dynamic subtest active: SUCCESS (6.829s)
[1117.437593] Starting dynamic subtest: objects
[1138.716610] Dynamic subtest objects: SUCCESS (21.413s)
[1138.862978] Starting dynamic subtest: mman
[1168.331515] Dynamic subtest mman: SUCCESS (29.600s)
[1168.479999] Starting dynamic subtest: dmabuf
[1175.369806] Dynamic subtest dmabuf: SUCCESS (7.038s)
[1175.513845] Starting dynamic subtest: vma
[1182.214612] Dynamic subtest vma: SUCCESS (6.843s)
[1182.276855] Starting dynamic subtest: coherency
[1204.338978] Dynamic subtest coherency: SUCCESS (22.107s)
[1204.484170] Starting dynamic subtest: gtt
[1221.556924] Dynamic subtest gtt: SUCCESS (17.211s)
[1221.710197] Starting dynamic subtest: gem
[1229.501603] Dynamic subtest gem: SUCCESS (7.933s)
[1229.654959] Starting dynamic subtest: evict
[1254.439153] Dynamic subtest evict: SUCCESS (24.930s)
[1254.499787] Starting dynamic subtest: hugepages
[1267.543133] Dynamic subtest hugepages: SUCCESS (13.095s)
[1267.697212] Starting dynamic subtest: gem_contexts
[1355.311525] Dynamic subtest gem_contexts: SUCCESS (87.747s)
[1355.533317] Starting dynamic subtest: client
[1364.255448] Dynamic subtest client: SUCCESS (8.924s)
[1364.467368] Starting dynamic subtest: gem_migrate
[1372.051771] Dynamic subtest gem_migrate: SUCCESS (7.854s)
[1372.198470] Starting dynamic subtest: reset
[1386.598696] Dynamic subtest reset: SUCCESS (14.459s)
[1386.744900] Starting dynamic subtest: memory_region
[1394.914131] Dynamic subtest memory_region: SUCCESS (8.303s)
[1395.147726] Starting dynamic subtest: hangcheck