[53.400248] Initializing watchdogs [53.400318] /dev/watchdog0 [53.405044] [001/171] (960s left) i915_module_load (load) [53.455835] Starting subtest: load [55.339792] Subtest load: SUCCESS (1.884s) [55.353203] [002/171] (958s left) core_auth (basic-auth) [55.436562] Starting subtest: basic-auth [55.437810] Subtest basic-auth: SUCCESS (0.001s) [55.496496] [003/171] (958s left) debugfs_test (read_all_entries) [55.556034] Starting subtest: read_all_entries [55.755163] Subtest read_all_entries: SUCCESS (0.199s) [55.836272] [004/171] (958s left) debugfs_test (basic-hwmon) [55.887977] Starting subtest: basic-hwmon [55.889420] Subtest basic-hwmon: SKIP (0.000s) [55.976150] [005/171] (957s left) fbdev (eof) [56.036234] Starting subtest: eof [56.037166] Subtest eof: SUCCESS (0.000s) [56.092347] [006/171] (957s left) fbdev (info) [56.151738] Starting subtest: info [56.152520] Subtest info: SUCCESS (0.000s) [56.225370] [007/171] (957s left) fbdev (nullptr) [56.286435] Starting subtest: nullptr [56.287329] Subtest nullptr: SUCCESS (0.000s) [56.341838] [008/171] (957s left) fbdev (read) [56.402617] Starting subtest: read [63.660489] Subtest read: SUCCESS (7.223s) [63.695447] [009/171] (950s left) fbdev (write) [63.757683] Starting subtest: write [67.456187] Subtest write: SUCCESS (3.663s) [67.489826] [010/171] (946s left) gem_basic (bad-close) [67.549813] Starting subtest: bad-close [67.551382] Subtest bad-close: SUCCESS (0.000s) [67.625888] [011/171] (946s left) gem_basic (create-close) [67.686235] Starting subtest: create-close [67.687742] Subtest create-close: SUCCESS (0.000s) [67.772517] [012/171] (946s left) gem_basic (create-fd-close) [67.835516] Starting subtest: create-fd-close [67.837033] Subtest create-fd-close: SUCCESS (0.000s) [67.922820] [013/171] (946s left) gem_busy (busy@all-engines) [67.992305] Starting subtest: busy [67.993184] Starting dynamic subtest: all-engines [68.017792] Dynamic subtest all-engines: SUCCESS (0.026s) [68.018589] Subtest busy: SUCCESS (0.026s) [68.365989] [014/171] (945s left) gem_close_race (basic-process) [68.435578] Starting subtest: basic-process [68.467162] Subtest basic-process: SUCCESS (0.031s) [68.655046] [015/171] (945s left) gem_close_race (basic-threads) [68.722024] Starting subtest: basic-threads [69.844783] Subtest basic-threads: SUCCESS (1.122s) [70.038705] [016/171] (944s left) gem_ctx_create (basic) [70.144580] Starting subtest: basic [70.145674] Subtest basic: SUCCESS (0.000s) [70.336307] [017/171] (943s left) gem_ctx_create (basic-files) [70.423825] Starting subtest: basic-files [72.439228] Subtest basic-files: SUCCESS (2.015s) [72.759376] [018/171] (941s left) gem_ctx_exec (basic) [72.843200] Starting subtest: basic [72.847085] Subtest basic: SUCCESS (0.004s) [72.960530] [019/171] (941s left) gem_exec_basic (basic) [73.043510] Starting subtest: basic [73.044456] Starting dynamic subtest: rcs0-smem [73.045412] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [73.052885] Starting dynamic subtest: bcs0-smem [73.053739] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [73.060670] Starting dynamic subtest: vcs0-smem [73.061622] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [73.068432] Starting dynamic subtest: vecs0-smem [73.069429] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [73.070512] Subtest basic: SUCCESS (0.003s) [73.238835] [020/171] (940s left) gem_exec_create (basic) [73.320187] Starting subtest: basic [73.321093] Starting dynamic subtest: smem [75.418978] Dynamic subtest smem: SUCCESS (2.098s) [75.420472] Subtest basic: SUCCESS (2.098s) [75.606370] [021/171] (938s left) gem_exec_fence (basic-busy) [75.806923] Starting subtest: basic-busy [75.808251] Starting dynamic subtest: rcs0 [75.860877] Dynamic subtest rcs0: SUCCESS (0.062s) [75.872928] Starting dynamic subtest: bcs0 [75.908881] Dynamic subtest bcs0: SUCCESS (0.048s) [75.920835] Starting dynamic subtest: vcs0 [75.957638] Dynamic subtest vcs0: SUCCESS (0.049s) [75.964848] Starting dynamic subtest: vecs0 [76.013411] Dynamic subtest vecs0: SUCCESS (0.055s) [76.014740] Subtest basic-busy: SUCCESS (0.215s) [76.548246] [022/171] (937s left) gem_exec_fence (basic-wait) [76.733341] Starting subtest: basic-wait [76.734489] Starting dynamic subtest: rcs0 [76.775834] Dynamic subtest rcs0: SUCCESS (0.050s) [76.786505] Starting dynamic subtest: bcs0 [76.825803] Dynamic subtest bcs0: SUCCESS (0.049s) [76.836558] Starting dynamic subtest: vcs0 [76.874795] Dynamic subtest vcs0: SUCCESS (0.049s) [76.886816] Starting dynamic subtest: vecs0 [76.918583] Dynamic subtest vecs0: SUCCESS (0.043s) [76.920423] Subtest basic-wait: SUCCESS (0.193s) [77.412286] [023/171] (936s left) gem_exec_fence (basic-await) [77.598341] Starting subtest: basic-await [77.599221] Starting dynamic subtest: rcs0 [77.669038] Dynamic subtest rcs0: SUCCESS (0.079s) [77.681683] Starting dynamic subtest: bcs0 [77.748516] Dynamic subtest bcs0: SUCCESS (0.079s) [77.762222] Starting dynamic subtest: vcs0 [77.832562] Dynamic subtest vcs0: SUCCESS (0.084s) [77.848549] Starting dynamic subtest: vecs0 [77.917056] Dynamic subtest vecs0: SUCCESS (0.084s) [77.918779] Subtest basic-await: SUCCESS (0.327s) [78.405770] [024/171] (935s left) gem_exec_fence (nb-await) [78.590788] Starting subtest: nb-await [78.591799] Starting dynamic subtest: rcs0 [78.647737] Dynamic subtest rcs0: SUCCESS (0.065s) [78.664863] Starting dynamic subtest: bcs0 [78.713110] Dynamic subtest bcs0: SUCCESS (0.065s) [78.728812] Starting dynamic subtest: vcs0 [78.780171] Dynamic subtest vcs0: SUCCESS (0.067s) [78.798338] Starting dynamic subtest: vecs0 [78.846852] Dynamic subtest vecs0: SUCCESS (0.067s) [78.848498] Subtest nb-await: SUCCESS (0.264s) [79.344182] [025/171] (934s left) gem_exec_gttfill (basic) [79.408388] Starting subtest: basic [83.462403] Subtest basic: SUCCESS (4.045s) [83.645179] [026/171] (930s left) gem_exec_parallel (engines) [83.795056] Starting subtest: engines [83.796178] Starting dynamic subtest: basic [89.264530] Dynamic subtest basic: SUCCESS (5.466s) [89.277107] Starting dynamic subtest: contexts [93.575125] Dynamic subtest contexts: SUCCESS (4.304s) [93.585416] Starting dynamic subtest: fds [98.148195] Dynamic subtest fds: SUCCESS (4.573s) [98.159140] Starting dynamic subtest: userptr [101.727468] Dynamic subtest userptr: SUCCESS (3.587s) [101.728806] Subtest engines: SUCCESS (17.931s) [101.916701] [027/171] (912s left) gem_exec_store (basic) [101.994101] Starting subtest: basic [102.093062] Subtest basic: SUCCESS (0.098s) [102.279953] [028/171] (912s left) gem_flink_basic (bad-flink) [102.346101] Starting subtest: bad-flink [102.346997] Subtest bad-flink: SUCCESS (0.000s) [102.412525] [029/171] (911s left) gem_flink_basic (bad-open) [102.477087] Starting subtest: bad-open [102.478180] Subtest bad-open: SUCCESS (0.000s) [102.548286] [030/171] (911s left) gem_flink_basic (basic) [102.613025] Starting subtest: basic [102.613978] Subtest basic: SUCCESS (0.000s) [102.696348] [031/171] (911s left) gem_flink_basic (double-flink) [102.762070] Starting subtest: double-flink [102.762927] Subtest double-flink: SUCCESS (0.000s) [102.847694] [032/171] (911s left) gem_flink_basic (flink-lifetime) [102.913924] Starting subtest: flink-lifetime [102.914847] Subtest flink-lifetime: SUCCESS (0.001s) [102.997406] [033/171] (911s left) gem_huc_copy (huc-copy) [103.070121] Starting subtest: huc-copy [103.072986] Subtest huc-copy: SUCCESS (0.003s) [103.195759] [034/171] (911s left) gem_linear_blits (basic) [103.352613] Starting subtest: basic [103.360591] Subtest basic: SUCCESS (0.007s) [103.480378] [035/171] (910s left) gem_mmap (basic) [103.593454] Starting subtest: basic [103.597193] Subtest basic: SUCCESS (0.000s) [103.695272] [036/171] (910s left) gem_mmap_gtt (basic) [103.760456] Starting subtest: basic [103.761379] Subtest basic: SUCCESS (0.001s) [103.834392] [037/171] (910s left) gem_render_linear_blits (basic) [103.905780] Starting subtest: basic [103.942579] Subtest basic: SUCCESS (0.037s) [104.011858] [038/171] (910s left) gem_render_tiled_blits (basic) [104.085208] Starting subtest: basic [104.124059] Subtest basic: SUCCESS (0.037s) [104.214340] [039/171] (910s left) gem_ringfill (basic-all) [104.533477] Starting subtest: basic-all [105.675813] Subtest basic-all: SUCCESS (1.135s) [105.787791] [040/171] (908s left) gem_softpin (allocator-basic) [105.868565] Starting subtest: allocator-basic [105.969803] Subtest allocator-basic: SUCCESS (0.101s) [106.085996] [041/171] (908s left) gem_softpin (allocator-basic-reserve) [106.163993] Starting subtest: allocator-basic-reserve [106.265166] Subtest allocator-basic-reserve: SUCCESS (0.101s) [106.382198] [042/171] (908s left) gem_softpin (safe-alignment) [106.459077] Starting subtest: safe-alignment [106.471971] Subtest safe-alignment: SUCCESS (0.012s) [106.582950] [043/171] (907s left) gem_sync (basic-all) [106.666891] Starting subtest: basic-all [108.881830] Subtest basic-all: SUCCESS (2.214s) [109.070560] [044/171] (905s left) gem_sync (basic-each) [109.138634] Starting subtest: basic-each [111.879196] Subtest basic-each: SUCCESS (2.740s) [112.071022] [045/171] (902s left) gem_tiled_blits (basic) [112.210690] Starting subtest: basic [112.228245] Subtest basic: SUCCESS (0.018s) [112.361558] [046/171] (902s left) gem_tiled_fence_blits (basic) [112.549563] Starting subtest: basic [112.571182] Subtest basic: SUCCESS (0.022s) [112.689294] [047/171] (901s left) gem_tiled_pread_basic [112.832707] [048/171] (901s left) gem_wait (busy@all-engines) [112.909780] Starting subtest: busy [112.910666] Starting dynamic subtest: all-engines [113.474823] Dynamic subtest all-engines: SUCCESS (0.564s) [113.476597] Subtest busy: SUCCESS (0.564s) [113.682943] [049/171] (900s left) gem_wait (wait@all-engines) [113.760975] Starting subtest: wait [113.761910] Starting dynamic subtest: all-engines [114.814103] Dynamic subtest all-engines: SUCCESS (1.052s) [114.815516] Subtest wait: SUCCESS (1.053s) [115.026506] [050/171] (899s left) i915_getparams_basic (basic-eu-total) [115.083965] Starting subtest: basic-eu-total [115.085578] Subtest basic-eu-total: SUCCESS (0.000s) [115.151286] [051/171] (899s left) i915_getparams_basic (basic-subslice-total) [115.206372] Starting subtest: basic-subslice-total [115.207991] Subtest basic-subslice-total: SUCCESS (0.000s) [115.273315] [052/171] (899s left) i915_hangman (error-state-basic) [115.330700] Starting subtest: error-state-basic [115.443336] Subtest error-state-basic: SUCCESS (0.113s) [115.527593] [053/171] (899s left) i915_pciid [115.643389] [054/171] (899s left) kms_addfb_basic (addfb25-bad-modifier) [115.706857] Starting subtest: addfb25-bad-modifier [115.707874] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [115.818758] [055/171] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [115.880833] Starting subtest: addfb25-framebuffer-vs-set-tiling [115.881810] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [115.999102] [056/171] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [116.064966] Starting subtest: addfb25-modifier-no-flag [116.065785] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [116.186731] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [116.254843] Starting subtest: addfb25-x-tiled-legacy [116.255933] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [116.374127] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [116.443976] Starting subtest: addfb25-x-tiled-mismatch-legacy [116.444988] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [116.572844] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [116.659239] Starting subtest: addfb25-yf-tiled-legacy [116.660150] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [116.757261] [060/171] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [116.841315] Starting subtest: addfb25-y-tiled-legacy [116.842165] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [116.941131] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [117.024869] Starting subtest: addfb25-y-tiled-small-legacy [117.025802] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [117.134442] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [117.201908] Starting subtest: bad-pitch-0 [117.202739] Subtest bad-pitch-0: SUCCESS (0.000s) [117.318853] [063/171] (897s left) kms_addfb_basic (bad-pitch-1024) [117.388042] Starting subtest: bad-pitch-1024 [117.388856] Subtest bad-pitch-1024: SUCCESS (0.000s) [117.502587] [064/171] (897s left) kms_addfb_basic (bad-pitch-128) [117.572522] Starting subtest: bad-pitch-128 [117.573400] Subtest bad-pitch-128: SUCCESS (0.000s) [117.696103] [065/171] (897s left) kms_addfb_basic (bad-pitch-256) [117.764896] Starting subtest: bad-pitch-256 [117.765806] Subtest bad-pitch-256: SUCCESS (0.000s) [117.880978] [066/171] (897s left) kms_addfb_basic (bad-pitch-32) [117.950853] Starting subtest: bad-pitch-32 [117.951795] Subtest bad-pitch-32: SUCCESS (0.000s) [118.076533] [067/171] (896s left) kms_addfb_basic (bad-pitch-63) [118.145128] Starting subtest: bad-pitch-63 [118.145961] Subtest bad-pitch-63: SUCCESS (0.000s) [118.258502] [068/171] (896s left) kms_addfb_basic (bad-pitch-65536) [118.327294] Starting subtest: bad-pitch-65536 [118.328104] Subtest bad-pitch-65536: SUCCESS (0.000s) [118.442179] [069/171] (896s left) kms_addfb_basic (bad-pitch-999) [118.512131] Starting subtest: bad-pitch-999 [118.512943] Subtest bad-pitch-999: SUCCESS (0.000s) [118.619116] [070/171] (896s left) kms_addfb_basic (basic) [118.688099] Starting subtest: basic [118.688991] Subtest basic: SUCCESS (0.000s) [118.811264] [071/171] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [118.881383] Starting subtest: basic-x-tiled-legacy [118.882188] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.997512] [072/171] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [119.066288] Starting subtest: basic-y-tiled-legacy [119.067156] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [119.185338] [073/171] (895s left) kms_addfb_basic (bo-too-small) [119.273939] Starting subtest: bo-too-small [119.274993] Subtest bo-too-small: SUCCESS (0.000s) [119.372176] [074/171] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.460614] Starting subtest: bo-too-small-due-to-tiling [119.461662] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [119.555893] [075/171] (895s left) kms_addfb_basic (clobberred-modifier) [119.625846] Starting subtest: clobberred-modifier [119.626906] Subtest clobberred-modifier: SUCCESS (0.000s) [119.742909] [076/171] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling) [119.811894] Starting subtest: framebuffer-vs-set-tiling [119.812856] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [119.928338] [077/171] (895s left) kms_addfb_basic (invalid-get-prop) [119.997216] Starting subtest: invalid-get-prop [119.998137] Subtest invalid-get-prop: SUCCESS (0.000s) [120.111146] [078/171] (894s left) kms_addfb_basic (invalid-get-prop-any) [120.181895] Starting subtest: invalid-get-prop-any [120.183508] Subtest invalid-get-prop-any: SUCCESS (0.000s) [120.298109] [079/171] (894s left) kms_addfb_basic (invalid-set-prop) [120.366390] Starting subtest: invalid-set-prop [120.367273] Subtest invalid-set-prop: SUCCESS (0.000s) [120.490140] [080/171] (894s left) kms_addfb_basic (invalid-set-prop-any) [120.558588] Starting subtest: invalid-set-prop-any [120.559450] Subtest invalid-set-prop-any: SUCCESS (0.000s) [120.676435] [081/171] (894s left) kms_addfb_basic (no-handle) [120.745220] Starting subtest: no-handle [120.746060] Subtest no-handle: SUCCESS (0.000s) [120.862909] [082/171] (894s left) kms_addfb_basic (size-max) [120.949119] Starting subtest: size-max [120.949990] Subtest size-max: SUCCESS (0.000s) [121.043411] [083/171] (894s left) kms_addfb_basic (small-bo) [121.132870] Starting subtest: small-bo [121.133887] Subtest small-bo: SUCCESS (0.000s) [121.236996] [084/171] (893s left) kms_addfb_basic (tile-pitch-mismatch) [121.305463] Starting subtest: tile-pitch-mismatch [121.306340] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [121.431122] [085/171] (893s left) kms_addfb_basic (too-high) [121.519800] Starting subtest: too-high [121.520890] Subtest too-high: SUCCESS (0.001s) [121.614246] [086/171] (893s left) kms_addfb_basic (too-wide) [121.703495] Starting subtest: too-wide [121.704465] Subtest too-wide: SUCCESS (0.000s) [121.812253] [087/171] (893s left) kms_addfb_basic (unused-handle) [121.881483] Starting subtest: unused-handle [121.882337] Subtest unused-handle: SUCCESS (0.000s) [121.998578] [088/171] (893s left) kms_addfb_basic (unused-modifier) [122.066941] Starting subtest: unused-modifier [122.067901] Subtest unused-modifier: SUCCESS (0.000s) [122.181784] [089/171] (893s left) kms_addfb_basic (unused-offsets) [122.250549] Starting subtest: unused-offsets [122.251421] Subtest unused-offsets: SUCCESS (0.000s) [122.360192] [090/171] (892s left) kms_addfb_basic (unused-pitches) [122.428668] Starting subtest: unused-pitches [122.429580] Subtest unused-pitches: SUCCESS (0.000s) [122.541591] [091/171] (892s left) kms_busy (basic) [122.636211] Starting subtest: basic [122.637078] Starting dynamic subtest: flip [123.521123] Dynamic subtest flip: SUCCESS (0.884s) [123.528033] Starting dynamic subtest: modeset [127.402403] Dynamic subtest modeset: SUCCESS (3.880s) [127.403758] Subtest basic: SUCCESS (4.766s) [128.355224] [092/171] (886s left) kms_chamelium_hpd (dp-hpd-fast) [128.747345] Subtest dp-hpd-fast: SKIP (0.000s) [129.657158] [093/171] (885s left) kms_chamelium_edid (dp-edid-read) [130.049571] Subtest dp-edid-read: SKIP (0.000s) [130.937865] [094/171] (884s left) kms_chamelium_frames (dp-crc-fast) [131.326842] Subtest dp-crc-fast: SKIP (0.000s) [132.217415] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast) [132.602108] Subtest hdmi-hpd-fast: SKIP (0.000s) [133.496724] [096/171] (881s left) kms_chamelium_edid (hdmi-edid-read) [133.886331] Subtest hdmi-edid-read: SKIP (0.000s) [134.777662] [097/171] (880s left) kms_chamelium_frames (hdmi-crc-fast) [135.173893] Subtest hdmi-crc-fast: SKIP (0.000s) [136.056959] [098/171] (879s left) kms_chamelium_hpd (vga-hpd-fast) [136.446135] Subtest vga-hpd-fast: SKIP (0.000s) [137.336322] [099/171] (878s left) kms_chamelium_edid (vga-edid-read) [137.727657] Subtest vga-edid-read: SKIP (0.000s) [138.616666] [100/171] (876s left) kms_prop_blob (basic) [138.671267] Starting subtest: basic [138.672072] Subtest basic: SUCCESS (0.000s) [138.738370] [101/171] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [138.850390] Starting subtest: basic-busy-flip-before-cursor-atomic [138.852171] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [138.950560] [102/171] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [139.052910] Starting subtest: basic-busy-flip-before-cursor-legacy [139.054652] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [139.153271] [103/171] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [139.254849] Starting subtest: basic-flip-after-cursor-atomic [140.480176] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.223s) [141.409995] [104/171] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [141.518979] Starting subtest: basic-flip-after-cursor-legacy [142.742476] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.223s) [143.670891] [105/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [143.778907] Starting subtest: basic-flip-after-cursor-varying-size [144.994909] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.216s) [145.950729] [106/171] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [146.061913] Starting subtest: basic-flip-before-cursor-atomic [147.279025] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.216s) [148.210789] [107/171] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [148.319329] Starting subtest: basic-flip-before-cursor-legacy [149.546075] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.222s) [150.495953] [108/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [150.606199] Starting subtest: basic-flip-before-cursor-varying-size [151.821191] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.215s) [152.755293] [109/171] (862s left) kms_flip (basic-flip-vs-dpms) [152.823509] Starting subtest: basic-flip-vs-dpms [152.825230] Starting dynamic subtest: A-eDP1 [155.634236] Dynamic subtest A-eDP1: SUCCESS (2.808s) [155.650960] Starting dynamic subtest: B-eDP1 [158.065386] Dynamic subtest B-eDP1: SUCCESS (2.430s) [158.081765] Starting dynamic subtest: C-eDP1 [160.441529] Dynamic subtest C-eDP1: SUCCESS (2.375s) [160.443083] Subtest basic-flip-vs-dpms: SUCCESS (7.620s) [161.376793] [110/171] (854s left) kms_flip (basic-flip-vs-modeset) [161.439766] Starting subtest: basic-flip-vs-modeset [161.440559] Starting dynamic subtest: A-eDP1 [164.268105] Dynamic subtest A-eDP1: SUCCESS (2.820s) [164.283699] Starting dynamic subtest: B-eDP1 [166.697889] Dynamic subtest B-eDP1: SUCCESS (2.433s) [166.714135] Starting dynamic subtest: C-eDP1 [169.129666] Dynamic subtest C-eDP1: SUCCESS (2.433s) [169.131247] Subtest basic-flip-vs-modeset: SUCCESS (7.692s) [170.080952] [111/171] (845s left) kms_flip (basic-flip-vs-wf_vblank) [170.143938] Starting subtest: basic-flip-vs-wf_vblank [170.145777] Starting dynamic subtest: A-eDP1 [172.433484] Dynamic subtest A-eDP1: SUCCESS (2.287s) [172.442336] Starting dynamic subtest: B-eDP1 [174.694131] Dynamic subtest B-eDP1: SUCCESS (2.259s) [174.703184] Starting dynamic subtest: C-eDP1 [176.953851] Dynamic subtest C-eDP1: SUCCESS (2.259s) [176.954973] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.812s) [178.274619] [112/171] (837s left) kms_flip (basic-plain-flip) [178.337484] Starting subtest: basic-plain-flip [178.339293] Starting dynamic subtest: A-eDP1 [180.339605] Dynamic subtest A-eDP1: SUCCESS (2.000s) [180.349046] Starting dynamic subtest: B-eDP1 [182.322890] Dynamic subtest B-eDP1: SUCCESS (1.982s) [182.331946] Starting dynamic subtest: C-eDP1 [184.287195] Dynamic subtest C-eDP1: SUCCESS (1.964s) [184.288467] Subtest basic-plain-flip: SUCCESS (5.951s) [185.571310] [113/171] (830s left) kms_force_connector_basic (force-connector-state) [185.625964] Starting subtest: force-connector-state [186.396399] Subtest force-connector-state: SUCCESS (0.771s) [187.203715] [114/171] (828s left) kms_force_connector_basic (force-edid) [187.255240] Starting subtest: force-edid [187.280319] Subtest force-edid: SUCCESS (0.025s) [187.370165] [115/171] (828s left) kms_force_connector_basic (force-load-detect) [187.430146] Starting subtest: force-load-detect [187.431677] Subtest force-load-detect: SKIP (0.000s) [187.520623] [116/171] (828s left) kms_force_connector_basic (prune-stale-modes) [187.571269] Starting subtest: prune-stale-modes [187.594103] Subtest prune-stale-modes: SUCCESS (0.023s) [187.670952] [117/171] (828s left) kms_frontbuffer_tracking (basic) [187.738968] Starting subtest: basic [192.051065] Subtest basic: SUCCESS (4.313s) [192.146402] [118/171] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [192.227933] Starting subtest: compare-crc-sanitycheck [192.228739] Starting dynamic subtest: pipe-A-eDP-1 [192.893623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s) [192.900672] Starting dynamic subtest: pipe-B-eDP-1 [194.325678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s) [194.343960] Starting dynamic subtest: pipe-C-eDP-1 [195.685566] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s) [195.686397] Subtest compare-crc-sanitycheck: SUCCESS (3.457s) [196.668583] [119/171] (819s left) kms_pipe_crc_basic (hang-read-crc) [196.750770] Starting subtest: hang-read-crc [196.751599] Starting dynamic subtest: pipe-A-eDP-1 [199.089548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.336s) [199.105424] Starting dynamic subtest: pipe-B-eDP-1 [202.127252] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.036s) [202.144857] Starting dynamic subtest: pipe-C-eDP-1 [205.090771] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.960s) [205.091731] Subtest hang-read-crc: SUCCESS (8.340s) [206.041770] [120/171] (809s left) kms_pipe_crc_basic (nonblocking-crc) [206.151338] Starting subtest: nonblocking-crc [206.152203] Starting dynamic subtest: pipe-A-eDP-1 [206.989833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s) [206.999299] Starting dynamic subtest: pipe-B-eDP-1 [208.564375] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.573s) [208.581824] Starting dynamic subtest: pipe-C-eDP-1 [210.108052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s) [210.108925] Subtest nonblocking-crc: SUCCESS (3.958s) [211.042810] [121/171] (804s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [211.121719] Starting subtest: nonblocking-crc-frame-sequence [211.122486] Starting dynamic subtest: pipe-A-eDP-1 [211.983536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s) [211.999776] Starting dynamic subtest: pipe-B-eDP-1 [213.572828] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.586s) [213.592084] Starting dynamic subtest: pipe-C-eDP-1 [215.098112] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s) [215.099025] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.976s) [216.035538] [122/171] (799s left) kms_pipe_crc_basic (read-crc) [216.114629] Starting subtest: read-crc [216.115446] Starting dynamic subtest: pipe-A-eDP-1 [216.908125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [216.925140] Starting dynamic subtest: pipe-B-eDP-1 [218.416217] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s) [218.432816] Starting dynamic subtest: pipe-C-eDP-1 [219.894494] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [219.895355] Subtest read-crc: SUCCESS (3.781s) [220.835631] [123/171] (795s left) kms_pipe_crc_basic (read-crc-frame-sequence) [220.917608] Starting subtest: read-crc-frame-sequence [220.918519] Starting dynamic subtest: pipe-A-eDP-1 [221.692452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s) [221.699661] Starting dynamic subtest: pipe-B-eDP-1 [223.227677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s) [223.244499] Starting dynamic subtest: pipe-C-eDP-1 [224.704195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s) [224.705114] Subtest read-crc-frame-sequence: SUCCESS (3.787s) [225.633873] [124/171] (790s left) kms_psr (primary_page_flip) [225.715667] Starting subtest: primary_page_flip [227.663433] Subtest primary_page_flip: SUCCESS (1.946s) [228.587168] [125/171] (787s left) kms_psr (cursor_plane_move) [228.665888] Starting subtest: cursor_plane_move [230.584121] Subtest cursor_plane_move: SUCCESS (1.916s) [231.525732] [126/171] (784s left) kms_psr (sprite_plane_onoff) [231.606353] Starting subtest: sprite_plane_onoff [233.595309] Subtest sprite_plane_onoff: SUCCESS (1.989s) [234.530236] [127/171] (781s left) kms_psr (primary_mmap_gtt) [234.614404] Starting subtest: primary_mmap_gtt [236.565971] Subtest primary_mmap_gtt: SUCCESS (1.951s) [237.538309] [128/171] (778s left) kms_setmode (basic-clone-single-crtc) [237.597552] Starting subtest: basic-clone-single-crtc [237.599730] Subtest basic-clone-single-crtc: SKIP (0.000s) [237.670015] [129/171] (778s left) i915_pm_backlight (basic-brightness) [237.747506] Starting subtest: basic-brightness [237.827841] Starting dynamic subtest: eDP-1 [238.163606] Dynamic subtest eDP-1: SUCCESS (0.340s) [238.164858] Subtest basic-brightness: SUCCESS (0.416s) [239.075019] [130/171] (776s left) i915_pm_rpm (basic-pci-d3-state) [244.450428] Starting subtest: basic-pci-d3-state [249.104406] Subtest basic-pci-d3-state: SUCCESS (4.650s) [249.273487] [131/171] (766s left) i915_pm_rpm (basic-rte) [249.327324] Starting subtest: basic-rte [259.273934] Subtest basic-rte: SUCCESS (9.945s) [264.626266] [132/171] (751s left) i915_pm_rps (basic-api) [264.686014] Starting subtest: basic-api [264.687538] Subtest basic-api: SKIP (0.000s) [264.758176] [133/171] (751s left) prime_self_import (basic-llseek-bad) [264.807765] Starting subtest: basic-llseek-bad [264.809995] Subtest basic-llseek-bad: SUCCESS (0.001s) [264.891930] [134/171] (751s left) prime_self_import (basic-llseek-size) [264.942162] Starting subtest: basic-llseek-size [264.944211] Subtest basic-llseek-size: SUCCESS (0.002s) [265.026885] [135/171] (751s left) prime_self_import (basic-with_fd_dup) [265.076947] Starting subtest: basic-with_fd_dup [265.079189] Subtest basic-with_fd_dup: SUCCESS (0.002s) [265.177090] [136/171] (750s left) prime_self_import (basic-with_one_bo) [265.226919] Starting subtest: basic-with_one_bo [265.229212] Subtest basic-with_one_bo: SUCCESS (0.003s) [265.290591] [137/171] (750s left) prime_self_import (basic-with_one_bo_two_files) [265.341121] Starting subtest: basic-with_one_bo_two_files [265.343315] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [265.443092] [138/171] (750s left) prime_self_import (basic-with_two_bos) [265.492912] Starting subtest: basic-with_two_bos [265.495155] Subtest basic-with_two_bos: SUCCESS (0.002s) [265.589718] [139/171] (750s left) prime_vgem (basic-fence-flip) [265.651824] Starting subtest: basic-fence-flip [266.094742] Subtest basic-fence-flip: SUCCESS (0.443s) [266.197897] [140/171] (749s left) prime_vgem (basic-fence-mmap) [266.275196] Starting subtest: basic-fence-mmap [266.295339] Subtest basic-fence-mmap: SUCCESS (0.020s) [266.390537] [141/171] (749s left) prime_vgem (basic-fence-read) [266.448500] Starting subtest: basic-fence-read [266.456721] Subtest basic-fence-read: SKIP (0.008s) [266.557884] [142/171] (749s left) prime_vgem (basic-gtt) [266.615140] Starting subtest: basic-gtt [266.626663] Subtest basic-gtt: SUCCESS (0.012s) [266.705928] [143/171] (749s left) prime_vgem (basic-read) [266.775691] Starting subtest: basic-read [266.777998] Subtest basic-read: SKIP (0.008s) [266.873579] [144/171] (749s left) prime_vgem (basic-write) [266.931629] Starting subtest: basic-write [266.939868] Subtest basic-write: SKIP (0.008s) [267.023480] [145/171] (749s left) prime_vgem (basic-userptr) [267.081455] Starting subtest: basic-userptr [267.089876] Subtest basic-userptr: SKIP (0.008s) [267.190427] [146/171] (749s left) vgem_basic (setversion) [267.244408] Starting subtest: setversion [267.245932] Subtest setversion: SUCCESS (0.000s) [267.302752] [147/171] (748s left) vgem_basic (create) [267.361196] Starting subtest: create [267.379143] Subtest create: SUCCESS (0.000s) [267.432324] [148/171] (748s left) vgem_basic (debugfs) [267.494603] Starting subtest: debugfs [267.495875] Subtest debugfs: SUCCESS (0.000s) [267.554882] [149/171] (748s left) vgem_basic (dmabuf-export) [267.611442] Starting subtest: dmabuf-export [267.613916] Subtest dmabuf-export: SUCCESS (0.001s) [267.691311] [150/171] (748s left) vgem_basic (dmabuf-fence) [267.744416] Starting subtest: dmabuf-fence [267.745276] Subtest dmabuf-fence: SUCCESS (0.000s) [267.806867] [151/171] (748s left) vgem_basic (dmabuf-fence-before) [267.861350] Starting subtest: dmabuf-fence-before [267.862306] Subtest dmabuf-fence-before: SUCCESS (0.000s) [267.921278] [152/171] (748s left) vgem_basic (dmabuf-mmap) [267.977809] Starting subtest: dmabuf-mmap [267.992805] Subtest dmabuf-mmap: SUCCESS (0.014s) [268.030335] [153/171] (748s left) vgem_basic (mmap) [268.095367] Starting subtest: mmap [268.111099] Subtest mmap: SUCCESS (0.016s) [268.172650] [154/171] (748s left) vgem_basic (second-client) [268.227743] Starting subtest: second-client [268.279089] Subtest second-client: SUCCESS (0.050s) [268.340692] [155/171] (748s left) vgem_basic (sysfs) [268.394392] Starting subtest: sysfs [268.395268] Subtest sysfs: SUCCESS (0.000s) [268.453224] [156/171] (748s left) core_hotunplug (unbind-rebind) [268.527693] Starting subtest: unbind-rebind [270.696911] Subtest unbind-rebind: SUCCESS (2.169s) [270.712601] [157/171] (745s left) vgem_basic (unload) [270.763724] Starting subtest: unload [299.582601] Subtest unload: SUCCESS (28.783s) [299.667624] [158/171] (716s left) i915_module_load (reload) [299.721921] Starting subtest: reload [302.421533] Subtest reload: SUCCESS (2.700s) [302.434276] [159/171] (714s left) gem_lmem_swapping (basic) [302.491368] Subtest basic: SKIP (0.000s) [302.512250] [160/171] (714s left) gem_lmem_swapping (parallel-random-engines) [302.565498] Subtest parallel-random-engines: SKIP (0.000s) [302.597655] [161/171] (713s left) gem_lmem_swapping (random-engines) [302.683421] Subtest random-engines: SKIP (0.000s) [302.713861] [162/171] (713s left) gem_lmem_swapping (verify-random) [302.765263] Subtest verify-random: SKIP (0.000s) [302.802319] [163/171] (713s left) i915_pm_rpm (module-reload) [309.177906] Starting subtest: module-reload [329.031621] Subtest module-reload: SUCCESS (19.846s) [329.051099] [164/171] (687s left) i915_selftest (live) [329.111997] Starting subtest: live [329.113012] Starting dynamic subtest: sanitycheck [330.550450] Dynamic subtest sanitycheck: SUCCESS (1.429s) [330.556024] Starting dynamic subtest: uncore [332.047465] Dynamic subtest uncore: SUCCESS (1.496s) [332.052817] Starting dynamic subtest: workarounds [334.220424] Dynamic subtest workarounds: SUCCESS (2.173s) [334.225742] Starting dynamic subtest: gt_engines [336.127415] Dynamic subtest gt_engines: SUCCESS (1.906s) [336.133134] Starting dynamic subtest: gt_timelines [344.815508] Dynamic subtest gt_timelines: SUCCESS (8.688s) [344.820903] Starting dynamic subtest: gt_contexts [346.314489] Dynamic subtest gt_contexts: SUCCESS (1.499s) [346.319996] Starting dynamic subtest: gt_lrc [350.216356] Dynamic subtest gt_lrc: SUCCESS (3.901s) [350.221790] Starting dynamic subtest: gt_mocs [352.147445] Dynamic subtest gt_mocs: SUCCESS (1.931s) [352.152826] Starting dynamic subtest: gt_pm [354.563433] Dynamic subtest gt_pm: SUCCESS (2.416s) [354.568929] Starting dynamic subtest: gt_heartbeat [356.205418] Dynamic subtest gt_heartbeat: SUCCESS (1.642s) [356.211334] Starting dynamic subtest: requests [363.885829] Dynamic subtest requests: SUCCESS (7.680s) [363.892434] Starting dynamic subtest: migrate [368.143413] Dynamic subtest migrate: SUCCESS (4.257s) [368.149071] Starting dynamic subtest: active [369.614491] Dynamic subtest active: SUCCESS (1.471s) [369.620071] Starting dynamic subtest: objects [371.721432] Dynamic subtest objects: SUCCESS (2.107s) [371.726829] Starting dynamic subtest: mman [376.720920] Dynamic subtest mman: SUCCESS (4.999s) [376.727070] Starting dynamic subtest: dmabuf [378.276549] Dynamic subtest dmabuf: SUCCESS (1.555s) [378.282584] Starting dynamic subtest: vma [379.784415] Dynamic subtest vma: SUCCESS (1.507s) [379.789913] Starting dynamic subtest: coherency [384.038589] Dynamic subtest coherency: SUCCESS (4.254s) [384.044069] Starting dynamic subtest: gtt [394.227890] Dynamic subtest gtt: SUCCESS (10.189s) [394.234574] Starting dynamic subtest: gem [395.923516] Dynamic subtest gem: SUCCESS (1.695s) [395.929046] Starting dynamic subtest: evict [399.055327] Dynamic subtest evict: SUCCESS (3.131s) [399.060824] Starting dynamic subtest: hugepages [405.621866] Dynamic subtest hugepages: SUCCESS (6.566s) [405.629074] Starting dynamic subtest: gem_contexts [419.608075] Dynamic subtest gem_contexts: SUCCESS (13.986s) [419.615192] Starting dynamic subtest: client [421.187729] Dynamic subtest client: SUCCESS (1.579s) [421.193737] Starting dynamic subtest: gem_migrate [422.662529] Dynamic subtest gem_migrate: SUCCESS (1.474s) [422.668377] Starting dynamic subtest: reset [426.925731] Dynamic subtest reset: SUCCESS (4.263s) [426.931746] Starting dynamic subtest: memory_region [428.427662] Dynamic subtest memory_region: SUCCESS (1.502s) [428.433479] Starting dynamic subtest: hangcheck [444.490896] Dynamic subtest hangcheck: SUCCESS (16.063s) [444.497806] Starting dynamic subtest: execlists [446.051504] Dynamic subtest execlists: SUCCESS (1.560s) [446.057743] Starting dynamic subtest: ring_submission [447.571496] Dynamic subtest ring_submission: SUCCESS (1.520s) [447.577410] Starting dynamic subtest: perf [449.159453] Dynamic subtest perf: SUCCESS (1.587s) [449.165230] Starting dynamic subtest: slpc [455.486692] Dynamic subtest slpc: FAIL (6.281s) [455.491946] Starting dynamic subtest: guc [457.741484] Dynamic subtest guc: SUCCESS (2.299s) [457.747415] Starting dynamic subtest: guc_multi_lrc [459.290526] Dynamic subtest guc_multi_lrc: SUCCESS (1.549s) [459.296458] Starting dynamic subtest: guc_hang [461.348569] Dynamic subtest guc_hang: SUCCESS (2.058s) [461.354525] Starting dynamic subtest: late_gt_pm [462.864484] Dynamic subtest late_gt_pm: SUCCESS (1.515s) [462.865555] Subtest live: FAIL (133.744s) [462.921050] [165/171] (553s left) dmabuf (all-tests) [462.975465] Starting subtest: all-tests [462.976392] Starting dynamic subtest: sanitycheck [462.992288] Dynamic subtest sanitycheck: SUCCESS (0.017s) [463.000724] Starting dynamic subtest: dma_fence [463.115207] Dynamic subtest dma_fence: SUCCESS (0.123s) [463.120320] Starting dynamic subtest: dma_fence_chain [475.848629] Dynamic subtest dma_fence_chain: SUCCESS (12.733s) [475.864320] Starting dynamic subtest: dma_fence_unwrap [475.872526] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s) [475.889834] Starting dynamic subtest: dma_resv [475.900298] Dynamic subtest dma_resv: SUCCESS (0.027s) [475.901641] Subtest all-tests: SUCCESS (12.925s) [475.917789] [166/171] (540s left) i915_suspend (basic-s2idle-without-i915) [475.980598] Starting subtest: basic-s2idle-without-i915 [494.715200] Subtest basic-s2idle-without-i915: SUCCESS (4.014s) [495.041791] [167/171] (536s left) i915_suspend (basic-s3-without-i915) [495.096552] Starting subtest: basic-s3-without-i915 [513.631789] Subtest basic-s3-without-i915: SUCCESS (2.818s) [513.970348] [168/171] (533s left) gem_exec_suspend (basic-s0) [514.060041] Starting subtest: basic-S0 [514.061057] Starting dynamic subtest: smem [531.781836] Dynamic subtest smem: SUCCESS (3.946s) [531.783408] Subtest basic-S0: SUCCESS (3.947s) [531.940313] [169/171] (528s left) gem_exec_suspend (basic-s3) [532.000231] Starting subtest: basic-S3 [532.001048] Starting dynamic subtest: smem [549.777698] Dynamic subtest smem: SUCCESS (2.826s) [549.779458] Subtest basic-S3: SUCCESS (2.826s) [549.930718] [170/171] (525s left) kms_chamelium_hpd (common-hpd-after-suspend) [550.328386] Subtest common-hpd-after-suspend: SKIP (0.000s) [551.240037] [171/171] (524s left) kms_pipe_crc_basic (suspend-read-crc) [551.318249] Starting subtest: suspend-read-crc [551.319462] Starting dynamic subtest: pipe-A-eDP-1 [569.025857] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.428s) [569.044627] Starting dynamic subtest: pipe-B-eDP-1 [587.015790] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.156s) [587.037546] Starting dynamic subtest: pipe-C-eDP-1 [604.965268] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.098s) [604.966566] Subtest suspend-read-crc: SUCCESS (8.692s) [605.861968] Closing watchdogs Done.