[76.977976] Initializing watchdogs
[76.978149]   /dev/watchdog0
[76.997381] [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)
[77.005452] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[77.009243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[77.015550] [001/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[77.503140] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[77.504858] Starting dynamic subtest: pipe-A
[77.512147] Dynamic subtest pipe-A: SKIP (0.002s)
[77.527144] Starting dynamic subtest: pipe-B
[77.535221] Dynamic subtest pipe-B: SKIP (0.001s)
[77.539119] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.004s)
[77.592790] [002/133] (959s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[78.170621] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[78.378607] [003/133] (959s left) gem_exec_params (no-blt)
[78.444217] Starting subtest: no-blt
[78.445977] Subtest no-blt: SUCCESS (0.000s)
[78.544634] [004/133] (959s left) gem_eio (in-flight-1us)
[78.621573] Starting subtest: in-flight-1us
[80.043506] Subtest in-flight-1us: SUCCESS (1.422s)
[80.566776] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[80.570706] [005/133] (957s left) gem_spin_batch (legacy)
[80.640384] Starting subtest: legacy
[80.642155] Starting dynamic subtest: default
[83.954859] Dynamic subtest default: SUCCESS (3.310s)
[83.965200] Starting dynamic subtest: render
[87.266864] Dynamic subtest render: SUCCESS (3.311s)
[87.277112] Starting dynamic subtest: bsd
[90.578184] Dynamic subtest bsd: SUCCESS (3.310s)
[90.588371] Starting dynamic subtest: bsd1
[93.889493] Dynamic subtest bsd1: SUCCESS (3.310s)
[93.899802] Starting dynamic subtest: blt
[97.200761] Dynamic subtest blt: SUCCESS (3.310s)
[97.202388] Subtest legacy: SUCCESS (16.554s)
[97.422858] [006/133] (940s left) sw_sync (sync_multi_consumer)
[97.486501] Starting subtest: sync_multi_consumer
[98.371881] Subtest sync_multi_consumer: SUCCESS (0.886s)
[98.447873] [007/133] (939s left) syncobj_timeline (wait-any-complex)
[98.506760] Starting subtest: wait-any-complex
[98.571683] Subtest wait-any-complex: SUCCESS (0.063s)
[98.670020] [008/133] (939s left) gem_exec_schedule (implicit-write-read)
[98.743162] Starting subtest: implicit-write-read
[98.744858] Starting dynamic subtest: rcs0
[98.774964] Dynamic subtest rcs0: SUCCESS (0.031s)
[98.786571] Starting dynamic subtest: bcs0
[98.803996] Dynamic subtest bcs0: SUCCESS (0.029s)
[98.805851] Subtest implicit-write-read: SUCCESS (0.061s)
[99.034150] [009/133] (938s left) gem_exec_reloc (basic-cpu-read)
[99.095858] Starting subtest: basic-cpu-read
[99.099346] Subtest basic-cpu-read: SUCCESS (0.004s)
[99.614943] [010/133] (938s left) kms_rotation_crc (exhaust-fences)
[100.088098] Starting subtest: exhaust-fences
[100.092272] Subtest exhaust-fences: SKIP (0.000s)
[100.182486] [011/133] (937s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[100.667911] Starting subtest: cursorA-vs-flipB-toggle
[111.660494] Subtest cursorA-vs-flipB-toggle: SUCCESS (10.991s)
[111.923676] [012/133] (926s left) gem_exec_params (rel-constants-invalid-ring)
[111.991046] Starting subtest: rel-constants-invalid-ring
[111.992858] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[112.106794] [013/133] (926s left) gem_exec_await (wide-contexts)
[112.197047] Starting subtest: wide-contexts
[134.156937] Subtest wide-contexts: SUCCESS (21.956s)
[134.379416] [014/133] (903s left) kms_content_protection (suspend-resume)
[134.970668] Starting subtest: suspend-resume
[134.975027] Subtest suspend-resume: SKIP (0.000s)
[135.076268] [015/133] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[135.588712] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[137.116238] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (1.529s)
[137.262908] [016/133] (901s left) prime_busy (hang-wait)
[137.333035] Starting subtest: hang-wait
[137.334983] Starting dynamic subtest: rcs0
[143.864263] Dynamic subtest rcs0: SUCCESS (6.528s)
[143.876122] Starting dynamic subtest: bcs0
[149.872927] Dynamic subtest bcs0: SUCCESS (6.012s)
[149.884831] Starting dynamic subtest: vcs0
[155.888801] Dynamic subtest vcs0: SUCCESS (6.016s)
[155.890506] Subtest hang-wait: SUCCESS (18.558s)
[156.014599] [017/133] (882s left) kms_big_fb (x-tiled-addfb)
[156.505927] Starting subtest: x-tiled-addfb
[156.507912] Subtest x-tiled-addfb: SUCCESS (0.000s)
[156.608651] [018/133] (881s left) core_setmaster_vs_auth
[156.768573] [019/133] (881s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[157.251371] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[157.319584] [020/133] (881s left) api_intel_allocator (fork-simple-stress)
[157.384305] Starting subtest: fork-simple-stress
[162.815863] Subtest fork-simple-stress: SUCCESS (5.430s)
[162.929663] [021/133] (875s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[163.422037] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[163.426277] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[163.527924] [022/133] (875s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[164.018043] Starting subtest: cursor-rapid-movement-32x10
[164.070705] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[164.196889] [023/133] (874s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[164.272710] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[164.274817] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[164.363691] [024/133] (874s left) syncobj_wait (invalid-signal-illegal-handle)
[164.430457] Starting subtest: invalid-signal-illegal-handle
[164.432341] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[164.526822] [025/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[165.016999] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[165.021098] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[165.131701] [026/133] (873s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[165.624808] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[167.955336] Subtest fbc-2p-primscrn-cur-indfb-onoff: SUCCESS (2.331s)
[168.106794] [027/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[168.598885] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[168.602943] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[168.708361] [028/133] (870s left) gen7_exec_parse (load-register-reg)
[168.775121] Subtest load-register-reg: SKIP (0.000s)
[168.834031] [029/133] (870s left) kms_pm_rpm (pm-caching)
[180.650580] Subtest pm-caching: SKIP (0.000s)
[180.707584] [030/133] (858s left) vgem_basic (busy-fence)
[180.780112] Starting subtest: busy-fence
[180.781880] Subtest busy-fence: SUCCESS (0.000s)
[180.860091] [031/133] (858s left) kms_flip (2x-blocking-wf_vblank)
[181.341634] Starting subtest: 2x-blocking-wf_vblank
[181.343404] Starting dynamic subtest: AB-VGA1-HDMI-A1
[212.102174] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.753s)
[212.104259] Subtest 2x-blocking-wf_vblank: SUCCESS (30.756s)
[212.353650] [032/133] (826s left) syncobj_wait (wait-all-delayed-signal)
[212.421509] Starting subtest: wait-all-delayed-signal
[212.525798] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[212.619382] [033/133] (826s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[212.679634] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[212.741292] [034/133] (826s left) gem_partial_pwrite_pread (reads-snoop)
[212.802801] Starting subtest: reads-snoop
[213.900042] Subtest reads-snoop: SUCCESS (1.096s)
[214.033752] [035/133] (825s left) gem_exec_async (concurrent-writes)
[214.100698] Starting subtest: concurrent-writes
[214.102418] Starting dynamic subtest: rcs0
[214.104055] Dynamic subtest rcs0: SUCCESS (0.002s)
[214.116322] Starting dynamic subtest: bcs0
[214.118041] Dynamic subtest bcs0: SUCCESS (0.001s)
[214.130828] Starting dynamic subtest: vcs0
[214.132679] Dynamic subtest vcs0: SUCCESS (0.002s)
[214.134478] Subtest concurrent-writes: SUCCESS (0.006s)
[214.334938] [036/133] (825s left) syncobj_timeline (invalid-transfer-non-existent-point)
[214.398087] Starting subtest: invalid-transfer-non-existent-point
[214.399850] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[214.484903] [037/133] (824s left) perf (oa-formats)
[214.644294] Subtest oa-formats: SKIP (0.000s)
[214.714159] [038/133] (824s left) syncobj_timeline (multi-wait-available-submitted)
[214.775013] Starting subtest: multi-wait-available-submitted
[214.777648] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[214.873323] [039/133] (824s left) kms_psr (pr-cursor-plane-move)
[215.357862] Subtest pr-cursor-plane-move: SKIP (0.000s)
[215.425415] [040/133] (824s left) kms_cursor_crc (cursor-onscreen-32x32)
[215.908895] Starting subtest: cursor-onscreen-32x32
[215.960663] Subtest cursor-onscreen-32x32: SKIP (0.050s)
[216.082666] [041/133] (823s left) gem_mmap_gtt (basic-write)
[216.147116] Starting subtest: basic-write
[216.292838] Subtest basic-write: SUCCESS (0.150s)
[216.405298] [042/133] (823s left) kms_lease (invalid-create-leases)
[216.894919] Starting subtest: invalid-create-leases
[216.900474] Subtest invalid-create-leases: SUCCESS (0.005s)
[216.995254] [043/133] (822s left) kms_pipe_crc_basic (nonblocking-crc)
[217.480137] Starting subtest: nonblocking-crc
[217.481947] Starting dynamic subtest: pipe-A-VGA-1
[218.101825] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.622s)
[218.115930] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.697023] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.593s)
[218.698813] Subtest nonblocking-crc: SUCCESS (1.218s)
[218.941642] [044/133] (820s left) gem_exec_whisper (basic-fds-priority-all)
[219.016103] Starting subtest: basic-fds-priority-all
[219.019728] Subtest basic-fds-priority-all: SKIP (0.001s)
[219.222676] [045/133] (820s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[219.284656] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[219.350345] [046/133] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[219.835894] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[221.930713] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.097s)
[222.082098] [047/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[222.570443] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[222.575141] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[222.681169] [048/133] (817s left) kms_sequence (get-forked)
[223.159045] Starting subtest: get-forked
[223.161046] Starting dynamic subtest: pipe-A-VGA-1
[225.543269] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.383s)
[225.557958] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.868378] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.324s)
[227.880883] Starting dynamic subtest: pipe-B-VGA-1
[230.116204] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.246s)
[230.128577] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.453496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.334s)
[232.455250] Subtest get-forked: SUCCESS (9.293s)
[232.703413] [049/133] (807s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[233.196100] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[235.137453] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SUCCESS (1.943s)
[235.285452] [050/133] (804s left) gem_lmem_swapping (verify)
[235.352356] Subtest verify: SKIP (0.000s)
[235.414587] [051/133] (804s left) kms_psr (fbc-psr-basic)
[235.895614] Subtest fbc-psr-basic: SKIP (0.000s)
[235.948854] [052/133] (804s left) gem_reg_read (timestamp-monotonic)
[236.016996] Starting subtest: timestamp-monotonic
[240.594812] Subtest timestamp-monotonic: SUCCESS (4.576s)
[240.695190] [053/133] (799s left) gem_ccs (block-multicopy-compressed)
[240.758557] Subtest block-multicopy-compressed: SKIP (0.000s)
[240.820359] [054/133] (799s left) kms_dsc (dsc-basic)
[241.300831] Subtest dsc-basic: SKIP (0.000s)
[241.369456] [055/133] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[241.854289] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[241.858299] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[241.959483] [056/133] (798s left) kms_pm_backlight (basic-brightness)
[242.434305] Subtest basic-brightness: SKIP (0.000s)
[242.504083] [057/133] (797s left) kms_flip (dpms-off-confusion)
[242.985536] Starting subtest: dpms-off-confusion
[242.988625] Starting dynamic subtest: A-VGA1
[250.772226] Dynamic subtest A-VGA1: SUCCESS (7.786s)
[250.786855] Starting dynamic subtest: B-VGA1
[258.482665] Dynamic subtest B-VGA1: SUCCESS (7.704s)
[258.495021] Starting dynamic subtest: A-HDMI-A1
[266.218876] Dynamic subtest A-HDMI-A1: SUCCESS (7.738s)
[266.231711] Starting dynamic subtest: B-HDMI-A1
[273.987424] Dynamic subtest B-HDMI-A1: SUCCESS (7.767s)
[273.989194] Subtest dpms-off-confusion: SUCCESS (31.003s)
[274.168586] [058/133] (766s left) gem_pxp (reject-modify-context-protection-off-3)
[276.748858] Starting subtest: reject-modify-context-protection-off-3
[276.753172] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[276.847936] [059/133] (763s left) kms_plane (plane-position-covered)
[277.325239] Starting subtest: plane-position-covered
[277.665564] Starting dynamic subtest: pipe-A-plane-1
[278.039257] Dynamic subtest pipe-A-plane-1: SUCCESS (0.374s)
[278.054109] Starting dynamic subtest: pipe-A-plane-2
[278.057696] Dynamic subtest pipe-A-plane-2: SUCCESS (0.005s)
[278.353766] Starting dynamic subtest: pipe-B-plane-1
[278.771846] Dynamic subtest pipe-B-plane-1: SUCCESS (0.426s)
[278.784635] Starting dynamic subtest: pipe-B-plane-2
[278.788987] Dynamic subtest pipe-B-plane-2: SUCCESS (0.009s)
[278.791146] Subtest plane-position-covered: SUCCESS (1.455s)
[279.039969] [060/133] (761s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[279.529071] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[279.532688] Starting dynamic subtest: AB-VGA1-HDMI-A1
[282.200330] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.669s)
[282.202388] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (2.673s)
[282.465390] [061/133] (758s left) gem_exec_capture (pi)
[282.533595] Subtest pi: SKIP (0.000s)
[282.607842] [062/133] (758s left) i915_pm_rpm (gem-pread)
[294.382468] Subtest gem-pread: SKIP (0.000s)
[294.434364] [063/133] (746s left) prime_self_import (basic-with_two_bos)
[294.494966] Starting subtest: basic-with_two_bos
[294.498554] Subtest basic-with_two_bos: SUCCESS (0.004s)
[294.603297] [064/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[295.088729] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[296.915945] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SUCCESS (1.827s)
[297.045733] [065/133] (743s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[297.115805] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[297.178887] [066/133] (743s left) i915_pm_rps (thresholds-idle-park)
[297.249096] Starting subtest: thresholds-idle-park
[297.250920] Starting dynamic subtest: gt0
[312.543056] Dynamic subtest gt0: SUCCESS (15.294s)
[312.544902] Subtest thresholds-idle-park: SUCCESS (15.296s)
[312.641263] [067/133] (728s left) gem_exec_params (cliprects-invalid)
[312.706927] Starting subtest: cliprects-invalid
[312.709139] Subtest cliprects-invalid: SUCCESS (0.000s)
[312.818525] [068/133] (728s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[312.895524] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[312.899062] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[313.093934] [069/133] (728s left) i915_hangman (gt-error-state-capture)
[313.157822] Starting subtest: gt-error-state-capture
[313.159564] Starting dynamic subtest: rcs0
[316.881187] Dynamic subtest rcs0: SUCCESS (3.722s)
[316.893609] Starting dynamic subtest: bcs0
[319.885830] Dynamic subtest bcs0: SUCCESS (3.003s)
[319.898396] Starting dynamic subtest: vcs0
[323.921693] Dynamic subtest vcs0: SUCCESS (4.034s)
[323.923622] Subtest gt-error-state-capture: SUCCESS (10.765s)
[323.988936] [070/133] (717s left) syncobj_eventfd (timeline-wait)
[324.051927] Starting subtest: timeline-wait
[324.061352] Subtest timeline-wait: SUCCESS (0.011s)
[324.174330] [071/133] (717s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[324.759838] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[324.991972] [072/133] (716s left) kms_prop_blob (blob-multiple)
[325.055053] Starting subtest: blob-multiple
[325.056853] Subtest blob-multiple: SUCCESS (0.002s)
[325.153905] [073/133] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[325.640931] Starting subtest: fbcpsr-rgb101010-draw-blt
[325.644974] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[325.759171] [074/133] (715s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[326.252832] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[326.256889] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[326.353569] [075/133] (715s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[326.851048] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[328.315029] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.465s)
[328.552100] [076/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[329.042937] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[329.046788] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[329.154388] [077/133] (712s left) i915_drm_fdinfo (virtual-busy)
[329.223302] Subtest virtual-busy: SKIP (0.000s)
[329.276999] [078/133] (712s left) kms_vblank (query-idle-hang)
[329.751921] Starting subtest: query-idle-hang
[329.754201] Starting dynamic subtest: pipe-A-VGA-1
[335.907896] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.152s)
[335.923079] Starting dynamic subtest: pipe-A-HDMI-A-1
[341.938922] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.031s)
[341.951772] Starting dynamic subtest: pipe-B-VGA-1
[347.932982] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.991s)
[347.949151] Starting dynamic subtest: pipe-B-HDMI-A-1
[353.976679] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.038s)
[353.978823] Subtest query-idle-hang: SUCCESS (24.221s)
[354.247436] [079/133] (687s left) kms_invalid_mode (bad-vsync-start)
[354.736310] Starting subtest: bad-vsync-start
[354.738033] Starting dynamic subtest: pipe-A-VGA-1
[354.847396] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.114s)
[354.861787] Starting dynamic subtest: pipe-A-HDMI-A-1
[354.863503] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[354.879662] Starting dynamic subtest: pipe-B-VGA-1
[354.881420] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[354.895917] Starting dynamic subtest: pipe-B-HDMI-A-1
[354.897601] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[354.899202] Subtest bad-vsync-start: SUCCESS (0.122s)
[355.110909] [080/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[355.598172] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[355.602183] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[355.710590] [081/133] (686s left) gem_ctx_persistence (engines-queued)
[355.778569] Subtest engines-queued: SKIP (0.000s)
[355.840119] [082/133] (686s left) syncobj_wait (reset-signaled)
[355.906849] Starting subtest: reset-signaled
[355.908678] Subtest reset-signaled: SUCCESS (0.000s)
[356.007761] [083/133] (685s left) kms_dp_link_training (non-uhbr-sst)
[356.489237] Starting subtest: non-uhbr-sst
[356.501456] Subtest non-uhbr-sst: SKIP (0.000s)
[356.592616] [084/133] (685s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[357.081227] Starting subtest: yf-tiled-64bpp-rotate-270
[357.085275] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[357.200259] [085/133] (684s left) gem_ctx_param (set-priority-range)
[357.262853] Subtest set-priority-range: SKIP (0.000s)
[357.369233] [086/133] (684s left) gem_tiled_pread_pwrite
[357.846290] [087/133] (684s left) api_intel_bb (delta-check)
[357.983202] Starting subtest: delta-check
[357.986993] Subtest delta-check: SKIP (0.001s)
[358.105309] [088/133] (684s left) gem_vm_create (create-ext)
[358.171659] Subtest create-ext: SKIP (0.000s)
[358.236204] [089/133] (684s left) gem_softpin (evict-active-interruptible)
[358.303771] Starting subtest: evict-active-interruptible
[358.305437] Subtest evict-active-interruptible: SUCCESS (0.004s)
[358.438379] [090/133] (683s left) gem_eio (suspend)
[358.506892] Starting subtest: suspend
[369.911742] Subtest suspend: SUCCESS (11.344s)
[378.584894] [091/133] (671s left) intel_hwmon (hwmon-write)
[378.656158] Subtest hwmon-write: SKIP (0.000s)
[378.726149] [092/133] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[379.215322] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[379.219158] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[379.327231] [093/133] (671s left) kms_addfb_basic (bo-too-small)
[379.808299] Starting subtest: bo-too-small
[379.810136] Subtest bo-too-small: SUCCESS (0.001s)
[379.923482] [094/133] (670s left) perf_pmu (rc6-suspend)
[379.988946] Starting subtest: rc6-suspend
[403.016938] Subtest rc6-suspend: SUCCESS (6.910s)
[405.758330] [095/133] (646s left) kms_psr (fbc-pr-no-drrs)
[406.250035] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[406.324347] [096/133] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[406.817665] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[406.821874] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[406.930494] [097/133] (645s left) gem_exec_fence (long-history)
[407.150490] Starting subtest: long-history
[407.215476] Subtest long-history: SUCCESS (0.066s)
[407.547077] [098/133] (645s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[408.028791] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[408.032901] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[408.137016] [099/133] (644s left) kms_frontbuffer_tracking (psr-slowdraw)
[408.630340] Starting subtest: psr-slowdraw
[408.634389] Subtest psr-slowdraw: SKIP (0.000s)
[408.738417] [100/133] (644s left) kms_atomic_interruptible (legacy-cursor)
[409.225004] Starting subtest: legacy-cursor
[409.226641] Starting dynamic subtest: pipe-A-VGA-1
[415.543500] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.316s)
[415.546374] Subtest legacy-cursor: SUCCESS (6.318s)
[415.824694] [101/133] (637s left) gem_pipe_control_store_loop (fresh-buffer)
[415.891479] Starting subtest: fresh-buffer
[418.041642] Subtest fresh-buffer: SUCCESS (2.149s)
[418.177006] [102/133] (634s left) kms_busy (extended-pageflip-hang-oldfb)
[418.697476] Starting subtest: extended-pageflip-hang-oldfb
[418.699774] Starting dynamic subtest: pipe-A
[418.947351] Dynamic subtest pipe-A: SUCCESS (0.250s)
[418.963196] Starting dynamic subtest: pipe-B
[419.221283] Dynamic subtest pipe-B: SUCCESS (0.272s)
[419.222985] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.527s)
[419.510820] [103/133] (633s left) perf_pmu (busy-double-start)
[419.576202] Starting subtest: busy-double-start
[419.578120] Starting dynamic subtest: rcs0
[423.104137] Dynamic subtest rcs0: SUCCESS (3.528s)
[423.123608] Starting dynamic subtest: bcs0
[426.622044] Dynamic subtest bcs0: SUCCESS (3.515s)
[426.644967] Starting dynamic subtest: vcs0
[430.639937] Dynamic subtest vcs0: SUCCESS (4.015s)
[430.641921] Subtest busy-double-start: SUCCESS (11.066s)
[430.738482] [104/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[431.228915] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[433.195078] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.968s)
[433.452261] [105/133] (619s left) kms_psr (psr2-sprite-render)
[433.933371] Subtest psr2-sprite-render: SKIP (0.000s)
[433.999570] [106/133] (619s left) gem_ctx_persistence (legacy-engines-mixed-process)
[434.063156] Subtest legacy-engines-mixed-process: SKIP (0.000s)
[434.133415] [107/133] (619s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[434.620966] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[434.624942] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[434.741431] [108/133] (618s left) gem_ctx_bad_destroy (invalid-pad)
[434.803286] Starting subtest: invalid-pad
[434.805420] Subtest invalid-pad: SUCCESS (0.000s)
[434.904450] [109/133] (618s left) syncobj_wait (multi-wait-for-submit-signaled)
[434.969477] Starting subtest: multi-wait-for-submit-signaled
[434.971467] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[435.071808] [110/133] (618s left) kms_psr (psr-primary-render)
[435.554616] Subtest psr-primary-render: SKIP (0.000s)
[435.628925] [111/133] (617s left) kms_plane_lowres (tiling-4)
[436.111530] Starting subtest: tiling-4
[436.115855] Subtest tiling-4: SKIP (0.000s)
[436.214576] [112/133] (617s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[436.277705] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[436.345701] [113/133] (617s left) kms_color (ctm-0-25)
[436.828166] Starting subtest: ctm-0-25
[436.830476] Starting dynamic subtest: pipe-A-VGA-1
[438.158211] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.331s)
[438.178824] Starting dynamic subtest: pipe-A-HDMI-A-1
[439.619576] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.461s)
[439.638597] Starting dynamic subtest: pipe-B-VGA-1
[440.861058] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.238s)
[440.877441] Starting dynamic subtest: pipe-B-HDMI-A-1
[442.317133] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.455s)
[442.318897] Subtest ctm-0-25: SUCCESS (5.493s)
[442.583292] [114/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[443.075845] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[443.079812] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[443.186241] [115/133] (610s left) gem_create (create-clear)
[443.252281] Starting subtest: create-clear
[443.255323] Starting dynamic subtest: smem0
[475.959782] Dynamic subtest smem0: SUCCESS (32.709s)
[475.961467] Subtest create-clear: SUCCESS (32.712s)
[476.216728] [116/133] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[476.694505] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[476.697812] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[476.837603] [117/133] (577s left) kms_cursor_crc (cursor-sliding-32x10)
[477.318925] Starting subtest: cursor-sliding-32x10
[477.400634] Subtest cursor-sliding-32x10: SKIP (0.077s)
[477.515089] [118/133] (576s left) gem_exec_schedule (semaphore-user)
[477.589174] Subtest semaphore-user: SKIP (0.000s)
[477.798671] [119/133] (576s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[477.860192] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[477.929697] [120/133] (576s left) gem_exec_params (readonly)
[477.991740] Starting subtest: readonly
[477.993548] Subtest readonly: SUCCESS (0.001s)
[478.127009] [121/133] (576s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[478.615516] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[479.770195] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.153s)
[480.031708] [122/133] (574s left) kms_hdr (invalid-metadata-sizes)
[480.511496] Starting subtest: invalid-metadata-sizes
[480.519406] Subtest invalid-metadata-sizes: SKIP (0.000s)
[480.610106] [123/133] (573s left) gem_mmap_offset (mmap-unmap)
[480.674735] Starting subtest: mmap-unmap
[480.677392] Starting dynamic subtest: smem0
[549.353319] Dynamic subtest smem0: SUCCESS (68.679s)
[549.356343] Subtest mmap-unmap: SUCCESS (68.681s)
[549.562890] [124/133] (504s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[549.642979] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[549.748498] [125/133] (504s left) gem_lmem_swapping (heavy-multi)
[549.810093] Subtest heavy-multi: SKIP (0.000s)
[549.875657] [126/133] (504s left) kms_addfb_basic (invalid-get-prop-any)
[549.937420] Starting subtest: invalid-get-prop-any
[549.939194] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[550.467110] [127/133] (504s left) dmabuf_sync_file (export-multiwait)
[550.552629] Starting subtest: export-multiwait
[550.554925] Subtest export-multiwait: SUCCESS (0.001s)
[550.635729] [128/133] (503s left) gem_exec_balancer (parallel)
[550.702853] Subtest parallel: SKIP (0.000s)
[550.801411] [129/133] (503s left) gem_softpin (overlap)
[550.872718] Starting subtest: overlap
[551.062009] Subtest overlap: SUCCESS (0.191s)
[551.185462] [130/133] (503s left) kms_psr (fbc-pr-primary-page-flip)
[551.667640] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[551.733439] [131/133] (503s left) gem_pxp (display-protected-crc)
[554.308782] Starting subtest: display-protected-crc
[554.312555] Subtest display-protected-crc: SKIP (0.000s)
[554.410875] [132/133] (500s left) kms_atomic (crtc-invalid-params)
[554.890059] Starting subtest: crtc-invalid-params
[554.891776] Starting dynamic subtest: pipe-A-VGA-1
[555.049335] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.158s)
[555.051245] Subtest crtc-invalid-params: SUCCESS (0.161s)
[555.314332] [133/133] (499s left) syncobj_wait (invalid-reset-one-illegal-handle)
[555.378825] Starting subtest: invalid-reset-one-illegal-handle
[555.381108] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[555.475869] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: gem_spin_batch
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_exec_await
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_busy
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: core_setmaster_vs_auth
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gen7_exec_parse
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: vgem_basic
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: gem_partial_pwrite_pread
results: parsing output: 34/ for test: gem_exec_async
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_reg_read
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_exec_capture
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: prime_self_import
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: syncobj_eventfd
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_prop_blob
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_dp_link_training
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: gem_tiled_pread_pwrite
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_vm_create
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: intel_hwmon
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_atomic_interruptible
results: parsing output: 100/ for test: gem_pipe_control_store_loop
results: parsing output: 101/ for test: kms_busy
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ctx_bad_destroy
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: gem_mmap_offset
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: dmabuf_sync_file
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_atomic
results: parsing output: 132/ for test: syncobj_wait
Done.