[154.015990] Initializing watchdogs
[154.016735]   /dev/watchdog0
[154.145569] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a001 Intel Pineview (Gen3) Atom Processor D4xx/D5xx/N4xx/N5xx Integrated Graphics Controller (DeskTop Board D510MO)
[154.184582] [001/161] (960s left) i915_module_load (load)
[155.774993] Starting subtest: load
[163.346364] Subtest load: SUCCESS (7.576s)
[163.730232] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[163.742667] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[163.773700] [002/161] (951s left) core_auth (basic-auth)
[164.315730] Starting subtest: basic-auth
[164.322146] Subtest basic-auth: SUCCESS (0.005s)
[164.627255] [003/161] (950s left) debugfs_test (read_all_entries)
[165.167000] Starting subtest: read_all_entries
[165.368561] Subtest read_all_entries: SUCCESS (0.202s)
[165.711552] [004/161] (949s left) debugfs_test (basic-hwmon)
[166.177616] Starting subtest: basic-hwmon
[166.186636] Subtest basic-hwmon: SKIP (0.000s)
[166.529811] [005/161] (949s left) debugfs_test (sysfs)
[167.008873] Starting subtest: sysfs
[167.169506] Subtest sysfs: SUCCESS (0.156s)
[167.586458] [006/161] (948s left) fbdev (eof)
[168.049732] Starting subtest: eof
[168.055096] Subtest eof: SUCCESS (0.005s)
[168.342250] [007/161] (948s left) fbdev (info)
[168.794847] Starting subtest: info
[168.798420] Subtest info: SUCCESS (0.000s)
[169.095740] [008/161] (947s left) fbdev (nullptr)
[169.547074] Starting subtest: nullptr
[169.550758] Subtest nullptr: SUCCESS (0.001s)
[169.841909] [009/161] (947s left) fbdev (read)
[170.297317] Starting subtest: read
[170.600789] Subtest read: SUCCESS (0.305s)
[170.893378] [010/161] (946s left) fbdev (write)
[171.331896] Starting subtest: write
[171.510496] Subtest write: SUCCESS (0.181s)
[171.815973] [011/161] (945s left) gem_basic (bad-close)
[172.271309] Starting subtest: bad-close
[172.279205] Subtest bad-close: SUCCESS (0.000s)
[172.579379] [012/161] (945s left) gem_basic (create-close)
[173.044580] Starting subtest: create-close
[173.051881] Subtest create-close: SUCCESS (0.001s)
[173.355682] [013/161] (944s left) gem_basic (create-fd-close)
[173.874496] Starting subtest: create-fd-close
[173.885656] Subtest create-fd-close: SUCCESS (0.002s)
[174.196335] [014/161] (944s left) gem_busy (busy@all-engines)
[174.752857] Starting subtest: busy
[174.757725] Starting dynamic subtest: all-engines
[174.901909] Dynamic subtest all-engines: SUCCESS (0.156s)
[174.906450] Subtest busy: SUCCESS (0.160s)
[175.657268] [015/161] (943s left) gem_close_race (basic-process)
[176.225101] Starting subtest: basic-process
[176.438406] Subtest basic-process: SUCCESS (0.223s)
[176.887560] [016/161] (942s left) gem_close_race (basic-threads)
[177.449570] Starting subtest: basic-threads
[179.003910] Subtest basic-threads: SUCCESS (1.557s)
[179.454127] [017/161] (939s left) gem_ctx_create (basic)
[179.994105] Subtest basic: SKIP (0.000s)
[180.278514] [018/161] (939s left) gem_ctx_create (basic-files)
[180.740266] Subtest basic-files: SKIP (0.000s)
[181.082308] [019/161] (938s left) gem_ctx_exec (basic)
[181.576213] Subtest basic: SKIP (0.000s)
[181.914628] [020/161] (938s left) gem_exec_basic (basic)
[182.431421] Starting subtest: basic
[182.437139] Starting dynamic subtest: rcs0-smem
[182.441112] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[182.444530] Subtest basic: SUCCESS (0.008s)
[182.886613] [021/161] (937s left) gem_exec_create (basic)
[183.421486] Starting subtest: basic
[183.426110] Starting dynamic subtest: smem
[185.579121] Dynamic subtest smem: SUCCESS (2.164s)
[185.582886] Subtest basic: SUCCESS (2.167s)
[186.038830] [022/161] (934s left) gem_exec_fence (basic-busy)
[186.782817] Starting subtest: basic-busy
[186.791131] Starting dynamic subtest: rcs0
[186.831807] Dynamic subtest rcs0: SUCCESS (0.050s)
[186.835853] Subtest basic-busy: SUCCESS (0.054s)
[188.016547] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[188.029648] [023/161] (932s left) gem_exec_fence (basic-wait)
[188.774580] Starting subtest: basic-wait
[188.779381] Starting dynamic subtest: rcs0
[188.810513] Dynamic subtest rcs0: SUCCESS (0.037s)
[188.814690] Subtest basic-wait: SUCCESS (0.041s)
[189.769338] [024/161] (931s left) gem_exec_fence (basic-await)
[190.516626] Starting subtest: basic-await
[190.521756] Starting dynamic subtest: rcs0
[190.665922] Dynamic subtest rcs0: SUCCESS (0.143s)
[190.670354] Subtest basic-await: SUCCESS (0.148s)
[191.619542] [025/161] (929s left) gem_exec_fence (nb-await)
[192.361299] Starting subtest: nb-await
[192.366464] Starting dynamic subtest: rcs0
[192.429876] Dynamic subtest rcs0: SUCCESS (0.065s)
[192.434124] Subtest nb-await: SUCCESS (0.070s)
[193.384426] [026/161] (928s left) gem_exec_gttfill (basic)
[193.918526] Starting subtest: basic
[204.011537] Subtest basic: SUCCESS (10.099s)
[204.575495] [027/161] (917s left) gem_exec_parallel (engines)
[205.334718] Starting subtest: engines
[205.339203] Starting dynamic subtest: basic
[209.513858] Dynamic subtest basic: SUCCESS (4.179s)
[209.567411] Starting dynamic subtest: contexts
[209.574461] Dynamic subtest contexts: SKIP (0.003s)
[209.617273] Starting dynamic subtest: fds
[209.623677] Dynamic subtest fds: SKIP (0.003s)
[209.664249] Starting dynamic subtest: userptr
[213.790234] Dynamic subtest userptr: SUCCESS (4.264s)
[213.793971] Subtest engines: SUCCESS (8.459s)
[214.287597] [028/161] (908s left) gem_exec_store (basic)
[214.819193] Starting subtest: basic
[214.869881] Subtest basic: SUCCESS (0.053s)
[215.361604] [029/161] (907s left) gem_flink_basic (bad-flink)
[215.814913] Starting subtest: bad-flink
[215.819459] Subtest bad-flink: SUCCESS (0.001s)
[216.159912] [030/161] (907s left) gem_flink_basic (bad-open)
[216.606872] Starting subtest: bad-open
[216.611705] Subtest bad-open: SUCCESS (0.000s)
[216.945682] [031/161] (906s left) gem_flink_basic (basic)
[217.383794] Starting subtest: basic
[217.388794] Subtest basic: SUCCESS (0.001s)
[217.745407] [032/161] (906s left) gem_flink_basic (double-flink)
[218.190435] Starting subtest: double-flink
[218.194963] Subtest double-flink: SUCCESS (0.001s)
[218.558644] [033/161] (905s left) gem_flink_basic (flink-lifetime)
[219.001641] Starting subtest: flink-lifetime
[219.016429] Subtest flink-lifetime: SUCCESS (0.008s)
[219.362919] [034/161] (905s left) gem_huc_copy (huc-copy)
[219.824680] Subtest huc-copy: SKIP (0.000s)
[220.137105] [035/161] (904s left) gem_linear_blits (basic)
[220.925493] Starting subtest: basic
[220.972770] Subtest basic: SUCCESS (0.053s)
[221.408582] [036/161] (903s left) gem_mmap (basic)
[222.101103] Starting subtest: basic
[222.123413] Subtest basic: SUCCESS (0.003s)
[222.460887] [037/161] (902s left) gem_mmap_gtt (basic)
[222.918364] Starting subtest: basic
[222.923227] Subtest basic: SUCCESS (0.007s)
[223.277131] [038/161] (902s left) gem_render_linear_blits (basic)
[223.734240] Starting subtest: basic
[223.888603] Subtest basic: SUCCESS (0.153s)
[224.227511] [039/161] (901s left) gem_render_tiled_blits (basic)
[224.707115] Starting subtest: basic
[224.939134] Subtest basic: SUCCESS (0.232s)
[225.302753] [040/161] (901s left) gem_ringfill (basic-all)
[225.865988] Starting subtest: basic-all
[227.088987] Subtest basic-all: SUCCESS (1.226s)
[227.442182] [041/161] (899s left) gem_softpin (allocator-basic)
[227.908885] Subtest allocator-basic: SKIP (0.000s)
[228.255796] [042/161] (898s left) gem_softpin (allocator-basic-reserve)
[228.720645] Subtest allocator-basic-reserve: SKIP (0.000s)
[229.069157] [043/161] (898s left) gem_softpin (safe-alignment)
[229.530210] Starting subtest: safe-alignment
[229.543671] Subtest safe-alignment: SUCCESS (0.020s)
[229.906643] [044/161] (897s left) gem_sync (basic-all)
[230.438888] Starting subtest: basic-all
[232.628739] Subtest basic-all: SUCCESS (2.188s)
[233.129278] [045/161] (894s left) gem_sync (basic-each)
[233.666565] Starting subtest: basic-each
[235.828648] Subtest basic-each: SUCCESS (2.157s)
[236.315271] [046/161] (891s left) gem_tiled_blits (basic)
[237.139102] Starting subtest: basic
[237.266970] Subtest basic: SUCCESS (0.134s)
[237.731931] [047/161] (890s left) gem_tiled_fence_blits (basic)
[238.812334] Starting subtest: basic
[238.879559] Subtest basic: SUCCESS (0.068s)
[239.338794] [048/161] (889s left) gem_tiled_pread_basic
[242.227450] [049/161] (887s left) gem_wait (busy@all-engines)
[242.830610] Starting subtest: busy
[242.835733] Starting dynamic subtest: all-engines
[243.362666] Dynamic subtest all-engines: SUCCESS (0.531s)
[243.367339] Subtest busy: SUCCESS (0.535s)
[244.015596] [050/161] (885s left) gem_wait (wait@all-engines)
[244.602416] Starting subtest: wait
[244.609737] Starting dynamic subtest: all-engines
[245.646672] Dynamic subtest all-engines: SUCCESS (1.045s)
[245.654109] Subtest wait: SUCCESS (1.052s)
[246.303980] [051/161] (883s left) i915_getparams_basic (basic-eu-total)
[246.746342] Starting subtest: basic-eu-total
[246.755248] Subtest basic-eu-total: SUCCESS (0.000s)
[247.106698] [052/161] (883s left) i915_getparams_basic (basic-subslice-total)
[247.548769] Starting subtest: basic-subslice-total
[247.557623] Subtest basic-subslice-total: SUCCESS (0.000s)
[247.904648] [053/161] (882s left) i915_hangman (error-state-basic)
[248.385404] Starting subtest: error-state-basic
[248.798292] Subtest error-state-basic: SUCCESS (0.408s)
[249.173723] [054/161] (881s left) i915_pciid
[249.984427] [055/161] (881s left) kms_addfb_basic (addfb25-4-tiled)
[250.512720] Starting subtest: addfb25-4-tiled
[250.518490] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[250.868678] [056/161] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[251.359242] Starting subtest: addfb25-bad-modifier
[251.364756] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[251.734515] [057/161] (880s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[252.249284] Starting subtest: addfb25-framebuffer-vs-set-tiling
[252.253756] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[252.607834] [058/161] (879s left) kms_addfb_basic (addfb25-modifier-no-flag)
[253.107178] Starting subtest: addfb25-modifier-no-flag
[253.112412] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[253.472432] [059/161] (878s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[253.963846] Starting subtest: addfb25-x-tiled-legacy
[253.969077] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[254.321713] [060/161] (878s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[254.884871] Starting subtest: addfb25-x-tiled-mismatch-legacy
[254.896218] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[255.285461] [061/161] (877s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[255.779630] Starting subtest: addfb25-yf-tiled-legacy
[255.784346] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[256.144174] [062/161] (877s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[256.647850] Starting subtest: addfb25-y-tiled-legacy
[256.653246] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[257.025959] [063/161] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[257.532758] Starting subtest: addfb25-y-tiled-small-legacy
[257.541644] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[257.886693] [064/161] (876s left) kms_addfb_basic (bad-pitch-0)
[258.335819] Starting subtest: bad-pitch-0
[258.340836] Subtest bad-pitch-0: SUCCESS (0.000s)
[258.743205] [065/161] (875s left) kms_addfb_basic (bad-pitch-1024)
[259.192754] Starting subtest: bad-pitch-1024
[259.198341] Subtest bad-pitch-1024: SUCCESS (0.000s)
[259.592115] [066/161] (875s left) kms_addfb_basic (bad-pitch-128)
[260.043145] Starting subtest: bad-pitch-128
[260.047998] Subtest bad-pitch-128: SUCCESS (0.000s)
[260.480908] [067/161] (874s left) kms_addfb_basic (bad-pitch-256)
[260.942982] Starting subtest: bad-pitch-256
[260.948339] Subtest bad-pitch-256: SUCCESS (0.000s)
[261.346639] [068/161] (873s left) kms_addfb_basic (bad-pitch-32)
[261.797977] Starting subtest: bad-pitch-32
[261.803604] Subtest bad-pitch-32: SUCCESS (0.000s)
[262.196103] [069/161] (873s left) kms_addfb_basic (bad-pitch-63)
[262.645205] Starting subtest: bad-pitch-63
[262.649854] Subtest bad-pitch-63: SUCCESS (0.000s)
[263.078919] [070/161] (872s left) kms_addfb_basic (bad-pitch-65536)
[263.536489] Starting subtest: bad-pitch-65536
[263.541470] Subtest bad-pitch-65536: SUCCESS (0.002s)
[263.947789] [071/161] (872s left) kms_addfb_basic (bad-pitch-999)
[264.400212] Starting subtest: bad-pitch-999
[264.405392] Subtest bad-pitch-999: SUCCESS (0.000s)
[264.817190] [072/161] (871s left) kms_addfb_basic (basic)
[265.267859] Starting subtest: basic
[265.273716] Subtest basic: SUCCESS (0.000s)
[265.675190] [073/161] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[266.122315] Starting subtest: basic-x-tiled-legacy
[266.126897] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[266.527413] [074/161] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[266.986973] Starting subtest: basic-y-tiled-legacy
[266.991756] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[267.404380] [075/161] (870s left) kms_addfb_basic (bo-too-small)
[267.903747] Starting subtest: bo-too-small
[267.911111] Subtest bo-too-small: SUCCESS (0.002s)
[268.271304] [076/161] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[268.782956] Starting subtest: bo-too-small-due-to-tiling
[268.787441] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[269.160947] [077/161] (869s left) kms_addfb_basic (clobberred-modifier)
[269.602746] Starting subtest: clobberred-modifier
[269.608653] Subtest clobberred-modifier: SUCCESS (0.001s)
[270.085999] [078/161] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[270.537822] Starting subtest: framebuffer-vs-set-tiling
[270.541646] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[270.964590] [079/161] (867s left) kms_addfb_basic (invalid-get-prop)
[271.421720] Starting subtest: invalid-get-prop
[271.426935] Subtest invalid-get-prop: SUCCESS (0.000s)
[271.838453] [080/161] (867s left) kms_addfb_basic (invalid-get-prop-any)
[272.284539] Starting subtest: invalid-get-prop-any
[272.290411] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[272.704648] [081/161] (866s left) kms_addfb_basic (invalid-set-prop)
[273.171885] Starting subtest: invalid-set-prop
[273.176468] Subtest invalid-set-prop: SUCCESS (0.000s)
[273.602508] [082/161] (866s left) kms_addfb_basic (invalid-set-prop-any)
[274.061547] Starting subtest: invalid-set-prop-any
[274.066137] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[274.485453] [083/161] (865s left) kms_addfb_basic (no-handle)
[274.948534] Starting subtest: no-handle
[274.953815] Subtest no-handle: SUCCESS (0.000s)
[275.367677] [084/161] (865s left) kms_addfb_basic (size-max)
[275.892395] Starting subtest: size-max
[275.897053] Subtest size-max: SUCCESS (0.001s)
[276.252888] [085/161] (864s left) kms_addfb_basic (small-bo)
[276.758585] Starting subtest: small-bo
[276.763199] Subtest small-bo: SUCCESS (0.000s)
[277.123270] [086/161] (864s left) kms_addfb_basic (tile-pitch-mismatch)
[277.584971] Starting subtest: tile-pitch-mismatch
[277.590835] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[278.011637] [087/161] (863s left) kms_addfb_basic (too-high)
[278.522709] Starting subtest: too-high
[278.528503] Subtest too-high: SUCCESS (0.006s)
[278.891748] [088/161] (862s left) kms_addfb_basic (too-wide)
[279.389276] Starting subtest: too-wide
[279.393861] Subtest too-wide: SUCCESS (0.000s)
[279.762546] [089/161] (862s left) kms_addfb_basic (unused-handle)
[280.212706] Starting subtest: unused-handle
[280.217901] Subtest unused-handle: SUCCESS (0.000s)
[280.630304] [090/161] (861s left) kms_addfb_basic (unused-modifier)
[281.092085] Starting subtest: unused-modifier
[281.096818] Subtest unused-modifier: SUCCESS (0.001s)
[281.503096] [091/161] (861s left) kms_addfb_basic (unused-offsets)
[281.951534] Starting subtest: unused-offsets
[281.956649] Subtest unused-offsets: SUCCESS (0.000s)
[282.390632] [092/161] (860s left) kms_addfb_basic (unused-pitches)
[282.844155] Starting subtest: unused-pitches
[282.849967] Subtest unused-pitches: SUCCESS (0.000s)
[283.255447] [093/161] (860s left) kms_busy (basic)
[283.777765] Starting subtest: basic
[283.782963] Starting dynamic subtest: flip
[284.867145] Dynamic subtest flip: SUCCESS (1.060s)
[284.933849] Starting dynamic subtest: modeset
[284.947325] Dynamic subtest modeset: SKIP (0.000s)
[284.952177] Subtest basic: SUCCESS (1.077s)
[285.418342] [094/161] (858s left) kms_prop_blob (basic)
[285.867465] Starting subtest: basic
[285.872432] Subtest basic: SUCCESS (0.000s)
[286.221215] [095/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[286.737494] Starting subtest: basic-busy-flip-before-cursor-atomic
[286.759692] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.019s)
[287.112212] [096/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[287.603239] Starting subtest: basic-busy-flip-before-cursor-legacy
[288.703885] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.105s)
[289.227719] [097/161] (855s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[289.733383] Starting subtest: basic-flip-after-cursor-atomic
[289.742684] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[290.092876] [098/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[290.583826] Starting subtest: basic-flip-after-cursor-legacy
[291.668122] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.087s)
[292.185733] [099/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[292.673536] Starting subtest: basic-flip-after-cursor-varying-size
[293.770362] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.096s)
[294.287329] [100/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[294.800924] Starting subtest: basic-flip-before-cursor-atomic
[294.810230] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[295.158251] [101/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[295.646547] Starting subtest: basic-flip-before-cursor-legacy
[296.731899] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.087s)
[297.285851] [102/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[297.784922] Starting subtest: basic-flip-before-cursor-varying-size
[298.867750] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.087s)
[299.392657] [103/161] (847s left) kms_dsc (dsc-basic)
[299.962929] Subtest dsc-basic: SKIP (0.000s)
[300.297456] [104/161] (846s left) kms_flip (basic-flip-vs-dpms)
[300.796170] Starting subtest: basic-flip-vs-dpms
[300.800874] Starting dynamic subtest: A-VGA1
[302.458730] Dynamic subtest A-VGA1: SUCCESS (1.656s)
[302.508235] Starting dynamic subtest: B-VGA1
[304.053881] Dynamic subtest B-VGA1: SUCCESS (1.572s)
[304.058773] Subtest basic-flip-vs-dpms: SUCCESS (3.240s)
[304.715408] [105/161] (842s left) kms_flip (basic-flip-vs-modeset)
[305.224569] Starting subtest: basic-flip-vs-modeset
[305.230427] Starting dynamic subtest: A-VGA1
[306.919722] Dynamic subtest A-VGA1: SUCCESS (1.691s)
[306.968947] Starting dynamic subtest: B-VGA1
[308.425375] Dynamic subtest B-VGA1: SUCCESS (1.504s)
[308.430252] Subtest basic-flip-vs-modeset: SUCCESS (3.207s)
[309.047198] [106/161] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[309.536074] Starting subtest: basic-flip-vs-wf_vblank
[309.541430] Starting dynamic subtest: A-VGA1
[311.374306] Dynamic subtest A-VGA1: SUCCESS (1.827s)
[311.428429] Starting dynamic subtest: B-VGA1
[313.107877] Dynamic subtest B-VGA1: SUCCESS (1.731s)
[313.112892] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.570s)
[313.823569] [107/161] (834s left) kms_flip (basic-plain-flip)
[314.332893] Starting subtest: basic-plain-flip
[314.338826] Starting dynamic subtest: A-VGA1
[315.904865] Dynamic subtest A-VGA1: SUCCESS (1.569s)
[315.980269] Starting dynamic subtest: B-VGA1
[317.451568] Dynamic subtest B-VGA1: SUCCESS (1.528s)
[317.457485] Subtest basic-plain-flip: SUCCESS (3.118s)
[318.148452] [108/161] (830s left) kms_force_connector_basic (force-connector-state)
[318.705103] Starting subtest: force-connector-state
[319.011602] Subtest force-connector-state: SUCCESS (0.301s)
[319.680729] [109/161] (828s left) kms_force_connector_basic (force-edid)
[320.219809] Starting subtest: force-edid
[320.333622] Subtest force-edid: SUCCESS (0.116s)
[320.821216] [110/161] (828s left) kms_force_connector_basic (force-load-detect)
[321.414300] Starting subtest: force-load-detect
[321.855859] Subtest force-load-detect: SUCCESS (0.480s)
[322.474612] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes)
[323.030557] Starting subtest: prune-stale-modes
[323.123964] Subtest prune-stale-modes: SUCCESS (0.098s)
[323.560511] [112/161] (826s left) kms_frontbuffer_tracking (basic)
[324.056367] Subtest basic: SKIP (0.000s)
[324.383417] [113/161] (825s left) kms_hdmi_inject (inject-audio)
[324.836844] Subtest inject-audio: SKIP (0.000s)
[325.152412] [114/161] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[325.651523] Starting subtest: compare-crc-sanitycheck-xr24
[325.656445] Starting dynamic subtest: pipe-A-VGA-1
[326.028424] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.378s)
[326.092361] Starting dynamic subtest: pipe-B-VGA-1
[326.556418] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.519s)
[326.560882] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.913s)
[327.056273] [115/161] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[327.545528] Starting subtest: compare-crc-sanitycheck-nv12
[327.550347] Starting dynamic subtest: pipe-A-VGA-1
[327.557225] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[327.603763] Starting dynamic subtest: pipe-B-VGA-1
[327.611311] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[327.617807] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[327.946588] [116/161] (823s left) kms_pipe_crc_basic (hang-read-crc)
[328.450238] Starting subtest: hang-read-crc
[328.455899] Starting dynamic subtest: pipe-A-VGA-1
[329.766857] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.312s)
[329.845572] Starting dynamic subtest: pipe-B-VGA-1
[331.228539] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.453s)
[331.233274] Subtest hang-read-crc: SUCCESS (2.784s)
[331.728364] [117/161] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[332.254990] Starting subtest: nonblocking-crc
[332.259968] Starting dynamic subtest: pipe-A-VGA-1
[332.835594] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.579s)
[332.903402] Starting dynamic subtest: pipe-B-VGA-1
[333.560493] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.719s)
[333.565522] Subtest nonblocking-crc: SUCCESS (1.311s)
[334.043492] [118/161] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[334.535137] Starting subtest: nonblocking-crc-frame-sequence
[334.540540] Starting dynamic subtest: pipe-A-VGA-1
[335.141745] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.606s)
[335.196421] Starting dynamic subtest: pipe-B-VGA-1
[335.910549] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.754s)
[335.915676] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.378s)
[336.416399] [119/161] (815s left) kms_pipe_crc_basic (read-crc)
[336.906463] Starting subtest: read-crc
[336.911447] Starting dynamic subtest: pipe-A-VGA-1
[337.435382] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.524s)
[337.487105] Starting dynamic subtest: pipe-B-VGA-1
[338.117187] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.672s)
[338.122204] Subtest read-crc: SUCCESS (1.217s)
[338.618347] [120/161] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[339.117979] Starting subtest: read-crc-frame-sequence
[339.123511] Starting dynamic subtest: pipe-A-VGA-1
[339.649324] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.523s)
[339.713949] Starting dynamic subtest: pipe-B-VGA-1
[340.285983] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.631s)
[340.290930] Subtest read-crc-frame-sequence: SUCCESS (1.170s)
[340.793796] [121/161] (811s left) kms_pm_backlight (basic-brightness)
[341.288380] Subtest basic-brightness: SKIP (0.000s)
[341.625254] [122/161] (811s left) kms_pm_rpm (basic-pci-d3-state)
[353.524756] Subtest basic-pci-d3-state: SKIP (0.000s)
[353.842980] [123/161] (799s left) kms_pm_rpm (basic-rte)
[354.270693] Starting subtest: basic-rte
[365.741677] Subtest basic-rte: SKIP (11.459s)
[366.069112] [124/161] (787s left) kms_psr (psr-primary-page-flip)
[366.574738] Subtest psr-primary-page-flip: SKIP (0.000s)
[366.908618] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[367.404470] Subtest psr-cursor-plane-move: SKIP (0.000s)
[367.738482] [126/161] (786s left) kms_psr (psr-sprite-plane-onoff)
[368.237669] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[368.560366] [127/161] (785s left) kms_psr (psr-primary-mmap-gtt)
[369.060705] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[369.384944] [128/161] (785s left) kms_setmode (basic-clone-single-crtc)
[369.845276] Starting subtest: basic-clone-single-crtc
[369.858081] Subtest basic-clone-single-crtc: SKIP (0.001s)
[370.196695] [129/161] (784s left) i915_pm_rps (basic-api)
[370.656769] Subtest basic-api: SKIP (0.000s)
[370.988971] [130/161] (784s left) prime_self_import (basic-llseek-bad)
[371.427246] Starting subtest: basic-llseek-bad
[371.438494] Subtest basic-llseek-bad: SUCCESS (0.013s)
[371.798249] [131/161] (783s left) prime_self_import (basic-llseek-size)
[372.230081] Starting subtest: basic-llseek-size
[372.260759] Subtest basic-llseek-size: SUCCESS (0.031s)
[372.621857] [132/161] (783s left) prime_self_import (basic-with_fd_dup)
[373.051529] Starting subtest: basic-with_fd_dup
[373.076420] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[373.436304] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[373.863726] Starting subtest: basic-with_one_bo
[373.881728] Subtest basic-with_one_bo: SUCCESS (0.020s)
[374.245198] [134/161] (782s left) prime_self_import (basic-with_one_bo_two_files)
[374.712367] Starting subtest: basic-with_one_bo_two_files
[374.725166] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[375.141246] [135/161] (781s left) prime_self_import (basic-with_two_bos)
[375.574949] Starting subtest: basic-with_two_bos
[375.594408] Subtest basic-with_two_bos: SUCCESS (0.021s)
[375.950991] [136/161] (781s left) prime_vgem (basic-fence-flip)
[376.435511] Starting subtest: basic-fence-flip
[377.088925] Subtest basic-fence-flip: SUCCESS (0.658s)
[377.468471] [137/161] (780s left) prime_vgem (basic-fence-mmap)
[377.953181] Starting subtest: basic-fence-mmap
[378.152721] Subtest basic-fence-mmap: SUCCESS (0.200s)
[378.529905] [138/161] (779s left) prime_vgem (basic-fence-read)
[379.021754] Starting subtest: basic-fence-read
[379.286675] Subtest basic-fence-read: SUCCESS (0.264s)
[379.660124] [139/161] (778s left) prime_vgem (basic-gtt)
[380.130875] Starting subtest: basic-gtt
[380.211080] Subtest basic-gtt: SUCCESS (0.079s)
[380.570597] [140/161] (778s left) prime_vgem (basic-read)
[381.060464] Starting subtest: basic-read
[381.160326] Subtest basic-read: SUCCESS (0.106s)
[381.520673] [141/161] (777s left) prime_vgem (basic-write)
[381.986885] Starting subtest: basic-write
[382.093574] Subtest basic-write: SUCCESS (0.112s)
[382.476615] [142/161] (776s left) vgem_basic (setversion)
[382.945826] Starting subtest: setversion
[382.955140] Subtest setversion: SUCCESS (0.000s)
[383.294198] [143/161] (776s left) vgem_basic (create)
[383.750410] Starting subtest: create
[383.754535] Subtest create: SUCCESS (0.003s)
[384.094573] [144/161] (775s left) vgem_basic (debugfs)
[384.553739] Starting subtest: debugfs
[384.559266] Subtest debugfs: SUCCESS (0.004s)
[384.893684] [145/161] (775s left) vgem_basic (dmabuf-export)
[385.351661] Starting subtest: dmabuf-export
[385.362123] Subtest dmabuf-export: SUCCESS (0.015s)
[385.711670] [146/161] (774s left) vgem_basic (dmabuf-fence)
[386.170225] Starting subtest: dmabuf-fence
[386.174852] Subtest dmabuf-fence: SUCCESS (0.005s)
[386.504430] [147/161] (774s left) vgem_basic (dmabuf-fence-before)
[386.953271] Starting subtest: dmabuf-fence-before
[386.958368] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[387.293732] [148/161] (773s left) vgem_basic (dmabuf-mmap)
[387.754790] Starting subtest: dmabuf-mmap
[387.827855] Subtest dmabuf-mmap: SUCCESS (0.082s)
[388.179639] [149/161] (773s left) vgem_basic (mmap)
[388.636639] Starting subtest: mmap
[388.689133] Subtest mmap: SUCCESS (0.059s)
[389.026487] [150/161] (772s left) vgem_basic (second-client)
[389.482558] Starting subtest: second-client
[389.514954] Subtest second-client: SUCCESS (0.033s)
[389.916957] [151/161] (772s left) vgem_basic (sysfs)
[390.369423] Starting subtest: sysfs
[390.374945] Subtest sysfs: SUCCESS (0.004s)
[390.712702] [152/161] (771s left) core_hotunplug (unbind-rebind)
[391.467668] Starting subtest: unbind-rebind
[397.147597] Subtest unbind-rebind: SUCCESS (5.680s)
[397.474169] [153/161] (765s left) vgem_basic (unload)
[397.918642] Starting subtest: unload
[427.592959] Subtest unload: SUCCESS (29.678s)
[428.134581] [154/161] (735s left) i915_module_load (reload)
[428.603519] Starting subtest: reload
[438.444605] Subtest reload: SUCCESS (9.846s)
[439.270574] [155/161] (724s left) gem_lmem_swapping (basic)
[439.930138] Subtest basic: SKIP (0.000s)
[440.251202] [156/161] (724s left) gem_lmem_swapping (parallel-random-engines)
[440.731380] Subtest parallel-random-engines: SKIP (0.000s)
[441.067679] [157/161] (723s left) gem_lmem_swapping (random-engines)
[441.537411] Subtest random-engines: SKIP (0.000s)
[441.863908] [158/161] (723s left) gem_lmem_swapping (verify-random)
[442.329137] Subtest verify-random: SKIP (0.000s)
[442.655450] [159/161] (722s left) i915_pm_rpm (module-reload)
[454.591828] Subtest module-reload: SKIP (0.000s)
[454.920790] [160/161] (710s left) i915_selftest (live)
[457.871784] Starting subtest: live
[457.875344] Starting dynamic subtest: sanitycheck
[465.266502] Dynamic subtest sanitycheck: SUCCESS (7.393s)
[465.350312] Starting dynamic subtest: uncore
[472.564488] Dynamic subtest uncore: SUCCESS (7.292s)
[472.610255] Starting dynamic subtest: workarounds
[479.877261] Dynamic subtest workarounds: SUCCESS (7.303s)
[479.972918] Starting dynamic subtest: gt_engines
[487.240804] Dynamic subtest gt_engines: SUCCESS (7.360s)
[487.284386] Starting dynamic subtest: gt_timelines
[500.738612] Dynamic subtest gt_timelines: SUCCESS (13.493s)
[500.787686] Starting dynamic subtest: gt_contexts
[508.112587] Dynamic subtest gt_contexts: SUCCESS (7.364s)
[508.201393] Starting dynamic subtest: gt_lrc
[515.403841] Dynamic subtest gt_lrc: SUCCESS (7.284s)
[515.479913] Starting dynamic subtest: gt_mocs
[522.675391] Dynamic subtest gt_mocs: SUCCESS (7.265s)
[522.742249] Starting dynamic subtest: gt_pm
[530.494942] Dynamic subtest gt_pm: SUCCESS (7.813s)
[530.544973] Starting dynamic subtest: gt_heartbeat
[537.807480] Dynamic subtest gt_heartbeat: SUCCESS (7.306s)
[537.897111] Starting dynamic subtest: gt_tlb
[545.068617] Dynamic subtest gt_tlb: SUCCESS (7.255s)
[545.110836] Starting dynamic subtest: requests
[555.039925] Dynamic subtest requests: SUCCESS (9.965s)
[555.099639] Starting dynamic subtest: migrate
[562.290354] Dynamic subtest migrate: SUCCESS (7.247s)
[562.332877] Starting dynamic subtest: active
[569.718824] Dynamic subtest active: SUCCESS (7.421s)
[569.792369] Starting dynamic subtest: objects
[577.880782] Dynamic subtest objects: SUCCESS (8.152s)
[577.977138] Starting dynamic subtest: mman
[592.556917] Dynamic subtest mman: SUCCESS (14.669s)
[592.604115] Starting dynamic subtest: dmabuf
[599.972977] Dynamic subtest dmabuf: SUCCESS (7.408s)
[600.033428] Starting dynamic subtest: vma
[607.301345] Dynamic subtest vma: SUCCESS (7.324s)
[607.356666] Starting dynamic subtest: coherency
[620.235651] Dynamic subtest coherency: SUCCESS (12.926s)
[620.326929] Starting dynamic subtest: gtt
[630.480992] Dynamic subtest gtt: SUCCESS (10.232s)
[630.542627] Starting dynamic subtest: gem
[637.944081] Dynamic subtest gem: SUCCESS (7.461s)
[637.992454] Starting dynamic subtest: evict
[645.161139] Dynamic subtest evict: SUCCESS (7.206s)
[645.223775] Starting dynamic subtest: hugepages
[652.482256] Dynamic subtest hugepages: SUCCESS (7.320s)
[652.550277] Starting dynamic subtest: gem_contexts
[659.741231] Dynamic subtest gem_contexts: SUCCESS (7.250s)
[659.815393] Starting dynamic subtest: client
[667.132926] Dynamic subtest client: SUCCESS (7.387s)
[667.182383] Starting dynamic subtest: gem_migrate
[674.360813] Dynamic subtest gem_migrate: SUCCESS (7.220s)
[674.448985] Starting dynamic subtest: reset
[683.643167] Dynamic subtest reset: SUCCESS (9.279s)
[683.695634] Starting dynamic subtest: memory_region
[690.857550] Dynamic subtest memory_region: SUCCESS (7.206s)
[690.923106] Starting dynamic subtest: hangcheck
[701.449384] Dynamic subtest hangcheck: SUCCESS (10.585s)
[701.497306] Starting dynamic subtest: execlists
[708.767626] Dynamic subtest execlists: SUCCESS (7.312s)
[708.818081] Starting dynamic subtest: ring_submission
[716.010307] Dynamic subtest ring_submission: SUCCESS (7.232s)
[716.062659] Starting dynamic subtest: perf
[723.439141] Dynamic subtest perf: SUCCESS (7.422s)
[723.497337] Starting dynamic subtest: slpc
[730.790742] Dynamic subtest slpc: SUCCESS (7.337s)
[730.856467] Starting dynamic subtest: guc
[738.127462] Dynamic subtest guc: SUCCESS (7.332s)
[738.214819] Starting dynamic subtest: guc_multi_lrc
[745.351983] Dynamic subtest guc_multi_lrc: SUCCESS (7.212s)
[745.455727] Starting dynamic subtest: guc_hang
[752.767626] Dynamic subtest guc_hang: SUCCESS (7.410s)
[752.823291] Starting dynamic subtest: late_gt_pm
[760.079233] Dynamic subtest late_gt_pm: SUCCESS (7.305s)
[760.091537] Subtest live: SUCCESS (302.213s)
[760.332184] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[760.341996] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[760.354402] [161/161] (405s left) dmabuf (all-tests)
[760.814368] Starting subtest: all-tests
[760.818544] Starting dynamic subtest: sanitycheck
[760.907119] Dynamic subtest sanitycheck: SUCCESS (0.099s)
[760.968491] Starting dynamic subtest: dma_fence
[761.201439] Dynamic subtest dma_fence: SUCCESS (0.286s)
[761.250744] Starting dynamic subtest: dma_fence_chain