[72.198597] Initializing watchdogs
[72.198801]   /dev/watchdog0
[72.219491] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[72.227043] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.231100] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.234242] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[72.782350] Starting subtest: cursor-offscreen-256x85
[72.842141] Subtest cursor-offscreen-256x85: SKIP (0.058s)
[73.417808] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[73.474877] Starting subtest: cpuset-big-copy-odd
[76.952256] Subtest cpuset-big-copy-odd: SUCCESS (3.480s)
[77.181628] [003/134] (955s left) gem_ctx_engines (execute-allforone)
[77.357666] Starting subtest: execute-allforone
[77.359496] Subtest execute-allforone: SUCCESS (0.002s)
[77.608373] [004/134] (955s left) perf_pmu (busy-idle)
[77.666164] Starting subtest: busy-idle
[77.667015] Starting dynamic subtest: rcs0
[78.299675] Dynamic subtest rcs0: SUCCESS (0.633s)
[78.316858] Starting dynamic subtest: bcs0
[78.936402] Dynamic subtest bcs0: SUCCESS (0.636s)
[78.956445] Starting dynamic subtest: vcs0
[80.079420] Dynamic subtest vcs0: SUCCESS (1.142s)
[80.080754] Subtest busy-idle: SUCCESS (2.413s)
[80.205776] [005/134] (952s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[80.719701] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[80.722256] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[81.319817] [006/134] (951s left) api_intel_bb (lot-of-buffers)
[81.377324] Starting subtest: lot-of-buffers
[82.105971] Subtest lot-of-buffers: SUCCESS (0.728s)
[82.403453] [007/134] (950s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[82.465538] Starting subtest: yf-tiled-to-vebox-x-tiled
[82.467336] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[82.699511] [008/134] (950s left) kms_plane (plane-panning-top-left)
[83.201116] Starting subtest: plane-panning-top-left
[83.202016] Starting dynamic subtest: pipe-A
[83.947198] Dynamic subtest pipe-A: SUCCESS (0.743s)
[83.957578] Starting dynamic subtest: pipe-B
[84.528353] Dynamic subtest pipe-B: SUCCESS (0.582s)
[84.529193] Subtest plane-panning-top-left: SUCCESS (1.328s)
[85.243245] [009/134] (947s left) kms_psr (fbc-psr-cursor-plane-onoff)
[85.744872] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[86.037158] [010/134] (947s left) kms_cursor_crc (cursor-tearing-position-change)
[86.534161] Starting subtest: cursor-tearing-position-change
[86.534988] Starting dynamic subtest: pipe-A-HDMI-A-1
[86.945934] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.410s)
[86.958224] Starting dynamic subtest: pipe-B-HDMI-A-1
[87.316164] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.369s)
[87.317062] Subtest cursor-tearing-position-change: SUCCESS (0.782s)
[88.024046] [011/134] (945s left) kms_frontbuffer_tracking (basic)
[88.527778] Starting subtest: basic
[90.957671] Subtest basic: SUCCESS (2.430s)
[91.583992] [012/134] (941s left) gem_spin_batch (spin-each)
[91.655663] Starting subtest: spin-each
[94.990740] Subtest spin-each: SUCCESS (3.335s)
[95.242997] [013/134] (938s left) gem_exec_reloc (basic-gtt-cpu)
[95.300916] Starting subtest: basic-gtt-cpu
[95.304679] Subtest basic-gtt-cpu: SUCCESS (0.004s)
[96.340283] [014/134] (936s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[96.838483] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[96.878379] Starting dynamic subtest: pipe-A-plane-0
[96.880058] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[96.893204] Starting dynamic subtest: pipe-A-plane-1
[96.895078] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[96.906586] Starting dynamic subtest: pipe-A-plane-2
[96.908245] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[97.120816] Starting dynamic subtest: pipe-B-plane-0
[97.122112] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[97.135293] Starting dynamic subtest: pipe-B-plane-1
[97.137089] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[97.147720] Starting dynamic subtest: pipe-B-plane-2
[97.149080] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[97.209067] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.371s)
[97.918106] [015/134] (935s left) gem_render_copy (y-tiled-ccs-to-linear)
[97.983041] Starting subtest: y-tiled-ccs-to-linear
[97.984659] Starting dynamic subtest: smem
[97.986996] Dynamic subtest smem: SKIP (0.000s)
[97.989570] Subtest y-tiled-ccs-to-linear: SKIP (0.001s)
[98.218173] [016/134] (935s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[98.714278] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[98.715719] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[99.316408] [017/134] (934s left) kms_psr (pr-sprite-render)
[99.808927] Subtest pr-sprite-render: SKIP (0.000s)
[100.109241] [018/134] (933s left) gen9_exec_parse (shadow-peek)
[100.167425] Subtest shadow-peek: SKIP (0.000s)
[100.228245] [019/134] (933s left) perf (invalid-remove-userspace-config)
[100.427290] Subtest invalid-remove-userspace-config: SKIP (0.000s)
[100.479583] [020/134] (933s left) gem_ctx_param (invalid-size-set)
[100.532359] Starting subtest: invalid-size-set
[100.533165] Subtest invalid-size-set: SUCCESS (0.000s)
[100.648365] [021/134] (932s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[100.702569] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[100.759122] [022/134] (932s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[100.813401] Starting subtest: invalid-bsd2-flag-on-blt
[100.814203] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[100.948849] [023/134] (932s left) gem_render_copy (yf-tiled-ccs-to-linear)
[101.012503] Starting subtest: yf-tiled-ccs-to-linear
[101.013516] Starting dynamic subtest: smem
[101.015862] Dynamic subtest smem: SKIP (0.000s)
[101.018446] Subtest yf-tiled-ccs-to-linear: SKIP (0.001s)
[101.255347] [024/134] (932s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[101.314721] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[101.418057] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[101.529024] [025/134] (932s left) gem_exec_fence (invalid-timeline-fence-array)
[101.881672] Starting subtest: invalid-timeline-fence-array
[101.887280] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[102.148231] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[102.151217] [026/134] (931s left) kms_chamelium_edid (dp-edid-read)
[102.715344] Subtest dp-edid-read: SKIP (0.000s)
[103.118742] [027/134] (930s left) gem_exec_params (invalid-bsd1-flag-on-render)
[103.180512] Starting subtest: invalid-bsd1-flag-on-render
[103.181374] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[103.327281] [028/134] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[103.825870] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[103.827349] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[104.438918] [029/134] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[104.491510] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[104.555986] [030/134] (929s left) gem_eio (kms)
[105.059218] Starting subtest: kms
[109.833868] Subtest kms: SUCCESS (4.775s)
[110.463393] [031/134] (923s left) kms_cursor_legacy (torture-move)
[110.961329] Starting subtest: torture-move
[110.961949] Starting dynamic subtest: pipe-A
[116.987052] Dynamic subtest pipe-A: SUCCESS (6.025s)
[116.999988] Starting dynamic subtest: pipe-B
[122.784536] Dynamic subtest pipe-B: SUCCESS (5.796s)
[122.796721] Starting dynamic subtest: all-pipes
[129.219383] Dynamic subtest all-pipes: SUCCESS (6.434s)
[129.220399] Subtest torture-move: SUCCESS (18.258s)
[129.819785] [032/134] (904s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[129.878923] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[129.929840] [033/134] (904s left) gem_exec_capture (pi)
[129.986422] Subtest pi: SKIP (0.000s)
[130.062909] [034/134] (904s left) syncobj_timeline (wait-all-snapshot)
[130.118483] Starting subtest: wait-all-snapshot
[130.201872] Subtest wait-all-snapshot: SUCCESS (0.082s)
[130.334871] [035/134] (904s left) kms_async_flips (test-cursor-atomic)
[130.824386] Starting subtest: test-cursor-atomic
[130.969721] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.125549] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.156s)
[131.282854] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.373757] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.102s)
[131.374569] Subtest test-cursor-atomic: SUCCESS (0.550s)
[132.236218] [036/134] (902s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[132.738050] Starting subtest: x-tiled-32bpp-rotate-180
[134.180127] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.441s)
[134.812908] [037/134] (899s left) i915_pm_freq_api (freq-reset)
[134.870915] Subtest freq-reset: SKIP (0.000s)
[134.937707] [038/134] (899s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[135.432850] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[137.290182] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.857s)
[137.905459] [039/134] (896s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[137.961745] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[138.014089] [040/134] (896s left) gem_mmap (short-mmap)
[138.067800] Starting subtest: short-mmap
[138.068531] Subtest short-mmap: SUCCESS (0.000s)
[138.203493] [041/134] (896s left) vgem_basic (dmabuf-export)
[138.273830] Starting subtest: dmabuf-export
[138.275264] Subtest dmabuf-export: SUCCESS (0.003s)
[138.409425] [042/134] (896s left) gem_render_copy (y-tiled)
[138.469525] Starting subtest: y-tiled
[138.470218] Starting dynamic subtest: smem
[138.536160] Dynamic subtest smem: SUCCESS (0.066s)
[138.536896] Subtest y-tiled: SUCCESS (0.067s)
[138.789864] [043/134] (895s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[139.276872] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[139.278108] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[139.885602] [044/134] (894s left) gem_exec_schedule (implicit-write-read)
[139.956835] Starting subtest: implicit-write-read
[139.957704] Starting dynamic subtest: rcs0
[139.988968] Dynamic subtest rcs0: SUCCESS (0.032s)
[140.002635] Starting dynamic subtest: bcs0
[140.017904] Dynamic subtest bcs0: SUCCESS (0.028s)
[140.018684] Subtest implicit-write-read: SUCCESS (0.062s)
[140.289486] [045/134] (894s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[140.784585] Starting subtest: 4-tiled-64bpp-rotate-90
[140.786161] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[141.397619] [046/134] (893s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[141.894998] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[141.896880] Starting dynamic subtest: A-VGA1
[149.915680] Dynamic subtest A-VGA1: SUCCESS (8.019s)
[149.928663] Starting dynamic subtest: B-VGA1
[157.908090] Dynamic subtest B-VGA1: SUCCESS (7.991s)
[157.925121] Starting dynamic subtest: A-HDMI-A1
[166.066338] Dynamic subtest A-HDMI-A1: SUCCESS (8.154s)
[166.078323] Starting dynamic subtest: B-HDMI-A1
[174.247654] Dynamic subtest B-HDMI-A1: SUCCESS (8.181s)
[174.249122] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.354s)
[175.037392] [047/134] (859s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[175.531089] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[175.533456] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[176.134587] [048/134] (858s left) kms_color_pipeline (plane-lut1d)
[176.626596] Starting subtest: plane-lut1d
[176.896765] Subtest plane-lut1d: SKIP (0.269s)
[177.618264] [049/134] (857s left) i915_pm_rc6_residency (rc6-accuracy)
[177.678396] Starting subtest: rc6-accuracy
[177.679201] Starting dynamic subtest: gt0
[180.849327] Dynamic subtest gt0: SUCCESS (3.168s)
[180.850193] Subtest rc6-accuracy: SUCCESS (3.170s)
[180.955165] [050/134] (854s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[181.442205] Starting subtest: basic-flip-before-cursor-atomic
[182.415855] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.974s)
[183.133656] [051/134] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[183.631631] Starting subtest: psr-2p-primscrn-spr-indfb-move
[183.633174] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[184.243560] [052/134] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[184.732218] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[184.734054] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.341843] [053/134] (849s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[185.833597] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[186.134289] [054/134] (849s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[186.194783] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[186.298272] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[186.422734] [055/134] (848s left) gem_mmap_wc (bad-size)
[186.479256] Starting subtest: bad-size
[186.480965] Subtest bad-size: SUCCESS (0.001s)
[186.623827] [056/134] (848s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[187.120553] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[187.123415] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[187.705214] [057/134] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[188.195433] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[188.196849] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[188.805189] [058/134] (846s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[189.294330] Starting subtest: cursorA-vs-flipB-atomic
[189.296279] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[189.907724] [059/134] (845s left) sysfs_heartbeat_interval (nopreempt)
[189.964767] Starting subtest: nopreempt
[189.966724] Starting dynamic subtest: vcs0
[189.967912] Dynamic subtest vcs0: SKIP (0.000s)
[189.982257] Starting dynamic subtest: bcs0
[189.984058] Dynamic subtest bcs0: SKIP (0.000s)
[190.000886] Starting dynamic subtest: rcs0
[190.002976] Dynamic subtest rcs0: SKIP (0.000s)
[190.004830] Subtest nopreempt: SKIP (0.005s)
[190.098557] [060/134] (845s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[190.594958] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[190.596440] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[191.196175] [061/134] (844s left) gem_wait (busy)
[191.266743] Starting subtest: busy
[191.267617] Starting dynamic subtest: all-engines
[191.788456] Dynamic subtest all-engines: SUCCESS (0.521s)
[191.802598] Starting dynamic subtest: rcs0
[192.309563] Dynamic subtest rcs0: SUCCESS (0.519s)
[192.323951] Starting dynamic subtest: bcs0
[192.825920] Dynamic subtest bcs0: SUCCESS (0.514s)
[192.842865] Starting dynamic subtest: vcs0
[193.353671] Dynamic subtest vcs0: SUCCESS (0.524s)
[193.355075] Subtest busy: SUCCESS (2.088s)
[193.608280] [062/134] (842s left) kms_setmode (clone-exclusive-crtc)
[193.668914] Starting subtest: clone-exclusive-crtc
[193.671071] Subtest clone-exclusive-crtc: SKIP (0.000s)
[193.792759] [063/134] (842s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[194.277383] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[194.565020] [064/134] (841s left) sw_sync (sync_merge_same)
[194.622050] Starting subtest: sync_merge_same
[194.622908] Subtest sync_merge_same: SUCCESS (0.000s)
[194.730699] [065/134] (841s left) kms_hdr (static-toggle)
[195.223741] Starting subtest: static-toggle
[195.225932] Subtest static-toggle: SKIP (0.000s)
[195.837405] [066/134] (840s left) gem_exec_await (wide-contexts)
[195.930883] Starting subtest: wide-contexts
[217.680811] Subtest wide-contexts: SUCCESS (21.752s)
[217.938269] [067/134] (818s left) kms_invalid_mode (uint-max-clock)
[218.549831] Starting subtest: uint-max-clock
[218.554221] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.622599] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.072s)
[218.639993] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.641141] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[218.642121] Subtest uint-max-clock: SUCCESS (0.077s)
[219.129448] [068/134] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[219.627875] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[221.536857] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.911s)
[222.181925] [069/134] (814s left) kms_pm_rpm (modeset-non-lpsp)
[234.039102] Subtest modeset-non-lpsp: SKIP (0.000s)
[234.340575] [070/134] (801s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[234.834297] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[235.136519] [071/134] (801s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[235.626470] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[237.056342] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.430s)
[237.715444] [072/134] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[238.204240] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[238.205598] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[238.803766] [073/134] (797s left) i915_pm_rps (thresholds-idle)
[238.875571] Starting subtest: thresholds-idle
[238.876451] Starting dynamic subtest: gt0
[249.239273] Dynamic subtest gt0: SUCCESS (10.362s)
[249.241845] Subtest thresholds-idle: SUCCESS (10.365s)
[249.365639] [074/134] (787s left) kms_vblank (query-idle-hang)
[249.854855] Starting subtest: query-idle-hang
[249.856109] Starting dynamic subtest: pipe-A-HDMI-A-1
[255.933179] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.075s)
[255.951634] Starting dynamic subtest: pipe-B-HDMI-A-1
[261.951927] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.017s)
[261.954151] Subtest query-idle-hang: SUCCESS (12.099s)
[262.667840] [075/134] (773s left) perf_pmu (most-busy-idle-check-all)
[262.734958] Starting subtest: most-busy-idle-check-all
[262.737048] Starting dynamic subtest: rcs0
[263.353764] Dynamic subtest rcs0: SUCCESS (0.617s)
[263.370021] Starting dynamic subtest: bcs0
[263.983571] Dynamic subtest bcs0: SUCCESS (0.627s)
[264.000710] Starting dynamic subtest: vcs0
[264.602590] Dynamic subtest vcs0: SUCCESS (0.616s)
[264.605799] Subtest most-busy-idle-check-all: SUCCESS (1.869s)
[264.728091] [076/134] (771s left) kms_atomic_interruptible (universal-setplane-cursor)
[265.221512] Starting subtest: universal-setplane-cursor
[265.223522] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.504721] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.281s)
[271.505342] Subtest universal-setplane-cursor: SUCCESS (6.283s)
[272.212695] [077/134] (764s left) gem_userptr_blits (process-exit-busy)
[272.289403] Starting subtest: process-exit-busy
[272.309173] Subtest process-exit-busy: SUCCESS (0.020s)
[272.494882] [078/134] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[272.981499] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[272.983024] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[273.580626] [079/134] (763s left) gem_lmem_swapping (heavy-verify-multi)
[273.640666] Subtest heavy-verify-multi: SKIP (0.000s)
[273.711841] [080/134] (763s left) gen9_exec_parse (bb-start-cmd)
[273.768644] Subtest bb-start-cmd: SKIP (0.000s)
[273.837647] [081/134] (762s left) fbdev (unaligned-read)
[273.914216] Starting subtest: unaligned-read
[273.925984] Subtest unaligned-read: SUCCESS (0.013s)
[274.046068] [082/134] (762s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[274.609892] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[275.018567] [083/134] (761s left) gem_ppgtt (blt-vs-render-ctx0)
[275.076601] Starting subtest: blt-vs-render-ctx0
[307.643709] Subtest blt-vs-render-ctx0: SUCCESS (32.566s)
[307.814770] [084/134] (729s left) core_setmaster_vs_auth
[308.102178] [085/134] (728s left) prime_busy (hang)
[308.159807] Starting subtest: hang
[308.160601] Starting dynamic subtest: rcs0
[313.845824] Dynamic subtest rcs0: SUCCESS (5.683s)
[313.858060] Starting dynamic subtest: bcs0
[319.861259] Dynamic subtest bcs0: SUCCESS (6.013s)
[319.875082] Starting dynamic subtest: vcs0
[325.873840] Dynamic subtest vcs0: SUCCESS (6.010s)
[325.874643] Subtest hang: SUCCESS (17.712s)
[326.041386] [086/134] (711s left) gem_eio (unwedge-stress)
[326.133092] Starting subtest: unwedge-stress
[326.133879] Starting dynamic subtest: render
[327.832535] Dynamic subtest render: SUCCESS (1.698s)
[327.849752] Starting dynamic subtest: bsd
[329.068094] Dynamic subtest bsd: FAIL (1.202s)
[329.068905] Subtest unwedge-stress: FAIL (2.904s)
[330.131155] [087/134] (707s left) kms_cursor_crc (cursor-random-256x256)
[330.643998] Starting subtest: cursor-random-256x256
[330.646532] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.369779] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.724s)
[334.416900] Starting dynamic subtest: pipe-B-HDMI-A-1
[338.089757] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.688s)
[338.090460] Subtest cursor-random-256x256: SUCCESS (7.448s)
[338.812975] [088/134] (698s left) syncobj_timeline (multi-wait-submitted-signaled)
[338.882545] Starting subtest: multi-wait-submitted-signaled
[338.884741] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[339.009317] [089/134] (698s left) kms_dsc (dsc-with-formats)
[339.495682] Subtest dsc-with-formats: SKIP (0.000s)
[339.785586] [090/134] (697s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[340.282138] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[340.283364] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[340.877880] [091/134] (696s left) api_intel_allocator (reopen-fork)
[340.935750] Starting subtest: reopen-fork
[344.477169] Subtest reopen-fork: SUCCESS (3.539s)
[344.601810] [092/134] (692s left) gem_exec_whisper (basic-fds-priority-all)
[344.667875] Starting subtest: basic-fds-priority-all
[344.670925] Subtest basic-fds-priority-all: SKIP (0.001s)
[344.915521] [093/134] (692s left) gem_exec_fence (basic-wait-all)
[344.984583] Starting subtest: basic-wait-all
[345.018647] Subtest basic-wait-all: SUCCESS (0.034s)
[345.514796] [094/134] (692s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[345.571632] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[345.638039] [095/134] (691s left) kms_psr (fbc-psr2-no-drrs)
[346.123266] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[346.422661] [096/134] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[346.911425] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[346.912894] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[347.525231] [097/134] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[348.011636] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[348.013129] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[348.622524] [098/134] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[349.112259] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[351.050538] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.938s)
[351.699603] [099/134] (686s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[352.188076] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[352.188948] Starting dynamic subtest: pipe-A
[352.191114] Dynamic subtest pipe-A: SKIP (0.001s)
[352.203977] Starting dynamic subtest: pipe-B
[352.205739] Dynamic subtest pipe-B: SKIP (0.001s)
[352.207205] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.006s)
[352.782717] [100/134] (685s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[352.839036] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[352.895297] [101/134] (685s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[353.377953] Starting subtest: flip-vs-cursor-busy-crc-atomic
[353.943063] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.566s)
[354.637581] [102/134] (683s left) core_getstats (basic)
[354.699363] Starting subtest: basic
[354.700203] Subtest basic: SUCCESS (0.000s)
[354.821219] [103/134] (683s left) gem_mmap_gtt (hang-busy)
[354.875770] Starting subtest: hang-busy
[360.882279] Subtest hang-busy: SUCCESS (6.006s)
[361.042945] [104/134] (677s left) kms_flip (flip-vs-expired-vblank-interruptible)
[361.536015] Starting subtest: flip-vs-expired-vblank-interruptible
[361.538223] Starting dynamic subtest: A-VGA1
[369.258626] Dynamic subtest A-VGA1: SUCCESS (7.720s)
[369.273012] Starting dynamic subtest: B-VGA1
[376.933135] Dynamic subtest B-VGA1: SUCCESS (7.671s)
[376.949702] Starting dynamic subtest: A-HDMI-A1
[384.640776] Dynamic subtest A-HDMI-A1: SUCCESS (7.704s)
[384.656514] Starting dynamic subtest: B-HDMI-A1
[392.408443] Dynamic subtest B-HDMI-A1: SUCCESS (7.764s)
[392.409762] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.874s)
[393.214768] [105/134] (644s left) gem_exec_schedule (preempt-queue-contexts)
[393.287100] Subtest preempt-queue-contexts: SKIP (0.000s)
[393.529220] [106/134] (644s left) perf (oa-formats)
[393.736255] Subtest oa-formats: SKIP (0.000s)
[393.792736] [107/134] (644s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[394.285799] Starting subtest: fbcpsr-modesetfrombusy
[394.287265] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[394.896230] [108/134] (643s left) kms_flip (2x-dpms-vs-vblank-race)
[395.383857] Starting subtest: 2x-dpms-vs-vblank-race
[395.386203] Starting dynamic subtest: AB-VGA1-HDMI-A1
[406.044369] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.659s)
[406.046959] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.662s)
[406.787931] [109/134] (631s left) gem_exec_params (readonly)
[406.880507] Starting subtest: readonly
[406.881401] Subtest readonly: SUCCESS (0.001s)
[407.019884] [110/134] (631s left) kms_vblank (invalid)
[407.503102] Starting subtest: invalid
[407.504620] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.715110] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.210s)
[407.715928] Subtest invalid: SUCCESS (0.213s)
[408.427260] [111/134] (630s left) gem_exec_reloc (basic-cpu-read-noreloc)
[408.489112] Starting subtest: basic-cpu-read-noreloc
[408.491682] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[409.526571] [112/134] (628s left) gem_ctx_persistence (engines-hostile)
[409.584626] Subtest engines-hostile: SKIP (0.000s)
[409.650213] [113/134] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[410.139753] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[412.052107] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.911s)
[412.720429] [114/134] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[413.211966] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[413.213287] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[413.824842] [115/134] (624s left) gem_caching (writes)
[413.889192] Starting subtest: writes
[416.848957] Subtest writes: SUCCESS (2.961s)
[417.026514] [116/134] (621s left) kms_pm_backlight (fade-with-suspend)
[417.508246] Subtest fade-with-suspend: SKIP (0.000s)
[417.804668] [117/134] (620s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[418.290896] Starting subtest: coverage-vs-premult-vs-constant
[418.450473] Subtest coverage-vs-premult-vs-constant: SKIP (0.160s)
[419.213708] [118/134] (619s left) kms_lease (master-vs-lease)
[419.703844] Starting subtest: master-vs-lease
[419.704688] Subtest master-vs-lease: SUCCESS (0.002s)
[420.305423] [119/134] (618s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[420.789283] Starting subtest: psr-rgb565-draw-mmap-wc
[420.790650] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[421.393373] [120/134] (617s left) kms_addfb_basic (addfb25-4-tiled)
[421.880956] Starting subtest: addfb25-4-tiled
[421.881817] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[422.486156] [121/134] (616s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[422.540968] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[422.599507] [122/134] (616s left) kms_plane_multiple (2x-tiling-x)
[423.086937] Starting subtest: 2x-tiling-x
[423.088183] Subtest 2x-tiling-x: SKIP (0.000s)
[423.703559] [123/134] (615s left) kms_psr (psr2-primary-render)
[424.184627] Subtest psr2-primary-render: SKIP (0.000s)
[424.478296] [124/134] (614s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[424.542090] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[424.642270] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[424.783629] [125/134] (614s left) gem_exec_balancer (full)
[424.841846] Subtest full: SKIP (0.000s)
[424.968571] [126/134] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[425.459939] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[425.461297] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[426.062827] [127/134] (613s left) gem_mmap_wc (write-read)
[426.124835] Starting subtest: write-read
[426.138673] Subtest write-read: SUCCESS (0.015s)
[426.263762] [128/134] (613s left) gem_ctx_persistence (process)
[426.320671] Subtest process: SKIP (0.000s)
[426.390568] [129/134] (613s left) gem_ctx_param (non-root-set)
[426.446998] Starting subtest: non-root-set
[426.474626] Subtest non-root-set: SUCCESS (0.027s)
[426.613387] [130/134] (612s left) sw_sync (timeline_closed)
[426.670788] Starting subtest: timeline_closed
[426.671518] Subtest timeline_closed: SUCCESS (0.000s)
[426.759862] [131/134] (612s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[427.241688] Starting subtest: primary-4-tiled-reflect-x-180
[427.243169] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s)
[427.844979] [132/134] (611s left) gem_exec_parallel (basic)
[427.909473] Starting subtest: basic
[427.910413] Starting dynamic subtest: rcs0
[429.631865] Dynamic subtest rcs0: SUCCESS (1.721s)
[429.652056] Starting dynamic subtest: bcs0
[431.406787] Dynamic subtest bcs0: SUCCESS (1.772s)
[431.411461] Subtest basic: SUCCESS (3.499s)
[431.652820] [133/134] (607s left) kms_content_protection (uevent-hdcp14)
[432.158492] Starting subtest: uevent-hdcp14
[432.159870] Subtest uevent-hdcp14: SKIP (0.000s)
[432.766335] [134/134] (606s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[432.825161] Starting subtest: multi-wait-all-for-submit-available-signaled
[432.827287] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[432.937414] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_ctx_engines
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: i915_pm_freq_api
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: sysfs_heartbeat_interval
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_exec_await
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rps
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: core_setmaster_vs_auth
results: parsing output: 84/ for test: prime_busy
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: core_getstats
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_caching
results: parsing output: 115/ for test: kms_pm_backlight
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: gem_exec_parallel
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: syncobj_timeline
Done.