[69.279690] Initializing watchdogs
[69.279845]   /dev/watchdog0
[69.301488] [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)
[69.309348] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.312805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.315807] [001/131] (960s left) gem_exec_balancer (bonded-pair)
[69.403151] Subtest bonded-pair: SKIP (0.000s)
[69.495324] [002/131] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[69.867731] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[69.869117] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[70.311457] [003/131] (959s left) kms_getfb (getfb-handle-valid)
[70.682247] Starting subtest: getfb-handle-valid
[70.682891] Subtest getfb-handle-valid: SUCCESS (0.000s)
[71.118846] [004/131] (958s left) kms_psr (psr2-suspend)
[71.491783] Subtest psr2-suspend: SKIP (0.000s)
[71.728496] [005/131] (958s left) syncobj_eventfd (binary-wait)
[71.784980] Starting subtest: binary-wait
[71.796392] Subtest binary-wait: SUCCESS (0.011s)
[71.885996] [006/131] (958s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[72.259160] Starting subtest: cursorA-vs-flipB-toggle
[72.261077] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[72.701088] [007/131] (957s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[72.771653] Starting subtest: yf-tiled-to-vebox-y-tiled
[72.773634] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[72.965474] [008/131] (957s left) kms_plane (planar-pixel-format-settings)
[73.330990] Starting subtest: planar-pixel-format-settings
[73.332801] Subtest planar-pixel-format-settings: SKIP (0.000s)
[73.760751] [009/131] (956s left) dumb_buffer (create-clear)
[73.819403] Starting subtest: create-clear
[112.380221] Subtest create-clear: SUCCESS (38.564s)
[112.511814] [010/131] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[112.883282] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[112.884815] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[113.327535] [011/131] (916s left) gen7_exec_parse (oacontrol-tracking)
[113.388690] Subtest oacontrol-tracking: SKIP (0.000s)
[113.439515] [012/131] (916s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[113.820090] Starting subtest: x-tiled-64bpp-rotate-180
[115.868307] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.047s)
[116.326330] [013/131] (914s left) kms_frontbuffer_tracking (psr-1p-rte)
[116.699092] Starting subtest: psr-1p-rte
[116.700437] Subtest psr-1p-rte: SKIP (0.000s)
[117.145838] [014/131] (913s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[117.207659] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[117.313425] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[117.411944] [015/131] (913s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[117.465072] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[117.517983] [016/131] (912s left) syncobj_wait (invalid-reset-illegal-handle)
[117.575961] Starting subtest: invalid-reset-illegal-handle
[117.576919] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[117.660056] [017/131] (912s left) kms_psr (pr-sprite-blt)
[118.019554] Subtest pr-sprite-blt: SKIP (0.000s)
[118.251382] [018/131] (912s left) syncobj_wait (single-wait-submitted)
[118.304993] Starting subtest: single-wait-submitted
[118.409065] Subtest single-wait-submitted: SUCCESS (0.103s)
[118.488522] [019/131] (912s left) kms_pipe_crc_basic (read-crc)
[118.858582] Starting subtest: read-crc
[118.859347] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.341516] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.483s)
[119.350695] Starting dynamic subtest: pipe-B-HDMI-A-1
[119.869957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.527s)
[119.870683] Subtest read-crc: SUCCESS (1.012s)
[120.415349] [020/131] (910s left) syncobj_timeline (invalid-query-bad-pad)
[120.473575] Starting subtest: invalid-query-bad-pad
[120.474376] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[120.566147] [021/131] (910s left) kms_psr (fbc-psr-sprite-render)
[120.938028] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[121.157135] [022/131] (909s left) kms_psr (psr-sprite-render)
[121.524869] Subtest psr-sprite-render: SKIP (0.000s)
[121.775759] [023/131] (909s left) kms_atomic_interruptible (legacy-setmode)
[122.164709] Starting subtest: legacy-setmode
[122.166123] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.456385] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.291s)
[128.457069] Subtest legacy-setmode: SUCCESS (6.292s)
[129.007097] [024/131] (901s left) kms_flip (2x-flip-vs-dpms-on-nop)
[129.376149] Starting subtest: 2x-flip-vs-dpms-on-nop
[129.377113] Starting dynamic subtest: AB-VGA1-HDMI-A1
[132.002165] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.625s)
[132.003077] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (2.628s)
[132.687169] [025/131] (898s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[133.050598] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[133.051560] Starting dynamic subtest: pipe-A
[133.053332] Dynamic subtest pipe-A: SKIP (0.001s)
[133.062291] Starting dynamic subtest: pipe-B
[133.064333] Dynamic subtest pipe-B: SKIP (0.001s)
[133.065928] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.003s)
[133.500662] [026/131] (897s left) kms_cursor_crc (cursor-random-32x10)
[133.872387] Starting subtest: cursor-random-32x10
[133.930270] Subtest cursor-random-32x10: SKIP (0.056s)
[134.366016] [027/131] (896s left) kms_vblank (crtc-id)
[134.732069] Starting subtest: crtc-id
[134.734468] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.998619] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[135.008136] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.284742] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.285s)
[135.285323] Subtest crtc-id: SUCCESS (0.553s)
[135.831669] [028/131] (895s left) kms_addfb_basic (master-rmfb)
[135.888756] Starting subtest: master-rmfb
[135.889510] Subtest master-rmfb: SUCCESS (0.001s)
[136.626961] [029/131] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[136.995215] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[136.996611] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[137.423272] [030/131] (893s left) sw_sync (sync_multi_consumer_producer)
[137.483153] Starting subtest: sync_multi_consumer_producer
[138.129683] Subtest sync_multi_consumer_producer: SUCCESS (0.646s)
[138.208299] [031/131] (892s left) gem_spin_batch (spin-all)
[138.268166] Starting subtest: spin-all
[138.270622] Subtest spin-all: SUCCESS (0.003s)
[138.473931] [032/131] (892s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[138.848543] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[138.850204] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[139.292091] [033/131] (891s left) kms_chamelium_frames (vga-frame-dump)
[139.747211] Subtest vga-frame-dump: SKIP (0.000s)
[140.080327] [034/131] (891s left) i915_getparams_basic (basic-subslice-total)
[140.138816] Starting subtest: basic-subslice-total
[140.140576] Subtest basic-subslice-total: SUCCESS (0.000s)
[140.221485] [035/131] (891s left) gem_gpgpu_fill (basic)
[140.275154] Subtest basic: SKIP (0.000s)
[140.364306] [036/131] (891s left) prime_mmap (test_map_unmap)
[140.421239] Starting subtest: test_map_unmap
[140.421959] Starting dynamic subtest: test_map_unmap-smem
[140.423713] Dynamic subtest test_map_unmap-smem: SUCCESS (0.002s)
[140.424649] Subtest test_map_unmap: SUCCESS (0.003s)
[140.519654] [037/131] (890s left) gem_busy (parallel)
[140.708345] Starting subtest: parallel
[140.709308] Starting dynamic subtest: rcs0
[140.740406] Dynamic subtest rcs0: SUCCESS (0.032s)
[140.754532] Starting dynamic subtest: bcs0
[140.757141] Dynamic subtest bcs0: SUCCESS (0.015s)
[140.758033] Subtest parallel: SUCCESS (0.049s)
[140.985910] [038/131] (890s left) kms_content_protection (uevent)
[141.370790] Starting subtest: uevent
[141.597983] Subtest uevent: SKIP (0.226s)
[142.259013] [039/131] (889s left) api_intel_allocator (simple-allocator)
[142.316899] Starting subtest: simple-allocator
[142.317593] Starting dynamic subtest: basic
[142.324711] Dynamic subtest basic: SUCCESS (0.008s)
[142.337395] Starting dynamic subtest: parallel-one
[142.634622] Dynamic subtest parallel-one: SUCCESS (0.308s)
[142.643713] Starting dynamic subtest: print
[142.644955] Dynamic subtest print: SUCCESS (0.000s)
[142.655482] Starting dynamic subtest: reuse
[142.656238] Dynamic subtest reuse: SUCCESS (0.000s)
[142.669978] Starting dynamic subtest: reserve
[142.671104] Dynamic subtest reserve: SUCCESS (0.000s)
[142.681688] Starting dynamic subtest: fork-reopen-allocator
[142.683113] Dynamic subtest fork-reopen-allocator: SUCCESS (0.019s)
[142.684193] Subtest simple-allocator: SUCCESS (0.340s)
[142.777317] [040/131] (888s left) gem_userptr_blits (forbidden-operations)
[142.834899] Starting subtest: forbidden-operations
[142.835785] Subtest forbidden-operations: SUCCESS (0.001s)
[142.963686] [041/131] (888s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[143.325346] Starting subtest: psr-rgb565-draw-render
[143.326830] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[143.759539] [042/131] (887s left) kms_joiner (basic-force-ultra-joiner)
[144.127419] Starting subtest: basic-force-ultra-joiner
[144.128652] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[144.571137] [043/131] (887s left) kms_psr (fbc-psr2-suspend)
[144.939931] Subtest fbc-psr2-suspend: SKIP (0.000s)
[145.164305] [044/131] (886s left) gem_ringfill (engines-basic)
[145.360729] Starting subtest: engines-basic
[145.361792] Starting dynamic subtest: rcs0
[145.384224] Dynamic subtest rcs0: SUCCESS (0.021s)
[145.398633] Starting dynamic subtest: bcs0
[145.399933] Dynamic subtest bcs0: SUCCESS (0.012s)
[145.400846] Subtest engines-basic: SUCCESS (0.036s)
[145.500366] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[145.503662] [045/131] (886s left) kms_pm_rpm (legacy-planes)
[157.109760] Subtest legacy-planes: SKIP (0.000s)
[157.347397] [046/131] (874s left) kms_flip (2x-flip-vs-rmfb)
[157.713521] Starting subtest: 2x-flip-vs-rmfb
[157.714403] Starting dynamic subtest: AB-VGA1-HDMI-A1
[188.057203] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.341s)
[188.058054] Subtest 2x-flip-vs-rmfb: SUCCESS (30.345s)
[188.719467] [047/131] (843s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[188.781274] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[188.781988] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[188.878314] [048/131] (843s left) vgem_basic (mmap)
[188.932347] Starting subtest: mmap
[188.944674] Subtest mmap: SUCCESS (0.012s)
[189.013193] [049/131] (842s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[189.069619] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[189.126707] [050/131] (842s left) gem_userptr_blits (sync-unmap)
[189.193712] Starting subtest: sync-unmap
[189.206785] Subtest sync-unmap: SUCCESS (0.013s)
[189.332446] [051/131] (842s left) core_setmaster (master-drop-set-root)
[189.433408] Starting subtest: master-drop-set-root
[189.447151] Subtest master-drop-set-root: SUCCESS (0.015s)
[189.508805] [052/131] (842s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[189.881369] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[192.441504] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.559s)
[192.944530] [053/131] (839s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[192.998885] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[193.049618] [054/131] (839s left) gem_exec_schedule (submit-golden-slice)
[193.122810] Subtest submit-golden-slice: SKIP (0.000s)
[193.327276] [055/131] (838s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[195.898689] Starting subtest: protected-encrypted-src-copy-not-readible
[195.900238] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[196.003709] [056/131] (836s left) kms_big_fb (linear-32bpp-rotate-180)
[196.376759] Starting subtest: linear-32bpp-rotate-180
[197.880803] Subtest linear-32bpp-rotate-180: SUCCESS (1.503s)
[198.345683] [057/131] (834s left) gem_ctx_persistence (heartbeat-stop)
[198.403849] Subtest heartbeat-stop: SKIP (0.000s)
[198.454227] [058/131] (834s left) sysfs_preempt_timeout (idempotent)
[198.507153] Starting subtest: idempotent
[198.509111] Starting dynamic subtest: vcs0
[198.510759] Dynamic subtest vcs0: SKIP (0.000s)
[198.521516] Starting dynamic subtest: bcs0
[198.523680] Dynamic subtest bcs0: SKIP (0.000s)
[198.538734] Starting dynamic subtest: rcs0
[198.540982] Dynamic subtest rcs0: SKIP (0.000s)
[198.542934] Subtest idempotent: SKIP (0.004s)
[198.614757] [059/131] (833s left) kms_flip (2x-dpms-vs-vblank-race)
[198.981550] Starting subtest: 2x-dpms-vs-vblank-race
[198.982166] Starting dynamic subtest: AB-VGA1-HDMI-A1
[209.667611] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.684s)
[209.668272] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.688s)
[210.248612] [060/131] (822s left) gem_eio (suspend)
[210.343287] Starting subtest: suspend
[221.342490] Subtest suspend: SUCCESS (10.863s)
[230.076922] [061/131] (810s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[230.146834] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[230.214619] [062/131] (810s left) gem_userptr_blits (unsync-unmap)
[230.275395] Subtest unsync-unmap: SKIP (0.000s)
[230.402677] [063/131] (810s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[230.458362] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[230.511415] [064/131] (810s left) kms_pm_rpm (pm-caching)
[242.107442] Subtest pm-caching: SKIP (0.000s)
[242.337389] [065/131] (798s left) gem_exec_balancer (full-pulse)
[242.397638] Subtest full-pulse: SKIP (0.000s)
[242.497032] [066/131] (798s left) kms_dp_link_training (uhbr-mst)
[242.867023] Starting subtest: uhbr-mst
[242.868547] Subtest uhbr-mst: SKIP (0.000s)
[243.162612] [067/131] (797s left) kms_psr (fbc-pr-sprite-blt)
[243.519739] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[243.753578] [068/131] (797s left) gen9_exec_parse (batch-zero-length)
[243.812189] Subtest batch-zero-length: SKIP (0.000s)
[243.871506] [069/131] (797s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[244.230423] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[244.231253] Starting dynamic subtest: pipe-A
[244.233576] Dynamic subtest pipe-A: SKIP (0.001s)
[244.245245] Starting dynamic subtest: pipe-B
[244.247936] Dynamic subtest pipe-B: SKIP (0.001s)
[244.249851] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.005s)
[244.688631] [070/131] (796s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[245.054597] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[247.735165] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.679s)
[248.230129] [071/131] (792s left) gem_exec_params (invalid-batch-start-offset)
[248.287349] Starting subtest: invalid-batch-start-offset
[248.290916] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[248.400869] [072/131] (792s left) kms_getfb (getfb2-handle-closed)
[248.762150] Starting subtest: getfb2-handle-closed
[248.763281] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[249.213730] [073/131] (792s left) gem_userptr_blits (map-fixed-invalidate-busy)
[249.286886] Starting subtest: map-fixed-invalidate-busy
[249.287746] Starting dynamic subtest: gtt
[250.309478] Dynamic subtest gtt: SUCCESS (1.021s)
[250.324928] Starting dynamic subtest: wb
[251.300777] Dynamic subtest wb: SUCCESS (0.989s)
[251.314156] Starting dynamic subtest: wc
[252.285529] Dynamic subtest wc: SUCCESS (0.983s)
[252.298073] Starting dynamic subtest: uc
[253.277958] Dynamic subtest uc: SUCCESS (0.991s)
[253.278893] Subtest map-fixed-invalidate-busy: SUCCESS (3.992s)
[253.420542] [074/131] (787s left) gem_eio (throttle)
[253.478043] Starting subtest: throttle
[253.501052] Subtest throttle: SUCCESS (0.024s)
[254.257066] [075/131] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[254.630241] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[254.631583] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[255.070619] [076/131] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[255.433195] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[255.434548] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[255.869438] [077/131] (785s left) gem_userptr_blits (stress-mm)
[255.951763] Starting subtest: stress-mm
[261.320145] Subtest stress-mm: SUCCESS (5.369s)
[261.444797] [078/131] (780s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[261.818120] Starting subtest: yf-tiled-16bpp-rotate-0
[261.820247] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[262.253542] [079/131] (779s left) gem_fence_thrash (bo-write-verify-threaded-none)
[262.307513] Starting subtest: bo-write-verify-threaded-none
[264.089553] Subtest bo-write-verify-threaded-none: SUCCESS (1.781s)
[264.203551] [080/131] (777s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[264.575337] Starting subtest: 4-tiled-16bpp-rotate-0
[264.576697] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[265.015666] [081/131] (776s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[265.390983] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[265.393412] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[265.829656] [082/131] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[266.199859] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[266.201202] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[266.641662] [083/131] (775s left) gem_ctx_persistence (legacy-engines-mixed-process)
[266.701014] Subtest legacy-engines-mixed-process: SKIP (0.000s)
[266.756793] [084/131] (775s left) gen3_render_linear_blits
[266.891870] [085/131] (774s left) gem_exec_suspend (basic-s3)
[266.952199] Starting subtest: basic-S3
[266.953098] Starting dynamic subtest: smem
[285.079339] Dynamic subtest smem: SUCCESS (1.374s)
[285.083817] Subtest basic-S3: SUCCESS (1.377s)
[293.308836] [086/131] (756s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[293.393064] Starting subtest: map-fixed-invalidate-overlap-busy
[293.393843] Starting dynamic subtest: gtt
[294.459215] Dynamic subtest gtt: SUCCESS (1.065s)
[294.475494] Starting dynamic subtest: wb
[295.514389] Dynamic subtest wb: SUCCESS (1.053s)
[295.526341] Starting dynamic subtest: wc
[296.564166] Dynamic subtest wc: SUCCESS (1.048s)
[296.576096] Starting dynamic subtest: uc
[297.607861] Dynamic subtest uc: SUCCESS (1.042s)
[297.608614] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.215s)
[297.753295] [087/131] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[298.120416] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[298.121684] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[298.564353] [088/131] (751s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[298.627935] Starting subtest: multi-wait-for-submit-available-signaled
[298.628724] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[298.737824] [089/131] (751s left) gem_tiling_max_stride
[298.919816] [090/131] (751s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[299.285775] Starting subtest: cursor-rapid-movement-128x128
[299.289990] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.646729] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.358s)
[299.688357] Starting dynamic subtest: pipe-B-HDMI-A-1
[300.039421] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.362s)
[300.040224] Subtest cursor-rapid-movement-128x128: SUCCESS (0.753s)
[300.603204] [091/131] (749s left) gem_mmap_offset (mmap-boundaries)
[300.664186] Starting subtest: mmap-boundaries
[300.664836] Starting dynamic subtest: smem0
[302.566527] Dynamic subtest smem0: SUCCESS (1.903s)
[302.568867] Subtest mmap-boundaries: SUCCESS (1.905s)
[302.837985] [092/131] (747s left) gem_exec_schedule (semaphore-noskip)
[302.900539] Subtest semaphore-noskip: SKIP (0.000s)
[303.094769] [093/131] (747s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[303.438970] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[303.664992] [094/131] (746s left) kms_lease (atomic-implicit-crtc)
[304.021169] Starting subtest: atomic-implicit-crtc
[304.022047] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.025359] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[304.041285] Starting dynamic subtest: pipe-B-HDMI-A-1
[304.044885] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.009s)
[304.045813] Subtest atomic-implicit-crtc: SUCCESS (0.017s)
[304.474292] [095/131] (745s left) kms_cursor_edge_walk (64x64-right-edge)
[304.839521] Starting subtest: 64x64-right-edge
[304.840635] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.266489] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.430s)
[308.279764] Starting dynamic subtest: pipe-B-HDMI-A-1
[311.590204] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.328s)
[311.590939] Subtest 64x64-right-edge: SUCCESS (6.763s)
[312.138347] [096/131] (738s left) api_intel_allocator (open-vm)
[312.200566] Starting subtest: open-vm
[312.205607] Subtest open-vm: SUCCESS (0.006s)
[312.355390] [097/131] (738s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[312.416654] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[312.484241] [098/131] (738s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[312.841528] Starting subtest: fbc-rgb565-draw-mmap-wc
[314.662410] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.823s)
[315.151069] [099/131] (735s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[315.210509] Starting subtest: invalid-multi-wait-unsubmitted
[315.211409] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[315.314273] [100/131] (735s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[315.369358] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[315.421332] [101/131] (735s left) kms_chamelium_color (gamma)
[315.781801] Subtest gamma: SKIP (0.000s)
[316.030928] [102/131] (734s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[316.474328] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[316.835352] [103/131] (734s left) kms_atomic (plane-cursor-legacy)
[317.197924] Starting subtest: plane-cursor-legacy
[317.198687] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.383449] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.186s)
[317.384239] Subtest plane-cursor-legacy: SUCCESS (0.188s)
[317.934302] [104/131] (732s left) gem_fence_thrash (bo-copy)
[317.990478] Starting subtest: bo-copy
[319.089881] Subtest bo-copy: SUCCESS (1.099s)
[319.213390] [105/131] (731s left) gem_ctx_param (invalid-ctx-get)
[319.278401] Starting subtest: invalid-ctx-get
[319.279270] Subtest invalid-ctx-get: SUCCESS (0.000s)
[319.382596] [106/131] (731s left) i915_query (engine-info-invalid)
[319.436711] Starting subtest: engine-info-invalid
[319.437465] Subtest engine-info-invalid: SUCCESS (0.000s)
[319.531318] [107/131] (731s left) i915_pm_rpm (debugfs-forcewake-user)
[331.130051] Subtest debugfs-forcewake-user: SKIP (0.000s)
[331.365227] [108/131] (719s left) gem_exec_reloc (basic-cpu-active)
[331.426515] Starting subtest: basic-cpu-active
[331.539109] Subtest basic-cpu-active: SUCCESS (0.110s)
[332.283604] [109/131] (718s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[332.644668] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[332.872300] [110/131] (718s left) kms_universal_plane (universal-plane-pageflip-windowed)
[333.237165] Starting subtest: universal-plane-pageflip-windowed
[333.240259] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[333.678070] [111/131] (717s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[333.733865] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[333.795314] [112/131] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[334.162560] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[334.163767] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[334.608858] [113/131] (716s left) kms_flip (flip-vs-absolute-wf_vblank)
[334.974041] Starting subtest: flip-vs-absolute-wf_vblank
[334.974728] Starting dynamic subtest: A-VGA1
[343.023751] Dynamic subtest A-VGA1: SUCCESS (8.051s)
[343.039080] Starting dynamic subtest: B-VGA1
[351.030260] Dynamic subtest B-VGA1: SUCCESS (8.006s)
[351.045044] Starting dynamic subtest: A-HDMI-A1
[359.202289] Dynamic subtest A-HDMI-A1: SUCCESS (8.171s)
[359.215893] Starting dynamic subtest: B-HDMI-A1
[367.399958] Dynamic subtest B-HDMI-A1: SUCCESS (8.197s)
[367.402721] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.438s)
[368.039957] [114/131] (683s left) gem_userptr_blits (usage-restrictions)
[368.099192] Starting subtest: usage-restrictions
[368.100014] Subtest usage-restrictions: SUCCESS (0.000s)
[368.239411] [115/131] (683s left) kms_properties (invalid-properties-atomic)
[368.599595] Starting subtest: invalid-properties-atomic
[368.639671] Subtest invalid-properties-atomic: SUCCESS (0.041s)
[369.085242] [116/131] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[369.449992] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[369.451279] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[369.910130] [117/131] (681s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[369.968857] Starting subtest: cpuset-basic-small-copy-XY
[371.307150] Subtest cpuset-basic-small-copy-XY: SUCCESS (1.339s)
[371.420061] [118/131] (680s left) gem_close_race (basic-threads)
[371.591933] Starting subtest: basic-threads
[372.796637] Subtest basic-threads: SUCCESS (1.205s)
[372.996839] [119/131] (678s left) kms_flip (2x-blocking-absolute-wf_vblank)
[373.375687] Starting subtest: 2x-blocking-absolute-wf_vblank
[373.376288] Starting dynamic subtest: AB-VGA1-HDMI-A1
[403.852875] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.487s)
[403.856561] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (30.491s)
[404.532265] [120/131] (647s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[404.915486] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[404.928196] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.013s)
[405.383073] [121/131] (646s left) gem_exec_create (legacy)
[405.450625] Starting subtest: legacy
[405.451438] Starting dynamic subtest: smem
[407.502368] Dynamic subtest smem: SUCCESS (2.049s)
[407.505924] Subtest legacy: SUCCESS (2.052s)
[407.710423] [122/131] (644s left) kms_vrr (seamless-rr-switch-virtual)
[408.074120] Starting subtest: seamless-rr-switch-virtual
[408.076308] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[408.525270] [123/131] (643s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[408.885330] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[408.886152] Starting dynamic subtest: pipe-A-HDMI-A-1
[409.004552] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.119s)
[409.102215] Starting dynamic subtest: pipe-B-HDMI-A-1
[409.372027] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.282s)
[409.456982] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.573s)
[410.018161] [124/131] (641s left) gem_exec_schedule (pi-common)
[410.093152] Subtest pi-common: SKIP (0.000s)
[410.303613] [125/131] (641s left) gem_eio (in-flight-contexts-immediate)
[410.369284] Starting subtest: in-flight-contexts-immediate
[414.837351] Subtest in-flight-contexts-immediate: SUCCESS (4.466s)
[415.597366] [126/131] (636s left) syncobj_timeline (wait-all-snapshot)
[415.662687] Starting subtest: wait-all-snapshot
[415.744968] Subtest wait-all-snapshot: SUCCESS (0.082s)
[415.842341] [127/131] (636s left) kms_setmode (basic-clone-single-crtc)
[415.897071] Starting subtest: basic-clone-single-crtc
[415.899282] Subtest basic-clone-single-crtc: SKIP (0.000s)
[415.994117] [128/131] (636s left) perf_pmu (busy-check-all)
[416.057946] Starting subtest: busy-check-all
[416.058775] Starting dynamic subtest: rcs0
[416.579116] Dynamic subtest rcs0: SUCCESS (0.520s)
[416.596974] Starting dynamic subtest: bcs0
[417.097163] Dynamic subtest bcs0: SUCCESS (0.515s)
[417.114453] Starting dynamic subtest: vcs0
[418.123049] Dynamic subtest vcs0: SUCCESS (1.023s)
[418.125681] Subtest busy-check-all: SUCCESS (2.065s)
[418.229419] [129/131] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[418.606888] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[418.609609] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[419.041225] [130/131] (633s left) perf_pmu (module-unload)
[419.120307] Starting subtest: module-unload
[425.736836] Subtest module-unload: FAIL (6.594s)
[425.769053] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[425.770353] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[425.772900] [131/131] (626s left) gem_ctx_engines (none)
[427.581610] Starting subtest: none
[427.584444] Subtest none: SUCCESS (0.002s)
[427.744018] [FACT gem_ctx_engines (none)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[427.745740] [FACT gem_ctx_engines (none)] new: kernel.kmod_is_loaded.i915: true
[427.746958] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: dumb_buffer
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gen7_exec_parse
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_pipe_crc_basic
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_atomic_interruptible
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_chamelium_frames
results: parsing output: 33/ for test: i915_getparams_basic
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: prime_mmap
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_joiner
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_ringfill
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: core_setmaster
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: sysfs_preempt_timeout
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_dp_link_training
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_getfb
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_fence_thrash
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gen3_render_linear_blits
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_tiling_max_stride
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: kms_cursor_edge_walk
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_chamelium_color
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_atomic
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: gem_ctx_param
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_universal_plane
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: gem_close_race
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_create
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_atomic_transition
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_setmode
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_ctx_engines
Done.