[72.440738] Initializing watchdogs
[72.440855]   /dev/watchdog0
[72.463174] [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.470776] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.476150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.479675] [001/134] (960s left) gem_ccs (block-multicopy-compressed)
[72.552151] Subtest block-multicopy-compressed: SKIP (0.000s)
[72.607140] [002/134] (960s left) kms_vrr (negative-basic)
[73.097375] Starting subtest: negative-basic
[73.099371] Subtest negative-basic: SKIP (0.000s)
[73.713279] [003/134] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[74.211584] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[74.212787] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[74.804167] [004/134] (958s left) gem_mmap_offset (partial-remap)
[74.859640] Starting subtest: partial-remap
[74.860231] Starting dynamic subtest: smem0
[74.865913] Dynamic subtest smem0: SUCCESS (0.005s)
[74.867548] Subtest partial-remap: SUCCESS (0.006s)
[75.040159] [005/134] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[75.535274] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[75.536532] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.133209] [006/134] (957s left) kms_plane_scaling (planes-downscale-factor-0-75)
[76.625022] Starting subtest: planes-downscale-factor-0-75
[76.625699] Starting dynamic subtest: pipe-A
[76.627486] Dynamic subtest pipe-A: SKIP (0.002s)
[76.636615] Starting dynamic subtest: pipe-B
[76.638326] Dynamic subtest pipe-B: SKIP (0.001s)
[76.639235] Subtest planes-downscale-factor-0-75: SKIP (0.005s)
[77.236347] [007/134] (956s left) gem_exec_whisper (basic-queues-all)
[77.300296] Starting subtest: basic-queues-all
[77.303804] Subtest basic-queues-all: SKIP (0.003s)
[77.537960] [008/134] (955s left) kms_plane (plane-position-covered)
[78.038824] Starting subtest: plane-position-covered
[78.479966] Starting dynamic subtest: pipe-A-plane-1
[78.907284] Dynamic subtest pipe-A-plane-1: SUCCESS (0.428s)
[78.915938] Starting dynamic subtest: pipe-A-plane-2
[78.919831] Dynamic subtest pipe-A-plane-2: SUCCESS (0.012s)
[79.224911] Starting dynamic subtest: pipe-B-plane-1
[79.639765] Dynamic subtest pipe-B-plane-1: SUCCESS (0.425s)
[79.649795] Starting dynamic subtest: pipe-B-plane-2
[79.651295] Dynamic subtest pipe-B-plane-2: SUCCESS (0.010s)
[79.651805] Subtest plane-position-covered: SUCCESS (1.612s)
[80.367246] [009/134] (952s left) gem_ctx_isolation (clean)
[80.431105] Starting subtest: clean
[80.431830] Starting dynamic subtest: rcs0
[80.498251] Dynamic subtest rcs0: SUCCESS (0.067s)
[80.498924] Subtest clean: SUCCESS (0.067s)
[80.766978] [010/134] (952s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[81.263884] Starting subtest: y-tiled-8bpp-rotate-0
[81.264969] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[81.872567] [011/134] (951s left) sw_sync (sync_multi_consumer)
[81.923097] Starting subtest: sync_multi_consumer
[82.775414] Subtest sync_multi_consumer: SUCCESS (0.852s)
[82.876598] [012/134] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[83.369305] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[83.370417] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[83.982872] [013/134] (949s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[84.478985] Starting subtest: cursor-rapid-movement-64x21
[84.535740] Subtest cursor-rapid-movement-64x21: SKIP (0.056s)
[85.139431] [014/134] (948s left) kms_chamelium_frames (hdmi-crc-single)
[85.714038] Subtest hdmi-crc-single: SKIP (0.000s)
[86.111562] [015/134] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[86.602139] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[86.603497] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[87.201817] [016/134] (946s left) gem_mmap_wc (invalid-flags)
[87.256465] Starting subtest: invalid-flags
[87.256989] Subtest invalid-flags: SUCCESS (0.000s)
[87.379690] [017/134] (946s left) gem_flink_race (flink_name)
[87.429343] Starting subtest: flink_name
[92.801985] Subtest flink_name: SUCCESS (5.373s)
[92.937262] [018/134] (940s left) gem_exec_params (invalid-fence-in)
[92.995180] Starting subtest: invalid-fence-in
[92.995875] Subtest invalid-fence-in: SUCCESS (0.001s)
[93.120671] [019/134] (940s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[93.179561] Starting subtest: rel-constants-invalid-rel-gen5
[93.180270] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[93.318603] [020/134] (940s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[93.368531] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[93.411756] [021/134] (940s left) gem_exec_schedule (preempt-engines)
[93.477865] Subtest preempt-engines: SKIP (0.000s)
[93.701602] [022/134] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[94.190069] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[94.191176] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[94.784566] [023/134] (939s left) api_intel_bb (blit-reloc-keep-cache)
[94.840936] Starting subtest: blit-reloc-keep-cache
[94.847288] Subtest blit-reloc-keep-cache: SUCCESS (0.007s)
[94.999256] [024/134] (938s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[95.055279] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[95.157538] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[95.280743] [025/134] (938s left) kms_sequence (get-idle)
[95.769021] Starting subtest: get-idle
[95.770672] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.999944] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.229s)
[98.009499] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.274826] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.273s)
[100.275410] Subtest get-idle: SUCCESS (4.506s)
[100.984479] [026/134] (933s left) kms_flip (flip-vs-suspend)
[101.476291] Starting subtest: flip-vs-suspend
[101.476797] Starting dynamic subtest: A-VGA1
[139.094863] Dynamic subtest A-VGA1: SUCCESS (5.174s)
[139.106912] Starting dynamic subtest: B-VGA1
[175.996931] Dynamic subtest B-VGA1: SUCCESS (5.558s)
[176.010811] Starting dynamic subtest: A-HDMI-A1
[212.571018] Dynamic subtest A-HDMI-A1: SUCCESS (5.461s)
[212.585389] Starting dynamic subtest: B-HDMI-A1
[248.624914] Dynamic subtest B-HDMI-A1: SUCCESS (5.018s)
[248.625967] Subtest flip-vs-suspend: SUCCESS (21.824s)
[255.678261] [027/134] (785s left) intel_hwmon (hwmon-read)
[255.738357] Subtest hwmon-read: SKIP (0.000s)
[255.793824] [028/134] (785s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[256.298572] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[256.595608] [029/134] (784s left) kms_atomic_interruptible (legacy-setmode)
[257.095769] Starting subtest: legacy-setmode
[257.097280] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.379695] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.192s)
[263.380170] Subtest legacy-setmode: SUCCESS (6.193s)
[264.117436] [030/134] (777s left) gem_exec_endless (dispatch)
[264.177781] Subtest dispatch: SKIP (0.000s)
[264.300690] [031/134] (777s left) kms_addfb_basic (addfb25-bad-modifier)
[264.791543] Starting subtest: addfb25-bad-modifier
[264.792298] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[265.408322] [032/134] (775s left) gem_ctx_param (invalid-size-get)
[265.463553] Starting subtest: invalid-size-get
[265.464018] Subtest invalid-size-get: SUCCESS (0.000s)
[265.592226] [033/134] (775s left) vgem_basic (second-client)
[265.715406] Starting subtest: second-client
[265.747382] Subtest second-client: SUCCESS (0.032s)
[265.860659] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[265.863347] [034/134] (775s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[266.369890] Starting subtest: 4-tiled-16bpp-rotate-180
[266.371228] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[266.984501] [035/134] (774s left) gem_render_copy (y-tiled-ccs-to-linear)
[267.046700] Starting subtest: y-tiled-ccs-to-linear
[267.047314] Starting dynamic subtest: smem
[267.048573] Dynamic subtest smem: SKIP (0.000s)
[267.049816] Subtest y-tiled-ccs-to-linear: SKIP (0.001s)
[267.288208] [036/134] (774s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[267.785471] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[267.786716] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[268.399979] [037/134] (773s left) gem_exec_reloc (basic-wc-read)
[268.459509] Starting subtest: basic-wc-read
[268.462108] Subtest basic-wc-read: SUCCESS (0.003s)
[269.528551] [038/134] (772s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[270.023673] Starting subtest: psr-rgb101010-draw-pwrite
[270.024735] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[270.628151] [039/134] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[271.122723] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[271.123865] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[271.734359] [040/134] (770s left) gem_exec_reloc (basic-cpu-gtt-active)
[271.792819] Starting subtest: basic-cpu-gtt-active
[271.902152] Subtest basic-cpu-gtt-active: SUCCESS (0.110s)
[272.932973] [041/134] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[273.427578] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[273.428655] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[274.046352] [042/134] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[274.532985] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[274.534060] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.132302] [043/134] (766s left) kms_psr (psr-dpms)
[275.612753] Subtest psr-dpms: SKIP (0.000s)
[275.913775] [044/134] (766s left) gem_mmap (big-bo)
[275.970217] Starting subtest: big-bo
[276.820935] Subtest big-bo: SUCCESS (0.849s)
[276.964170] [045/134] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[277.567838] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[277.569780] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[278.173707] [046/134] (763s left) gem_ctx_engines (execute-allforone)
[278.239243] Starting subtest: execute-allforone
[278.242455] Subtest execute-allforone: SUCCESS (0.003s)
[278.483271] [047/134] (763s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[278.975755] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[278.977622] Starting dynamic subtest: AB-VGA1-HDMI-A1
[309.738596] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.745s)
[309.741483] Subtest 2x-wf_vblank-ts-check-interruptible: SUCCESS (30.749s)
[310.569293] [048/134] (731s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[311.066742] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[311.068001] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[311.676824] [049/134] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[312.164487] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[312.165701] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[312.782929] [050/134] (729s left) kms_content_protection (legacy-hdcp14)
[313.287328] Starting subtest: legacy-hdcp14
[313.288586] Subtest legacy-hdcp14: SKIP (0.000s)
[313.909909] [051/134] (728s left) i915_pm_freq_api (freq-reset-multiple)
[313.968714] Subtest freq-reset-multiple: SKIP (0.000s)
[314.043579] [052/134] (728s left) gem_exec_params (mmapped)
[314.103942] Starting subtest: mmapped
[314.105903] Subtest mmapped: SUCCESS (0.002s)
[314.240320] [053/134] (728s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[314.304746] Starting subtest: x-tiled-to-vebox-y-tiled
[314.306652] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[314.541316] [054/134] (728s left) gen7_exec_parse (load-register-reg)
[314.597156] Subtest load-register-reg: SKIP (0.000s)
[314.654470] [055/134] (727s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[315.142514] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[316.237418] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.094s)
[316.896183] [056/134] (725s left) kms_pm_backlight (fade-with-suspend)
[317.380276] Subtest fade-with-suspend: SKIP (0.000s)
[317.680044] [057/134] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[318.165423] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[318.166500] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[318.767481] [058/134] (724s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[319.248151] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[319.549287] [059/134] (723s left) sysfs_timeslice_duration (timeout)
[319.604758] Starting subtest: timeout
[319.607033] Starting dynamic subtest: vcs0
[319.608202] Dynamic subtest vcs0: SKIP (0.000s)
[319.624171] Starting dynamic subtest: bcs0
[319.625773] Dynamic subtest bcs0: SKIP (0.000s)
[319.641823] Starting dynamic subtest: rcs0
[319.643939] Dynamic subtest rcs0: SKIP (0.000s)
[319.645930] Subtest timeout: SKIP (0.005s)
[319.717750] [060/134] (723s left) kms_cdclk (mode-transition-all-outputs)
[319.771109] Subtest mode-transition-all-outputs: SKIP (0.000s)
[319.825513] [061/134] (723s left) gem_pxp (create-valid-protected-context)
[322.395777] Starting subtest: create-valid-protected-context
[322.397885] Subtest create-valid-protected-context: SKIP (0.000s)
[322.527563] [062/134] (720s left) gem_ctx_shared (exec-shared-gtt)
[322.583396] Subtest exec-shared-gtt: SKIP (0.000s)
[322.713972] [063/134] (720s left) prime_vgem (basic-fence-flip)
[322.784830] Starting subtest: basic-fence-flip
[323.680985] Subtest basic-fence-flip: SUCCESS (0.897s)
[324.444782] [064/134] (718s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[324.937797] Starting subtest: cursorA-vs-flipB-varying-size
[324.939244] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[325.543062] [065/134] (717s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[326.022343] Starting subtest: nonblocking-crc-frame-sequence
[326.022970] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.571863] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.549s)
[326.586449] Starting dynamic subtest: pipe-B-HDMI-A-1
[327.169787] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.595s)
[327.170451] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.149s)
[327.864933] [066/134] (715s left) syncobj_timeline (etime-single-wait-all-submitted)
[327.927333] Starting subtest: etime-single-wait-all-submitted
[328.030690] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[328.163815] [067/134] (715s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[328.217436] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (0.000s)
[328.278482] [068/134] (715s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[328.333603] Starting subtest: multi-wait-for-submit-submitted-signaled
[328.336040] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[328.466657] [069/134] (714s left) gem_mmap_gtt (cpuset-medium-copy)
[328.519752] Starting subtest: cpuset-medium-copy
[330.036845] Subtest cpuset-medium-copy: SUCCESS (1.516s)
[330.190752] [070/134] (713s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[330.762942] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[331.058624] [071/134] (712s left) gem_exec_schedule (wide)
[331.137772] Subtest wide: SKIP (0.000s)
[331.379458] [072/134] (712s left) gem_pipe_control_store_loop (fresh-buffer)
[331.436299] Starting subtest: fresh-buffer
[333.585962] Subtest fresh-buffer: SUCCESS (2.149s)
[333.759122] [073/134] (709s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[334.244666] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[334.291390] Starting dynamic subtest: pipe-A-plane-0
[334.292707] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[334.308041] Starting dynamic subtest: pipe-A-plane-1
[334.309556] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[334.321924] Starting dynamic subtest: pipe-A-plane-2
[334.323183] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[334.537793] Starting dynamic subtest: pipe-B-plane-0
[334.540269] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[334.553395] Starting dynamic subtest: pipe-B-plane-1
[334.554640] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[334.566855] Starting dynamic subtest: pipe-B-plane-2
[334.568025] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[334.619434] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.374s)
[335.334359] [074/134] (708s left) gem_eio (hibernate)
[335.403817] Starting subtest: hibernate
[348.923416] Subtest hibernate: SUCCESS (13.511s)
[355.959227] [075/134] (693s left) kms_psr (fbc-psr-sprite-plane-onoff)
[356.442725] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[356.749798] [076/134] (693s left) kms_cursor_crc (cursor-onscreen-128x42)
[357.255772] Starting subtest: cursor-onscreen-128x42
[357.311387] Subtest cursor-onscreen-128x42: SKIP (0.055s)
[357.919544] [077/134] (691s left) kms_cursor_crc (cursor-sliding-max-size)
[358.414237] Starting subtest: cursor-sliding-max-size
[358.415576] Subtest cursor-sliding-max-size: SKIP (0.000s)
[359.017786] [078/134] (690s left) gem_softpin (noreloc-s3)
[359.075990] Starting subtest: noreloc-S3
[398.668419] Subtest noreloc-S3: SUCCESS (6.725s)
[404.731224] [079/134] (651s left) syncobj_timeline (wait-all-complex)
[404.795632] Starting subtest: wait-all-complex
[405.011285] Subtest wait-all-complex: SUCCESS (0.216s)
[405.149699] [080/134] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[405.655463] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[405.656560] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[406.261291] [081/134] (649s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[406.325429] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[406.326924] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[406.563079] [082/134] (649s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[406.616728] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[406.694121] [083/134] (649s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[407.189542] Starting subtest: multiplane-rotation-cropping-top
[407.190646] Subtest multiplane-rotation-cropping-top: SKIP (0.000s)
[407.793941] [084/134] (648s left) gem_pread (display)
[407.850087] Starting subtest: display
[409.117140] Subtest display: SUCCESS (1.244s)
[409.263452] [085/134] (647s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[409.584269] Starting subtest: syncobj-timeline-invalid-wait
[409.584916] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[409.876450] [086/134] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[410.375007] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[410.376721] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[411.005541] [087/134] (645s left) gem_exec_balancer (full-pulse)
[411.065516] Subtest full-pulse: SKIP (0.000s)
[411.190790] [088/134] (645s left) gem_exec_reloc (basic-gtt-wc)
[411.250148] Starting subtest: basic-gtt-wc
[411.254277] Subtest basic-gtt-wc: SUCCESS (0.004s)
[412.303356] [089/134] (644s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[412.792428] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[412.834535] Starting dynamic subtest: pipe-A-plane-0
[412.835905] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[412.854339] Starting dynamic subtest: pipe-A-plane-1
[412.855937] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[412.873614] Starting dynamic subtest: pipe-A-plane-2
[412.874651] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[413.085076] Starting dynamic subtest: pipe-B-plane-0
[413.087200] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[413.104960] Starting dynamic subtest: pipe-B-plane-1
[413.106162] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[413.119874] Starting dynamic subtest: pipe-B-plane-2
[413.121653] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[413.166343] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.370s)
[413.890949] [090/134] (642s left) kms_big_fb (linear-8bpp-rotate-90)
[414.390942] Starting subtest: linear-8bpp-rotate-90
[414.406624] Subtest linear-8bpp-rotate-90: SKIP (0.014s)
[415.029348] [091/134] (641s left) gem_eio (in-flight-contexts-10ms)
[415.092616] Starting subtest: in-flight-contexts-10ms
[418.492306] Subtest in-flight-contexts-10ms: SUCCESS (3.377s)
[419.532233] [092/134] (637s left) gem_spin_batch (spin-all-new)
[419.601327] Starting subtest: spin-all-new
[419.603182] Subtest spin-all-new: SUCCESS (0.004s)
[419.853092] [093/134] (636s left) api_intel_bb (destroy-bb)
[419.907918] Starting subtest: destroy-bb
[419.915129] Subtest destroy-bb: SUCCESS (0.007s)
[420.081053] [094/134] (636s left) gem_exec_schedule (thriceslice)
[420.148822] Subtest thriceslice: SKIP (0.000s)
[420.364254] [095/134] (636s left) syncobj_wait (reset-signaled)
[420.419956] Starting subtest: reset-signaled
[420.420660] Subtest reset-signaled: SUCCESS (0.000s)
[420.548945] [096/134] (636s left) gem_ctx_persistence (process)
[420.606126] Subtest process: SKIP (0.000s)
[420.677453] [097/134] (636s left) kms_joiner (basic-max-non-joiner)
[421.165996] Starting subtest: basic-max-non-joiner
[421.167215] Subtest basic-max-non-joiner: SKIP (0.000s)
[421.768560] [098/134] (635s left) kms_getfb (getfb-reject-nv12)
[422.256433] Starting subtest: getfb-reject-nv12
[422.257909] Subtest getfb-reject-nv12: SKIP (0.000s)
[422.872395] [099/134] (634s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[423.371901] Starting subtest: fbc-indfb-scaledprimary
[423.373131] Subtest fbc-indfb-scaledprimary: SKIP (0.000s)
[423.987344] [100/134] (633s left) perf_pmu (most-busy-idle-check-all)
[424.042375] Starting subtest: most-busy-idle-check-all
[424.042935] Starting dynamic subtest: rcs0
[424.663968] Dynamic subtest rcs0: SUCCESS (0.619s)
[424.681177] Starting dynamic subtest: bcs0
[425.291010] Dynamic subtest bcs0: SUCCESS (0.623s)
[425.308896] Starting dynamic subtest: vcs0
[425.913122] Dynamic subtest vcs0: SUCCESS (0.618s)
[425.916106] Subtest most-busy-idle-check-all: SUCCESS (1.868s)
[426.056871] [101/134] (631s left) gen9_exec_parse (unaligned-jump)
[426.111538] Subtest unaligned-jump: SKIP (0.000s)
[426.187419] [102/134] (631s left) kms_prime (basic-modeset-hybrid)
[426.690978] Subtest basic-modeset-hybrid: SKIP (0.000s)
[427.792278] [103/134] (629s left) kms_flip (dpms-off-confusion)
[428.278564] Starting subtest: dpms-off-confusion
[428.279797] Starting dynamic subtest: A-VGA1
[436.089348] Dynamic subtest A-VGA1: SUCCESS (7.799s)
[436.106910] Starting dynamic subtest: B-VGA1
[443.805088] Dynamic subtest B-VGA1: SUCCESS (7.713s)
[443.822212] Starting dynamic subtest: A-HDMI-A1
[451.545049] Dynamic subtest A-HDMI-A1: SUCCESS (7.736s)
[451.562287] Starting dynamic subtest: B-HDMI-A1
[459.314225] Dynamic subtest B-HDMI-A1: SUCCESS (7.765s)
[459.317612] Subtest dpms-off-confusion: SUCCESS (31.026s)
[460.111069] [104/134] (597s left) i915_pm_rps (waitboost)
[460.172664] Starting subtest: waitboost
[463.706528] Subtest waitboost: SUCCESS (3.532s)
[463.885247] [105/134] (593s left) kms_color (degamma)
[464.366363] Starting subtest: degamma
[464.367012] Starting dynamic subtest: pipe-A-HDMI-A-1
[464.368236] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[464.383743] Starting dynamic subtest: pipe-B-HDMI-A-1
[464.384921] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[464.385885] Subtest degamma: SKIP (0.005s)
[464.983319] [106/134] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[465.474832] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[465.476012] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.078008] [107/134] (591s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[466.642626] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[467.051251] [108/134] (590s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[467.105414] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[467.167044] [109/134] (590s left) kms_fb_coherency (memset-crc)
[467.653465] Starting subtest: memset-crc
[467.654197] Starting dynamic subtest: mmap-gtt
[468.001333] Dynamic subtest mmap-gtt: SUCCESS (0.347s)
[468.103342] Starting dynamic subtest: mmap-offset-wc
[468.455441] Dynamic subtest mmap-offset-wc: SUCCESS (0.370s)
[468.554772] Starting dynamic subtest: mmap-offset-uc
[468.921217] Dynamic subtest mmap-offset-uc: SUCCESS (0.380s)
[469.022181] Starting dynamic subtest: mmap-legacy-wc
[469.387176] Dynamic subtest mmap-legacy-wc: SUCCESS (0.379s)
[469.469956] Subtest memset-crc: SUCCESS (1.816s)
[470.185175] [110/134] (587s left) kms_vblank (wait-forked-busy-hang)
[470.669362] Starting subtest: wait-forked-busy-hang
[470.671258] Starting dynamic subtest: pipe-A-HDMI-A-1
[476.769518] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.095s)
[476.788929] Starting dynamic subtest: pipe-B-HDMI-A-1
[482.793455] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.019s)
[482.794149] Subtest wait-forked-busy-hang: SUCCESS (12.121s)
[483.511300] [111/134] (574s left) syncobj_eventfd (binary-wait-signaled)
[483.569375] Starting subtest: binary-wait-signaled
[483.569908] Subtest binary-wait-signaled: SUCCESS (0.000s)
[483.693855] [112/134] (574s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[483.748041] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[483.804525] [113/134] (574s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[484.282869] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[484.588945] [114/134] (573s left) kms_psr (pr-sprite-plane-move)
[485.072253] Subtest pr-sprite-plane-move: SKIP (0.000s)
[485.372792] [115/134] (572s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[485.867057] Starting subtest: x-tiled-16bpp-rotate-180
[487.151361] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.285s)
[487.809493] [116/134] (570s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[487.865149] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[487.933754] [117/134] (570s left) gem_exec_params (no-vebox)
[487.990510] Starting subtest: no-vebox
[487.991096] Subtest no-vebox: SUCCESS (0.000s)
[488.137046] [118/134] (570s left) kms_force_connector_basic (prune-stale-modes)
[488.209374] Starting subtest: prune-stale-modes
[488.229021] Subtest prune-stale-modes: SUCCESS (0.020s)
[488.870246] [119/134] (569s left) i915_pm_rpm (system-suspend-execbuf)
[500.651847] Subtest system-suspend-execbuf: SKIP (0.000s)
[500.963389] [120/134] (557s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[501.024407] Starting subtest: invalid-single-wait-unsubmitted
[501.025006] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[501.133200] [121/134] (557s left) kms_addfb_basic (small-bo)
[501.620934] Starting subtest: small-bo
[501.621548] Subtest small-bo: SUCCESS (0.000s)
[502.234461] [122/134] (556s left) gem_mmap_wc (write-gtt-read-wc)
[502.289272] Starting subtest: write-gtt-read-wc
[502.461000] Subtest write-gtt-read-wc: SUCCESS (0.172s)
[502.615128] [123/134] (555s left) kms_force_connector_basic (force-load-detect)
[502.681932] Starting subtest: force-load-detect
[502.889455] Subtest force-load-detect: SUCCESS (0.208s)
[503.426267] [124/134] (555s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[503.908537] Starting subtest: fb-8bpc-vs-panel-8bpc
[503.909157] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.004349] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.094s)
[504.005428] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.097s)
[504.735700] [125/134] (553s left) kms_big_fb (4-tiled-addfb)
[505.221038] Starting subtest: 4-tiled-addfb
[505.222248] Subtest 4-tiled-addfb: SKIP (0.000s)
[505.837156] [126/134] (552s left) gen7_exec_parse (basic-allocation)
[505.897765] Subtest basic-allocation: SKIP (0.000s)
[505.964112] [127/134] (552s left) gem_userptr_blits (unsync-overlap)
[506.021005] Subtest unsync-overlap: SKIP (0.000s)
[506.184310] [128/134] (552s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[506.667391] Starting subtest: basic-flip-before-cursor-varying-size
[507.658138] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.991s)
[508.375051] [129/134] (550s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[508.858719] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[510.299007] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.441s)
[510.937104] [130/134] (547s left) gem_ctx_bad_destroy (double-destroy)
[510.992704] Starting subtest: double-destroy
[510.993346] Subtest double-destroy: SUCCESS (0.000s)
[511.133275] [131/134] (547s left) core_setmaster (master-drop-set-root)
[511.265485] Starting subtest: master-drop-set-root
[511.279904] Subtest master-drop-set-root: SUCCESS (0.014s)
[511.349342] [132/134] (547s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[511.839925] Starting subtest: extended-modeset-hang-newfb-with-reset
[511.840668] Starting dynamic subtest: pipe-A
[524.408769] Dynamic subtest pipe-A: SUCCESS (12.570s)
[524.428765] Starting dynamic subtest: pipe-B
[536.186061] Dynamic subtest pipe-B: SUCCESS (11.775s)
[536.188938] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (24.351s)
[536.897309] [133/134] (522s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-render)
[537.385503] Starting subtest: fbc-abgr161616f-draw-render
[537.386605] Subtest fbc-abgr161616f-draw-render: SKIP (0.000s)
[538.001239] [134/134] (521s left) kms_lease (possible-crtcs-filtering)
[538.495191] Starting subtest: possible-crtcs-filtering
[538.497565] Subtest possible-crtcs-filtering: SUCCESS (0.003s)
[539.109814] Closing watchdogs
results: parsing output: 0/ for test: gem_ccs
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_flink_race
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: intel_hwmon
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: gem_exec_endless
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: i915_pm_freq_api
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gen7_exec_parse
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: sysfs_timeslice_duration
results: parsing output: 59/ for test: kms_cdclk
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_ctx_shared
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: gem_pipe_control_store_loop
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_pread
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_joiner
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_prime
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_fb_coherency
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: syncobj_eventfd
results: parsing output: 111/ for test: kms_pipe_b_c_ivb
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_force_connector_basic
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_force_connector_basic
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_bad_destroy
results: parsing output: 130/ for test: core_setmaster
results: parsing output: 131/ for test: kms_busy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_lease
Done.