[60.885574] Initializing watchdogs [60.885624] /dev/watchdog0 [60.900632] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.908699] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.911099] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.914579] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [61.042730] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [61.046988] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [61.161735] [002/133] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [61.270955] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [61.275160] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [61.364677] [003/133] (960s left) kms_psr (fbc-pr-sprite-mmap-cpu) [61.463902] Starting subtest: fbc-pr-sprite-mmap-cpu [61.468497] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [61.543723] [004/133] (959s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [61.648130] Starting subtest: fbc-rgb565-draw-mmap-wc [65.706980] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.075s) [66.861575] [005/133] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [66.959813] Starting subtest: fbc-2p-primscrn-cur-indfb-move [66.964387] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [67.515759] [006/133] (954s left) kms_big_fb (4-tiled-8bpp-rotate-0) [67.776236] Starting subtest: 4-tiled-8bpp-rotate-0 [69.089718] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.316s) [69.212052] [007/133] (952s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [69.313014] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [69.314932] Starting dynamic subtest: pipe-A-eDP-1 [75.205769] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.903s) [75.214435] Starting dynamic subtest: pipe-B-eDP-1 [81.860589] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s) [81.862908] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.561s) [82.720758] [008/133] (938s left) kms_getfb (getfb2-handle-not-fb) [82.816839] Starting subtest: getfb2-handle-not-fb [82.819168] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [82.913330] [009/133] (938s left) i915_pm_rpm (gem-execbuf-stress-pc8) [85.049538] Starting subtest: gem-execbuf-stress-pc8 [85.092497] Subtest gem-execbuf-stress-pc8: SKIP (0.044s) [85.421702] [010/133] (936s left) kms_psr (psr2-sprite-plane-onoff) [85.521649] Starting subtest: psr2-sprite-plane-onoff [85.523923] Starting dynamic subtest: eDP-1 [87.237107] Dynamic subtest eDP-1: SUCCESS (1.715s) [87.239362] Subtest psr2-sprite-plane-onoff: SUCCESS (1.716s) [88.098274] [011/133] (933s left) perf_pmu (busy-accuracy-50) [88.149559] Starting subtest: busy-accuracy-50 [88.151930] Starting dynamic subtest: rcs0 [89.686267] Dynamic subtest rcs0: SUCCESS (1.532s) [89.698041] Starting dynamic subtest: bcs0 [91.227800] Dynamic subtest bcs0: SUCCESS (1.542s) [91.238285] Starting dynamic subtest: vcs0 [92.766517] Dynamic subtest vcs0: SUCCESS (1.538s) [92.775565] Starting dynamic subtest: vcs1 [94.309729] Dynamic subtest vcs1: SUCCESS (1.542s) [94.320054] Starting dynamic subtest: vecs0 [95.853776] Dynamic subtest vecs0: SUCCESS (1.543s) [95.862971] Starting dynamic subtest: ccs0 [97.401439] Dynamic subtest ccs0: SUCCESS (1.546s) [97.403790] Subtest busy-accuracy-50: SUCCESS (9.251s) [97.516210] [012/133] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [97.625573] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [97.630079] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [97.716570] [013/133] (924s left) gem_userptr_blits (create-destroy-unsync) [97.785169] Subtest create-destroy-unsync: SKIP (0.000s) [97.900690] [014/133] (924s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [97.984871] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [97.989220] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [98.054371] [015/133] (923s left) kms_pm_rpm (modeset-non-lpsp-stress) [100.098495] Starting subtest: modeset-non-lpsp-stress [101.245510] Subtest modeset-non-lpsp-stress: SKIP (1.146s) [101.638811] [016/133] (920s left) sysfs_heartbeat_interval (invalid) [101.704522] Starting subtest: invalid [101.706775] Starting dynamic subtest: vecs0 [101.709216] Dynamic subtest vecs0: SUCCESS (0.000s) [101.718987] Starting dynamic subtest: ccs0 [101.720872] Dynamic subtest ccs0: SUCCESS (0.000s) [101.728191] Starting dynamic subtest: vcs0 [101.730065] Dynamic subtest vcs0: SUCCESS (0.000s) [101.737318] Starting dynamic subtest: bcs0 [101.739392] Dynamic subtest bcs0: SUCCESS (0.000s) [101.747678] Starting dynamic subtest: rcs0 [101.749638] Dynamic subtest rcs0: SUCCESS (0.000s) [101.759220] Starting dynamic subtest: vcs1 [101.761397] Dynamic subtest vcs1: SUCCESS (0.000s) [101.763677] Subtest invalid: SUCCESS (0.003s) [101.808549] [017/133] (920s left) gem_ctx_engines (execute-allforone) [101.862662] Starting subtest: execute-allforone [101.875070] Subtest execute-allforone: SUCCESS (0.013s) [103.977973] [018/133] (918s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [104.074310] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [104.076647] Starting dynamic subtest: pipe-A-eDP-1 [104.097185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [104.107277] Starting dynamic subtest: pipe-B-eDP-1 [104.126489] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [104.134583] Starting dynamic subtest: pipe-C-eDP-1 [104.153335] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [104.161066] Starting dynamic subtest: pipe-D-eDP-1 [104.180194] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [104.182294] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [106.401810] [019/133] (915s left) gem_ctx_persistence (userptr) [106.466332] Starting subtest: userptr [106.654651] Subtest userptr: SUCCESS (0.188s) [106.739515] [020/133] (915s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [106.800124] Starting subtest: x-tiled-to-vebox-yf-tiled [106.804489] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [106.991174] [021/133] (915s left) syncobj_timeline (multi-wait-available-submitted-signaled) [107.046865] Starting subtest: multi-wait-available-submitted-signaled [107.049285] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s) [107.147453] [022/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256) [107.377591] Starting subtest: cursor-rapid-movement-256x256 [107.382448] Starting dynamic subtest: pipe-A-eDP-1 [107.928774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s) [107.957683] Starting dynamic subtest: pipe-D-eDP-1 [109.120691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.170s) [109.122704] Subtest cursor-rapid-movement-256x256: SUCCESS (1.742s) [109.970693] [023/133] (912s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [110.073220] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [110.718962] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s) [110.866663] [024/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [110.984093] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [110.988568] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [111.079833] [025/133] (911s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [111.205427] Starting subtest: cursorA-vs-flipA-toggle [122.343484] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.137s) [123.195768] [026/133] (899s left) fbdev (info) [123.236963] Starting subtest: info [123.239468] Subtest info: SUCCESS (0.000s) [123.314160] [027/133] (899s left) gem_mmap_gtt (basic-small-copy-xy) [123.373187] Subtest basic-small-copy-XY: SKIP (0.000s) [123.430983] [028/133] (899s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [123.527156] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [123.531606] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [123.606941] [029/133] (898s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [123.662475] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [123.771470] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s) [123.843071] [030/133] (898s left) sriov_basic (enable-vfs-bind-unbind-each) [123.896537] Starting subtest: enable-vfs-bind-unbind-each [123.898673] Starting dynamic subtest: numvfs-1 [123.975321] Dynamic subtest numvfs-1: FAIL (0.014s) [123.984883] Starting dynamic subtest: numvfs-2 [124.059517] Dynamic subtest numvfs-2: FAIL (0.004s) [124.069152] Starting dynamic subtest: numvfs-3 [124.143790] Dynamic subtest numvfs-3: FAIL (0.004s) [124.152479] Starting dynamic subtest: numvfs-4 [124.226370] Dynamic subtest numvfs-4: FAIL (0.004s) [124.236429] Starting dynamic subtest: numvfs-5 [124.309632] Dynamic subtest numvfs-5: FAIL (0.004s) [124.318703] Starting dynamic subtest: numvfs-6 [124.392424] Dynamic subtest numvfs-6: FAIL (0.003s) [124.402247] Starting dynamic subtest: numvfs-7 [124.476197] Dynamic subtest numvfs-7: FAIL (0.004s) [124.485121] Starting dynamic subtest: numvfs-random [124.559170] Dynamic subtest numvfs-random: FAIL (0.004s) [124.561547] Subtest enable-vfs-bind-unbind-each: FAIL (0.044s) [124.599145] [031/133] (898s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [124.693582] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [124.695725] Starting dynamic subtest: pipe-A-eDP-1 [124.717731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [124.727660] Starting dynamic subtest: pipe-B-eDP-1 [124.748167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [124.756017] Starting dynamic subtest: pipe-C-eDP-1 [124.776963] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [124.786644] Starting dynamic subtest: pipe-D-eDP-1 [124.805347] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [124.808777] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [126.861865] [032/133] (895s left) kms_invalid_mode (bad-htotal) [126.953065] Starting subtest: bad-htotal [126.955308] Starting dynamic subtest: pipe-A-eDP-1 [127.242467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [127.251233] Starting dynamic subtest: pipe-B-eDP-1 [127.253209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [127.260539] Starting dynamic subtest: pipe-C-eDP-1 [127.262509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [127.270425] Starting dynamic subtest: pipe-D-eDP-1 [127.272756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [127.275065] Subtest bad-htotal: SUCCESS (0.295s) [128.098100] [033/133] (894s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [128.185589] Starting subtest: plane-upscale-20x20-with-pixel-format [128.188081] Starting dynamic subtest: pipe-A [129.232232] Dynamic subtest pipe-A: SUCCESS (1.050s) [129.239957] Starting dynamic subtest: pipe-B [131.328893] Dynamic subtest pipe-B: SUCCESS (2.096s) [131.336526] Starting dynamic subtest: pipe-C [132.506446] Dynamic subtest pipe-C: SUCCESS (1.176s) [132.515526] Starting dynamic subtest: pipe-D [133.741031] Dynamic subtest pipe-D: SUCCESS (1.234s) [133.743286] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.559s) [134.940925] [034/133] (887s left) gem_mmap_gtt (basic-write-read-distinct) [135.008223] Subtest basic-write-read-distinct: SKIP (0.000s) [135.070560] [035/133] (887s left) gem_exec_fence (invalid-timeline-fence-array) [135.660846] Starting subtest: invalid-timeline-fence-array [135.666596] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [136.992715] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [136.996088] [036/133] (885s left) vgem_basic (create) [137.044659] Starting subtest: create [137.046585] Subtest create: SUCCESS (0.000s) [137.105729] [037/133] (885s left) gem_tiled_blits (basic) [137.176958] Subtest basic: SKIP (0.000s) [137.249514] [038/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [137.345055] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [137.349159] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [137.438788] [039/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [137.533093] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [137.537059] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [137.626543] [040/133] (885s left) gem_userptr_blits (nohangcheck) [137.698264] Starting subtest: nohangcheck [137.947350] Subtest nohangcheck: SUCCESS (0.246s) [138.086712] [041/133] (884s left) gem_exec_parallel (basic) [138.149892] Starting subtest: basic [138.152314] Starting dynamic subtest: rcs0 [139.564802] Dynamic subtest rcs0: SUCCESS (1.415s) [139.573469] Starting dynamic subtest: bcs0 [141.017740] Dynamic subtest bcs0: SUCCESS (1.451s) [141.029072] Starting dynamic subtest: vcs0 [142.871030] Dynamic subtest vcs0: SUCCESS (1.850s) [142.880512] Starting dynamic subtest: vcs1 [144.855122] Dynamic subtest vcs1: SUCCESS (1.982s) [144.868665] Starting dynamic subtest: vecs0 [146.838450] Dynamic subtest vecs0: SUCCESS (1.981s) [146.850538] Starting dynamic subtest: ccs0 [148.308569] Dynamic subtest ccs0: SUCCESS (1.470s) [148.310745] Subtest basic: SUCCESS (10.160s) [148.511604] [042/133] (874s left) perf_pmu (interrupts-sync) [148.557171] Starting subtest: interrupts-sync [149.665252] Subtest interrupts-sync: SUCCESS (1.107s) [149.774795] [043/133] (873s left) gem_exec_schedule (noreorder-corked) [149.958088] Starting subtest: noreorder-corked [149.960966] Starting dynamic subtest: rcs0 [151.107660] Dynamic subtest rcs0: SUCCESS (1.150s) [151.119773] Starting dynamic subtest: vcs0 [152.919592] Dynamic subtest vcs0: SUCCESS (1.810s) [152.934565] Starting dynamic subtest: vcs1 [154.900336] Dynamic subtest vcs1: SUCCESS (1.978s) [154.911731] Starting dynamic subtest: vecs0 [156.889545] Dynamic subtest vecs0: SUCCESS (1.987s) [156.899625] Starting dynamic subtest: ccs0 [158.026773] Dynamic subtest ccs0: SUCCESS (1.137s) [158.029572] Subtest noreorder-corked: SUCCESS (8.070s) [158.227614] [044/133] (864s left) kms_cursor_crc (cursor-sliding-64x64) [158.402329] Starting subtest: cursor-sliding-64x64 [158.407258] Starting dynamic subtest: pipe-A-eDP-1 [161.631550] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.225s) [161.665332] Starting dynamic subtest: pipe-D-eDP-1 [165.544791] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.886s) [165.547191] Subtest cursor-sliding-64x64: SUCCESS (7.141s) [166.420710] [045/133] (856s left) kms_vrr (flip-dpms) [166.509767] Starting subtest: flip-dpms [166.516514] Subtest flip-dpms: SKIP (0.000s) [166.584977] [046/133] (856s left) gen9_exec_parse (batch-invalid-length) [166.643557] Subtest batch-invalid-length: SKIP (0.000s) [166.721741] [047/133] (856s left) gem_exec_fence (basic-await) [166.912789] Starting subtest: basic-await [166.914868] Starting dynamic subtest: rcs0 [166.987713] Dynamic subtest rcs0: SUCCESS (0.076s) [167.000680] Starting dynamic subtest: bcs0 [167.063441] Dynamic subtest bcs0: SUCCESS (0.074s) [167.074794] Starting dynamic subtest: vcs0 [167.137083] Dynamic subtest vcs0: SUCCESS (0.072s) [167.148694] Starting dynamic subtest: vcs1 [167.210357] Dynamic subtest vcs1: SUCCESS (0.072s) [167.221899] Starting dynamic subtest: vecs0 [167.284685] Dynamic subtest vecs0: SUCCESS (0.073s) [167.296171] Starting dynamic subtest: ccs0 [167.358285] Dynamic subtest ccs0: SUCCESS (0.072s) [167.360845] Subtest basic-await: SUCCESS (0.449s) [169.001779] [048/133] (854s left) gem_userptr_blits (coherency-sync) [169.063904] Starting subtest: coherency-sync [169.450572] Subtest coherency-sync: SKIP (0.347s) [169.536834] [049/133] (853s left) kms_psr (pr-sprite-plane-move) [169.670939] Starting subtest: pr-sprite-plane-move [169.675296] Subtest pr-sprite-plane-move: SKIP (0.000s) [169.743827] [050/133] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [169.843162] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [169.847347] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [169.932956] [051/133] (853s left) kms_lease (lease-invalid-connector) [170.025789] Starting subtest: lease-invalid-connector [170.028117] Starting dynamic subtest: pipe-A-eDP-1 [170.030240] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [170.038792] Starting dynamic subtest: pipe-B-eDP-1 [170.040677] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [170.049174] Starting dynamic subtest: pipe-C-eDP-1 [170.051446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [170.059930] Starting dynamic subtest: pipe-D-eDP-1 [170.061787] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [170.063625] Subtest lease-invalid-connector: SUCCESS (0.004s) [170.101071] [052/133] (853s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [170.192013] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [170.194307] Starting dynamic subtest: pipe-A-eDP-1 [170.203400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [170.212766] Starting dynamic subtest: pipe-B-eDP-1 [170.221601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [170.230073] Starting dynamic subtest: pipe-C-eDP-1 [170.238149] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [170.246337] Starting dynamic subtest: pipe-D-eDP-1 [170.254971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [170.259077] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s) [172.470733] [053/133] (851s left) api_intel_allocator (reopen-fork) [172.534394] Starting subtest: reopen-fork [175.833073] Subtest reopen-fork: SUCCESS (3.298s) [175.909945] [054/133] (847s left) kms_pm_lpsp (screens-disabled) [177.026594] Starting subtest: screens-disabled [177.030801] Subtest screens-disabled: SKIP (0.000s) [177.094503] [055/133] (846s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [177.191339] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [177.193760] Starting dynamic subtest: pipe-A-default-mode [178.328355] Dynamic subtest pipe-A-default-mode: SKIP (1.134s) [178.332772] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.135s) [178.486167] [056/133] (845s left) kms_content_protection (srm) [178.637932] Starting subtest: srm [178.645023] Subtest srm: SKIP (0.003s) [178.764489] [057/133] (844s left) gem_exercise_blt (fast-copy-emit) [178.827179] Starting subtest: fast-copy-emit [178.829071] Starting dynamic subtest: linear-smem-smem-emit [178.855085] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.029s) [178.865597] Starting dynamic subtest: xmajor-smem-smem-emit [178.872649] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [178.881400] Starting dynamic subtest: tile4-smem-smem-emit [178.890131] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [178.898669] Starting dynamic subtest: tile64-smem-smem-emit [178.909130] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s) [178.911498] Subtest fast-copy-emit: SUCCESS (0.084s) [179.034007] [058/133] (844s left) kms_async_flips (async-flip-with-page-flip-events-linear) [179.131355] Starting subtest: async-flip-with-page-flip-events-linear [179.507872] Starting dynamic subtest: pipe-A-eDP-1 [182.273781] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s) [182.639436] Starting dynamic subtest: pipe-B-eDP-1 [185.401799] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s) [185.779080] Starting dynamic subtest: pipe-C-eDP-1 [188.525773] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.753s) [188.901826] Starting dynamic subtest: pipe-D-eDP-1 [191.652988] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s) [191.655531] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.522s) [192.853308] [059/133] (830s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [192.963977] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [193.777858] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s) [193.955897] [060/133] (829s left) kms_sequence (get-forked-busy) [194.044717] Starting subtest: get-forked-busy [194.046814] Starting dynamic subtest: pipe-A-eDP-1 [195.984630] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s) [195.994046] Starting dynamic subtest: pipe-B-eDP-1 [198.553062] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s) [198.567548] Starting dynamic subtest: pipe-C-eDP-1 [201.174454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s) [201.191853] Starting dynamic subtest: pipe-D-eDP-1 [203.796632] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s) [203.799057] Subtest get-forked-busy: SUCCESS (9.753s) [204.595546] [061/133] (819s left) gem_madvise (dontneed-before-exec) [204.639197] Starting subtest: dontneed-before-exec [204.656528] Subtest dontneed-before-exec: SKIP (0.014s) [204.727606] [062/133] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [204.830590] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [204.834831] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [204.920025] [063/133] (819s left) gem_softpin (evict-active) [204.978568] Starting subtest: evict-active [204.983489] Subtest evict-active: SUCCESS (0.005s) [205.113210] [064/133] (818s left) gem_fenced_exec_thrash (no-spare-fences) [205.172654] Subtest no-spare-fences: SKIP (0.000s) [205.243095] [065/133] (818s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [205.305241] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [205.411062] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [205.488099] [066/133] (818s left) kms_chamelium_edid (dp-edid-change-during-suspend) [205.872272] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [206.695667] [067/133] (817s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [206.801826] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [206.826761] Starting dynamic subtest: pipe-A-plane-0 [207.515782] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s) [207.524784] Starting dynamic subtest: pipe-A-plane-3 [207.903770] Dynamic subtest pipe-A-plane-3: SUCCESS (0.386s) [208.999714] Starting dynamic subtest: pipe-B-plane-0 [209.636488] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s) [209.647952] Starting dynamic subtest: pipe-B-plane-3 [210.048632] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s) [210.360299] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.560s) [211.177350] [068/133] (812s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [211.264204] Starting subtest: primary-x-tiled-reflect-x-180 [218.189281] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.926s) [219.444699] [069/133] (804s left) gem_mmap_gtt (big-bo-tiledy) [219.510184] Subtest big-bo-tiledY: SKIP (0.000s) [219.574747] [070/133] (804s left) kms_big_fb (x-tiled-16bpp-rotate-90) [219.677471] Starting subtest: x-tiled-16bpp-rotate-90 [219.697075] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [219.823212] [071/133] (804s left) kms_pwrite_crc [221.482520] [072/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [221.587150] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [221.591398] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [221.679055] [073/133] (802s left) kms_atomic_transition (modeset-transition) [221.773935] Starting subtest: modeset-transition [221.776157] Starting dynamic subtest: 1x-outputs [232.655151] Dynamic subtest 1x-outputs: SUCCESS (10.882s) [232.657636] Subtest modeset-transition: SUCCESS (10.884s) [233.514328] [074/133] (790s left) kms_psr (fbc-psr-primary-mmap-cpu) [233.611995] Starting subtest: fbc-psr-primary-mmap-cpu [233.614204] Starting dynamic subtest: eDP-1 [233.618159] Dynamic subtest eDP-1: SKIP (0.000s) [233.622182] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [233.687806] [075/133] (790s left) gem_mmap_gtt (basic-small-bo) [233.745402] Subtest basic-small-bo: SKIP (0.000s) [233.802611] [076/133] (790s left) kms_rotation_crc (sprite-rotation-180) [233.903907] Starting subtest: sprite-rotation-180 [240.721839] Subtest sprite-rotation-180: SUCCESS (6.820s) [241.882865] [077/133] (782s left) gem_ctx_sseu (engines) [241.942576] Subtest engines: SKIP (0.000s) [242.005976] [078/133] (782s left) kms_ccs (random-ccs-data-y-tiled-ccs) [242.098940] Starting subtest: random-ccs-data-y-tiled-ccs [242.101185] Starting dynamic subtest: pipe-A-eDP-1 [242.125370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [242.136096] Starting dynamic subtest: pipe-B-eDP-1 [242.158606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [242.167049] Starting dynamic subtest: pipe-C-eDP-1 [242.190252] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [242.199336] Starting dynamic subtest: pipe-D-eDP-1 [242.222231] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [242.226419] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s) [244.336629] [079/133] (780s left) gem_exec_balancer (hang) [244.597889] Starting subtest: hang [246.305082] Subtest hang: SUCCESS (1.711s) [246.454449] [080/133] (778s left) kms_chamelium_hpd (hdmi-hpd-storm) [246.834069] Subtest hdmi-hpd-storm: SKIP (0.000s) [247.639806] [081/133] (777s left) gem_pxp (create-protected-buffer) [247.758441] Starting subtest: create-protected-buffer [247.760958] Subtest create-protected-buffer: SUCCESS (0.000s) [247.862981] [082/133] (776s left) gem_exec_schedule (submit-late-slice) [247.935154] Starting subtest: submit-late-slice [247.937148] Starting dynamic subtest: rcs0 [247.958756] Dynamic subtest rcs0: SUCCESS (0.032s) [247.971269] Starting dynamic subtest: bcs0 [247.989320] Dynamic subtest bcs0: SUCCESS (0.030s) [247.998410] Starting dynamic subtest: vcs0 [248.021571] Dynamic subtest vcs0: SUCCESS (0.031s) [248.033417] Starting dynamic subtest: vcs1 [248.048907] Dynamic subtest vcs1: SUCCESS (0.027s) [248.057958] Starting dynamic subtest: vecs0 [248.076972] Dynamic subtest vecs0: SUCCESS (0.027s) [248.087590] Starting dynamic subtest: ccs0 [248.105949] Dynamic subtest ccs0: SUCCESS (0.028s) [248.108432] Subtest submit-late-slice: SUCCESS (0.180s) [249.971330] [083/133] (774s left) gem_ctx_param (invalid-set-ringsize) [250.021872] Starting subtest: invalid-set-ringsize [250.024230] Subtest invalid-set-ringsize: SUCCESS (0.000s) [250.098691] [084/133] (774s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [250.162216] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [250.227616] [085/133] (774s left) perf (short-reads) [250.375929] Starting subtest: short-reads [250.390330] Subtest short-reads: SUCCESS (0.015s) [250.440313] [086/133] (774s left) kms_flip (2x-plain-flip-ts-check) [250.536899] Starting subtest: 2x-plain-flip-ts-check [250.546142] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [250.629267] [087/133] (774s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [250.731257] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [250.733706] Starting dynamic subtest: pipe-A-eDP-1 [250.865696] Dynamic subtest pipe-A-eDP-1: SKIP (0.136s) [250.877363] Starting dynamic subtest: pipe-B-eDP-1 [252.042138] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s) [252.046821] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.313s) [253.261610] [088/133] (771s left) gen9_exec_parse (shadow-peek) [253.316585] Subtest shadow-peek: SKIP (0.000s) [253.383515] [089/133] (771s left) gem_userptr_blits (map-fixed-invalidate-busy) [253.434594] Starting subtest: map-fixed-invalidate-busy [253.438859] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [253.561690] [090/133] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [253.657354] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [262.315485] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.661s) [262.436029] [091/133] (762s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [262.494703] Starting subtest: invalid-multi-wait-unsubmitted [262.497038] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [262.579973] [092/133] (762s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [262.693233] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [262.697590] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [262.849702] [093/133] (762s left) gem_exec_params (mmapped) [262.902918] Starting subtest: mmapped [262.905317] Subtest mmapped: SUCCESS (0.003s) [263.018080] [094/133] (762s left) i915_pm_freq_api (freq-reset) [263.076580] Starting subtest: freq-reset [263.079022] Starting dynamic subtest: gt0 [263.273337] Dynamic subtest gt0: SUCCESS (0.194s) [263.282554] Starting dynamic subtest: gt1 [263.440334] Dynamic subtest gt1: SUCCESS (0.167s) [263.443072] Subtest freq-reset: SUCCESS (0.363s) [263.514499] [095/133] (761s left) core_auth (getclient-simple) [263.548318] Starting subtest: getclient-simple [263.575651] Subtest getclient-simple: SUCCESS (0.026s) [263.668160] [096/133] (761s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [263.782163] Starting subtest: y-tiled-addfb-size-offset-overflow [263.786198] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [263.879436] [097/133] (761s left) kms_atomic_interruptible (legacy-cursor) [263.968820] Starting subtest: legacy-cursor [263.970990] Starting dynamic subtest: pipe-A-eDP-1 [271.398432] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s) [271.400403] Subtest legacy-cursor: SUCCESS (7.429s) [272.238419] [098/133] (753s left) kms_cursor_crc (cursor-offscreen-64x21) [272.430814] Starting subtest: cursor-offscreen-64x21 [272.479946] Subtest cursor-offscreen-64x21: SKIP (0.043s) [272.730384] [099/133] (752s left) kms_plane_alpha_blend (alpha-transparent-fb) [272.819745] Starting subtest: alpha-transparent-fb [273.098702] Starting dynamic subtest: pipe-A-eDP-1 [273.747115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.648s) [273.756597] Starting dynamic subtest: pipe-D-eDP-1 [275.140816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.390s) [275.143158] Subtest alpha-transparent-fb: SUCCESS (2.321s) [276.006863] [100/133] (749s left) i915_query (query-topology-kernel-writes) [276.080649] Starting subtest: query-topology-kernel-writes [276.082844] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [276.198152] [101/133] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [276.288277] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [283.017555] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.733s) [283.154386] [102/133] (742s left) kms_color_pipeline (plane-lut1d-ctm3x4) [283.264743] Starting subtest: plane-lut1d-ctm3x4 [283.432883] Starting dynamic subtest: pipe-A-plane-0 [283.610453] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [283.620206] Starting dynamic subtest: pipe-A-plane-1 [283.766073] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [283.775418] Starting dynamic subtest: pipe-A-plane-2 [283.954655] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [285.124056] Starting dynamic subtest: pipe-B-plane-0 [285.294647] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [285.304252] Starting dynamic subtest: pipe-B-plane-1 [285.451934] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [285.461067] Starting dynamic subtest: pipe-B-plane-2 [285.616964] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s) [286.777992] Starting dynamic subtest: pipe-C-plane-0 [286.926082] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [286.935787] Starting dynamic subtest: pipe-C-plane-1 [287.072044] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [287.081734] Starting dynamic subtest: pipe-C-plane-2 [287.215073] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [288.446440] Starting dynamic subtest: pipe-D-plane-0 [288.593296] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [288.602816] Starting dynamic subtest: pipe-D-plane-1 [288.738308] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s) [288.750074] Starting dynamic subtest: pipe-D-plane-2 [288.882226] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [289.174306] Subtest plane-lut1d-ctm3x4: SUCCESS (5.909s) [289.985897] [103/133] (735s left) kms_flip (flip-vs-dpms-on-nop) [290.088695] Starting subtest: flip-vs-dpms-on-nop [290.091079] Starting dynamic subtest: A-eDP1 [291.989682] Dynamic subtest A-eDP1: SUCCESS (1.902s) [292.003673] Starting dynamic subtest: B-eDP1 [293.833862] Dynamic subtest B-eDP1: SUCCESS (1.841s) [293.845314] Starting dynamic subtest: C-eDP1 [295.649451] Dynamic subtest C-eDP1: SUCCESS (1.814s) [295.659716] Starting dynamic subtest: D-eDP1 [297.502905] Dynamic subtest D-eDP1: SUCCESS (1.852s) [297.509110] Subtest flip-vs-dpms-on-nop: SUCCESS (7.421s) [298.685583] [104/133] (727s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [298.788224] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [298.792295] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [298.885890] [105/133] (726s left) syncobj_wait (multi-wait-submitted-signaled) [298.932504] Starting subtest: multi-wait-submitted-signaled [298.934750] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [299.035958] [106/133] (726s left) kms_explicit_fence (multiplane-atomic-fence-wait) [299.209112] Starting subtest: multiplane-atomic-fence-wait [299.527966] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s) [300.625043] [107/133] (725s left) kms_atomic_transition (plane-all-transition-nonblocking) [300.731678] Starting subtest: plane-all-transition-nonblocking [300.733834] Starting dynamic subtest: pipe-A-eDP-1 [303.225792] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [303.550981] Starting dynamic subtest: pipe-B-eDP-1 [306.773916] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s) [307.078536] Subtest plane-all-transition-nonblocking: SUCCESS (6.346s) [307.883077] [108/133] (717s left) syncobj_timeline (wait-all-for-submit-complex) [307.939736] Starting subtest: wait-all-for-submit-complex [308.152946] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [308.243684] [109/133] (717s left) gem_mmap_gtt (basic-write-read) [308.304994] Subtest basic-write-read: SKIP (0.000s) [308.366508] [110/133] (717s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [308.461711] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [315.212254] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.752s) [315.341552] [111/133] (710s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [315.401926] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [315.403998] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [315.502652] [112/133] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [315.602054] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [322.963382] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.365s) [323.092084] [113/133] (703s left) gem_userptr_blits (sync-unmap-cycles) [323.156638] Starting subtest: sync-unmap-cycles [328.527887] Subtest sync-unmap-cycles: SUCCESS (5.371s) [328.651812] [114/133] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [328.762541] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [335.550533] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.790s) [335.665172] [115/133] (690s left) gem_softpin (allocator-nopin-reserve) [335.719957] Starting subtest: allocator-nopin-reserve [335.803573] Subtest allocator-nopin-reserve: SUCCESS (0.083s) [335.940096] [116/133] (690s left) gem_eio (wait-1us) [336.215737] Starting subtest: wait-1us [336.570668] Subtest wait-1us: SUCCESS (0.356s) [336.696235] [117/133] (689s left) kms_rotation_crc (primary-rotation-90) [336.777402] Starting subtest: primary-rotation-90 [336.781096] Subtest primary-rotation-90: SKIP (0.001s) [336.863149] [118/133] (689s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [336.955376] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [340.987970] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.035s) [342.173495] [119/133] (684s left) perf (invalid-open-flags) [342.262569] Starting subtest: invalid-open-flags [342.265065] Subtest invalid-open-flags: SUCCESS (0.000s) [342.305498] [120/133] (684s left) gen3_render_mixed_blits [342.429561] [121/133] (684s left) perf_pmu (gt-awake) [342.472936] Starting subtest: gt-awake [350.935905] Subtest gt-awake: SUCCESS (8.462s) [351.052548] [122/133] (675s left) gem_unfence_active_buffers [351.198554] [123/133] (675s left) kms_psr (psr-sprite-render) [351.299787] Starting subtest: psr-sprite-render [351.301959] Starting dynamic subtest: eDP-1 [353.095356] Dynamic subtest eDP-1: SUCCESS (1.795s) [353.097594] Subtest psr-sprite-render: SUCCESS (1.796s) [353.936176] [124/133] (672s left) device_reset (unbind-cold-reset-rebind) [353.990635] Starting subtest: unbind-cold-reset-rebind [353.995293] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [354.063688] [125/133] (672s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [354.169846] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [354.173741] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [354.241114] [126/133] (672s left) i915_selftest (mock) [357.587224] Starting subtest: mock [357.590268] Starting dynamic subtest: sanitycheck [358.296165] Dynamic subtest sanitycheck: SUCCESS (0.708s) [358.305990] Starting dynamic subtest: shmem [358.968282] Dynamic subtest shmem: SUCCESS (0.670s) [358.977663] Starting dynamic subtest: fence [367.047612] Dynamic subtest fence: SUCCESS (8.076s) [367.057361] Starting dynamic subtest: scatterlist [368.716026] Dynamic subtest scatterlist: SUCCESS (1.667s) [368.725830] Starting dynamic subtest: syncmap [371.884072] Dynamic subtest syncmap: SUCCESS (3.166s) [371.893245] Starting dynamic subtest: uncore [372.585070] Dynamic subtest uncore: SUCCESS (0.699s) [372.594923] Starting dynamic subtest: ring [373.253046] Dynamic subtest ring: SUCCESS (0.666s) [373.263040] Starting dynamic subtest: engine [373.955046] Dynamic subtest engine: SUCCESS (0.700s) [373.964876] Starting dynamic subtest: timelines [377.799066] Dynamic subtest timelines: SUCCESS (3.841s) [377.813110] Starting dynamic subtest: requests [381.131629] Dynamic subtest requests: SUCCESS (3.331s) [381.139152] Starting dynamic subtest: objects [381.945505] Dynamic subtest objects: SUCCESS (0.813s) [381.954125] Starting dynamic subtest: phys [382.726422] Dynamic subtest phys: SUCCESS (0.778s) [382.734445] Starting dynamic subtest: dmabuf [383.512223] Dynamic subtest dmabuf: SUCCESS (0.783s) [383.522175] Starting dynamic subtest: vma [389.313696] Dynamic subtest vma: SUCCESS (5.799s) [389.323632] Starting dynamic subtest: evict [390.724854] Dynamic subtest evict: SUCCESS (1.410s) [390.734672] Starting dynamic subtest: gtt [394.047545] Dynamic subtest gtt: SUCCESS (3.322s) [394.057156] Starting dynamic subtest: hugepages [394.933843] Dynamic subtest hugepages: SUCCESS (0.885s) [394.943752] Starting dynamic subtest: memory_region [397.387081] Dynamic subtest memory_region: SUCCESS (2.451s) [397.389593] Subtest mock: SUCCESS (39.799s) [397.417905] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [397.418621] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [397.421649] [127/133] (629s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [398.968543] Starting subtest: yf-tiled-to-vebox-x-tiled [398.972948] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [399.114963] [FACT gem_render_copy (yf-tiled-to-vebox-x-tiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [399.116366] [FACT gem_render_copy (yf-tiled-to-vebox-x-tiled)] new: kernel.kmod_is_loaded.i915: true [399.120297] [128/133] (627s left) gem_exec_schedule (u-submit-late-slice) [399.187093] Starting subtest: u-submit-late-slice [399.189639] Starting dynamic subtest: rcs0 [399.223309] Dynamic subtest rcs0: SUCCESS (0.039s) [399.234651] Starting dynamic subtest: bcs0 [399.253404] Dynamic subtest bcs0: SUCCESS (0.029s) [399.261816] Starting dynamic subtest: vcs0 [399.287281] Dynamic subtest vcs0: SUCCESS (0.033s) [399.297048] Starting dynamic subtest: vcs1 [399.325673] Dynamic subtest vcs1: SUCCESS (0.037s) [399.338428] Starting dynamic subtest: vecs0 [399.355403] Dynamic subtest vecs0: SUCCESS (0.029s) [399.363907] Starting dynamic subtest: ccs0 [399.384878] Dynamic subtest ccs0: SUCCESS (0.029s) [399.387091] Subtest u-submit-late-slice: SUCCESS (0.201s) [401.008408] [129/133] (625s left) kms_properties (get_properties-sanity-atomic) [401.116447] Starting subtest: get_properties-sanity-atomic [401.118621] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [401.196364] [130/133] (625s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [401.284624] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [401.286752] Starting dynamic subtest: pipe-A-eDP-1 [401.308557] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [401.318690] Starting dynamic subtest: pipe-B-eDP-1 [401.339221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [401.346849] Starting dynamic subtest: pipe-C-eDP-1 [401.368180] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [401.376230] Starting dynamic subtest: pipe-D-eDP-1 [401.398210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [401.402578] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [403.582190] [131/133] (623s left) kms_addfb_basic (unused-offsets) [403.641921] Starting subtest: unused-offsets [403.644069] Subtest unused-offsets: SUCCESS (0.000s) [403.789554] [132/133] (623s left) gem_mmap_offset (perf) [403.845433] Starting subtest: perf [403.847630] Starting dynamic subtest: smem0 [404.183964] Dynamic subtest smem0: SUCCESS (0.337s) [404.186130] Subtest perf: SUCCESS (0.338s) [404.301346] [133/133] (622s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [404.418854] Starting subtest: short-flip-after-cursor-atomic-transitions [405.383735] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s) [406.226911] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_getfb results: parsing output: 8/ for test: i915_pm_rpm results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_userptr_blits results: parsing output: 13/ for test: kms_plane results: parsing output: 14/ for test: kms_pm_rpm results: parsing output: 15/ for test: sysfs_heartbeat_interval results: parsing output: 16/ for test: gem_ctx_engines results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: gem_ctx_persistence results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: fbdev results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: kms_psr2_sf results: parsing output: 28/ for test: syncobj_wait results: parsing output: 29/ for test: sriov_basic results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: kms_plane_scaling results: parsing output: 33/ for test: gem_mmap_gtt results: parsing output: 34/ for test: gem_exec_fence results: parsing output: 35/ for test: vgem_basic results: parsing output: 36/ for test: gem_tiled_blits results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: gem_exec_parallel results: parsing output: 41/ for test: perf_pmu results: parsing output: 42/ for test: gem_exec_schedule results: parsing output: 43/ for test: kms_cursor_crc results: parsing output: 44/ for test: kms_vrr results: parsing output: 45/ for test: gen9_exec_parse results: parsing output: 46/ for test: gem_exec_fence results: parsing output: 47/ for test: gem_userptr_blits results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_lease results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: api_intel_allocator results: parsing output: 53/ for test: kms_pm_lpsp results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: gem_exercise_blt results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_sequence results: parsing output: 60/ for test: gem_madvise results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_softpin results: parsing output: 63/ for test: gem_fenced_exec_thrash results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_chamelium_edid results: parsing output: 66/ for test: kms_plane results: parsing output: 67/ for test: kms_rotation_crc results: parsing output: 68/ for test: gem_mmap_gtt results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_pwrite_crc results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_atomic_transition results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: gem_mmap_gtt results: parsing output: 75/ for test: kms_rotation_crc results: parsing output: 76/ for test: gem_ctx_sseu results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_exec_balancer results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: gem_pxp results: parsing output: 81/ for test: gem_exec_schedule results: parsing output: 82/ for test: gem_ctx_param results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: gem_userptr_blits results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: gem_exec_params results: parsing output: 93/ for test: i915_pm_freq_api results: parsing output: 94/ for test: core_auth results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_atomic_interruptible results: parsing output: 97/ for test: kms_cursor_crc results: parsing output: 98/ for test: kms_plane_alpha_blend results: parsing output: 99/ for test: i915_query results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_color_pipeline results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_explicit_fence results: parsing output: 106/ for test: kms_atomic_transition results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_userptr_blits results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: gem_eio results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: perf results: parsing output: 119/ for test: gen3_render_mixed_blits results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: gem_unfence_active_buffers results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: device_reset results: parsing output: 124/ for test: kms_plane results: parsing output: 125/ for test: i915_selftest results: parsing output: 126/ for test: gem_render_copy results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: kms_properties results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: gem_mmap_offset results: parsing output: 132/ for test: kms_cursor_legacy Done.