[48.371868] Initializing watchdogs [48.372047] /dev/watchdog0 [48.383137] [001/171] (960s left) i915_module_load (load) [48.534101] Starting subtest: load [51.104889] Subtest load: SUCCESS (2.571s) [51.130432] [002/171] (957s left) core_auth (basic-auth) [51.275900] Starting subtest: basic-auth [51.277242] Subtest basic-auth: SUCCESS (0.001s) [51.361140] [003/171] (957s left) debugfs_test (read_all_entries) [51.511384] Starting subtest: read_all_entries [51.589667] Subtest read_all_entries: SUCCESS (0.078s) [51.704959] [004/171] (957s left) debugfs_test (basic-hwmon) [51.855105] Starting subtest: basic-hwmon [51.857902] Subtest basic-hwmon: SKIP (0.000s) [51.983868] [005/171] (957s left) fbdev (eof) [52.156237] Starting subtest: eof [52.157529] Subtest eof: SUCCESS (0.001s) [52.223488] [006/171] (956s left) fbdev (info) [52.394282] Starting subtest: info [52.395421] Subtest info: SUCCESS (0.000s) [52.471216] [007/171] (956s left) fbdev (nullptr) [52.622212] Starting subtest: nullptr [52.623414] Subtest nullptr: SUCCESS (0.000s) [52.689384] [008/171] (956s left) fbdev (read) [52.839758] Starting subtest: read [59.933663] Subtest read: SUCCESS (7.060s) [59.971489] [009/171] (949s left) fbdev (write) [60.123580] Starting subtest: write [63.903469] Subtest write: SUCCESS (3.745s) [63.939788] [010/171] (945s left) gem_basic (bad-close) [64.096697] Starting subtest: bad-close [64.099237] Subtest bad-close: SUCCESS (0.000s) [64.174073] [011/171] (944s left) gem_basic (create-close) [64.314125] Starting subtest: create-close [64.316101] Subtest create-close: SUCCESS (0.000s) [64.405211] [012/171] (944s left) gem_basic (create-fd-close) [64.547310] Starting subtest: create-fd-close [64.549357] Subtest create-fd-close: SUCCESS (0.000s) [64.638294] [013/171] (944s left) gem_busy (busy@all-engines) [64.797595] Starting subtest: busy [64.798840] Starting dynamic subtest: all-engines [64.867550] Dynamic subtest all-engines: SUCCESS (0.070s) [64.868641] Subtest busy: SUCCESS (0.070s) [65.238805] [014/171] (943s left) gem_close_race (basic-process) [65.399439] Starting subtest: basic-process [65.472163] Subtest basic-process: SUCCESS (0.072s) [65.673703] [015/171] (943s left) gem_close_race (basic-threads) [65.833136] Starting subtest: basic-threads [67.022424] Subtest basic-threads: SUCCESS (1.189s) [67.241068] [016/171] (942s left) gem_ctx_create (basic) [67.413605] Starting subtest: basic [67.414869] Subtest basic: SUCCESS (0.000s) [67.623023] [017/171] (941s left) gem_ctx_create (basic-files) [67.778183] Starting subtest: basic-files [69.802175] Subtest basic-files: SUCCESS (2.024s) [70.053080] [018/171] (939s left) gem_ctx_exec (basic) [70.196339] Starting subtest: basic [70.201026] Subtest basic: SUCCESS (0.005s) [70.307327] [019/171] (939s left) gem_exec_basic (basic) [70.458424] Starting subtest: basic [70.459650] Starting dynamic subtest: rcs0-smem [70.460800] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [70.473511] Starting dynamic subtest: bcs0-smem [70.474677] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [70.485840] Starting dynamic subtest: vcs0-smem [70.487100] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [70.498299] Starting dynamic subtest: vecs0-smem [70.499689] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [70.500997] Subtest basic: SUCCESS (0.006s) [70.673542] [020/171] (938s left) gem_exec_create (basic) [70.828083] Starting subtest: basic [70.829277] Starting dynamic subtest: smem [72.891075] Dynamic subtest smem: SUCCESS (2.040s) [72.892350] Subtest basic: SUCCESS (2.040s) [73.091790] [021/171] (936s left) gem_exec_fence (basic-busy) [73.410813] Starting subtest: basic-busy [73.412172] Starting dynamic subtest: rcs0 [73.430985] Dynamic subtest rcs0: SUCCESS (0.028s) [73.443834] Starting dynamic subtest: bcs0 [73.463988] Dynamic subtest bcs0: SUCCESS (0.033s) [73.476025] Starting dynamic subtest: vcs0 [73.499730] Dynamic subtest vcs0: SUCCESS (0.035s) [73.513931] Starting dynamic subtest: vecs0 [73.527631] Dynamic subtest vecs0: SUCCESS (0.028s) [73.528781] Subtest basic-busy: SUCCESS (0.126s) [74.141590] [022/171] (935s left) gem_exec_fence (basic-wait) [74.447647] Starting subtest: basic-wait [74.449250] Starting dynamic subtest: rcs0 [74.466269] Dynamic subtest rcs0: SUCCESS (0.027s) [74.479504] Starting dynamic subtest: bcs0 [74.499689] Dynamic subtest bcs0: SUCCESS (0.033s) [74.512684] Starting dynamic subtest: vcs0 [74.534961] Dynamic subtest vcs0: SUCCESS (0.035s) [74.546838] Starting dynamic subtest: vecs0 [74.566168] Dynamic subtest vecs0: SUCCESS (0.029s) [74.567518] Subtest basic-wait: SUCCESS (0.126s) [75.107963] [023/171] (934s left) gem_exec_fence (basic-await) [75.407325] Starting subtest: basic-await [75.408475] Starting dynamic subtest: rcs0 [75.499331] Dynamic subtest rcs0: SUCCESS (0.099s) [75.526602] Starting dynamic subtest: bcs0 [75.640684] Dynamic subtest bcs0: SUCCESS (0.132s) [75.667840] Starting dynamic subtest: vcs0 [75.764875] Dynamic subtest vcs0: SUCCESS (0.131s) [75.792188] Starting dynamic subtest: vecs0 [75.902060] Dynamic subtest vecs0: SUCCESS (0.128s) [75.903955] Subtest basic-await: SUCCESS (0.494s) [76.475728] [024/171] (933s left) gem_exec_fence (nb-await) [76.780356] Starting subtest: nb-await [76.781466] Starting dynamic subtest: rcs0 [76.839091] Dynamic subtest rcs0: SUCCESS (0.065s) [76.857313] Starting dynamic subtest: bcs0 [76.908134] Dynamic subtest bcs0: SUCCESS (0.069s) [76.936782] Starting dynamic subtest: vcs0 [76.985785] Dynamic subtest vcs0: SUCCESS (0.077s) [77.013192] Starting dynamic subtest: vecs0 [77.061311] Dynamic subtest vecs0: SUCCESS (0.075s) [77.063438] Subtest nb-await: SUCCESS (0.289s) [77.625127] [025/171] (931s left) gem_exec_gttfill (basic) [77.782233] Starting subtest: basic [83.820380] Subtest basic: SUCCESS (6.030s) [84.011317] [026/171] (925s left) gem_exec_parallel (engines) [84.233449] Starting subtest: engines [84.234725] Starting dynamic subtest: basic [86.816500] Dynamic subtest basic: SUCCESS (2.563s) [86.829904] Starting dynamic subtest: contexts [90.279390] Dynamic subtest contexts: SUCCESS (3.474s) [90.294837] Starting dynamic subtest: fds [94.895228] Dynamic subtest fds: SUCCESS (4.623s) [94.928286] Starting dynamic subtest: userptr [97.563324] Dynamic subtest userptr: SUCCESS (2.639s) [97.565665] Subtest engines: SUCCESS (13.300s) [97.758554] [027/171] (911s left) gem_exec_store (basic) [97.917193] Starting subtest: basic [97.973295] Subtest basic: SUCCESS (0.056s) [98.177712] [028/171] (911s left) gem_flink_basic (bad-flink) [98.313251] Starting subtest: bad-flink [98.314475] Subtest bad-flink: SUCCESS (0.000s) [98.391758] [029/171] (911s left) gem_flink_basic (bad-open) [98.529830] Starting subtest: bad-open [98.531301] Subtest bad-open: SUCCESS (0.000s) [98.608301] [030/171] (911s left) gem_flink_basic (basic) [98.747970] Starting subtest: basic [98.749241] Subtest basic: SUCCESS (0.000s) [98.859470] [031/171] (910s left) gem_flink_basic (double-flink) [98.998451] Starting subtest: double-flink [98.999797] Subtest double-flink: SUCCESS (0.000s) [99.108663] [032/171] (910s left) gem_flink_basic (flink-lifetime) [99.247612] Starting subtest: flink-lifetime [99.250348] Subtest flink-lifetime: SUCCESS (0.002s) [99.358374] [033/171] (910s left) gem_huc_copy (huc-copy) [99.502445] Starting subtest: huc-copy [99.505035] Subtest huc-copy: SKIP (0.000s) [99.625285] [034/171] (910s left) gem_linear_blits (basic) [99.918980] Starting subtest: basic [99.930620] Subtest basic: SUCCESS (0.012s) [100.058862] [035/171] (909s left) gem_mmap (basic) [100.255656] Starting subtest: basic [100.261096] Subtest basic: SUCCESS (0.001s) [100.358703] [036/171] (909s left) gem_mmap_gtt (basic) [100.499990] Starting subtest: basic [100.504461] Subtest basic: SUCCESS (0.001s) [100.589967] [037/171] (909s left) gem_render_linear_blits (basic) [100.731371] Starting subtest: basic [100.781589] Subtest basic: SUCCESS (0.050s) [100.840750] [038/171] (909s left) gem_render_tiled_blits (basic) [100.985395] Starting subtest: basic [101.044607] Subtest basic: SUCCESS (0.059s) [101.139463] [039/171] (908s left) gem_ringfill (basic-all) [101.412772] Starting subtest: basic-all [102.666393] Subtest basic-all: SUCCESS (1.244s) [102.747539] [040/171] (907s left) gem_softpin (allocator-basic) [102.891811] Starting subtest: allocator-basic [103.064175] Subtest allocator-basic: SUCCESS (0.164s) [103.176232] [041/171] (906s left) gem_softpin (allocator-basic-reserve) [103.337350] Starting subtest: allocator-basic-reserve [103.511415] Subtest allocator-basic-reserve: SUCCESS (0.165s) [103.626103] [042/171] (906s left) gem_softpin (safe-alignment) [103.787250] Starting subtest: safe-alignment [103.805284] Subtest safe-alignment: SUCCESS (0.018s) [103.927020] [043/171] (906s left) gem_sync (basic-all) [104.084329] Starting subtest: basic-all [106.375538] Subtest basic-all: SUCCESS (2.268s) [106.560333] [044/171] (903s left) gem_sync (basic-each) [106.720453] Starting subtest: basic-each [109.009466] Subtest basic-each: SUCCESS (2.290s) [109.247238] [045/171] (900s left) gem_tiled_blits (basic) [109.544721] Starting subtest: basic [109.574563] Subtest basic: SUCCESS (0.030s) [109.707409] [046/171] (900s left) gem_tiled_fence_blits (basic) [110.074942] Starting subtest: basic [110.101732] Subtest basic: SUCCESS (0.027s) [110.241112] [047/171] (899s left) gem_tiled_pread_basic [110.777082] [048/171] (899s left) gem_wait (busy@all-engines) [110.943913] Starting subtest: busy [110.945237] Starting dynamic subtest: all-engines [111.477461] Dynamic subtest all-engines: SUCCESS (0.534s) [111.478726] Subtest busy: SUCCESS (0.534s) [111.727865] [049/171] (898s left) gem_wait (wait@all-engines) [111.891507] Starting subtest: wait [111.892749] Starting dynamic subtest: all-engines [112.932104] Dynamic subtest all-engines: SUCCESS (1.038s) [112.933397] Subtest wait: SUCCESS (1.038s) [113.177503] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [113.314990] Starting subtest: basic-eu-total [113.317698] Subtest basic-eu-total: SUCCESS (0.000s) [113.392805] [051/171] (896s left) i915_getparams_basic (basic-subslice-total) [113.532694] Starting subtest: basic-subslice-total [113.535347] Subtest basic-subslice-total: SUCCESS (0.000s) [113.609325] [052/171] (896s left) i915_hangman (error-state-basic) [113.764405] Starting subtest: error-state-basic [113.776704] Subtest error-state-basic: SUCCESS (0.013s) [113.859904] [053/171] (896s left) i915_pciid [114.076516] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [114.218931] Starting subtest: addfb25-bad-modifier [114.220123] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [114.358222] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [114.499500] Starting subtest: addfb25-framebuffer-vs-set-tiling [114.500663] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.624858] [056/171] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [114.765125] Starting subtest: addfb25-modifier-no-flag [114.766320] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [114.891656] [057/171] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [115.032347] Starting subtest: addfb25-x-tiled-legacy [115.033478] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [115.179245] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [115.318644] Starting subtest: addfb25-x-tiled-mismatch-legacy [115.319872] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [115.442281] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [115.613349] Starting subtest: addfb25-yf-tiled-legacy [115.614537] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [115.708986] [060/171] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [115.877357] Starting subtest: addfb25-y-tiled-legacy [115.878564] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [115.975695] [061/171] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [116.145503] Starting subtest: addfb25-y-tiled-small-legacy [116.146698] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [116.241588] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [116.383773] Starting subtest: bad-pitch-0 [116.385152] Subtest bad-pitch-0: SUCCESS (0.000s) [116.508465] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [116.651474] Starting subtest: bad-pitch-1024 [116.652711] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.774812] [064/171] (893s left) kms_addfb_basic (bad-pitch-128) [116.905411] Starting subtest: bad-pitch-128 [116.906624] Subtest bad-pitch-128: SUCCESS (0.000s) [117.042534] [065/171] (893s left) kms_addfb_basic (bad-pitch-256) [117.182718] Starting subtest: bad-pitch-256 [117.184141] Subtest bad-pitch-256: SUCCESS (0.000s) [117.309483] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [117.450702] Starting subtest: bad-pitch-32 [117.452067] Subtest bad-pitch-32: SUCCESS (0.000s) [117.575319] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [117.716199] Starting subtest: bad-pitch-63 [117.717349] Subtest bad-pitch-63: SUCCESS (0.000s) [117.841940] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536) [117.980900] Starting subtest: bad-pitch-65536 [117.982201] Subtest bad-pitch-65536: SUCCESS (0.000s) [118.092211] [069/171] (892s left) kms_addfb_basic (bad-pitch-999) [118.232889] Starting subtest: bad-pitch-999 [118.234114] Subtest bad-pitch-999: SUCCESS (0.000s) [118.358879] [070/171] (892s left) kms_addfb_basic (basic) [118.499561] Starting subtest: basic [118.500777] Subtest basic: SUCCESS (0.000s) [118.624725] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [118.766532] Starting subtest: basic-x-tiled-legacy [118.767679] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.892655] [072/171] (891s left) kms_addfb_basic (basic-y-tiled-legacy) [119.032508] Starting subtest: basic-y-tiled-legacy [119.033657] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [119.159629] [073/171] (891s left) kms_addfb_basic (bo-too-small) [119.329464] Starting subtest: bo-too-small [119.330664] Subtest bo-too-small: SUCCESS (0.000s) [119.426079] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.595433] Starting subtest: bo-too-small-due-to-tiling [119.596838] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [119.691369] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [119.832706] Starting subtest: clobberred-modifier [119.833928] Subtest clobberred-modifier: SUCCESS (0.000s) [119.963305] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [120.105467] Starting subtest: framebuffer-vs-set-tiling [120.106607] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.227277] [077/171] (890s left) kms_addfb_basic (invalid-get-prop) [120.368950] Starting subtest: invalid-get-prop [120.370206] Subtest invalid-get-prop: SUCCESS (0.000s) [120.491202] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [120.632399] Starting subtest: invalid-get-prop-any [120.633522] Subtest invalid-get-prop-any: SUCCESS (0.000s) [120.758875] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [120.901331] Starting subtest: invalid-set-prop [120.902456] Subtest invalid-set-prop: SUCCESS (0.000s) [121.025217] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [121.165217] Starting subtest: invalid-set-prop-any [121.166417] Subtest invalid-set-prop-any: SUCCESS (0.000s) [121.293115] [081/171] (889s left) kms_addfb_basic (no-handle) [121.433668] Starting subtest: no-handle [121.434872] Subtest no-handle: SUCCESS (0.000s) [121.559683] [082/171] (889s left) kms_addfb_basic (size-max) [121.733270] Starting subtest: size-max [121.734499] Subtest size-max: SUCCESS (0.000s) [121.842688] [083/171] (889s left) kms_addfb_basic (small-bo) [122.011245] Starting subtest: small-bo [122.012473] Subtest small-bo: SUCCESS (0.000s) [122.109293] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [122.252595] Starting subtest: tile-pitch-mismatch [122.253738] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [122.374598] [085/171] (888s left) kms_addfb_basic (too-high) [122.544771] Starting subtest: too-high [122.546190] Subtest too-high: SUCCESS (0.001s) [122.642589] [086/171] (888s left) kms_addfb_basic (too-wide) [122.814063] Starting subtest: too-wide [122.815182] Subtest too-wide: SUCCESS (0.000s) [122.907970] [087/171] (888s left) kms_addfb_basic (unused-handle) [123.049891] Starting subtest: unused-handle [123.051189] Subtest unused-handle: SUCCESS (0.000s) [123.174783] [088/171] (888s left) kms_addfb_basic (unused-modifier) [123.313170] Starting subtest: unused-modifier [123.314467] Subtest unused-modifier: SUCCESS (0.000s) [123.442167] [089/171] (887s left) kms_addfb_basic (unused-offsets) [123.577966] Starting subtest: unused-offsets [123.579497] Subtest unused-offsets: SUCCESS (0.000s) [123.708280] [090/171] (887s left) kms_addfb_basic (unused-pitches) [123.844801] Starting subtest: unused-pitches [123.846089] Subtest unused-pitches: SUCCESS (0.000s) [123.975141] [091/171] (887s left) kms_busy (basic) [124.150220] Starting subtest: basic [124.151519] Starting dynamic subtest: flip [125.243660] Dynamic subtest flip: SUCCESS (1.089s) [125.262566] Starting dynamic subtest: modeset [129.120875] Dynamic subtest modeset: SUCCESS (3.880s) [129.122375] Subtest basic: SUCCESS (4.972s) [130.040068] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [130.523881] Subtest dp-hpd-fast: SKIP (0.000s) [131.395340] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [131.876272] Subtest dp-edid-read: SKIP (0.000s) [132.739125] [094/171] (878s left) kms_chamelium_frames (dp-crc-fast) [133.219376] Subtest dp-crc-fast: SKIP (0.000s) [134.082161] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [134.561321] Subtest hdmi-hpd-fast: SKIP (0.000s) [135.429602] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [135.909817] Subtest hdmi-edid-read: SKIP (0.000s) [136.771336] [097/171] (874s left) kms_chamelium_frames (hdmi-crc-fast) [137.253333] Subtest hdmi-crc-fast: SKIP (0.000s) [138.116244] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [138.595678] Subtest vga-hpd-fast: SKIP (0.000s) [139.461831] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [139.940336] Subtest vga-edid-read: SKIP (0.000s) [140.806210] [100/171] (870s left) kms_prop_blob (basic) [140.947876] Starting subtest: basic [140.949157] Subtest basic: SUCCESS (0.000s) [141.042922] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [141.212948] Starting subtest: basic-busy-flip-before-cursor-atomic [141.215351] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [141.287716] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [141.458118] Starting subtest: basic-busy-flip-before-cursor-legacy [141.460310] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [141.537857] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [141.705510] Starting subtest: basic-flip-after-cursor-atomic [142.996891] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.291s) [143.928336] [104/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [144.094648] Starting subtest: basic-flip-after-cursor-legacy [145.375357] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.277s) [146.295186] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [146.462589] Starting subtest: basic-flip-after-cursor-varying-size [147.768804] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.306s) [148.724558] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [148.893234] Starting subtest: basic-flip-before-cursor-atomic [150.188546] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.290s) [151.157723] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [151.325087] Starting subtest: basic-flip-before-cursor-legacy [152.618376] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.289s) [153.590776] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [153.758768] Starting subtest: basic-flip-before-cursor-varying-size [155.066840] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.307s) [156.021822] [109/171] (855s left) kms_flip (basic-flip-vs-dpms) [156.170612] Starting subtest: basic-flip-vs-dpms [156.173522] Starting dynamic subtest: A-eDP1 [159.042460] Dynamic subtest A-eDP1: SUCCESS (2.869s) [159.069073] Starting dynamic subtest: B-eDP1 [161.390551] Dynamic subtest B-eDP1: SUCCESS (2.346s) [161.417903] Starting dynamic subtest: C-eDP1 [163.760354] Dynamic subtest C-eDP1: SUCCESS (2.369s) [163.763136] Subtest basic-flip-vs-dpms: SUCCESS (7.594s) [164.669213] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [164.817456] Starting subtest: basic-flip-vs-modeset [164.822936] Starting dynamic subtest: A-eDP1 [167.725354] Dynamic subtest A-eDP1: SUCCESS (2.903s) [167.742665] Starting dynamic subtest: B-eDP1 [170.094487] Dynamic subtest B-eDP1: SUCCESS (2.368s) [170.112290] Starting dynamic subtest: C-eDP1 [172.466151] Dynamic subtest C-eDP1: SUCCESS (2.369s) [172.467478] Subtest basic-flip-vs-modeset: SUCCESS (7.650s) [173.432398] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [173.579438] Starting subtest: basic-flip-vs-wf_vblank [173.582944] Starting dynamic subtest: A-eDP1 [175.891614] Dynamic subtest A-eDP1: SUCCESS (2.309s) [175.909552] Starting dynamic subtest: B-eDP1 [178.117724] Dynamic subtest B-eDP1: SUCCESS (2.225s) [178.135844] Starting dynamic subtest: C-eDP1 [180.356219] Dynamic subtest C-eDP1: SUCCESS (2.237s) [180.359275] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.781s) [181.687298] [112/171] (830s left) kms_flip (basic-plain-flip) [181.833855] Starting subtest: basic-plain-flip [181.837839] Starting dynamic subtest: A-eDP1 [183.866051] Dynamic subtest A-eDP1: SUCCESS (2.028s) [183.883074] Starting dynamic subtest: B-eDP1 [185.835104] Dynamic subtest B-eDP1: SUCCESS (1.968s) [185.852358] Starting dynamic subtest: C-eDP1 [187.817832] Dynamic subtest C-eDP1: SUCCESS (1.981s) [187.820952] Subtest basic-plain-flip: SUCCESS (5.987s) [189.113128] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [189.257620] Starting subtest: force-connector-state [190.980736] Subtest force-connector-state: SUCCESS (1.721s) [191.597764] [114/171] (820s left) kms_force_connector_basic (force-edid) [191.744126] Starting subtest: force-edid [191.999477] Subtest force-edid: SUCCESS (0.252s) [192.131713] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [192.275096] Starting subtest: force-load-detect [192.277659] Subtest force-load-detect: SKIP (0.000s) [192.398115] [116/171] (819s left) kms_force_connector_basic (prune-stale-modes) [192.540731] Starting subtest: prune-stale-modes [192.847417] Subtest prune-stale-modes: SUCCESS (0.306s) [192.981539] [117/171] (819s left) kms_frontbuffer_tracking (basic) [193.157371] Starting subtest: basic [196.413267] Subtest basic: SUCCESS (3.255s) [196.533565] [118/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [196.704316] Starting subtest: compare-crc-sanitycheck-xr24 [196.707235] Starting dynamic subtest: pipe-A-eDP-1 [197.396362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s) [197.415109] Starting dynamic subtest: pipe-B-eDP-1 [198.761946] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s) [198.792142] Starting dynamic subtest: pipe-C-eDP-1 [200.311200] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [200.322893] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.608s) [201.264557] [119/171] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [201.434415] Starting subtest: compare-crc-sanitycheck-nv12 [201.435568] Starting dynamic subtest: pipe-A-eDP-1 [202.356460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [202.377318] Starting dynamic subtest: pipe-B-eDP-1 [203.821962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s) [203.847077] Starting dynamic subtest: pipe-C-eDP-1 [205.594714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.768s) [205.603037] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.161s) [206.514262] [120/171] (805s left) kms_pipe_crc_basic (hang-read-crc) [206.683363] Starting subtest: hang-read-crc [206.686680] Starting dynamic subtest: pipe-A-eDP-1 [208.992175] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.304s) [209.012911] Starting dynamic subtest: pipe-B-eDP-1 [211.991942] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.997s) [212.012876] Starting dynamic subtest: pipe-C-eDP-1 [215.324062] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.327s) [215.325411] Subtest hang-read-crc: SUCCESS (8.640s) [216.255166] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [216.427410] Starting subtest: nonblocking-crc [216.428572] Starting dynamic subtest: pipe-A-eDP-1 [217.276951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [217.297666] Starting dynamic subtest: pipe-B-eDP-1 [218.834342] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [218.853710] Starting dynamic subtest: pipe-C-eDP-1 [220.549933] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.711s) [220.551293] Subtest nonblocking-crc: SUCCESS (4.124s) [221.488938] [122/171] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [221.661639] Starting subtest: nonblocking-crc-frame-sequence [221.665257] Starting dynamic subtest: pipe-A-eDP-1 [222.513761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s) [222.532869] Starting dynamic subtest: pipe-B-eDP-1 [224.067425] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [224.088613] Starting dynamic subtest: pipe-C-eDP-1 [225.783315] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s) [225.784562] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.122s) [226.738072] [123/171] (785s left) kms_pipe_crc_basic (read-crc) [226.908804] Starting subtest: read-crc [226.912167] Starting dynamic subtest: pipe-A-eDP-1 [227.696532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s) [227.717179] Starting dynamic subtest: pipe-B-eDP-1 [229.180788] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.481s) [229.201378] Starting dynamic subtest: pipe-C-eDP-1 [230.833285] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [230.834475] Subtest read-crc: SUCCESS (3.926s) [231.793735] [124/171] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [231.965422] Starting subtest: read-crc-frame-sequence [231.968520] Starting dynamic subtest: pipe-A-eDP-1 [232.751252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s) [232.771252] Starting dynamic subtest: pipe-B-eDP-1 [234.238407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [234.260088] Starting dynamic subtest: pipe-C-eDP-1 [235.894303] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [235.895697] Subtest read-crc-frame-sequence: SUCCESS (3.926s) [236.848942] [125/171] (775s left) kms_psr (primary_page_flip) [237.041891] Starting subtest: primary_page_flip [241.273084] Subtest primary_page_flip: SUCCESS (4.231s) [242.225367] [126/171] (770s left) kms_psr (cursor_plane_move) [242.397812] Starting subtest: cursor_plane_move [246.557755] Subtest cursor_plane_move: SUCCESS (4.154s) [247.473117] [127/171] (765s left) kms_psr (sprite_plane_onoff) [247.644502] Starting subtest: sprite_plane_onoff [251.899636] Subtest sprite_plane_onoff: SUCCESS (4.254s) [252.849126] [128/171] (759s left) kms_psr (primary_mmap_gtt) [253.023437] Starting subtest: primary_mmap_gtt [257.272946] Subtest primary_mmap_gtt: SUCCESS (4.249s) [258.225808] [129/171] (754s left) kms_setmode (basic-clone-single-crtc) [258.365919] Starting subtest: basic-clone-single-crtc [258.384109] Subtest basic-clone-single-crtc: SKIP (0.000s) [258.442191] [130/171] (754s left) i915_pm_backlight (basic-brightness) [258.607945] Starting subtest: basic-brightness [258.711914] Starting dynamic subtest: eDP-1 [259.251218] Dynamic subtest eDP-1: SUCCESS (0.545s) [259.257782] Subtest basic-brightness: SUCCESS (0.644s) [260.210067] [131/171] (752s left) i915_pm_rpm (basic-pci-d3-state) [262.097507] Starting subtest: basic-pci-d3-state [266.507933] Subtest basic-pci-d3-state: SUCCESS (4.409s) [266.712514] [132/171] (745s left) i915_pm_rpm (basic-rte) [266.850517] Starting subtest: basic-rte [272.973769] Subtest basic-rte: SUCCESS (6.119s) [278.284277] [133/171] (734s left) i915_pm_rps (basic-api) [278.432387] Starting subtest: basic-api [278.437961] Subtest basic-api: SUCCESS (0.006s) [278.550128] [134/171] (734s left) prime_self_import (basic-llseek-bad) [278.690203] Starting subtest: basic-llseek-bad [278.692536] Subtest basic-llseek-bad: SUCCESS (0.004s) [278.782968] [135/171] (733s left) prime_self_import (basic-llseek-size) [278.919575] Starting subtest: basic-llseek-size [278.924272] Subtest basic-llseek-size: SUCCESS (0.004s) [279.033832] [136/171] (733s left) prime_self_import (basic-with_fd_dup) [279.170803] Starting subtest: basic-with_fd_dup [279.175407] Subtest basic-with_fd_dup: SUCCESS (0.005s) [279.267081] [137/171] (733s left) prime_self_import (basic-with_one_bo) [279.405922] Starting subtest: basic-with_one_bo [279.411109] Subtest basic-with_one_bo: SUCCESS (0.005s) [279.498402] [138/171] (733s left) prime_self_import (basic-with_one_bo_two_files) [279.635856] Starting subtest: basic-with_one_bo_two_files [279.640913] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [279.738706] [139/171] (733s left) prime_self_import (basic-with_two_bos) [279.875252] Starting subtest: basic-with_two_bos [279.880239] Subtest basic-with_two_bos: SUCCESS (0.005s) [279.990895] [140/171] (732s left) prime_vgem (basic-fence-flip) [280.163270] Starting subtest: basic-fence-flip [280.693725] Subtest basic-fence-flip: SUCCESS (0.531s) [280.801714] [141/171] (732s left) prime_vgem (basic-fence-mmap) [280.953151] Starting subtest: basic-fence-mmap [281.001280] Subtest basic-fence-mmap: SUCCESS (0.048s) [281.106120] [142/171] (731s left) prime_vgem (basic-fence-read) [281.290286] Starting subtest: basic-fence-read [281.364825] Subtest basic-fence-read: SUCCESS (0.074s) [281.455414] [143/171] (731s left) prime_vgem (basic-gtt) [281.626970] Starting subtest: basic-gtt [281.649542] Subtest basic-gtt: SUCCESS (0.023s) [281.754086] [144/171] (731s left) prime_vgem (basic-read) [281.902891] Starting subtest: basic-read [281.938596] Subtest basic-read: SUCCESS (0.036s) [282.055634] [145/171] (731s left) prime_vgem (basic-write) [282.224344] Starting subtest: basic-write [282.266336] Subtest basic-write: SUCCESS (0.042s) [282.353358] [146/171] (730s left) vgem_basic (setversion) [282.495241] Starting subtest: setversion [282.497680] Subtest setversion: SUCCESS (0.000s) [282.571142] [147/171] (730s left) vgem_basic (create) [282.729229] Starting subtest: create [282.730448] Subtest create: SUCCESS (0.000s) [282.803840] [148/171] (730s left) vgem_basic (debugfs) [282.945176] Starting subtest: debugfs [282.946424] Subtest debugfs: SUCCESS (0.001s) [283.021119] [149/171] (730s left) vgem_basic (dmabuf-export) [283.179563] Starting subtest: dmabuf-export [283.191868] Subtest dmabuf-export: SUCCESS (0.011s) [283.304577] [150/171] (729s left) vgem_basic (dmabuf-fence) [283.447831] Starting subtest: dmabuf-fence [283.449163] Subtest dmabuf-fence: SUCCESS (0.001s) [283.517300] [151/171] (729s left) vgem_basic (dmabuf-fence-before) [283.682073] Starting subtest: dmabuf-fence-before [283.683275] Subtest dmabuf-fence-before: SUCCESS (0.001s) [283.751541] [152/171] (729s left) vgem_basic (dmabuf-mmap) [283.914674] Starting subtest: dmabuf-mmap [283.939053] Subtest dmabuf-mmap: SUCCESS (0.026s) [284.018781] [153/171] (729s left) vgem_basic (mmap) [284.181274] Starting subtest: mmap [284.196234] Subtest mmap: SUCCESS (0.017s) [284.267363] [154/171] (729s left) vgem_basic (second-client) [284.414383] Starting subtest: second-client [284.447754] Subtest second-client: SUCCESS (0.033s) [284.518885] [155/171] (728s left) vgem_basic (sysfs) [284.681691] Starting subtest: sysfs [284.683062] Subtest sysfs: SUCCESS (0.001s) [284.752315] [156/171] (728s left) core_hotunplug (unbind-rebind) [284.946825] Starting subtest: unbind-rebind [287.440739] Subtest unbind-rebind: SUCCESS (2.494s) [287.501271] [157/171] (725s left) vgem_basic (unload) [287.643391] Starting subtest: unload [316.691992] Subtest unload: SUCCESS (29.014s) [316.799373] [158/171] (696s left) i915_module_load (reload) [316.938492] Starting subtest: reload [320.546880] Subtest reload: SUCCESS (3.608s) [320.580183] [159/171] (692s left) gem_lmem_swapping (basic) [320.738235] Subtest basic: SKIP (0.000s) [320.782398] [160/171] (692s left) gem_lmem_swapping (parallel-random-engines) [320.928817] Subtest parallel-random-engines: SKIP (0.000s) [320.982567] [161/171] (692s left) gem_lmem_swapping (random-engines) [321.128232] Subtest random-engines: SKIP (0.000s) [321.181992] [162/171] (692s left) gem_lmem_swapping (verify-random) [321.327372] Subtest verify-random: SKIP (0.000s) [321.381875] [163/171] (692s left) i915_pm_rpm (module-reload) [333.922324] Starting subtest: module-reload [368.916809] Subtest module-reload: SUCCESS (34.987s) [368.942605] [164/171] (644s left) i915_selftest (live) [369.088454] Starting subtest: live [369.089933] Starting dynamic subtest: sanitycheck [370.959466] Dynamic subtest sanitycheck: SUCCESS (1.861s) [370.974323] Starting dynamic subtest: uncore [372.854458] Dynamic subtest uncore: SUCCESS (1.892s) [372.869381] Starting dynamic subtest: workarounds [374.966569] Dynamic subtest workarounds: SUCCESS (2.109s) [374.981988] Starting dynamic subtest: gt_engines [377.241533] Dynamic subtest gt_engines: SUCCESS (2.271s) [377.257530] Starting dynamic subtest: gt_timelines [390.063244] Dynamic subtest gt_timelines: SUCCESS (12.818s) [390.078429] Starting dynamic subtest: gt_contexts [391.965549] Dynamic subtest gt_contexts: SUCCESS (1.899s) [391.981399] Starting dynamic subtest: gt_lrc [396.384612] Dynamic subtest gt_lrc: SUCCESS (4.415s) [396.400184] Starting dynamic subtest: gt_mocs [398.315570] Dynamic subtest gt_mocs: SUCCESS (1.928s) [398.330868] Starting dynamic subtest: gt_pm [403.433061] Dynamic subtest gt_pm: SUCCESS (5.114s) [403.448029] Starting dynamic subtest: gt_heartbeat [405.402680] Dynamic subtest gt_heartbeat: SUCCESS (1.966s) [405.417593] Starting dynamic subtest: gt_tlb [408.518622] Dynamic subtest gt_tlb: SUCCESS (3.112s) [408.533225] Starting dynamic subtest: requests [416.140269] Dynamic subtest requests: SUCCESS (7.618s) [416.156367] Starting dynamic subtest: migrate [420.742774] Dynamic subtest migrate: SUCCESS (4.599s) [420.758460] Starting dynamic subtest: active [422.613186] Dynamic subtest active: SUCCESS (1.867s) [422.628237] Starting dynamic subtest: objects [426.012914] Dynamic subtest objects: SUCCESS (3.396s) [426.028129] Starting dynamic subtest: mman [433.018442] Dynamic subtest mman: SUCCESS (7.002s) [433.034087] Starting dynamic subtest: dmabuf [434.850459] Dynamic subtest dmabuf: SUCCESS (1.829s) [434.866431] Starting dynamic subtest: vma [436.703473] Dynamic subtest vma: SUCCESS (1.850s) [436.718575] Starting dynamic subtest: coherency [441.201774] Dynamic subtest coherency: SUCCESS (4.495s) [441.216950] Starting dynamic subtest: gtt [450.706391] Dynamic subtest gtt: SUCCESS (9.501s) [450.722562] Starting dynamic subtest: gem [452.667586] Dynamic subtest gem: SUCCESS (1.958s) [452.682958] Starting dynamic subtest: evict [456.559617] Dynamic subtest evict: SUCCESS (3.889s) [456.575753] Starting dynamic subtest: hugepages [464.322062] Dynamic subtest hugepages: SUCCESS (7.759s) [464.337458] Starting dynamic subtest: gem_contexts [479.695553] Dynamic subtest gem_contexts: SUCCESS (15.370s) [479.711051] Starting dynamic subtest: client [481.586652] Dynamic subtest client: SUCCESS (1.888s) [481.602142] Starting dynamic subtest: gem_migrate [483.430233] Dynamic subtest gem_migrate: SUCCESS (1.840s) [483.446142] Starting dynamic subtest: reset [488.838750] Dynamic subtest reset: SUCCESS (5.405s) [488.854584] Starting dynamic subtest: memory_region [490.669783] Dynamic subtest memory_region: SUCCESS (1.828s) [490.686037] Starting dynamic subtest: hangcheck [515.080477] Dynamic subtest hangcheck: SUCCESS (24.407s) [515.097231] Starting dynamic subtest: execlists [525.247730] Dynamic subtest execlists: SUCCESS (10.164s) [525.263911] Starting dynamic subtest: ring_submission [527.154515] Dynamic subtest ring_submission: SUCCESS (1.903s) [527.170429] Starting dynamic subtest: perf [529.081501] Dynamic subtest perf: SUCCESS (1.924s) [529.097234] Starting dynamic subtest: slpc [530.915591] Dynamic subtest slpc: SUCCESS (1.831s) [530.931459] Starting dynamic subtest: guc [532.779778] Dynamic subtest guc: SUCCESS (1.861s) [532.795399] Starting dynamic subtest: guc_multi_lrc [534.644411] Dynamic subtest guc_multi_lrc: SUCCESS (1.861s) [534.660594] Starting dynamic subtest: guc_hang [536.485440] Dynamic subtest guc_hang: SUCCESS (1.837s) [536.500849] Starting dynamic subtest: late_gt_pm [538.351568] Dynamic subtest late_gt_pm: SUCCESS (1.862s) [538.352861] Subtest live: SUCCESS (169.256s) [538.575452] [165/171] (475s left) dmabuf (all-tests) [538.715873] Starting subtest: all-tests [538.717191] Starting dynamic subtest: sanitycheck [538.792042] Dynamic subtest sanitycheck: SUCCESS (0.074s) [538.811622] Starting dynamic subtest: dma_fence [538.978228] Dynamic subtest dma_fence: SUCCESS (0.182s) [538.996888] Starting dynamic subtest: dma_fence_chain [556.744520] Dynamic subtest dma_fence_chain: SUCCESS (17.754s) [556.757850] Starting dynamic subtest: dma_fence_unwrap [556.817853] Dynamic subtest dma_fence_unwrap: SUCCESS (0.078s) [556.837828] Starting dynamic subtest: dma_resv [556.882974] Dynamic subtest dma_resv: SUCCESS (0.061s) [556.885476] Subtest all-tests: SUCCESS (18.168s) [556.916984] [166/171] (456s left) i915_suspend (basic-s2idle-without-i915) [557.055497] Starting subtest: basic-s2idle-without-i915 [580.857349] Subtest basic-s2idle-without-i915: SUCCESS (8.281s) [581.166190] [167/171] (448s left) i915_suspend (basic-s3-without-i915) [581.305543] Starting subtest: basic-s3-without-i915 [604.950396] Subtest basic-s3-without-i915: SUCCESS (7.050s) [605.263961] [168/171] (440s left) gem_exec_suspend (basic-s0) [605.421367] Starting subtest: basic-S0 [605.422596] Starting dynamic subtest: smem [625.140575] Dynamic subtest smem: SUCCESS (4.011s) [625.141775] Subtest basic-S0: SUCCESS (4.013s) [625.299231] [169/171] (436s left) gem_exec_suspend (basic-s3) [625.448731] Starting subtest: basic-S3 [625.449960] Starting dynamic subtest: smem [644.196089] Dynamic subtest smem: SUCCESS (3.789s) [644.197418] Subtest basic-S3: SUCCESS (3.790s) [644.364130] [170/171] (432s left) kms_chamelium_hpd (common-hpd-after-suspend) [644.846717] Subtest common-hpd-after-suspend: SKIP (0.000s) [645.760629] [171/171] (430s left) kms_pipe_crc_basic (suspend-read-crc) [645.925374] Starting subtest: suspend-read-crc [645.928931] Starting dynamic subtest: pipe-A-eDP-1 [664.022275] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.428s) [664.045095] Starting dynamic subtest: pipe-B-eDP-1 [681.998521] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.076s) [682.021007] Starting dynamic subtest: pipe-C-eDP-1 [700.989564] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.246s) [700.990767] Subtest suspend-read-crc: SUCCESS (8.762s) [701.929637] Closing watchdogs Done.