[68.177595] Initializing watchdogs
[68.177740]   /dev/watchdog0
[68.203760] [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)
[68.211416] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.215109] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.218493] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[68.742486] Starting subtest: cursor-offscreen-256x85
[68.801840] Subtest cursor-offscreen-256x85: SKIP (0.058s)
[69.394687] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[69.447935] Starting subtest: cpuset-big-copy-odd
[72.931311] Subtest cpuset-big-copy-odd: SUCCESS (3.483s)
[73.167077] [003/134] (955s left) gem_ctx_engines (execute-allforone)
[73.328012] Starting subtest: execute-allforone
[73.330475] Subtest execute-allforone: SUCCESS (0.003s)
[73.591870] [004/134] (955s left) perf_pmu (busy-idle)
[73.653021] Starting subtest: busy-idle
[73.654295] Starting dynamic subtest: rcs0
[74.286670] Dynamic subtest rcs0: SUCCESS (0.635s)
[74.306396] Starting dynamic subtest: bcs0
[74.926706] Dynamic subtest bcs0: SUCCESS (0.639s)
[74.946335] Starting dynamic subtest: vcs0
[76.068565] Dynamic subtest vcs0: SUCCESS (1.141s)
[76.070029] Subtest busy-idle: SUCCESS (2.418s)
[76.190940] [005/134] (952s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[76.704736] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[76.709225] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[77.303364] [006/134] (951s left) api_intel_bb (lot-of-buffers)
[77.360653] Starting subtest: lot-of-buffers
[78.085749] Subtest lot-of-buffers: SUCCESS (0.724s)
[78.386074] [007/134] (950s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[78.448610] Starting subtest: yf-tiled-to-vebox-x-tiled
[78.451209] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[78.682214] [008/134] (950s left) kms_plane (plane-panning-top-left)
[79.177473] Starting subtest: plane-panning-top-left
[79.179416] Starting dynamic subtest: pipe-A
[79.778322] Dynamic subtest pipe-A: SUCCESS (0.599s)
[79.793125] Starting dynamic subtest: pipe-B
[80.400960] Dynamic subtest pipe-B: SUCCESS (0.621s)
[80.402144] Subtest plane-panning-top-left: SUCCESS (1.223s)
[81.125996] [009/134] (947s left) kms_psr (fbc-psr-cursor-plane-onoff)
[81.619294] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[81.938294] [010/134] (947s left) kms_cursor_crc (cursor-tearing-position-change)
[82.436942] Starting subtest: cursor-tearing-position-change
[82.438498] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.828669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.391s)
[82.851958] Starting dynamic subtest: pipe-B-HDMI-A-1
[83.228195] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.398s)
[83.229232] Subtest cursor-tearing-position-change: SUCCESS (0.792s)
[83.933385] [011/134] (945s left) kms_frontbuffer_tracking (basic)
[84.429452] Starting subtest: basic
[86.864214] Subtest basic: SUCCESS (2.435s)
[87.476317] [012/134] (941s left) gem_spin_batch (spin-each)
[87.543912] Starting subtest: spin-each
[90.877348] Subtest spin-each: SUCCESS (3.333s)
[91.134415] [013/134] (938s left) gem_exec_reloc (basic-gtt-cpu)
[91.194203] Starting subtest: basic-gtt-cpu
[91.197195] Subtest basic-gtt-cpu: SUCCESS (0.004s)
[92.214157] [014/134] (937s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[92.707478] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[92.752860] Starting dynamic subtest: pipe-A-plane-0
[92.755252] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[92.766985] Starting dynamic subtest: pipe-A-plane-1
[92.769441] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[92.780410] Starting dynamic subtest: pipe-A-plane-2
[92.782554] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[92.978164] Starting dynamic subtest: pipe-B-plane-0
[92.980554] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[92.992053] Starting dynamic subtest: pipe-B-plane-1
[92.994329] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[93.004841] Starting dynamic subtest: pipe-B-plane-2
[93.007184] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[93.049092] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.341s)
[93.764112] [015/134] (935s left) gem_render_copy (y-tiled-ccs-to-linear)
[93.826725] Starting subtest: y-tiled-ccs-to-linear
[93.828156] Starting dynamic subtest: smem
[93.830386] Dynamic subtest smem: SKIP (0.000s)
[93.832662] Subtest y-tiled-ccs-to-linear: SKIP (0.001s)
[94.063736] [016/134] (935s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[94.567921] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[94.570274] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[95.162161] [017/134] (934s left) kms_psr (pr-sprite-render)
[95.655101] Subtest pr-sprite-render: SKIP (0.000s)
[95.958104] [018/134] (933s left) gen9_exec_parse (shadow-peek)
[96.016966] Subtest shadow-peek: SKIP (0.000s)
[96.072611] [019/134] (933s left) perf (invalid-remove-userspace-config)
[96.256647] Subtest invalid-remove-userspace-config: SKIP (0.000s)
[96.311890] [020/134] (933s left) gem_ctx_param (invalid-size-set)
[96.367367] Starting subtest: invalid-size-set
[96.368466] Subtest invalid-size-set: SUCCESS (0.000s)
[96.496283] [021/134] (933s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[96.550372] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[96.607289] [022/134] (933s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.665731] Starting subtest: invalid-bsd2-flag-on-blt
[96.666872] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.809239] [023/134] (932s left) gem_render_copy (yf-tiled-ccs-to-linear)
[96.874389] Starting subtest: yf-tiled-ccs-to-linear
[96.875752] Starting dynamic subtest: smem
[96.878183] Dynamic subtest smem: SKIP (0.000s)
[96.880543] Subtest yf-tiled-ccs-to-linear: SKIP (0.001s)
[97.110232] [024/134] (932s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[97.167789] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[97.274043] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[97.395677] [025/134] (932s left) gem_exec_fence (invalid-timeline-fence-array)
[97.741767] Starting subtest: invalid-timeline-fence-array
[97.746640] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[98.025617] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[98.028333] [026/134] (931s left) kms_chamelium_edid (dp-edid-read)
[98.595991] Subtest dp-edid-read: SKIP (0.000s)
[98.998376] [027/134] (930s left) gem_exec_params (invalid-bsd1-flag-on-render)
[99.055317] Starting subtest: invalid-bsd1-flag-on-render
[99.056683] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[99.186284] [028/134] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[99.684025] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.686354] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[100.285768] [029/134] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[100.341019] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[100.395700] [030/134] (929s left) gem_eio (kms)
[100.893078] Starting subtest: kms
[105.694940] Subtest kms: SUCCESS (4.802s)
[106.445557] [031/134] (923s left) kms_cursor_legacy (torture-move)
[106.937280] Starting subtest: torture-move
[106.938317] Starting dynamic subtest: pipe-A
[112.473138] Dynamic subtest pipe-A: SUCCESS (5.531s)
[112.485498] Starting dynamic subtest: pipe-B
[118.048398] Dynamic subtest pipe-B: SUCCESS (5.576s)
[118.063022] Starting dynamic subtest: all-pipes
[123.591514] Dynamic subtest all-pipes: SUCCESS (5.544s)
[123.592630] Subtest torture-move: SUCCESS (16.655s)
[124.221804] [032/134] (905s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[124.274456] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[124.332774] [033/134] (905s left) gem_exec_capture (pi)
[124.390195] Subtest pi: SKIP (0.000s)
[124.466577] [034/134] (905s left) syncobj_timeline (wait-all-snapshot)
[124.520787] Starting subtest: wait-all-snapshot
[124.603304] Subtest wait-all-snapshot: SUCCESS (0.082s)
[124.739520] [035/134] (905s left) kms_async_flips (test-cursor-atomic)
[125.226805] Starting subtest: test-cursor-atomic
[125.358343] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.503485] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s)
[125.661323] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.752302] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.102s)
[125.753474] Subtest test-cursor-atomic: SUCCESS (0.527s)
[126.615328] [036/134] (903s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[127.118147] Starting subtest: x-tiled-32bpp-rotate-180
[128.561803] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.443s)
[129.193974] [037/134] (901s left) i915_pm_freq_api (freq-reset)
[129.255586] Subtest freq-reset: SKIP (0.000s)
[129.325262] [038/134] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[129.823362] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[131.655426] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.834s)
[132.303762] [039/134] (898s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[132.358723] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[132.416699] [040/134] (898s left) gem_mmap (short-mmap)
[132.473089] Starting subtest: short-mmap
[132.474185] Subtest short-mmap: SUCCESS (0.000s)
[132.621413] [041/134] (898s left) vgem_basic (dmabuf-export)
[132.689142] Starting subtest: dmabuf-export
[132.691356] Subtest dmabuf-export: SUCCESS (0.003s)
[132.836351] [042/134] (897s left) gem_render_copy (y-tiled)
[132.897758] Starting subtest: y-tiled
[132.898890] Starting dynamic subtest: smem
[132.963290] Dynamic subtest smem: SUCCESS (0.064s)
[132.966645] Subtest y-tiled: SUCCESS (0.066s)
[133.204455] [043/134] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[133.698631] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[133.700918] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[134.285099] [044/134] (896s left) gem_exec_schedule (implicit-write-read)
[134.356210] Starting subtest: implicit-write-read
[134.357686] Starting dynamic subtest: rcs0
[134.389180] Dynamic subtest rcs0: SUCCESS (0.032s)
[134.403879] Starting dynamic subtest: bcs0
[134.421085] Dynamic subtest bcs0: SUCCESS (0.030s)
[134.422296] Subtest implicit-write-read: SUCCESS (0.065s)
[134.683979] [045/134] (896s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[135.183147] Starting subtest: 4-tiled-64bpp-rotate-90
[135.185248] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[135.779811] [046/134] (895s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[136.276746] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[136.279456] Starting dynamic subtest: A-VGA1
[144.295707] Dynamic subtest A-VGA1: SUCCESS (8.019s)
[144.309533] Starting dynamic subtest: B-VGA1
[152.267925] Dynamic subtest B-VGA1: SUCCESS (7.972s)
[152.282205] Starting dynamic subtest: A-HDMI-A1
[160.421423] Dynamic subtest A-HDMI-A1: SUCCESS (8.153s)
[160.435405] Starting dynamic subtest: B-HDMI-A1
[168.602906] Dynamic subtest B-HDMI-A1: SUCCESS (8.181s)
[168.604554] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.334s)
[169.387328] [047/134] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[169.881045] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[169.883223] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.487562] [048/134] (860s left) kms_color_pipeline (plane-lut1d)
[170.978618] Starting subtest: plane-lut1d
[171.248364] Subtest plane-lut1d: SKIP (0.270s)
[171.959099] [049/134] (859s left) i915_pm_rc6_residency (rc6-accuracy)
[172.015088] Starting subtest: rc6-accuracy
[172.016193] Starting dynamic subtest: gt0
[175.185512] Dynamic subtest gt0: SUCCESS (3.169s)
[175.186795] Subtest rc6-accuracy: SUCCESS (3.171s)
[175.318932] [050/134] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[175.806834] Starting subtest: basic-flip-before-cursor-atomic
[176.782505] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.974s)
[177.499741] [051/134] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[177.992260] Starting subtest: psr-2p-primscrn-spr-indfb-move
[177.994373] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[178.594128] [052/134] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[179.085764] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[179.087967] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.690677] [053/134] (851s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[180.184857] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[180.487339] [054/134] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[180.541548] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[180.649675] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[180.776802] [055/134] (850s left) gem_mmap_wc (bad-size)
[180.831043] Starting subtest: bad-size
[180.832135] Subtest bad-size: SUCCESS (0.001s)
[180.976495] [056/134] (850s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[181.468892] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[181.471100] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[182.068242] [057/134] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[182.560265] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[182.562737] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[183.167911] [058/134] (848s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[183.652532] Starting subtest: cursorA-vs-flipB-atomic
[183.654613] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[184.248130] [059/134] (847s left) sysfs_heartbeat_interval (nopreempt)
[184.309687] Starting subtest: nopreempt
[184.312549] Starting dynamic subtest: vcs0
[184.314737] Dynamic subtest vcs0: SKIP (0.000s)
[184.330294] Starting dynamic subtest: bcs0
[184.333093] Dynamic subtest bcs0: SKIP (0.000s)
[184.351241] Starting dynamic subtest: rcs0
[184.353909] Dynamic subtest rcs0: SKIP (0.000s)
[184.356530] Subtest nopreempt: SKIP (0.005s)
[184.447829] [060/134] (847s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[184.939234] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[184.941473] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[185.550599] [061/134] (846s left) gem_wait (busy)
[185.622913] Starting subtest: busy
[185.624086] Starting dynamic subtest: all-engines
[186.146721] Dynamic subtest all-engines: SUCCESS (0.523s)
[186.162461] Starting dynamic subtest: rcs0
[186.660745] Dynamic subtest rcs0: SUCCESS (0.512s)
[186.674407] Starting dynamic subtest: bcs0
[187.177586] Dynamic subtest bcs0: SUCCESS (0.515s)
[187.191597] Starting dynamic subtest: vcs0
[187.699768] Dynamic subtest vcs0: SUCCESS (0.520s)
[187.703192] Subtest busy: SUCCESS (2.079s)
[187.961403] [062/134] (843s left) kms_setmode (clone-exclusive-crtc)
[188.019176] Starting subtest: clone-exclusive-crtc
[188.022990] Subtest clone-exclusive-crtc: SKIP (0.000s)
[188.141158] [063/134] (843s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[188.628471] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[188.917698] [064/134] (842s left) sw_sync (sync_merge_same)
[188.975371] Starting subtest: sync_merge_same
[188.976778] Subtest sync_merge_same: SUCCESS (0.000s)
[189.071965] [065/134] (842s left) kms_hdr (static-toggle)
[189.553079] Starting subtest: static-toggle
[189.556458] Subtest static-toggle: SKIP (0.000s)
[190.152832] [066/134] (841s left) gem_exec_await (wide-contexts)
[190.239274] Starting subtest: wide-contexts
[211.989323] Subtest wide-contexts: SUCCESS (21.749s)
[212.240086] [067/134] (819s left) kms_invalid_mode (uint-max-clock)
[212.812264] Starting subtest: uint-max-clock
[212.813337] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.889233] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.075s)
[212.903340] Starting dynamic subtest: pipe-B-HDMI-A-1
[212.904392] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[212.905441] Subtest uint-max-clock: SUCCESS (0.080s)
[213.369765] [068/134] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[213.864137] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[215.777753] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.915s)
[216.411970] [069/134] (815s left) kms_pm_rpm (modeset-non-lpsp)
[228.265982] Subtest modeset-non-lpsp: SKIP (0.000s)
[228.566183] [070/134] (803s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[229.057700] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[229.368132] [071/134] (802s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[229.861577] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[231.314463] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.455s)
[231.944631] [072/134] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[232.433345] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[232.435439] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[233.056486] [073/134] (799s left) i915_pm_rps (thresholds-idle)
[233.116369] Starting subtest: thresholds-idle
[233.117424] Starting dynamic subtest: gt0
[243.526343] Dynamic subtest gt0: SUCCESS (10.409s)
[243.529840] Subtest thresholds-idle: SUCCESS (10.412s)
[243.656620] [074/134] (788s left) kms_vblank (query-idle-hang)
[244.143977] Starting subtest: query-idle-hang
[244.145078] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.987436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.842s)
[250.005612] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.945409] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.954s)
[255.946546] Subtest query-idle-hang: SUCCESS (11.803s)
[256.657830] [075/134] (775s left) perf_pmu (most-busy-idle-check-all)
[256.720251] Starting subtest: most-busy-idle-check-all
[256.721389] Starting dynamic subtest: rcs0
[257.339561] Dynamic subtest rcs0: SUCCESS (0.618s)
[257.355340] Starting dynamic subtest: bcs0
[257.959513] Dynamic subtest bcs0: SUCCESS (0.617s)
[257.975672] Starting dynamic subtest: vcs0
[258.585571] Dynamic subtest vcs0: SUCCESS (0.623s)
[258.589045] Subtest most-busy-idle-check-all: SUCCESS (1.867s)
[258.721373] [076/134] (773s left) kms_atomic_interruptible (universal-setplane-cursor)
[259.212527] Starting subtest: universal-setplane-cursor
[259.215432] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.493437] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.279s)
[265.494460] Subtest universal-setplane-cursor: SUCCESS (6.282s)
[266.214455] [077/134] (766s left) gem_userptr_blits (process-exit-busy)
[266.286408] Starting subtest: process-exit-busy
[266.305553] Subtest process-exit-busy: SUCCESS (0.019s)
[266.479991] [078/134] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[266.971312] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[266.973403] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[267.577117] [079/134] (765s left) gem_lmem_swapping (heavy-verify-multi)
[267.637148] Subtest heavy-verify-multi: SKIP (0.000s)
[267.708561] [080/134] (765s left) gen9_exec_parse (bb-start-cmd)
[267.765363] Subtest bb-start-cmd: SKIP (0.000s)
[267.820092] [081/134] (765s left) fbdev (unaligned-read)
[267.895831] Starting subtest: unaligned-read
[267.905210] Subtest unaligned-read: SUCCESS (0.011s)
[268.029330] [082/134] (764s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[268.592208] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[269.002983] [083/134] (763s left) gem_ppgtt (blt-vs-render-ctx0)
[269.060040] Starting subtest: blt-vs-render-ctx0
[301.622403] Subtest blt-vs-render-ctx0: SUCCESS (32.563s)
[301.793428] [084/134] (731s left) core_setmaster_vs_auth
[302.073050] [085/134] (730s left) prime_busy (hang)
[302.133361] Starting subtest: hang
[302.134619] Starting dynamic subtest: rcs0
[307.888772] Dynamic subtest rcs0: SUCCESS (5.754s)
[307.904469] Starting dynamic subtest: bcs0
[313.903174] Dynamic subtest bcs0: SUCCESS (6.013s)
[313.916370] Starting dynamic subtest: vcs0
[319.862206] Dynamic subtest vcs0: SUCCESS (5.957s)
[319.863332] Subtest hang: SUCCESS (17.730s)
[320.019434] [086/134] (713s left) gem_eio (unwedge-stress)
[320.081403] Starting subtest: unwedge-stress
[320.084107] Starting dynamic subtest: render
[321.831231] Dynamic subtest render: SUCCESS (1.747s)
[321.844451] Starting dynamic subtest: bsd
[323.050237] Dynamic subtest bsd: FAIL (1.174s)
[323.051306] Subtest unwedge-stress: FAIL (2.925s)
[324.046721] [087/134] (709s left) kms_cursor_crc (cursor-random-256x256)
[324.554273] Starting subtest: cursor-random-256x256
[324.557143] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.283403] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.725s)
[328.322585] Starting dynamic subtest: pipe-B-HDMI-A-1
[332.002322] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.690s)
[332.003518] Subtest cursor-random-256x256: SUCCESS (7.447s)
[332.713455] [088/134] (700s left) syncobj_timeline (multi-wait-submitted-signaled)
[332.779927] Starting subtest: multi-wait-submitted-signaled
[332.782976] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[332.914146] [089/134] (700s left) kms_dsc (dsc-with-formats)
[333.402140] Subtest dsc-with-formats: SKIP (0.000s)
[333.705858] [090/134] (699s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[334.194982] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[334.197145] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[334.821569] [091/134] (698s left) api_intel_allocator (reopen-fork)
[334.877191] Starting subtest: reopen-fork
[338.236762] Subtest reopen-fork: SUCCESS (3.359s)
[338.369840] [092/134] (695s left) gem_exec_whisper (basic-fds-priority-all)
[338.436786] Starting subtest: basic-fds-priority-all
[338.439186] Subtest basic-fds-priority-all: SKIP (0.001s)
[338.682446] [093/134] (694s left) gem_exec_fence (basic-wait-all)
[338.747609] Starting subtest: basic-wait-all
[338.784683] Subtest basic-wait-all: SUCCESS (0.037s)
[339.317335] [094/134] (694s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[339.371071] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[339.425761] [095/134] (694s left) kms_psr (fbc-psr2-no-drrs)
[339.907320] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[340.209029] [096/134] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.700633] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[340.704122] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.309724] [097/134] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[341.802242] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[341.804470] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[342.409125] [098/134] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[342.894294] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[344.834612] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.942s)
[345.483154] [099/134] (688s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[345.969316] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[345.970566] Starting dynamic subtest: pipe-A
[345.974336] Dynamic subtest pipe-A: SKIP (0.001s)
[345.987753] Starting dynamic subtest: pipe-B
[345.990921] Dynamic subtest pipe-B: SKIP (0.001s)
[345.993032] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[346.583849] [100/134] (687s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[346.642690] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[346.714295] [101/134] (687s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[347.200081] Starting subtest: flip-vs-cursor-busy-crc-atomic
[347.759938] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.561s)
[348.472936] [102/134] (685s left) core_getstats (basic)
[348.527243] Starting subtest: basic
[348.528346] Subtest basic: SUCCESS (0.000s)
[348.656992] [103/134] (685s left) gem_mmap_gtt (hang-busy)
[348.714969] Starting subtest: hang-busy
[354.865726] Subtest hang-busy: SUCCESS (6.152s)
[355.025161] [104/134] (679s left) kms_flip (flip-vs-expired-vblank-interruptible)
[355.511965] Starting subtest: flip-vs-expired-vblank-interruptible
[355.514936] Starting dynamic subtest: A-VGA1
[363.237801] Dynamic subtest A-VGA1: SUCCESS (7.724s)
[363.253153] Starting dynamic subtest: B-VGA1
[370.926988] Dynamic subtest B-VGA1: SUCCESS (7.686s)
[370.942562] Starting dynamic subtest: A-HDMI-A1
[378.649173] Dynamic subtest A-HDMI-A1: SUCCESS (7.719s)
[378.664701] Starting dynamic subtest: B-HDMI-A1
[386.399762] Dynamic subtest B-HDMI-A1: SUCCESS (7.748s)
[386.403598] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.890s)
[387.192461] [105/134] (646s left) gem_exec_schedule (preempt-queue-contexts)
[387.264794] Subtest preempt-queue-contexts: SKIP (0.000s)
[387.507307] [106/134] (646s left) perf (oa-formats)
[387.677529] Subtest oa-formats: SKIP (0.000s)
[387.736127] [107/134] (646s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[388.224326] Starting subtest: fbcpsr-modesetfrombusy
[388.226604] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[388.838325] [108/134] (645s left) kms_flip (2x-dpms-vs-vblank-race)
[389.319115] Starting subtest: 2x-dpms-vs-vblank-race
[389.320237] Starting dynamic subtest: AB-VGA1-HDMI-A1
[399.979862] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.659s)
[399.983270] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.663s)
[400.710660] [109/134] (633s left) gem_exec_params (readonly)
[400.779282] Starting subtest: readonly
[400.780429] Subtest readonly: SUCCESS (0.001s)
[400.941510] [110/134] (633s left) kms_vblank (invalid)
[401.426601] Starting subtest: invalid
[401.427635] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.639082] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.210s)
[401.640189] Subtest invalid: SUCCESS (0.214s)
[402.358120] [111/134] (632s left) gem_exec_reloc (basic-cpu-read-noreloc)
[402.419234] Starting subtest: basic-cpu-read-noreloc
[402.421809] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[403.455620] [112/134] (631s left) gem_ctx_persistence (engines-hostile)
[403.516256] Subtest engines-hostile: SKIP (0.000s)
[403.581900] [113/134] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[404.071232] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[405.994204] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.925s)
[406.647367] [114/134] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[407.136098] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[407.138173] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[407.746970] [115/134] (626s left) gem_caching (writes)
[407.805619] Starting subtest: writes
[410.719785] Subtest writes: SUCCESS (2.914s)
[410.887198] [116/134] (623s left) kms_pm_backlight (fade-with-suspend)
[411.377310] Subtest fade-with-suspend: SKIP (0.000s)
[411.681754] [117/134] (623s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[412.161248] Starting subtest: coverage-vs-premult-vs-constant
[412.321462] Subtest coverage-vs-premult-vs-constant: SKIP (0.161s)
[413.114259] [118/134] (621s left) kms_lease (master-vs-lease)
[413.595347] Starting subtest: master-vs-lease
[413.596396] Subtest master-vs-lease: SUCCESS (0.002s)
[414.196840] [119/134] (620s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[414.685427] Starting subtest: psr-rgb565-draw-mmap-wc
[414.687535] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[415.294601] [120/134] (619s left) kms_addfb_basic (addfb25-4-tiled)
[415.779193] Starting subtest: addfb25-4-tiled
[415.780321] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[416.387943] [121/134] (618s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[416.444408] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[416.500776] [122/134] (618s left) kms_plane_multiple (2x-tiling-x)
[416.981577] Starting subtest: 2x-tiling-x
[416.983776] Subtest 2x-tiling-x: SKIP (0.000s)
[417.570971] [123/134] (617s left) kms_psr (psr2-primary-render)
[418.055738] Subtest psr2-primary-render: SKIP (0.000s)
[418.347083] [124/134] (616s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[418.404994] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[418.506250] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[418.634417] [125/134] (616s left) gem_exec_balancer (full)
[418.693909] Subtest full: SKIP (0.000s)
[418.817454] [126/134] (616s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[419.304637] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[419.306848] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[419.928445] [127/134] (615s left) gem_mmap_wc (write-read)
[419.986455] Starting subtest: write-read
[420.000279] Subtest write-read: SUCCESS (0.015s)
[420.153565] [128/134] (615s left) gem_ctx_persistence (process)
[420.218255] Subtest process: SKIP (0.000s)
[420.276777] [129/134] (615s left) gem_ctx_param (non-root-set)
[420.331436] Starting subtest: non-root-set
[420.355391] Subtest non-root-set: SUCCESS (0.024s)
[420.499664] [130/134] (615s left) sw_sync (timeline_closed)
[420.555591] Starting subtest: timeline_closed
[420.556877] Subtest timeline_closed: SUCCESS (0.000s)
[420.660708] [131/134] (614s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[421.138883] Starting subtest: primary-4-tiled-reflect-x-180
[421.141144] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s)
[421.736610] [132/134] (613s left) gem_exec_parallel (basic)
[421.798928] Starting subtest: basic
[421.800057] Starting dynamic subtest: rcs0
[423.612232] Dynamic subtest rcs0: SUCCESS (1.812s)
[423.630384] Starting dynamic subtest: bcs0
[425.353042] Dynamic subtest bcs0: SUCCESS (1.738s)
[425.357908] Subtest basic: SUCCESS (3.556s)
[425.593602] [133/134] (610s left) kms_content_protection (uevent-hdcp14)
[426.101497] Starting subtest: uevent-hdcp14
[426.103748] Subtest uevent-hdcp14: SKIP (0.000s)
[426.734704] [134/134] (609s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[426.791775] Starting subtest: multi-wait-all-for-submit-available-signaled
[426.793651] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[426.933857] 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.