[62.558615] Initializing watchdogs
[62.558660]   /dev/watchdog0
[62.573429] [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]
[62.578092] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.580128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.582034] [001/133] (960s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[62.649596] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[62.706704] [002/133] (960s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[62.833023] Starting subtest: basic-busy-flip-before-cursor-legacy
[62.834816] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[62.993075] [003/133] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[68.081795] Starting subtest: pr-primary-plane-update-sf-dmg-area
[68.085519] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[68.937012] [004/133] (954s left) kms_flip (2x-nonexisting-fb)
[69.035199] Starting subtest: 2x-nonexisting-fb
[69.046380] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[69.143707] [005/133] (954s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[69.200805] Starting subtest: x-tiled-to-vebox-yf-tiled
[69.202678] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[69.394710] [006/133] (953s left) perf_pmu (rc6-suspend)
[69.431290] Starting subtest: rc6-suspend
[91.682237] Subtest rc6-suspend: SUCCESS (8.037s)
[95.088879] [007/133] (931s left) kms_cursor_crc (cursor-size-change)
[95.178889] Starting subtest: cursor-size-change
[95.179827] Starting dynamic subtest: pipe-A-eDP-1
[96.083113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.868s)
[96.090218] Starting dynamic subtest: pipe-D-eDP-1
[97.664095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[97.665027] Subtest cursor-size-change: SUCCESS (2.398s)
[98.487588] [008/133] (927s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[98.595010] Starting subtest: extended-modeset-hang-newfb-with-reset
[98.596019] Starting dynamic subtest: pipe-A
[112.156194] Dynamic subtest pipe-A: SUCCESS (13.392s)
[112.179295] Starting dynamic subtest: pipe-D
[128.039267] Dynamic subtest pipe-D: SUCCESS (15.839s)
[128.040216] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.239s)
[128.846866] [009/133] (897s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[128.935627] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[128.937590] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[129.060868] [010/133] (897s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[129.197103] Starting subtest: dp-mst-lic-type-0-hdcp14
[129.199623] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[129.360195] [011/133] (897s left) syncobj_timeline (multi-wait-available-signaled)
[129.408769] Starting subtest: multi-wait-available-signaled
[129.410082] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[129.533727] [012/133] (896s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[129.626048] Starting subtest: fb-8bpc-vs-panel-6bpc
[129.627053] Starting dynamic subtest: pipe-A-eDP-1
[130.978770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[130.979779] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.353s)
[131.803711] [013/133] (894s left) gem_linear_blits (basic)
[132.124273] Starting subtest: basic
[132.139991] Subtest basic: SUCCESS (0.016s)
[132.308263] [014/133] (894s left) perf_pmu (interrupts-sync)
[132.379299] Starting subtest: interrupts-sync
[133.513176] Subtest interrupts-sync: SUCCESS (1.130s)
[133.649911] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[133.651566] [015/133] (892s left) gem_exec_whisper (basic-fds-forked)
[133.719188] Starting subtest: basic-fds-forked
[158.144471] Subtest basic-fds-forked: SUCCESS (24.409s)
[158.350277] [016/133] (868s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[158.742533] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[159.515648] [017/133] (867s left) kms_joiner (invalid-modeset-ultra-joiner)
[159.611034] Starting subtest: invalid-modeset-ultra-joiner
[159.612820] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[159.701749] [018/133] (866s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[159.802334] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[159.803285] Starting dynamic subtest: pipe-A-eDP-1
[160.685283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.878s)
[160.699145] Starting dynamic subtest: pipe-B-eDP-1
[162.262388] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[162.270773] Starting dynamic subtest: pipe-C-eDP-1
[163.744677] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s)
[163.753339] Starting dynamic subtest: pipe-D-eDP-1
[165.332493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.587s)
[165.333340] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.526s)
[166.585412] [019/133] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[166.689705] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[166.691490] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[166.819656] [020/133] (859s left) kms_invalid_mode (bad-htotal)
[166.922636] Starting subtest: bad-htotal
[166.923852] Starting dynamic subtest: pipe-A-eDP-1
[167.216826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[167.226800] Starting dynamic subtest: pipe-B-eDP-1
[167.227685] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[167.235804] Starting dynamic subtest: pipe-C-eDP-1
[167.236716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[167.244956] Starting dynamic subtest: pipe-D-eDP-1
[167.245848] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[167.246752] Subtest bad-htotal: SUCCESS (0.305s)
[168.016323] [021/133] (858s left) i915_drm_fdinfo (basics)
[168.056331] Starting subtest: basics
[168.057138] Subtest basics: SUCCESS (0.000s)
[168.138220] [022/133] (858s left) syncobj_timeline (invalid-signal-bad-pad)
[168.195319] Starting subtest: invalid-signal-bad-pad
[168.196353] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[168.325117] [023/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[168.416265] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[168.417841] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[168.543999] [024/133] (858s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[168.628615] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[168.630245] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[168.773203] [025/133] (858s left) kms_big_fb (linear-32bpp-rotate-180)
[168.866865] Starting subtest: linear-32bpp-rotate-180
[170.335794] Subtest linear-32bpp-rotate-180: SUCCESS (1.468s)
[170.503415] [026/133] (856s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[170.596790] Starting subtest: 2x-absolute-wf_vblank-interruptible
[170.608910] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[170.752957] [027/133] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[170.850560] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[170.852419] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[170.970446] [028/133] (856s left) i915_query (query-garbage)
[171.033535] Starting subtest: query-garbage
[171.034600] Subtest query-garbage: SUCCESS (0.000s)
[171.157086] [029/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[171.251386] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[171.253075] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[171.381487] [030/133] (855s left) gem_exec_params (dr4-dirt)
[171.446257] Starting subtest: DR4-dirt
[171.447174] Subtest DR4-dirt: SUCCESS (0.000s)
[171.579079] [031/133] (855s left) kms_plane_scaling (planes-scaler-unity-scaling)
[171.674985] Starting subtest: planes-scaler-unity-scaling
[171.675949] Starting dynamic subtest: pipe-A
[171.740349] Dynamic subtest pipe-A: SUCCESS (0.065s)
[171.755408] Starting dynamic subtest: pipe-B
[172.920359] Dynamic subtest pipe-B: SUCCESS (1.178s)
[172.930649] Starting dynamic subtest: pipe-C
[174.038168] Dynamic subtest pipe-C: SUCCESS (1.115s)
[174.053663] Starting dynamic subtest: pipe-D
[175.176280] Dynamic subtest pipe-D: SUCCESS (1.136s)
[175.177441] Subtest planes-scaler-unity-scaling: SUCCESS (3.501s)
[176.351685] [032/133] (850s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[176.448209] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[176.449987] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[176.585833] [033/133] (850s left) gem_flink_basic (flink-lifetime)
[176.641458] Starting subtest: flink-lifetime
[176.642706] Subtest flink-lifetime: SUCCESS (0.002s)
[176.756429] [034/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[176.863497] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[176.865294] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[176.995856] [035/133] (850s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[177.060866] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[177.063007] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[177.260967] [036/133] (850s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[177.359350] Starting subtest: psr-2p-pri-indfb-multidraw
[177.361075] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[177.493503] [037/133] (849s left) template (b)
[177.556318] Starting subtest: B
[177.557397] Subtest B: SUCCESS (0.000s)
[177.694765] [038/133] (849s left) gem_exec_fence (invalid-fence-array)
[178.182480] Starting subtest: invalid-fence-array
[178.184987] Subtest invalid-fence-array: SUCCESS (0.004s)
[180.193892] [039/133] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[180.302891] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[187.247327] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.939s)
[187.421178] [040/133] (839s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[187.507213] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[187.508981] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[187.649141] [041/133] (839s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[187.754280] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[188.722111] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s)
[188.897367] [042/133] (838s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[189.024662] Starting subtest: cursorA-vs-flipB-toggle
[189.026242] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[189.188707] [043/133] (838s left) syncobj_wait (wait-all-complex)
[189.238313] Starting subtest: wait-all-complex
[189.453819] Subtest wait-all-complex: SUCCESS (0.214s)
[189.548892] [044/133] (837s left) prime_self_import (export-vs-gem_close-race)
[189.584511] Starting subtest: export-vs-gem_close-race
[194.697408] Subtest export-vs-gem_close-race: SUCCESS (5.115s)
[194.802269] [045/133] (832s left) gem_fenced_exec_thrash (no-spare-fences)
[194.857608] Subtest no-spare-fences: SKIP (0.000s)
[194.942991] [046/133] (832s left) i915_hangman (gt-engine-error)
[195.007100] Starting subtest: gt-engine-error
[195.007951] Starting dynamic subtest: rcs0
[196.083979] Dynamic subtest rcs0: SUCCESS (1.073s)
[196.095334] Starting dynamic subtest: bcs0
[198.061716] Dynamic subtest bcs0: SUCCESS (1.976s)
[198.073342] Starting dynamic subtest: vcs0
[200.110677] Dynamic subtest vcs0: SUCCESS (2.047s)
[200.125002] Starting dynamic subtest: vcs1
[202.029692] Dynamic subtest vcs1: SUCCESS (1.917s)
[202.041967] Starting dynamic subtest: vecs0
[203.052960] Dynamic subtest vecs0: SUCCESS (1.021s)
[203.064588] Starting dynamic subtest: ccs0
[205.102564] Dynamic subtest ccs0: SUCCESS (2.048s)
[205.104208] Subtest gt-engine-error: SUCCESS (10.096s)
[205.267554] [047/133] (822s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[205.325711] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[205.435273] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[205.527826] [048/133] (822s left) prime_vgem (fence-write-hang)
[205.604977] Subtest fence-write-hang: SKIP (0.000s)
[205.741497] [049/133] (821s left) kms_flip_event_leak (basic)
[205.845971] Starting subtest: basic
[205.846969] Starting dynamic subtest: pipe-A-eDP-1
[206.267428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[206.277869] Starting dynamic subtest: pipe-B-eDP-1
[207.355260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[207.363901] Starting dynamic subtest: pipe-C-eDP-1
[208.466593] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[208.480218] Starting dynamic subtest: pipe-D-eDP-1
[209.610551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[209.611620] Subtest basic: SUCCESS (3.764s)
[210.490789] [050/133] (817s left) gem_render_copy (linear)
[210.546290] Starting subtest: linear
[210.547306] Starting dynamic subtest: smem
[210.589203] Dynamic subtest smem: SUCCESS (0.042s)
[210.590401] Subtest linear: SUCCESS (0.043s)
[210.791159] [051/133] (817s left) kms_atomic_transition (modeset-transition-fencing)
[210.884004] Starting subtest: modeset-transition-fencing
[210.884830] Starting dynamic subtest: 1x-outputs
[221.724658] Dynamic subtest 1x-outputs: SUCCESS (10.840s)
[221.725779] Subtest modeset-transition-fencing: SUCCESS (10.841s)
[222.600089] [052/133] (805s left) gem_ctx_isolation (dirty-create)
[222.663527] Starting subtest: dirty-create
[222.664461] Starting dynamic subtest: rcs0
[222.857771] Dynamic subtest rcs0: SUCCESS (0.195s)
[222.867947] Starting dynamic subtest: bcs0
[223.068428] Dynamic subtest bcs0: SUCCESS (0.210s)
[223.077818] Starting dynamic subtest: vcs0
[223.284880] Dynamic subtest vcs0: SUCCESS (0.216s)
[223.295693] Starting dynamic subtest: vcs1
[225.330028] Dynamic subtest vcs1: SUCCESS (2.044s)
[225.340897] Starting dynamic subtest: vecs0
[227.317365] Dynamic subtest vecs0: SUCCESS (1.986s)
[227.326169] Starting dynamic subtest: ccs0
[229.378427] Dynamic subtest ccs0: SUCCESS (2.060s)
[229.379500] Subtest dirty-create: SUCCESS (6.716s)
[229.660778] [053/133] (798s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[229.752952] Starting subtest: plane-all-modeset-transition-internal-panels
[229.753854] Starting dynamic subtest: pipe-A-eDP-1
[231.046403] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.290s)
[231.331631] Starting dynamic subtest: pipe-B-eDP-1
[232.371140] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[232.635885] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.881s)
[233.500465] [054/133] (794s left) gem_sync (basic-many-each)
[233.560862] Starting subtest: basic-many-each
[235.871738] Subtest basic-many-each: SUCCESS (2.312s)
[236.075747] [055/133] (791s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[236.171031] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[236.171946] Starting dynamic subtest: pipe-A-eDP-1
[236.181901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.190858] Starting dynamic subtest: pipe-B-eDP-1
[236.200511] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.209015] Starting dynamic subtest: pipe-C-eDP-1
[236.218239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.226520] Starting dynamic subtest: pipe-D-eDP-1
[236.235812] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.237483] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[238.465567] [056/133] (789s left) kms_flip (2x-flip-vs-modeset)
[238.562367] Starting subtest: 2x-flip-vs-modeset
[238.575639] Subtest 2x-flip-vs-modeset: SKIP (0.013s)
[238.677221] [057/133] (789s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[238.768675] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[238.769511] Starting dynamic subtest: pipe-A-eDP-1
[238.777657] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.786785] Starting dynamic subtest: pipe-B-eDP-1
[238.795157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.803822] Starting dynamic subtest: pipe-C-eDP-1
[238.812017] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.820055] Starting dynamic subtest: pipe-D-eDP-1
[238.828608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.830221] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[241.033312] [058/133] (787s left) kms_pm_rpm (modeset-lpsp)
[243.256976] Starting subtest: modeset-lpsp
[244.723857] Subtest modeset-lpsp: SUCCESS (1.469s)
[244.830433] [059/133] (783s left) syncobj_timeline (wait-zero-handles)
[244.877958] Starting subtest: wait-zero-handles
[244.878831] Subtest wait-zero-handles: SUCCESS (0.000s)
[245.012744] [060/133] (783s left) gem_lmem_evict (dontneed-evict-race)
[245.046355] Subtest dontneed-evict-race: SKIP (0.000s)
[245.091163] [061/133] (783s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[245.180217] Starting subtest: plane-lut1d-ctm3x4-lut1d
[245.194839] Starting dynamic subtest: pipe-A-eDP-1
[245.645068] Dynamic subtest pipe-A-eDP-1: FAIL (0.301s)
[246.562573] Starting dynamic subtest: pipe-B-eDP-1
[247.034498] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[247.896870] Starting dynamic subtest: pipe-C-eDP-1
[248.361906] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[249.222490] Starting dynamic subtest: pipe-D-eDP-1
[249.665728] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[249.738320] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.557s)
[250.623678] [062/133] (777s left) api_intel_bb (render)
[250.675312] Starting subtest: render
[250.676339] Starting dynamic subtest: render-none-512
[250.790482] Dynamic subtest render-none-512: SUCCESS (0.112s)
[250.801948] Starting dynamic subtest: render-none-1024
[251.198593] Dynamic subtest render-none-1024: SUCCESS (0.407s)
[251.210089] Starting dynamic subtest: render-x-512
[251.287295] Dynamic subtest render-x-512: SUCCESS (0.090s)
[251.298607] Starting dynamic subtest: render-x-1024
[251.657889] Dynamic subtest render-x-1024: SUCCESS (0.368s)
[251.669360] Starting dynamic subtest: render-y-512
[251.743700] Dynamic subtest render-y-512: SUCCESS (0.087s)
[251.754915] Starting dynamic subtest: render-y-1024
[252.113881] Dynamic subtest render-y-1024: SUCCESS (0.368s)
[252.115439] Subtest render: SUCCESS (1.436s)
[252.259134] [063/133] (775s left) perf_pmu (busy-double-start)
[252.296440] Starting subtest: busy-double-start
[252.297336] Starting dynamic subtest: rcs0
[255.893381] Dynamic subtest rcs0: FAIL (3.571s)
[255.903173] Starting dynamic subtest: bcs0
[259.445276] Dynamic subtest bcs0: SUCCESS (3.575s)
[259.458111] Starting dynamic subtest: vcs0
[263.628521] Dynamic subtest vcs0: SUCCESS (4.179s)
[263.639976] Starting dynamic subtest: vcs1
[267.594724] Dynamic subtest vcs1: SUCCESS (3.963s)
[267.606635] Starting dynamic subtest: vecs0
[271.671331] Dynamic subtest vecs0: SUCCESS (4.073s)
[271.683976] Starting dynamic subtest: ccs0
[275.279640] Dynamic subtest ccs0: SUCCESS (3.603s)
[275.280983] Subtest busy-double-start: FAIL (22.976s)
[275.405561] [064/133] (752s left) gem_lmem_swapping (verify-random-ccs)
[275.448328] Subtest verify-random-ccs: SKIP (0.000s)
[275.485274] [065/133] (752s left) kms_vrr (flip-suspend)
[275.575188] Starting subtest: flip-suspend
[275.577884] Subtest flip-suspend: SKIP (0.000s)
[275.669128] [066/133] (752s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[280.699999] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[280.702829] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[281.560319] [067/133] (746s left) gem_exec_parallel (userptr)
[281.624618] Starting subtest: userptr
[281.625446] Starting dynamic subtest: rcs0
[283.100979] Dynamic subtest rcs0: SUCCESS (1.475s)
[283.112788] Starting dynamic subtest: bcs0
[284.601867] Dynamic subtest bcs0: SUCCESS (1.499s)
[284.613884] Starting dynamic subtest: vcs0
[286.126258] Dynamic subtest vcs0: SUCCESS (1.521s)
[286.137788] Starting dynamic subtest: vcs1
[288.079701] Dynamic subtest vcs1: SUCCESS (1.951s)
[288.091102] Starting dynamic subtest: vecs0
[290.127505] Dynamic subtest vecs0: SUCCESS (2.044s)
[290.137833] Starting dynamic subtest: ccs0
[291.646875] Dynamic subtest ccs0: SUCCESS (1.518s)
[291.647894] Subtest userptr: SUCCESS (10.019s)
[291.852399] [068/133] (736s left) sw_sync (sync_multi_consumer_producer)
[291.888422] Starting subtest: sync_multi_consumer_producer
[292.185704] Subtest sync_multi_consumer_producer: SUCCESS (0.293s)
[292.263397] [069/133] (736s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[292.360348] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[292.361965] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[292.485784] [070/133] (735s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[292.589866] Starting subtest: stress-xrgb8888-ytiled
[292.591812] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[292.672417] [071/133] (735s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[292.760378] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[292.761254] Starting dynamic subtest: pipe-A-default-mode
[293.055035] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[293.056887] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.295s)
[293.898405] [072/133] (734s left) kms_psr (psr2-primary-mmap-gtt)
[293.986193] Starting subtest: psr2-primary-mmap-gtt
[293.987241] Starting dynamic subtest: eDP-1
[295.369187] Dynamic subtest eDP-1: SKIP (1.380s)
[295.371138] Subtest psr2-primary-mmap-gtt: SKIP (1.382s)
[295.540701] [073/133] (733s left) kms_psr (psr-basic)
[295.646978] Starting subtest: psr-basic
[295.647825] Starting dynamic subtest: eDP-1
[297.295849] Dynamic subtest eDP-1: SUCCESS (1.648s)
[297.296740] Subtest psr-basic: SUCCESS (1.649s)
[298.189225] [074/133] (730s left) syncobj_wait (invalid-reset-bad-pad)
[298.256050] Starting subtest: invalid-reset-bad-pad
[298.257099] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[298.382821] [075/133] (730s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[298.518687] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[298.522776] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[298.680714] [076/133] (729s left) kms_vblank (query-busy)
[298.788716] Starting subtest: query-busy
[298.789697] Starting dynamic subtest: pipe-A-eDP-1
[300.667109] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[300.682208] Starting dynamic subtest: pipe-D-eDP-1
[303.230776] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[303.231630] Subtest query-busy: SUCCESS (4.443s)
[304.052889] [077/133] (724s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[304.318245] Starting subtest: cursor-rapid-movement-512x512
[304.320082] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[304.515995] [078/133] (724s left) gem_ctx_shared (q-out-order)
[304.582500] Starting subtest: Q-out-order
[304.583535] Starting dynamic subtest: rcs0
[304.704587] Dynamic subtest rcs0: SUCCESS (0.119s)
[304.716555] Starting dynamic subtest: vcs0
[304.800325] Dynamic subtest vcs0: SUCCESS (0.096s)
[304.817850] Starting dynamic subtest: vcs1
[304.892600] Dynamic subtest vcs1: SUCCESS (0.091s)
[304.909318] Starting dynamic subtest: vecs0
[304.973813] Dynamic subtest vecs0: SUCCESS (0.081s)
[304.990515] Starting dynamic subtest: ccs0
[305.058159] Dynamic subtest ccs0: SUCCESS (0.083s)
[305.059593] Subtest Q-out-order: SUCCESS (0.475s)
[306.260606] [079/133] (722s left) prime_mmap (test_refcounting)
[306.313647] Starting subtest: test_refcounting
[306.314660] Starting dynamic subtest: test_refcounting-smem
[306.345990] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[306.347149] Subtest test_refcounting: SUCCESS (0.034s)
[306.464335] [080/133] (722s left) perf (sysctl-defaults)
[306.550399] Starting subtest: sysctl-defaults
[306.551824] Subtest sysctl-defaults: SUCCESS (0.000s)
[306.637469] [081/133] (722s left) kms_properties (get_properties-sanity-atomic)
[306.731321] Starting subtest: get_properties-sanity-atomic
[306.733632] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[306.825243] [082/133] (722s left) gem_blits (basic)
[306.891169] Starting subtest: basic
[308.289401] Subtest basic: SUCCESS (1.395s)
[308.437254] [083/133] (720s left) perf (blocking)
[308.543839] Starting subtest: blocking
[308.545120] Starting dynamic subtest: 0-rcs0
[318.559018] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[318.568610] Starting dynamic subtest: 1-vcs1
[328.580469] Dynamic subtest 1-vcs1: SUCCESS (10.024s)
[328.581434] Subtest blocking: SUCCESS (20.035s)
[328.635639] [084/133] (700s left) gem_exec_balancer (full-late-pulse)
[328.699958] Starting subtest: full-late-pulse
[332.988352] Subtest full-late-pulse: SUCCESS (4.290s)
[333.337542] [085/133] (695s left) gem_exec_balancer (parallel-contexts)
[333.583761] Starting subtest: parallel-contexts
[337.409167] Subtest parallel-contexts: SUCCESS (3.827s)
[337.539455] [086/133] (691s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[337.604960] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[337.606012] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[337.746156] [087/133] (691s left) kms_setmode (basic)
[337.804135] Starting subtest: basic
[338.128519] Starting dynamic subtest: pipe-A-eDP-1
[340.245796] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.114s)
[340.587590] Starting dynamic subtest: pipe-B-eDP-1
[342.669533] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s)
[342.973585] Subtest basic: SUCCESS (5.170s)
[343.840941] [088/133] (685s left) device_reset (unbind-cold-reset-rebind)
[343.889401] Starting subtest: unbind-cold-reset-rebind
[343.891321] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[343.981438] [089/133] (685s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[344.062272] Starting subtest: crc-primary-basic-yf-tiled-ccs
[344.063174] Starting dynamic subtest: pipe-A-eDP-1
[344.071463] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.081072] Starting dynamic subtest: pipe-B-eDP-1
[344.089642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.099097] Starting dynamic subtest: pipe-C-eDP-1
[344.107417] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.116505] Starting dynamic subtest: pipe-D-eDP-1
[344.125390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.127054] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[346.394939] [090/133] (682s left) vgem_basic (dmabuf-export)
[346.437759] Starting subtest: dmabuf-export
[346.470708] Subtest dmabuf-export: SUCCESS (0.033s)
[346.623503] [091/133] (682s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[346.680333] Starting subtest: etime-single-wait-all-for-submit-submitted
[346.788431] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[346.921431] [092/133] (682s left) kms_psr (fbc-pr-primary-blt)
[347.017598] Starting subtest: fbc-pr-primary-blt
[347.019485] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[347.114822] [093/133] (682s left) gem_mmap_wc (bad-object)
[347.177207] Subtest bad-object: SKIP (0.000s)
[347.238895] [094/133] (682s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[347.348126] Starting subtest: x-tiled-64bpp-rotate-0
[349.083023] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.736s)
[349.293159] [095/133] (680s left) kms_cursor_crc (cursor-sliding-32x10)
[349.450376] Starting subtest: cursor-sliding-32x10
[349.490798] Subtest cursor-sliding-32x10: SKIP (0.038s)
[349.802444] [096/133] (679s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[349.886362] Starting subtest: disable-crc-after-crtc
[349.887249] Starting dynamic subtest: pipe-A-eDP-1
[351.542042] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.655s)
[351.551337] Starting dynamic subtest: pipe-B-eDP-1
[353.916258] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[353.926016] Starting dynamic subtest: pipe-C-eDP-1
[356.131774] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.215s)
[356.141397] Starting dynamic subtest: pipe-D-eDP-1
[358.397675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.265s)
[358.398507] Subtest disable-crc-after-crtc: SUCCESS (8.513s)
[359.249955] [097/133] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[359.362556] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[366.739437] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.378s)
[366.920173] [098/133] (662s left) kms_psr (fbc-psr2-primary-page-flip)
[367.019323] Starting subtest: fbc-psr2-primary-page-flip
[367.020201] Starting dynamic subtest: eDP-1
[367.021996] Dynamic subtest eDP-1: SKIP (0.000s)
[367.023623] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[367.111042] [099/133] (662s left) kms_psr (pr-cursor-plane-move)
[367.211128] Starting subtest: pr-cursor-plane-move
[367.212887] Subtest pr-cursor-plane-move: SKIP (0.000s)
[367.300030] [100/133] (662s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[367.405986] Starting subtest: 4-tiled-addfb-size-offset-overflow
[367.406977] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[367.544313] [101/133] (662s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[367.650425] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[367.652233] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.779026] [102/133] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[367.878715] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[367.880486] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[368.017749] [103/133] (661s left) gem_exec_schedule (smoketest)
[368.208842] Starting subtest: smoketest
[368.210683] Starting dynamic subtest: rcs0
[373.740259] Dynamic subtest rcs0: SUCCESS (5.507s)
[373.755638] Starting dynamic subtest: bcs0
[379.270631] Dynamic subtest bcs0: SUCCESS (5.531s)
[379.280744] Starting dynamic subtest: vcs0
[384.784988] Dynamic subtest vcs0: SUCCESS (5.512s)
[384.795839] Starting dynamic subtest: vcs1
[390.295739] Dynamic subtest vcs1: SUCCESS (5.509s)
[390.307010] Starting dynamic subtest: vecs0
[395.802585] Dynamic subtest vecs0: SUCCESS (5.499s)
[395.816129] Starting dynamic subtest: ccs0
[401.304535] Dynamic subtest ccs0: SUCCESS (5.508s)
[401.305451] Subtest smoketest: SUCCESS (33.075s)
[401.492114] [104/133] (628s left) gem_ctx_bad_destroy (invalid-default-ctx)
[401.542315] Starting subtest: invalid-default-ctx
[401.543546] Subtest invalid-default-ctx: SUCCESS (0.000s)
[401.636609] [105/133] (628s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[401.745542] Starting subtest: short-flip-after-cursor-atomic-transitions
[402.701912] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.956s)
[403.597959] [106/133] (626s left) gen9_exec_parse (batch-without-end)
[403.651309] Subtest batch-without-end: SKIP (0.000s)
[403.728375] [107/133] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[403.821395] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[410.478036] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.657s)
[410.638557] [108/133] (619s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[410.742699] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[414.830137] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.087s)
[416.032979] [109/133] (613s left) gem_wait (write-busy)
[416.099397] Starting subtest: write-busy
[416.100375] Starting dynamic subtest: all-engines
[416.740546] Dynamic subtest all-engines: SUCCESS (0.640s)
[416.758640] Starting dynamic subtest: rcs0
[417.297029] Dynamic subtest rcs0: SUCCESS (0.554s)
[417.313187] Starting dynamic subtest: bcs0
[417.850431] Dynamic subtest bcs0: SUCCESS (0.552s)
[417.866345] Starting dynamic subtest: vcs0
[419.087145] Dynamic subtest vcs0: SUCCESS (1.233s)
[419.103754] Starting dynamic subtest: vcs1
[421.135592] Dynamic subtest vcs1: SUCCESS (2.045s)
[421.151856] Starting dynamic subtest: vecs0
[423.118872] Dynamic subtest vecs0: SUCCESS (1.980s)
[423.135872] Starting dynamic subtest: ccs0
[423.667710] Dynamic subtest ccs0: SUCCESS (0.549s)
[423.668779] Subtest write-busy: SUCCESS (7.568s)
[423.879754] [110/133] (605s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[423.983775] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[423.985616] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[424.096802] [111/133] (605s left) kms_plane_scaling (invalid-parameters)
[424.192651] Starting subtest: invalid-parameters
[424.193662] Starting dynamic subtest: less-than-1-height-src
[424.204903] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s)
[424.214406] Starting dynamic subtest: less-than-1-width-src
[424.217021] Dynamic subtest less-than-1-width-src: SUCCESS (0.011s)
[424.217929] Subtest invalid-parameters: SUCCESS (0.025s)
[424.334427] [112/133] (605s left) kms_chamelium_edid (hdmi-mode-timings)
[424.710474] Subtest hdmi-mode-timings: SKIP (0.000s)
[425.514752] [113/133] (604s left) gem_tiled_swapping (non-threaded)
[425.573265] Subtest non-threaded: SKIP (0.000s)
[425.654369] [114/133] (604s left) gem_mmap_offset (clear)
[425.757717] Starting subtest: clear
[425.759114] Starting dynamic subtest: smem0
[449.709662] Dynamic subtest smem0: SUCCESS (23.946s)
[449.710562] Subtest clear: SUCCESS (23.947s)
[449.867083] [115/133] (580s left) kms_flip (wf_vblank-ts-check)
[450.000380] Starting subtest: wf_vblank-ts-check
[450.001542] Starting dynamic subtest: A-eDP1
[458.989459] Dynamic subtest A-eDP1: SUCCESS (8.986s)
[459.000508] Starting dynamic subtest: B-eDP1
[467.926312] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[467.937079] Starting dynamic subtest: C-eDP1
[476.851378] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[476.861129] Starting dynamic subtest: D-eDP1
[485.776889] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[485.779548] Subtest wf_vblank-ts-check: SUCCESS (35.772s)
[487.025150] [116/133] (543s left) gem_create (busy-create)
[487.090412] Starting subtest: busy-create
[487.091516] Starting dynamic subtest: smem0
[521.079320] Dynamic subtest smem0: SUCCESS (33.976s)
[521.080856] Subtest busy-create: SUCCESS (33.978s)
[521.285366] [117/133] (508s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[526.258750] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[526.260760] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[527.132545] [118/133] (503s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[527.239799] Starting subtest: y-tiled-16bpp-rotate-90
[527.241765] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[527.374748] [119/133] (502s left) kms_flip (flip-vs-wf_vblank-interruptible)
[527.469376] Starting subtest: flip-vs-wf_vblank-interruptible
[527.471660] Starting dynamic subtest: A-eDP1
[529.361997] Dynamic subtest A-eDP1: SUCCESS (1.890s)
[529.374906] Starting dynamic subtest: B-eDP1
[531.300134] Dynamic subtest B-eDP1: SUCCESS (1.936s)
[531.311220] Starting dynamic subtest: C-eDP1
[533.227818] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[533.249149] Starting dynamic subtest: D-eDP1
[535.171395] Dynamic subtest D-eDP1: SUCCESS (1.940s)
[535.175864] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.704s)
[536.406854] [120/133] (493s left) perf (invalid-oa-format-id)
[536.527664] Starting subtest: invalid-oa-format-id
[536.536443] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[536.573596] [121/133] (493s left) kms_cursor_crc (cursor-offscreen-32x32)
[536.721331] Starting subtest: cursor-offscreen-32x32
[536.761407] Subtest cursor-offscreen-32x32: SKIP (0.038s)
[537.097545] [122/133] (493s left) syncobj_timeline (wait-all-delayed-signal)
[537.154902] Starting subtest: wait-all-delayed-signal
[537.257917] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[537.352522] [123/133] (492s left) gem_fence_thrash (bo-write-verify-threaded-y)
[537.376616] Starting subtest: bo-write-verify-threaded-y
[537.390814] Subtest bo-write-verify-threaded-y: SKIP (0.013s)
[537.449592] [124/133] (492s left) gem_ctx_persistence (heartbeat-many)
[537.506933] Starting subtest: heartbeat-many
[537.508993] Subtest heartbeat-many: SKIP (0.000s)
[537.636897] [125/133] (492s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[537.726756] Starting subtest: plane-upscale-20x20-with-rotation
[537.727579] Starting dynamic subtest: pipe-A
[537.955164] Dynamic subtest pipe-A: SUCCESS (0.227s)
[537.966558] Starting dynamic subtest: pipe-B
[539.272621] Dynamic subtest pipe-B: SUCCESS (1.315s)
[539.282292] Starting dynamic subtest: pipe-C
[540.604687] Dynamic subtest pipe-C: SUCCESS (1.331s)
[540.616579] Starting dynamic subtest: pipe-D
[541.949615] Dynamic subtest pipe-D: SUCCESS (1.343s)
[541.952535] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.223s)
[543.142896] [126/133] (487s left) kms_addfb_basic (legacy-format)
[543.201896] Starting subtest: legacy-format
[543.228540] Subtest legacy-format: SUCCESS (0.026s)
[543.403499] [127/133] (487s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[543.491353] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[543.492294] Starting dynamic subtest: pipe-A-eDP-1
[543.501386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.511102] Starting dynamic subtest: pipe-B-eDP-1
[543.520144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.529350] Starting dynamic subtest: pipe-C-eDP-1
[543.538611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.547808] Starting dynamic subtest: pipe-D-eDP-1
[543.557184] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[543.558803] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[545.785280] [128/133] (484s left) gem_exec_schedule (preemptive-hang)
[545.961541] Starting subtest: preemptive-hang
[545.962551] Starting dynamic subtest: rcs0
[555.260217] Dynamic subtest rcs0: SUCCESS (9.298s)
[555.269125] Starting dynamic subtest: bcs0
[564.327489] Dynamic subtest bcs0: SUCCESS (9.063s)
[564.339481] Starting dynamic subtest: vcs0
[573.238141] Dynamic subtest vcs0: SUCCESS (8.907s)
[573.247295] Starting dynamic subtest: vcs1
[582.231594] Dynamic subtest vcs1: SUCCESS (8.997s)
[582.243095] Starting dynamic subtest: vecs0
[591.300385] Dynamic subtest vecs0: SUCCESS (9.076s)
[591.312317] Starting dynamic subtest: ccs0
[600.273613] Dynamic subtest ccs0: SUCCESS (8.974s)
[600.274899] Subtest preemptive-hang: SUCCESS (54.324s)
[600.547885] [129/133] (429s left) kms_sequence (queue-idle)
[600.641058] Starting subtest: queue-idle
[600.642025] Starting dynamic subtest: pipe-A-eDP-1
[602.439509] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[602.448799] Starting dynamic subtest: pipe-B-eDP-1
[604.926154] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.485s)
[604.936841] Starting dynamic subtest: pipe-C-eDP-1
[607.426020] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.501s)
[607.435661] Starting dynamic subtest: pipe-D-eDP-1
[609.844413] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s)
[609.845401] Subtest queue-idle: SUCCESS (9.208s)
[610.676051] [130/133] (419s left) i915_pm_rpm (gem-execbuf)
[612.207026] Starting subtest: gem-execbuf
[612.207960] Starting dynamic subtest: smem0
[614.439806] Dynamic subtest smem0: SUCCESS (2.234s)
[614.440686] Subtest gem-execbuf: SUCCESS (2.236s)
[614.546847] [131/133] (416s left) gem_softpin (32b-excludes-last-page)
[614.618106] Starting subtest: 32b-excludes-last-page
[614.621688] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[614.781636] [132/133] (415s left) i915_query (query-topology-garbage-items)
[614.839296] Starting subtest: query-topology-garbage-items
[614.840228] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[614.975084] [133/133] (415s left) kms_fb_coherency (memset-crc)
[615.066971] Starting subtest: memset-crc
[615.067792] Starting dynamic subtest: mmap-offset-wc
[615.431862] Dynamic subtest mmap-offset-wc: SUCCESS (0.365s)
[615.734523] Starting dynamic subtest: mmap-offset-uc
[621.730281] Dynamic subtest mmap-offset-uc: SUCCESS (6.007s)
[622.010608] Subtest memset-crc: SUCCESS (6.946s)
[622.873623] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_b_c_ivb
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_busy
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_dither
results: parsing output: 12/ for test: gem_linear_blits
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_flink_basic
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: template
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: gem_fenced_exec_thrash
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_flip_event_leak
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: gem_ctx_isolation
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: gem_sync
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_lmem_evict
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: kms_vrr
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_exec_parallel
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_pipe_stress
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_ctx_shared
results: parsing output: 78/ for test: prime_mmap
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_properties
results: parsing output: 81/ for test: gem_blits
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_setmode
results: parsing output: 87/ for test: device_reset
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_ctx_bad_destroy
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_wait
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_chamelium_edid
results: parsing output: 112/ for test: gem_tiled_swapping
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_sequence
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: i915_query
results: parsing output: 132/ for test: kms_fb_coherency
Done.