[94.970532] Initializing watchdogs [94.970579] /dev/watchdog0 [94.986190] [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] [94.990634] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [94.992969] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [94.996200] [001/131] (960s left) kms_cursor_legacy (torture-bo) [95.135207] Starting subtest: torture-bo [95.137475] Starting dynamic subtest: pipe-A [100.967598] Dynamic subtest pipe-A: SUCCESS (5.815s) [100.979084] Starting dynamic subtest: pipe-B [107.208594] Dynamic subtest pipe-B: SUCCESS (6.235s) [107.219610] Starting dynamic subtest: pipe-C [113.224908] Dynamic subtest pipe-C: SUCCESS (6.012s) [113.233560] Starting dynamic subtest: pipe-D [119.141828] Dynamic subtest pipe-D: SUCCESS (5.913s) [119.151682] Starting dynamic subtest: all-pipes [125.589609] Dynamic subtest all-pipes: SUCCESS (6.446s) [125.597753] Subtest torture-bo: SUCCESS (30.422s) [125.742549] [002/131] (929s left) gem_exec_reloc (basic-cpu) [125.800669] Subtest basic-cpu: SKIP (0.000s) [125.896516] [003/131] (929s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [125.952453] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [126.057658] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [126.134302] [004/131] (929s left) gem_mmap_gtt (cpuset-medium-copy-odd) [126.188963] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [126.263624] [005/131] (929s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [126.376313] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [126.380228] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [126.469787] [006/131] (929s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [126.553923] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [126.571910] Starting dynamic subtest: pipe-A-eDP-1 [126.594221] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [126.603411] Starting dynamic subtest: pipe-B-eDP-1 [126.625462] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [126.632410] Starting dynamic subtest: pipe-C-eDP-1 [126.654770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [126.662484] Starting dynamic subtest: pipe-D-eDP-1 [126.683131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [126.687060] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s) [128.688270] [007/131] (927s left) gem_wait (invalid-flags) [128.744575] Starting subtest: invalid-flags [128.746590] Subtest invalid-flags: SUCCESS (0.000s) [128.944102] [008/131] (926s left) gem_exec_reloc (basic-concurrent16) [129.004950] Subtest basic-concurrent16: SKIP (0.000s) [129.065112] [009/131] (926s left) gem_exec_fence (invalid-timeline-fence-array) [129.604579] Starting subtest: invalid-timeline-fence-array [129.609314] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [130.983157] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [130.986207] [010/131] (924s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [131.082906] Starting subtest: primary-y-tiled-reflect-x-0 [131.145557] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s) [131.248069] [011/131] (924s left) kms_atomic (atomic-plane-damage) [131.349643] Starting subtest: atomic-plane-damage [131.434753] Starting dynamic subtest: pipe-A-eDP-1 [132.052188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [132.054467] Subtest atomic-plane-damage: SUCCESS (0.700s) [132.920917] [012/131] (922s left) kms_chamelium_edid (dp-edid-change-during-suspend) [133.314084] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [134.145196] [013/131] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [134.256342] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [134.260783] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [134.367373] [014/131] (921s left) kms_cursor_crc (cursor-sliding-128x42) [134.573061] Starting subtest: cursor-sliding-128x42 [134.618652] Subtest cursor-sliding-128x42: SKIP (0.040s) [134.810363] [015/131] (921s left) kms_psr (fbc-pr-cursor-plane-onoff) [134.908213] Starting subtest: fbc-pr-cursor-plane-onoff [134.912700] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [134.982206] [016/131] (921s left) gem_exec_whisper (basic-queues-forked) [135.045990] Starting subtest: basic-queues-forked [157.980321] Subtest basic-queues-forked: SUCCESS (22.927s) [158.158222] [017/131] (897s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [158.292942] Starting subtest: cursorB-vs-flipA-varying-size [158.297505] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [158.460995] [018/131] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [158.559433] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [165.507313] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.950s) [165.617086] [019/131] (890s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [170.624293] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [170.626188] Starting dynamic subtest: pipe-A-eDP-1 [171.407153] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s) [171.415141] Starting dynamic subtest: pipe-B-eDP-1 [172.531211] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [172.535522] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.907s) [173.720533] [020/131] (882s left) kms_flip (2x-plain-flip-ts-check-interruptible) [173.827793] Starting subtest: 2x-plain-flip-ts-check-interruptible [173.839688] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [173.913238] [021/131] (882s left) kms_atomic_interruptible (legacy-setmode) [174.008809] Starting subtest: legacy-setmode [174.010976] Starting dynamic subtest: pipe-A-eDP-1 [180.860746] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.853s) [180.863339] Subtest legacy-setmode: SUCCESS (6.853s) [181.657522] [022/131] (874s left) gem_ppgtt (shrink-vs-evict-pinned) [181.730524] Starting subtest: shrink-vs-evict-pinned [188.920685] Subtest shrink-vs-evict-pinned: SUCCESS (7.188s) [189.023344] [023/131] (867s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [189.120634] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [189.122993] Starting dynamic subtest: pipe-A-eDP-1 [190.003901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s) [190.013826] Starting dynamic subtest: pipe-B-eDP-1 [191.590479] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.586s) [191.600070] Starting dynamic subtest: pipe-C-eDP-1 [193.075050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s) [193.084790] Starting dynamic subtest: pipe-D-eDP-1 [194.584390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s) [194.586339] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.452s) [195.750275] [024/131] (860s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [195.849062] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [195.851297] Starting dynamic subtest: pipe-A-default-mode [198.588711] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s) [198.590642] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.737s) [199.433131] [025/131] (857s left) gem_ctx_param (set-priority-not-supported) [199.489039] Starting subtest: set-priority-not-supported [199.493380] Subtest set-priority-not-supported: SKIP (0.000s) [199.562514] [026/131] (856s left) kms_getfb (getfb-addfb-different-handles) [199.656367] Starting subtest: getfb-addfb-different-handles [199.658658] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [199.757604] [027/131] (856s left) gem_exec_reloc (basic-write-gtt-noreloc) [199.812433] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [199.896669] [028/131] (856s left) kms_plane (pixel-format) [199.993061] Starting subtest: pixel-format [200.031613] Starting dynamic subtest: pipe-A-plane-0 [204.822870] Dynamic subtest pipe-A-plane-0: SUCCESS (4.789s) [204.833232] Starting dynamic subtest: pipe-A-plane-3 [207.154233] Dynamic subtest pipe-A-plane-3: SUCCESS (2.333s) [207.162372] Starting dynamic subtest: pipe-A-plane-5 [207.353202] Dynamic subtest pipe-A-plane-5: SUCCESS (0.199s) [208.411967] Starting dynamic subtest: pipe-B-plane-0 [213.226495] Dynamic subtest pipe-B-plane-0: SUCCESS (4.822s) [213.236596] Starting dynamic subtest: pipe-B-plane-3 [215.459767] Dynamic subtest pipe-B-plane-3: SUCCESS (2.233s) [215.468179] Starting dynamic subtest: pipe-B-plane-5 [215.637687] Dynamic subtest pipe-B-plane-5: SUCCESS (0.177s) [215.945576] Subtest pixel-format: SUCCESS (15.951s) [216.771302] [029/131] (839s left) gem_lmem_swapping (parallel-multi) [216.814530] Subtest parallel-multi: SKIP (0.000s) [216.862138] [030/131] (839s left) i915_query (query-topology-known-pci-ids) [216.913308] Starting subtest: query-topology-known-pci-ids [216.918110] Subtest query-topology-known-pci-ids: SKIP (0.000s) [217.006880] [031/131] (839s left) kms_chamelium_frames (hdmi-crc-fast) [217.383449] Subtest hdmi-crc-fast: SKIP (0.000s) [218.176228] [032/131] (838s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [218.285667] Starting subtest: yf-tiled-16bpp-rotate-90 [218.290399] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [218.390025] [033/131] (838s left) sw_sync (sync_merge_invalid) [218.419449] Starting subtest: sync_merge_invalid [218.452020] Subtest sync_merge_invalid: SUCCESS (0.031s) [218.529352] [034/131] (838s left) kms_pm_rpm (dpms-lpsp) [220.061928] Starting subtest: dpms-lpsp [220.764307] Subtest dpms-lpsp: SUCCESS (0.702s) [220.861770] [035/131] (836s left) perf_pmu (busy-double-start) [220.896982] Starting subtest: busy-double-start [220.899483] Starting dynamic subtest: rcs0 [224.536961] Dynamic subtest rcs0: FAIL (3.587s) [224.547030] Starting dynamic subtest: bcs0 [228.087045] Dynamic subtest bcs0: SUCCESS (3.604s) [228.096874] Starting dynamic subtest: vcs0 [232.449721] Dynamic subtest vcs0: SUCCESS (4.361s) [232.460764] Starting dynamic subtest: vcs1 [236.478880] Dynamic subtest vcs1: SUCCESS (4.027s) [236.490076] Starting dynamic subtest: vecs0 [240.409904] Dynamic subtest vecs0: SUCCESS (3.929s) [240.419341] Starting dynamic subtest: ccs0 [244.047879] Dynamic subtest ccs0: FAIL (3.566s) [244.049817] Subtest busy-double-start: FAIL (23.081s) [244.088643] [036/131] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [244.193630] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [250.648390] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.457s) [250.770244] [037/131] (806s left) gem_ctx_persistence (engines-cleanup) [250.831113] Starting subtest: engines-cleanup [250.833529] Starting dynamic subtest: rcs0 [250.918475] Dynamic subtest rcs0: SUCCESS (0.087s) [250.929628] Starting dynamic subtest: bcs0 [250.972613] Dynamic subtest bcs0: SUCCESS (0.053s) [250.982885] Starting dynamic subtest: vcs0 [251.013441] Dynamic subtest vcs0: SUCCESS (0.040s) [251.022536] Starting dynamic subtest: vcs1 [251.069758] Dynamic subtest vcs1: SUCCESS (0.055s) [251.080619] Starting dynamic subtest: vecs0 [251.123716] Dynamic subtest vecs0: SUCCESS (0.053s) [251.134254] Starting dynamic subtest: ccs0 [251.193302] Dynamic subtest ccs0: SUCCESS (0.067s) [251.195932] Subtest engines-cleanup: SUCCESS (0.362s) [251.271683] [038/131] (805s left) prime_mmap_coherency (write) [251.322677] Starting subtest: write [256.707811] Subtest write: SUCCESS (5.383s) [257.123556] [039/131] (799s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [257.184027] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [257.188400] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [257.366069] [040/131] (799s left) gem_userptr_blits (stress-purge) [257.428913] Starting subtest: stress-purge [262.825084] Subtest stress-purge: SUCCESS (5.400s) [262.992304] [041/131] (794s left) syncobj_timeline (etime-single-wait-all-submitted) [263.083293] Starting subtest: etime-single-wait-all-submitted [263.193094] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s) [263.294914] [042/131] (793s left) sysfs_preempt_timeout (timeout) [263.369736] Starting subtest: timeout [263.372082] Starting dynamic subtest: vecs0 [272.938337] Dynamic subtest vecs0: SUCCESS (9.564s) [272.953068] Starting dynamic subtest: ccs0 [274.317519] Dynamic subtest ccs0: SUCCESS (1.379s) [274.329292] Starting dynamic subtest: vcs0 [283.921835] Dynamic subtest vcs0: SUCCESS (9.601s) [283.931762] Starting dynamic subtest: bcs0 [285.282507] Dynamic subtest bcs0: SUCCESS (1.361s) [285.291884] Starting dynamic subtest: rcs0 [286.625322] Dynamic subtest rcs0: SUCCESS (1.341s) [286.637574] Starting dynamic subtest: vcs1 [295.906571] Dynamic subtest vcs1: SUCCESS (9.279s) [295.909241] Subtest timeout: SUCCESS (32.534s) [296.003192] [043/131] (761s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [296.102770] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [303.071102] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.971s) [303.206473] [044/131] (754s left) kms_big_fb (y-tiled-addfb) [303.317822] Starting subtest: y-tiled-addfb [303.322160] Subtest y-tiled-addfb: SKIP (0.000s) [303.421961] [045/131] (753s left) i915_module_load (reload) [303.453110] Starting subtest: reload [308.354671] Subtest reload: SUCCESS (4.901s) [308.394121] [046/131] (748s left) gem_exec_balancer (parallel-bb-first) [310.080266] Starting subtest: parallel-bb-first [310.989866] Subtest parallel-bb-first: SUCCESS (0.908s) [311.934254] [047/131] (745s left) gen9_exec_parse (bb-start-cmd) [311.993790] Subtest bb-start-cmd: SKIP (0.000s) [312.084133] [048/131] (745s left) gem_exec_parallel (basic) [312.147084] Starting subtest: basic [312.149415] Starting dynamic subtest: rcs0 [313.712566] Dynamic subtest rcs0: SUCCESS (1.564s) [313.720787] Starting dynamic subtest: bcs0 [315.226350] Dynamic subtest bcs0: SUCCESS (1.512s) [315.234704] Starting dynamic subtest: vcs0 [316.904053] Dynamic subtest vcs0: SUCCESS (1.675s) [316.912288] Starting dynamic subtest: vcs1 [318.932201] Dynamic subtest vcs1: SUCCESS (2.025s) [318.943170] Starting dynamic subtest: vecs0 [320.852594] Dynamic subtest vecs0: SUCCESS (1.918s) [320.863847] Starting dynamic subtest: ccs0 [322.330424] Dynamic subtest ccs0: SUCCESS (1.477s) [322.332720] Subtest basic: SUCCESS (10.183s) [322.517128] [049/131] (734s left) kms_flip (2x-wf_vblank-ts-check) [322.634440] Starting subtest: 2x-wf_vblank-ts-check [322.645754] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [322.723908] [050/131] (734s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [322.824124] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [322.828044] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [322.925956] [051/131] (734s left) kms_psr (fbc-psr2-primary-render) [323.027076] Starting subtest: fbc-psr2-primary-render [323.028940] Starting dynamic subtest: eDP-1 [323.033039] Dynamic subtest eDP-1: SKIP (0.000s) [323.037113] Subtest fbc-psr2-primary-render: SKIP (0.001s) [323.098415] [052/131] (734s left) syncobj_timeline (single-wait-signaled) [323.151864] Starting subtest: single-wait-signaled [323.154066] Subtest single-wait-signaled: SUCCESS (0.000s) [323.244334] [053/131] (734s left) gem_exec_reloc (basic-gtt-noreloc) [323.293639] Subtest basic-gtt-noreloc: SKIP (0.000s) [323.369637] [054/131] (734s left) kms_pm_backlight (basic-brightness) [323.463218] Starting subtest: basic-brightness [323.557535] Starting dynamic subtest: eDP-1 [324.085662] Dynamic subtest eDP-1: SUCCESS (0.525s) [324.087884] Subtest basic-brightness: SUCCESS (0.622s) [324.922998] [055/131] (732s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [325.018825] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [325.023327] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [325.118982] [056/131] (732s left) kms_joiner (invalid-modeset-big-joiner) [325.218572] Starting subtest: invalid-modeset-big-joiner [325.222835] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [325.285883] [057/131] (732s left) kms_pm_rpm (modeset-stress-extra-wait) [327.135391] Starting subtest: modeset-stress-extra-wait [381.331072] Subtest modeset-stress-extra-wait: SUCCESS (54.191s) [381.420420] [058/131] (676s left) perf_pmu (all-busy-check-all) [381.462346] Starting subtest: all-busy-check-all [382.934524] Subtest all-busy-check-all: SUCCESS (1.470s) [383.039457] [059/131] (674s left) kms_dsc (dsc-with-output-formats) [383.145297] Starting subtest: dsc-with-output-formats [383.168149] Subtest dsc-with-output-formats: SKIP (0.000s) [383.215604] [060/131] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [383.320589] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [383.324711] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [383.434875] [061/131] (674s left) syncobj_basic (bad-destroy-pad) [383.489693] Starting subtest: bad-destroy-pad [383.492079] Subtest bad-destroy-pad: SUCCESS (0.000s) [383.598930] [062/131] (674s left) kms_plane_scaling (planes-downscale-factor-0-75) [383.690131] Starting subtest: planes-downscale-factor-0-75 [383.692403] Starting dynamic subtest: pipe-A [383.713017] Dynamic subtest pipe-A: SKIP (0.017s) [383.721975] Starting dynamic subtest: pipe-B [383.748076] Dynamic subtest pipe-B: SKIP (0.034s) [383.756623] Starting dynamic subtest: pipe-C [383.782498] Dynamic subtest pipe-C: SKIP (0.034s) [383.790762] Starting dynamic subtest: pipe-D [383.816169] Dynamic subtest pipe-D: SKIP (0.034s) [383.819905] Subtest planes-downscale-factor-0-75: SKIP (0.121s) [383.924072] [063/131] (674s left) gem_exec_params (invalid-batch-start-offset) [383.980904] Starting subtest: invalid-batch-start-offset [383.985862] Subtest invalid-batch-start-offset: SUCCESS (0.003s) [384.117413] [064/131] (673s left) sw_sync (sync_multi_timeline_wait) [384.152669] Starting subtest: sync_multi_timeline_wait [384.154565] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [384.211537] [065/131] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [384.314180] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [387.876902] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.565s) [389.073771] [066/131] (669s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [389.177205] Starting subtest: invalidate-primary-flip-overlay [399.945624] Subtest invalidate-primary-flip-overlay: SUCCESS (10.770s) [400.079384] [067/131] (658s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [400.197341] Starting subtest: cursorA-vs-flipB-varying-size [400.201089] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [400.337655] [068/131] (657s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [400.430266] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [401.710441] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.279s) [401.868921] [069/131] (656s left) kms_draw_crc (draw-method-mmap-wc) [401.968797] Starting subtest: draw-method-mmap-wc [401.970702] Starting dynamic subtest: xrgb8888-untiled [402.196568] Dynamic subtest xrgb8888-untiled: SUCCESS (0.230s) [402.204961] Starting dynamic subtest: rgb565-untiled [402.441141] Dynamic subtest rgb565-untiled: SUCCESS (0.244s) [402.449372] Starting dynamic subtest: xrgb2101010-untiled [402.663194] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [402.672774] Starting dynamic subtest: xbgr16161616f-untiled [402.896816] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [402.906516] Starting dynamic subtest: xrgb8888-xtiled [403.029834] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [403.038683] Starting dynamic subtest: rgb565-xtiled [403.163474] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [403.172777] Starting dynamic subtest: xrgb2101010-xtiled [403.286139] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [403.294611] Starting dynamic subtest: xbgr16161616f-xtiled [403.430409] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s) [403.439196] Starting dynamic subtest: xrgb8888-4tiled [403.586042] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s) [403.600723] Starting dynamic subtest: rgb565-4tiled [403.730250] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [403.738995] Starting dynamic subtest: xrgb2101010-4tiled [403.874636] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s) [403.884114] Starting dynamic subtest: xbgr16161616f-4tiled [404.053204] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [404.055254] Subtest draw-method-mmap-wc: SUCCESS (2.086s) [404.179524] [070/131] (654s left) syncobj_wait (single-wait-for-submit-signaled) [404.226034] Starting subtest: single-wait-for-submit-signaled [404.228050] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [404.338865] [071/131] (654s left) kms_vblank (query-forked) [404.439557] Starting subtest: query-forked [404.441514] Starting dynamic subtest: pipe-A-eDP-1 [406.266229] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s) [406.280440] Starting dynamic subtest: pipe-D-eDP-1 [408.751772] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.482s) [408.754321] Subtest query-forked: SUCCESS (4.310s) [409.599051] [072/131] (648s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [414.677719] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [414.680249] Starting dynamic subtest: pipe-A-eDP-1 [426.388855] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.709s) [426.398697] Starting dynamic subtest: pipe-B-eDP-1 [438.110042] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.718s) [438.112708] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.431s) [438.967481] [073/131] (619s left) api_intel_bb (simple-bb-ctx) [439.028406] Starting subtest: simple-bb-ctx [439.034562] Subtest simple-bb-ctx: SUCCESS (0.008s) [439.157811] [074/131] (619s left) gem_exec_schedule (preempt-self) [439.225239] Starting subtest: preempt-self [439.227197] Starting dynamic subtest: rcs0 [439.237578] Dynamic subtest rcs0: SUCCESS (0.019s) [439.248201] Starting dynamic subtest: bcs0 [439.254317] Dynamic subtest bcs0: SUCCESS (0.016s) [439.263167] Starting dynamic subtest: vcs0 [439.272422] Dynamic subtest vcs0: SUCCESS (0.018s) [439.281242] Starting dynamic subtest: vcs1 [439.293143] Dynamic subtest vcs1: SUCCESS (0.020s) [439.302458] Starting dynamic subtest: vecs0 [439.312930] Dynamic subtest vecs0: SUCCESS (0.019s) [439.323836] Starting dynamic subtest: ccs0 [439.332339] Dynamic subtest ccs0: SUCCESS (0.019s) [439.334501] Subtest preempt-self: SUCCESS (0.114s) [441.033475] [075/131] (617s left) kms_psr (psr2-primary-render) [441.136171] Starting subtest: psr2-primary-render [441.138459] Starting dynamic subtest: eDP-1 [442.852879] Dynamic subtest eDP-1: SUCCESS (1.719s) [442.855389] Subtest psr2-primary-render: SUCCESS (1.720s) [443.717554] [076/131] (614s left) kms_flip (2x-nonexisting-fb) [443.812767] Starting subtest: 2x-nonexisting-fb [443.822711] Subtest 2x-nonexisting-fb: SKIP (0.011s) [443.902148] [077/131] (614s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [443.958008] Starting subtest: invalid-smem-bo-on-discrete [443.962050] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [444.108555] [078/131] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [444.201747] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [444.205953] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [444.305675] [079/131] (614s left) kms_content_protection (srm) [444.498179] Starting subtest: srm [447.855029] Subtest srm: SKIP (3.350s) [449.018169] [080/131] (609s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [449.114070] Starting subtest: random-ccs-data-yf-tiled-ccs [449.116284] Starting dynamic subtest: pipe-A-eDP-1 [449.141071] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [449.152114] Starting dynamic subtest: pipe-B-eDP-1 [449.175614] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [449.184972] Starting dynamic subtest: pipe-C-eDP-1 [449.209388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [449.217857] Starting dynamic subtest: pipe-D-eDP-1 [449.241933] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [449.246344] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s) [451.270982] [081/131] (607s left) kms_chamelium_hpd (vga-hpd-after-suspend) [451.664152] Subtest vga-hpd-after-suspend: SKIP (0.000s) [452.469409] [082/131] (606s left) kms_psr (psr2-sprite-mmap-gtt) [452.577211] Starting subtest: psr2-sprite-mmap-gtt [452.579573] Starting dynamic subtest: eDP-1 [453.992475] Dynamic subtest eDP-1: SKIP (1.413s) [453.997203] Subtest psr2-sprite-mmap-gtt: SKIP (1.415s) [454.134115] [083/131] (604s left) api_intel_bb (lot-of-buffers) [454.184929] Starting subtest: lot-of-buffers [455.270200] Subtest lot-of-buffers: SUCCESS (1.085s) [455.612458] [084/131] (603s left) kms_rotation_crc (exhaust-fences) [455.697145] Starting subtest: exhaust-fences [455.701570] Subtest exhaust-fences: SKIP (0.000s) [455.768900] [085/131] (603s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [455.862968] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [455.865115] Starting dynamic subtest: pipe-A-default-mode [458.554583] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s) [458.557098] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.693s) [459.382242] [086/131] (599s left) gem_create (create-valid-nonaligned) [459.446762] Starting subtest: create-valid-nonaligned [459.448808] Subtest create-valid-nonaligned: SUCCESS (0.000s) [459.635592] [087/131] (599s left) kms_flip (basic-plain-flip) [459.732526] Starting subtest: basic-plain-flip [459.735028] Starting dynamic subtest: A-eDP1 [461.490174] Dynamic subtest A-eDP1: SUCCESS (1.756s) [461.505513] Starting dynamic subtest: B-eDP1 [463.203943] Dynamic subtest B-eDP1: SUCCESS (1.712s) [463.212842] Starting dynamic subtest: C-eDP1 [464.921777] Dynamic subtest C-eDP1: SUCCESS (1.716s) [464.933109] Starting dynamic subtest: D-eDP1 [466.644076] Dynamic subtest D-eDP1: SUCCESS (1.722s) [466.646311] Subtest basic-plain-flip: SUCCESS (6.915s) [467.803459] [088/131] (591s left) kms_setmode (basic) [467.871094] Starting subtest: basic [468.204688] Starting dynamic subtest: pipe-A-eDP-1 [470.312086] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s) [470.666055] Starting dynamic subtest: pipe-B-eDP-1 [472.738747] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.076s) [473.047434] Subtest basic: SUCCESS (5.174s) [473.873969] [089/131] (585s left) i915_query (query-regions-sanity-check) [473.924786] Starting subtest: query-regions-sanity-check [473.935775] Subtest query-regions-sanity-check: SUCCESS (0.012s) [474.083440] [090/131] (585s left) gem_ctx_isolation (preservation-s3) [474.147545] Starting subtest: preservation-S3 [474.149916] Starting dynamic subtest: rcs0 [490.441219] Dynamic subtest rcs0: SUCCESS (2.007s) [490.454208] Starting dynamic subtest: bcs0 [507.363869] Dynamic subtest bcs0: SUCCESS (1.806s) [507.377100] Starting dynamic subtest: vcs0 [524.393359] Dynamic subtest vcs0: SUCCESS (3.414s) [524.405883] Starting dynamic subtest: vcs1 [542.456357] Dynamic subtest vcs1: SUCCESS (5.076s) [542.468184] Starting dynamic subtest: vecs0 [560.374782] Dynamic subtest vecs0: SUCCESS (4.927s) [560.385550] Starting dynamic subtest: ccs0 [578.380026] Dynamic subtest ccs0: SUCCESS (3.305s) [578.382436] Subtest preservation-S3: SUCCESS (20.539s) [585.669966] [091/131] (480s left) kms_cursor_crc (cursor-random-512x170) [586.002842] Starting subtest: cursor-random-512x170 [586.007454] Subtest cursor-random-512x170: SKIP (0.001s) [586.172162] [092/131] (480s left) kms_lease (setcrtc-implicit-plane) [586.266723] Starting subtest: setcrtc-implicit-plane [586.269145] Starting dynamic subtest: pipe-A-eDP-1 [586.768178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s) [586.778169] Starting dynamic subtest: pipe-B-eDP-1 [587.906382] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.098s) [587.917637] Starting dynamic subtest: pipe-C-eDP-1 [589.046802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [589.057759] Starting dynamic subtest: pipe-D-eDP-1 [590.199369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [590.201651] Subtest setcrtc-implicit-plane: SUCCESS (3.822s) [591.061390] [093/131] (475s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [591.155635] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [591.158029] Starting dynamic subtest: pipe-A-eDP-1 [591.634910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s) [591.646102] Starting dynamic subtest: pipe-B-eDP-1 [593.007928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s) [593.018058] Starting dynamic subtest: pipe-C-eDP-1 [594.409774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s) [594.421325] Starting dynamic subtest: pipe-D-eDP-1 [595.747954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [595.749923] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.495s) [596.940308] [094/131] (469s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [597.057388] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [597.061901] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [597.162974] [095/131] (469s left) gem_render_copy_redux (flink-interruptible) [597.228492] Starting subtest: flink-interruptible [598.190814] Subtest flink-interruptible: SUCCESS (0.954s) [598.339401] [096/131] (468s left) gem_pxp (regular-baseline-src-copy-readible) [598.459709] Starting subtest: regular-baseline-src-copy-readible [598.519166] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [598.630701] [097/131] (467s left) kms_psr (fbc-psr-sprite-plane-move) [598.731361] Starting subtest: fbc-psr-sprite-plane-move [598.732998] Starting dynamic subtest: eDP-1 [598.736399] Dynamic subtest eDP-1: SKIP (0.000s) [598.739771] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [598.806238] [098/131] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [598.906725] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [605.879301] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (6.940s) [606.018649] [099/131] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [606.121126] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [606.125583] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [606.233031] [100/131] (460s left) kms_big_fb (4-tiled-8bpp-rotate-180) [606.341941] Starting subtest: 4-tiled-8bpp-rotate-180 [607.567508] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.224s) [607.718809] [101/131] (458s left) gem_ctx_sseu (invalid-sseu) [607.785766] Subtest invalid-sseu: SKIP (0.000s) [607.876881] [102/131] (458s left) prime_busy (hang-wait) [607.937728] Starting subtest: hang-wait [607.939464] Starting dynamic subtest: rcs0 [634.083886] Dynamic subtest rcs0: SUCCESS (26.121s) [634.095796] Starting dynamic subtest: bcs0 [641.233659] Dynamic subtest bcs0: SUCCESS (7.145s) [641.242866] Starting dynamic subtest: vcs0 [648.271049] Dynamic subtest vcs0: SUCCESS (7.032s) [648.282260] Starting dynamic subtest: vcs1 [655.247258] Dynamic subtest vcs1: SUCCESS (6.973s) [655.258935] Starting dynamic subtest: vecs0 [662.286429] Dynamic subtest vecs0: SUCCESS (7.035s) [662.297780] Starting dynamic subtest: ccs0 [676.126660] Dynamic subtest ccs0: SUCCESS (13.832s) [676.129263] Subtest hang-wait: SUCCESS (68.146s) [676.252776] [103/131] (390s left) syncobj_wait (wait-for-submit-snapshot) [676.301783] Starting subtest: wait-for-submit-snapshot [676.381994] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [676.458696] [104/131] (390s left) kms_cursor_legacy (cursor-vs-flip-toggle) [676.582192] Starting subtest: cursor-vs-flip-toggle [706.914622] Subtest cursor-vs-flip-toggle: SUCCESS (30.336s) [707.759079] [105/131] (358s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [707.852534] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [707.854828] Starting dynamic subtest: pipe-A-eDP-1 [707.878739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [707.891390] Starting dynamic subtest: pipe-B-eDP-1 [707.913457] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [707.923149] Starting dynamic subtest: pipe-C-eDP-1 [707.945023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [707.954223] Starting dynamic subtest: pipe-D-eDP-1 [707.975866] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [707.980343] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [710.018188] [106/131] (356s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [710.118593] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [710.122538] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [710.224793] [107/131] (356s left) gem_blits (basic) [710.289222] Starting subtest: basic [711.646252] Subtest basic: SUCCESS (1.356s) [711.756462] [108/131] (355s left) perf_pmu (rc6-suspend) [711.793910] Starting subtest: rc6-suspend [734.513941] Subtest rc6-suspend: SUCCESS (7.935s) [737.538263] [109/131] (331s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [737.653314] Starting subtest: fbcpsr-farfromfence-mmap-gtt [737.658142] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [737.761701] [110/131] (331s left) kms_pipe_crc_basic (hang-read-crc) [737.851068] Starting subtest: hang-read-crc [737.853743] Starting dynamic subtest: pipe-A-eDP-1 [739.990341] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s) [740.002038] Starting dynamic subtest: pipe-B-eDP-1 [742.830769] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.839s) [742.842099] Starting dynamic subtest: pipe-C-eDP-1 [745.543564] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.710s) [745.555607] Starting dynamic subtest: pipe-D-eDP-1 [748.181348] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.634s) [748.184291] Subtest hang-read-crc: SUCCESS (10.326s) [748.999902] [111/131] (320s left) dumb_buffer (map-valid) [749.063916] Starting subtest: map-valid [749.066503] Subtest map-valid: SUCCESS (0.000s) [749.193057] [112/131] (319s left) gem_exec_schedule (u-semaphore-user) [749.270989] Starting subtest: u-semaphore-user [749.319683] Subtest u-semaphore-user: SUCCESS (0.058s) [750.438282] [113/131] (318s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [750.545154] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [751.769553] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.223s) [751.904135] [114/131] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [751.997466] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [752.001336] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [752.111769] [115/131] (317s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [752.209419] Starting subtest: psr-rgb101010-draw-mmap-cpu [759.161893] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.952s) [759.282514] [116/131] (309s left) gem_ctx_shared (exec-single-timeline) [759.351479] Starting subtest: exec-single-timeline [759.353927] Starting dynamic subtest: rcs0 [760.412381] Dynamic subtest rcs0: SUCCESS (1.058s) [760.426402] Starting dynamic subtest: bcs0 [761.500656] Dynamic subtest bcs0: SUCCESS (1.085s) [761.514295] Starting dynamic subtest: vcs0 [762.593703] Dynamic subtest vcs0: SUCCESS (1.086s) [762.611043] Starting dynamic subtest: vcs1 [763.677006] Dynamic subtest vcs1: SUCCESS (1.086s) [763.689426] Starting dynamic subtest: vecs0 [764.765681] Dynamic subtest vecs0: SUCCESS (1.086s) [764.779721] Starting dynamic subtest: ccs0 [765.853790] Dynamic subtest ccs0: SUCCESS (1.085s) [765.856851] Subtest exec-single-timeline: SUCCESS (6.500s) [766.044792] [117/131] (303s left) gem_ringfill (legacy-basic) [771.396015] Starting subtest: legacy-basic [771.398770] Starting dynamic subtest: default [771.458279] Dynamic subtest default: SUCCESS (0.063s) [771.472320] Starting dynamic subtest: render [771.502809] Dynamic subtest render: SUCCESS (0.041s) [771.516411] Starting dynamic subtest: bsd [771.546207] Dynamic subtest bsd: SUCCESS (0.041s) [771.559331] Starting dynamic subtest: bsd1 [771.586518] Dynamic subtest bsd1: SUCCESS (0.038s) [771.598584] Starting dynamic subtest: bsd2 [771.631478] Dynamic subtest bsd2: SUCCESS (0.043s) [771.643249] Starting dynamic subtest: blt [771.678248] Dynamic subtest blt: SUCCESS (0.045s) [771.689784] Starting dynamic subtest: vebox [771.721275] Dynamic subtest vebox: SUCCESS (0.041s) [771.724375] Subtest legacy-basic: SUCCESS (0.328s) [771.804167] [118/131] (297s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [771.913890] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [771.918164] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [772.003715] [119/131] (297s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [772.110034] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [778.538293] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.429s) [778.654045] [120/131] (290s left) syncobj_timeline (invalid-transfer-illegal-handle) [778.713345] Starting subtest: invalid-transfer-illegal-handle [778.715613] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [778.841987] [121/131] (290s left) syncobj_timeline (reset-unsignaled) [778.904943] Starting subtest: reset-unsignaled [778.907781] Subtest reset-unsignaled: SUCCESS (0.000s) [779.014232] [122/131] (290s left) kms_vrr (flip-dpms) [779.104025] Starting subtest: flip-dpms [779.111023] Subtest flip-dpms: SKIP (0.000s) [779.176910] [123/131] (290s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [779.273912] Starting subtest: plane-all-transition-nonblocking-fencing [779.276385] Starting dynamic subtest: pipe-A-eDP-1 [781.789766] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.513s) [782.093296] Starting dynamic subtest: pipe-B-eDP-1 [785.311936] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s) [785.610015] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.332s) [786.435388] [124/131] (283s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [786.489776] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [786.596458] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [786.679144] [125/131] (282s left) kms_big_fb (linear-16bpp-rotate-180) [786.778246] Starting subtest: linear-16bpp-rotate-180 [788.255138] Subtest linear-16bpp-rotate-180: SUCCESS (1.478s) [788.448246] [126/131] (281s left) gem_exec_reloc (basic-cpu-read) [788.500552] Subtest basic-cpu-read: SKIP (0.000s) [788.565550] [127/131] (281s left) gem_mmap_wc (write) [788.627196] Subtest write: SKIP (0.000s) [788.697605] [128/131] (281s left) i915_drm_fdinfo (memory-info-active) [788.732835] Starting subtest: memory-info-active [788.735335] Starting dynamic subtest: smem0 [792.006914] Dynamic subtest smem0: SUCCESS (3.271s) [792.009915] Subtest memory-info-active: SUCCESS (3.272s) [792.099716] [129/131] (277s left) gem_watchdog (default-virtual) [792.322765] Starting subtest: default-virtual [798.604313] Subtest default-virtual: SUCCESS (6.290s) [798.727211] [130/131] (271s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [798.829186] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [803.343551] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.517s) [804.526467] [131/131] (265s left) kms_properties (invalid-properties-atomic) [804.633032] Starting subtest: invalid-properties-atomic [804.884115] Subtest invalid-properties-atomic: SUCCESS (0.250s) [804.955611] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_legacy results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: syncobj_wait results: parsing output: 3/ for test: gem_mmap_gtt results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: gem_wait results: parsing output: 7/ for test: gem_exec_reloc results: parsing output: 8/ for test: gem_exec_fence results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: kms_atomic results: parsing output: 11/ for test: kms_chamelium_edid results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: gem_exec_whisper results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_atomic_interruptible results: parsing output: 21/ for test: gem_ppgtt results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_ctx_param results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: gem_lmem_swapping results: parsing output: 29/ for test: i915_query results: parsing output: 30/ for test: kms_chamelium_frames results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: sw_sync results: parsing output: 33/ for test: kms_pm_rpm results: parsing output: 34/ for test: perf_pmu results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_ctx_persistence results: parsing output: 37/ for test: prime_mmap_coherency results: parsing output: 38/ for test: gem_render_copy results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: sysfs_preempt_timeout results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: i915_module_load results: parsing output: 45/ for test: gem_exec_balancer results: parsing output: 46/ for test: gen9_exec_parse results: parsing output: 47/ for test: gem_exec_parallel results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: gem_exec_reloc results: parsing output: 53/ for test: kms_pm_backlight results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_joiner results: parsing output: 56/ for test: kms_pm_rpm results: parsing output: 57/ for test: perf_pmu results: parsing output: 58/ for test: kms_dsc results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_basic results: parsing output: 61/ for test: kms_plane_scaling results: parsing output: 62/ for test: gem_exec_params results: parsing output: 63/ for test: sw_sync results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_psr_stress_test results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_draw_crc results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: kms_vblank results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: api_intel_bb results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_chamelium_hpd results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: api_intel_bb results: parsing output: 83/ for test: kms_rotation_crc results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: gem_create results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_setmode results: parsing output: 88/ for test: i915_query results: parsing output: 89/ for test: gem_ctx_isolation results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_lease results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_render_copy_redux results: parsing output: 95/ for test: gem_pxp results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: gem_ctx_sseu results: parsing output: 101/ for test: prime_busy results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_blits results: parsing output: 107/ for test: perf_pmu results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_pipe_crc_basic results: parsing output: 110/ for test: dumb_buffer results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_ctx_shared results: parsing output: 116/ for test: gem_ringfill results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_vrr results: parsing output: 122/ for test: kms_atomic_transition results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: gem_exec_reloc results: parsing output: 126/ for test: gem_mmap_wc results: parsing output: 127/ for test: i915_drm_fdinfo results: parsing output: 128/ for test: gem_watchdog results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_properties Done.