[79.231747] Initializing watchdogs [79.234352] /dev/watchdog0 [79.319254] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [79.339965] [001/161] (960s left) i915_module_load (load) [80.278717] Starting subtest: load [85.845386] Subtest load: SUCCESS (5.562s) [86.234659] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [86.253786] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [86.277281] [002/161] (953s left) core_auth (basic-auth) [86.687187] Starting subtest: basic-auth [86.713363] Subtest basic-auth: SUCCESS (0.005s) [87.079217] [003/161] (953s left) debugfs_test (read_all_entries) [87.475926] Starting subtest: read_all_entries [87.814937] Subtest read_all_entries: SUCCESS (0.338s) [88.479241] [004/161] (952s left) debugfs_test (basic-hwmon) [88.750942] Starting subtest: basic-hwmon [88.755354] Subtest basic-hwmon: SKIP (0.000s) [89.445925] [005/161] (951s left) debugfs_test (sysfs) [89.716253] Starting subtest: sysfs [90.103172] Subtest sysfs: SUCCESS (0.387s) [90.806912] [006/161] (950s left) fbdev (eof) [91.108698] Starting subtest: eof [91.111458] Subtest eof: SUCCESS (0.004s) [91.325779] [007/161] (949s left) fbdev (info) [91.617986] Starting subtest: info [91.623832] Subtest info: SUCCESS (0.000s) [91.849464] [008/161] (949s left) fbdev (nullptr) [92.107109] Starting subtest: nullptr [92.108662] Subtest nullptr: SUCCESS (0.000s) [92.311557] [009/161] (949s left) fbdev (read) [92.571329] Starting subtest: read [94.659292] Subtest read: SUCCESS (2.083s) [94.864726] [010/161] (946s left) fbdev (write) [95.139999] Starting subtest: write [96.246838] Subtest write: SUCCESS (1.102s) [96.476736] [011/161] (945s left) gem_basic (bad-close) [96.734179] Starting subtest: bad-close [96.739249] Subtest bad-close: SUCCESS (0.000s) [96.949938] [012/161] (945s left) gem_basic (create-close) [97.206453] Starting subtest: create-close [97.212068] Subtest create-close: SUCCESS (0.001s) [97.427821] [013/161] (944s left) gem_basic (create-fd-close) [97.684924] Starting subtest: create-fd-close [97.691597] Subtest create-fd-close: SUCCESS (0.001s) [97.915211] [014/161] (944s left) gem_busy (busy@all-engines) [98.243526] Starting subtest: busy [98.245311] Starting dynamic subtest: all-engines [98.454331] Dynamic subtest all-engines: SUCCESS (0.218s) [98.456445] Subtest busy: SUCCESS (0.219s) [99.034499] [015/161] (943s left) gem_close_race (basic-process) [99.361282] Starting subtest: basic-process [99.510182] Subtest basic-process: SUCCESS (0.147s) [99.963433] [016/161] (942s left) gem_close_race (basic-threads) [100.351051] Starting subtest: basic-threads [101.659167] Subtest basic-threads: SUCCESS (1.306s) [102.116520] [017/161] (941s left) gem_ctx_create (basic) [102.521178] Starting subtest: basic [102.523178] Subtest basic: SUCCESS (0.001s) [102.871680] [018/161] (940s left) gem_ctx_create (basic-files) [103.191911] Starting subtest: basic-files [105.276329] Subtest basic-files: SUCCESS (2.081s) [105.627264] [019/161] (937s left) gem_ctx_exec (basic) [105.915291] Starting subtest: basic [105.937344] Subtest basic: SUCCESS (0.020s) [106.183821] [020/161] (937s left) gem_exec_basic (basic) [106.474101] Starting subtest: basic [106.477929] Starting dynamic subtest: rcs0-smem [106.479837] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [106.515597] Starting dynamic subtest: bcs0-smem [106.517746] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [106.546471] Starting dynamic subtest: vcs0-smem [106.550890] Dynamic subtest vcs0-smem: SUCCESS (0.023s) [106.580555] Starting dynamic subtest: vecs0-smem [106.584831] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [106.586741] Subtest basic: SUCCESS (0.042s) [106.862761] [021/161] (937s left) gem_exec_create (basic) [107.168560] Starting subtest: basic [107.171718] Starting dynamic subtest: smem [109.271831] Dynamic subtest smem: SUCCESS (2.099s) [109.274712] Subtest basic: SUCCESS (2.100s) [109.625854] [022/161] (934s left) gem_exec_fence (basic-busy) [110.108836] Starting subtest: basic-busy [110.112129] Starting dynamic subtest: rcs0 [110.140749] Dynamic subtest rcs0: SUCCESS (0.033s) [110.178525] Starting dynamic subtest: bcs0 [110.189921] Dynamic subtest bcs0: SUCCESS (0.047s) [110.214509] Starting dynamic subtest: vcs0 [110.222589] Dynamic subtest vcs0: SUCCESS (0.033s) [110.247583] Starting dynamic subtest: vecs0 [110.261497] Dynamic subtest vecs0: SUCCESS (0.038s) [110.265874] Subtest basic-busy: SUCCESS (0.159s) [111.285897] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [111.299638] [023/161] (932s left) gem_exec_fence (basic-wait) [111.789177] Starting subtest: basic-wait [111.790879] Starting dynamic subtest: rcs0 [111.812379] Dynamic subtest rcs0: SUCCESS (0.024s) [111.851147] Starting dynamic subtest: bcs0 [111.854627] Dynamic subtest bcs0: SUCCESS (0.037s) [111.880654] Starting dynamic subtest: vcs0 [111.903793] Dynamic subtest vcs0: SUCCESS (0.048s) [111.933978] Starting dynamic subtest: vecs0 [111.949602] Dynamic subtest vecs0: SUCCESS (0.042s) [111.952728] Subtest basic-wait: SUCCESS (0.165s) [112.804548] [024/161] (931s left) gem_exec_fence (basic-await) [113.291120] Starting subtest: basic-await [113.293485] Starting dynamic subtest: rcs0 [113.525324] Dynamic subtest rcs0: SUCCESS (0.231s) [113.551878] Starting dynamic subtest: bcs0 [113.756120] Dynamic subtest bcs0: SUCCESS (0.226s) [113.782443] Starting dynamic subtest: vcs0 [114.003135] Dynamic subtest vcs0: SUCCESS (0.241s) [114.031915] Starting dynamic subtest: vecs0 [114.285733] Dynamic subtest vecs0: SUCCESS (0.274s) [114.288726] Subtest basic-await: SUCCESS (0.987s) [115.146537] [025/161] (929s left) gem_exec_fence (nb-await) [115.627443] Starting subtest: nb-await [115.631653] Starting dynamic subtest: rcs0 [115.715740] Dynamic subtest rcs0: SUCCESS (0.087s) [115.742577] Starting dynamic subtest: bcs0 [115.819242] Dynamic subtest bcs0: SUCCESS (0.100s) [115.850346] Starting dynamic subtest: vcs0 [115.919837] Dynamic subtest vcs0: SUCCESS (0.096s) [115.945795] Starting dynamic subtest: vecs0 [116.018482] Dynamic subtest vecs0: SUCCESS (0.099s) [116.021078] Subtest nb-await: SUCCESS (0.393s) [116.870208] [026/161] (927s left) gem_exec_gttfill (basic) [117.183076] Starting subtest: basic [119.264804] Subtest basic: SKIP (2.056s) [119.662487] [027/161] (925s left) gem_exec_parallel (engines) [120.167940] Starting subtest: engines [120.171285] Starting dynamic subtest: basic [126.602750] Dynamic subtest basic: SUCCESS (6.437s) [126.642244] Starting dynamic subtest: contexts [136.709950] Dynamic subtest contexts: SUCCESS (10.102s) [136.738780] Starting dynamic subtest: fds [147.398562] Dynamic subtest fds: SUCCESS (10.695s) [147.434967] Starting dynamic subtest: userptr [153.801304] Dynamic subtest userptr: SUCCESS (6.398s) [153.803133] Subtest engines: SUCCESS (33.641s) [154.225682] [028/161] (891s left) gem_exec_store (basic) [154.550892] Starting subtest: basic [154.634316] Subtest basic: SUCCESS (0.086s) [155.033390] [029/161] (890s left) gem_flink_basic (bad-flink) [155.293208] Starting subtest: bad-flink [155.295619] Subtest bad-flink: SUCCESS (0.000s) [155.548349] [030/161] (890s left) gem_flink_basic (bad-open) [155.797942] Starting subtest: bad-open [155.801379] Subtest bad-open: SUCCESS (0.000s) [156.050546] [031/161] (889s left) gem_flink_basic (basic) [156.313549] Starting subtest: basic [156.315406] Subtest basic: SUCCESS (0.000s) [156.562925] [032/161] (889s left) gem_flink_basic (double-flink) [156.814974] Starting subtest: double-flink [156.817158] Subtest double-flink: SUCCESS (0.000s) [157.060429] [033/161] (889s left) gem_flink_basic (flink-lifetime) [157.316815] Starting subtest: flink-lifetime [157.327625] Subtest flink-lifetime: SUCCESS (0.011s) [157.595850] [034/161] (888s left) gem_huc_copy (huc-copy) [157.862629] Subtest huc-copy: SKIP (0.000s) [158.086068] [035/161] (888s left) gem_linear_blits (basic) [158.728687] Subtest basic: SKIP (0.000s) [158.992473] [036/161] (887s left) gem_mmap (basic) [159.432172] Starting subtest: basic [159.446061] Subtest basic: SUCCESS (0.002s) [159.692150] [037/161] (887s left) gem_mmap_gtt (basic) [159.946483] Starting subtest: basic [159.954741] Subtest basic: SUCCESS (0.004s) [160.201507] [038/161] (887s left) gem_render_linear_blits (basic) [160.474087] Starting subtest: basic [160.602340] Subtest basic: SUCCESS (0.123s) [160.810578] [039/161] (886s left) gem_render_tiled_blits (basic) [161.081975] Starting subtest: basic [161.237568] Subtest basic: SUCCESS (0.151s) [161.439843] [040/161] (886s left) gem_ringfill (basic-all) [161.961879] Starting subtest: basic-all [163.373232] Subtest basic-all: SUCCESS (1.406s) [163.639985] [041/161] (884s left) gem_softpin (allocator-basic) [163.922287] Starting subtest: allocator-basic [164.284535] Subtest allocator-basic: SUCCESS (0.359s) [164.596760] [042/161] (883s left) gem_softpin (allocator-basic-reserve) [164.872206] Starting subtest: allocator-basic-reserve [165.235817] Subtest allocator-basic-reserve: SUCCESS (0.364s) [165.526095] [043/161] (882s left) gem_softpin (safe-alignment) [165.799613] Starting subtest: safe-alignment [165.887858] Subtest safe-alignment: SUCCESS (0.063s) [166.168832] [044/161] (882s left) gem_sync (basic-all) [166.492491] Starting subtest: basic-all [169.579391] Subtest basic-all: SUCCESS (3.087s) [169.967411] [045/161] (878s left) gem_sync (basic-each) [170.279061] Starting subtest: basic-each [172.945486] Subtest basic-each: SUCCESS (2.665s) [173.308442] [046/161] (875s left) gem_tiled_blits (basic) [173.831645] Subtest basic: SKIP (0.000s) [174.058784] [047/161] (874s left) gem_tiled_fence_blits (basic) [174.724683] Starting subtest: basic [174.783626] Subtest basic: SUCCESS (0.065s) [175.070207] [048/161] (874s left) gem_tiled_pread_basic [176.595359] [049/161] (872s left) gem_wait (busy@all-engines) [176.941875] Starting subtest: busy [176.944952] Starting dynamic subtest: all-engines [177.470161] Dynamic subtest all-engines: SUCCESS (0.529s) [177.472503] Subtest busy: SUCCESS (0.531s) [177.954624] [050/161] (871s left) gem_wait (wait@all-engines) [178.296665] Starting subtest: wait [178.298663] Starting dynamic subtest: all-engines [179.339951] Dynamic subtest all-engines: SUCCESS (1.046s) [179.342771] Subtest wait: SUCCESS (1.050s) [179.830148] [051/161] (870s left) i915_getparams_basic (basic-eu-total) [180.088670] Starting subtest: basic-eu-total [180.093868] Subtest basic-eu-total: SUCCESS (0.000s) [180.325318] [052/161] (869s left) i915_getparams_basic (basic-subslice-total) [180.575723] Starting subtest: basic-subslice-total [180.580912] Subtest basic-subslice-total: SUCCESS (0.000s) [180.811892] [053/161] (869s left) i915_hangman (error-state-basic) [181.152330] Starting subtest: error-state-basic [181.184164] Subtest error-state-basic: SUCCESS (0.040s) [181.488493] [054/161] (868s left) i915_pciid [181.975854] [055/161] (868s left) kms_addfb_basic (addfb25-4-tiled) [182.725426] Starting subtest: addfb25-4-tiled [182.727879] Subtest addfb25-4-tiled: SUCCESS (0.001s) [182.956344] [056/161] (867s left) kms_addfb_basic (addfb25-bad-modifier) [183.689378] Starting subtest: addfb25-bad-modifier [183.691206] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [183.944496] [057/161] (867s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [184.722786] Starting subtest: addfb25-framebuffer-vs-set-tiling [184.727291] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [184.980605] [058/161] (866s left) kms_addfb_basic (addfb25-modifier-no-flag) [185.691189] Starting subtest: addfb25-modifier-no-flag [185.692822] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [185.947660] [059/161] (865s left) kms_addfb_basic (addfb25-x-tiled-legacy) [186.657432] Starting subtest: addfb25-x-tiled-legacy [186.659536] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [186.933857] [060/161] (864s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [187.649683] Starting subtest: addfb25-x-tiled-mismatch-legacy [187.652669] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [187.912533] [061/161] (863s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [188.624819] Starting subtest: addfb25-yf-tiled-legacy [188.628299] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [188.866594] [062/161] (863s left) kms_addfb_basic (addfb25-y-tiled-legacy) [189.594715] Starting subtest: addfb25-y-tiled-legacy [189.599846] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [189.848919] [063/161] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [190.583326] Starting subtest: addfb25-y-tiled-small-legacy [190.588635] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [190.830331] [064/161] (861s left) kms_addfb_basic (bad-pitch-0) [191.087387] Starting subtest: bad-pitch-0 [191.089214] Subtest bad-pitch-0: SUCCESS (0.000s) [191.806872] [065/161] (860s left) kms_addfb_basic (bad-pitch-1024) [192.066487] Starting subtest: bad-pitch-1024 [192.069715] Subtest bad-pitch-1024: SUCCESS (0.000s) [192.809974] [066/161] (859s left) kms_addfb_basic (bad-pitch-128) [193.065896] Starting subtest: bad-pitch-128 [193.070774] Subtest bad-pitch-128: SUCCESS (0.000s) [193.734401] [067/161] (859s left) kms_addfb_basic (bad-pitch-256) [193.987216] Starting subtest: bad-pitch-256 [193.988721] Subtest bad-pitch-256: SUCCESS (0.000s) [194.675614] [068/161] (858s left) kms_addfb_basic (bad-pitch-32) [194.941233] Starting subtest: bad-pitch-32 [194.943175] Subtest bad-pitch-32: SUCCESS (0.000s) [195.731568] [069/161] (857s left) kms_addfb_basic (bad-pitch-63) [196.026229] Starting subtest: bad-pitch-63 [196.029141] Subtest bad-pitch-63: SUCCESS (0.000s) [196.848439] [070/161] (856s left) kms_addfb_basic (bad-pitch-65536) [197.117544] Starting subtest: bad-pitch-65536 [197.120773] Subtest bad-pitch-65536: SUCCESS (0.002s) [197.843730] [071/161] (855s left) kms_addfb_basic (bad-pitch-999) [198.103147] Starting subtest: bad-pitch-999 [198.106137] Subtest bad-pitch-999: SUCCESS (0.000s) [198.835707] [072/161] (855s left) kms_addfb_basic (basic) [199.107139] Starting subtest: basic [199.109581] Subtest basic: SUCCESS (0.000s) [199.811047] [073/161] (854s left) kms_addfb_basic (basic-x-tiled-legacy) [200.070897] Starting subtest: basic-x-tiled-legacy [200.074869] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [200.777998] [074/161] (853s left) kms_addfb_basic (basic-y-tiled-legacy) [201.039128] Starting subtest: basic-y-tiled-legacy [201.042221] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [201.746626] [075/161] (852s left) kms_addfb_basic (bo-too-small) [202.496479] Starting subtest: bo-too-small [202.499229] Subtest bo-too-small: SUCCESS (0.002s) [202.750156] [076/161] (852s left) kms_addfb_basic (bo-too-small-due-to-tiling) [203.463839] Starting subtest: bo-too-small-due-to-tiling [203.467522] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [203.711952] [077/161] (851s left) kms_addfb_basic (clobberred-modifier) [203.970845] Starting subtest: clobberred-modifier [203.973392] Subtest clobberred-modifier: SUCCESS (0.000s) [204.727316] [078/161] (850s left) kms_addfb_basic (framebuffer-vs-set-tiling) [204.995150] Starting subtest: framebuffer-vs-set-tiling [204.997506] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [205.710771] [079/161] (849s left) kms_addfb_basic (invalid-get-prop) [205.982865] Starting subtest: invalid-get-prop [205.984708] Subtest invalid-get-prop: SUCCESS (0.000s) [206.709882] [080/161] (848s left) kms_addfb_basic (invalid-get-prop-any) [206.977978] Starting subtest: invalid-get-prop-any [206.979620] Subtest invalid-get-prop-any: SUCCESS (0.000s) [207.687508] [081/161] (848s left) kms_addfb_basic (invalid-set-prop) [207.944399] Starting subtest: invalid-set-prop [207.945883] Subtest invalid-set-prop: SUCCESS (0.000s) [208.647233] [082/161] (847s left) kms_addfb_basic (invalid-set-prop-any) [208.914961] Starting subtest: invalid-set-prop-any [208.917521] Subtest invalid-set-prop-any: SUCCESS (0.000s) [209.669801] [083/161] (846s left) kms_addfb_basic (no-handle) [209.927499] Starting subtest: no-handle [209.930668] Subtest no-handle: SUCCESS (0.000s) [210.646267] [084/161] (845s left) kms_addfb_basic (size-max) [211.390198] Starting subtest: size-max [211.392596] Subtest size-max: SUCCESS (0.001s) [211.631301] [085/161] (844s left) kms_addfb_basic (small-bo) [212.322568] Starting subtest: small-bo [212.325328] Subtest small-bo: SUCCESS (0.000s) [212.606913] [086/161] (844s left) kms_addfb_basic (tile-pitch-mismatch) [212.877253] Starting subtest: tile-pitch-mismatch [212.879325] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [213.628198] [087/161] (843s left) kms_addfb_basic (too-high) [214.395894] Starting subtest: too-high [214.398575] Subtest too-high: SUCCESS (0.004s) [214.651172] [088/161] (842s left) kms_addfb_basic (too-wide) [215.367120] Starting subtest: too-wide [215.370476] Subtest too-wide: SUCCESS (0.000s) [215.612144] [089/161] (841s left) kms_addfb_basic (unused-handle) [215.875155] Starting subtest: unused-handle [215.876634] Subtest unused-handle: SUCCESS (0.000s) [216.618292] [090/161] (840s left) kms_addfb_basic (unused-modifier) [216.882600] Starting subtest: unused-modifier [216.887179] Subtest unused-modifier: SUCCESS (0.000s) [217.573580] [091/161] (840s left) kms_addfb_basic (unused-offsets) [217.835123] Starting subtest: unused-offsets [217.837795] Subtest unused-offsets: SUCCESS (0.000s) [218.533434] [092/161] (839s left) kms_addfb_basic (unused-pitches) [218.796568] Starting subtest: unused-pitches [218.800720] Subtest unused-pitches: SUCCESS (0.000s) [219.507802] [093/161] (838s left) kms_busy (basic) [220.245932] Starting subtest: basic [220.250322] Starting dynamic subtest: flip [221.240107] Dynamic subtest flip: SUCCESS (0.978s) [221.299874] Starting dynamic subtest: modeset [223.203441] Dynamic subtest modeset: SUCCESS (1.950s) [223.211090] Subtest basic: SUCCESS (2.962s) [223.903277] [094/161] (834s left) kms_prop_blob (basic) [224.159853] Starting subtest: basic [224.164718] Subtest basic: SUCCESS (0.002s) [224.413361] [095/161] (834s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [225.138104] Starting subtest: basic-busy-flip-before-cursor-atomic [226.198529] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.059s) [226.804630] [096/161] (831s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [227.560557] Starting subtest: basic-busy-flip-before-cursor-legacy [228.628227] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.062s) [229.265364] [097/161] (829s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [230.021358] Starting subtest: basic-flip-after-cursor-atomic [231.064904] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.039s) [231.666164] [098/161] (827s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [232.410493] Starting subtest: basic-flip-after-cursor-legacy [233.510390] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.096s) [234.119740] [099/161] (825s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [234.844143] Starting subtest: basic-flip-after-cursor-varying-size [235.887706] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.043s) [236.529661] [100/161] (822s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [237.284577] Starting subtest: basic-flip-before-cursor-atomic [238.326592] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.044s) [238.917222] [101/161] (820s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [239.644173] Starting subtest: basic-flip-before-cursor-legacy [240.682698] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.037s) [241.337423] [102/161] (818s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [242.074340] Starting subtest: basic-flip-before-cursor-varying-size [243.123798] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.045s) [243.762623] [103/161] (816s left) kms_dsc (dsc-basic) [244.521195] Subtest dsc-basic: SKIP (0.000s) [244.729786] [104/161] (815s left) kms_flip (basic-flip-vs-dpms) [245.497996] Starting subtest: basic-flip-vs-dpms [245.501677] Starting dynamic subtest: C-HDMI-A2 [248.316332] Dynamic subtest C-HDMI-A2: SUCCESS (2.807s) [248.321877] Subtest basic-flip-vs-dpms: SUCCESS (2.822s) [248.973300] [105/161] (811s left) kms_flip (basic-flip-vs-modeset) [249.740251] Starting subtest: basic-flip-vs-modeset [249.757174] Starting dynamic subtest: C-HDMI-A2 [252.446907] Dynamic subtest C-HDMI-A2: SUCCESS (2.670s) [252.456890] Subtest basic-flip-vs-modeset: SUCCESS (2.696s) [253.140293] [106/161] (807s left) kms_flip (basic-flip-vs-wf_vblank) [253.906163] Starting subtest: basic-flip-vs-wf_vblank [253.917755] Starting dynamic subtest: C-HDMI-A2 [256.863183] Dynamic subtest C-HDMI-A2: SUCCESS (2.942s) [256.864904] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.965s) [257.193890] [107/161] (803s left) kms_flip (basic-plain-flip) [257.936368] Starting subtest: basic-plain-flip [257.941186] Starting dynamic subtest: C-HDMI-A2 [260.429223] Dynamic subtest C-HDMI-A2: SUCCESS (2.488s) [260.430860] Subtest basic-plain-flip: SUCCESS (2.505s) [260.756671] [108/161] (800s left) kms_force_connector_basic (force-connector-state) [261.145973] Starting subtest: force-connector-state [262.103780] Subtest force-connector-state: SUCCESS (0.947s) [263.656787] [109/161] (797s left) kms_force_connector_basic (force-edid) [264.075351] Starting subtest: force-edid [264.189773] Subtest force-edid: SUCCESS (0.110s) [265.115631] [110/161] (796s left) kms_force_connector_basic (force-load-detect) [265.556820] Starting subtest: force-load-detect [265.562522] Subtest force-load-detect: SKIP (0.000s) [266.408946] [111/161] (795s left) kms_force_connector_basic (prune-stale-modes) [267.018982] Starting subtest: prune-stale-modes [267.214749] Subtest prune-stale-modes: SUCCESS (0.194s) [268.550155] [112/161] (793s left) kms_frontbuffer_tracking (basic) [269.527502] Starting subtest: basic [275.037334] Subtest basic: SUCCESS (5.506s) [275.314693] [113/161] (787s left) kms_hdmi_inject (inject-audio) [275.680781] Starting subtest: inject-audio [276.334915] Subtest inject-audio: SUCCESS (0.659s) [277.110684] [114/161] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [277.890999] Starting subtest: compare-crc-sanitycheck-xr24 [277.896560] Starting dynamic subtest: pipe-C-HDMI-A-2 [278.470326] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.570s) [278.475773] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.590s) [279.104864] [115/161] (783s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [279.875775] Starting subtest: compare-crc-sanitycheck-nv12 [279.887178] Starting dynamic subtest: pipe-C-HDMI-A-2 [279.900261] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.005s) [279.905246] Subtest compare-crc-sanitycheck-nv12: SKIP (0.015s) [280.173763] [116/161] (782s left) kms_pipe_crc_basic (hang-read-crc) [280.937733] Starting subtest: hang-read-crc [280.939569] Starting dynamic subtest: pipe-C-HDMI-A-2 [282.581163] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.641s) [282.582743] Subtest hang-read-crc: SUCCESS (1.650s) [283.185527] [117/161] (779s left) kms_pipe_crc_basic (nonblocking-crc) [283.969932] Starting subtest: nonblocking-crc [283.978829] Starting dynamic subtest: pipe-C-HDMI-A-2 [284.697046] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.710s) [284.699760] Subtest nonblocking-crc: SUCCESS (0.729s) [285.298079] [118/161] (778s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [286.142727] Starting subtest: nonblocking-crc-frame-sequence [286.145121] Starting dynamic subtest: pipe-C-HDMI-A-2 [286.881544] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.738s) [286.883174] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.747s) [287.484921] [119/161] (776s left) kms_pipe_crc_basic (read-crc) [288.277543] Starting subtest: read-crc [288.279527] Starting dynamic subtest: pipe-C-HDMI-A-2 [288.935706] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.657s) [288.937858] Subtest read-crc: SUCCESS (0.667s) [289.589803] [120/161] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence) [290.308573] Starting subtest: read-crc-frame-sequence [290.311063] Starting dynamic subtest: pipe-C-HDMI-A-2 [290.944372] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.636s) [290.948534] Subtest read-crc-frame-sequence: SUCCESS (0.645s) [291.543295] [121/161] (772s left) kms_pm_backlight (basic-brightness) [292.276971] Subtest basic-brightness: SKIP (0.000s) [292.496674] [122/161] (771s left) kms_pm_rpm (basic-pci-d3-state) [294.891243] Starting subtest: basic-pci-d3-state [295.237114] Subtest basic-pci-d3-state: SUCCESS (0.341s) [295.754152] [123/161] (768s left) kms_pm_rpm (basic-rte) [296.003362] Starting subtest: basic-rte [298.388633] Subtest basic-rte: SUCCESS (2.377s) [299.468933] [124/161] (765s left) kms_psr (psr-primary-page-flip) [300.207204] Subtest psr-primary-page-flip: SKIP (0.000s) [300.421575] [125/161] (764s left) kms_psr (psr-cursor-plane-move) [301.297518] Subtest psr-cursor-plane-move: SKIP (0.000s) [301.525227] [126/161] (763s left) kms_psr (psr-sprite-plane-onoff) [302.275120] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [302.481365] [127/161] (762s left) kms_psr (psr-primary-mmap-gtt) [303.283615] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [303.514652] [128/161] (761s left) kms_setmode (basic-clone-single-crtc) [303.785337] Starting subtest: basic-clone-single-crtc [303.792856] Subtest basic-clone-single-crtc: SKIP (0.001s) [304.044189] [129/161] (761s left) i915_pm_rps (basic-api) [304.324198] Starting subtest: basic-api [304.342280] Subtest basic-api: SUCCESS (0.018s) [304.610677] [130/161] (761s left) prime_self_import (basic-llseek-bad) [304.866531] Starting subtest: basic-llseek-bad [304.878841] Subtest basic-llseek-bad: SUCCESS (0.010s) [305.137888] [131/161] (760s left) prime_self_import (basic-llseek-size) [305.400420] Starting subtest: basic-llseek-size [305.408875] Subtest basic-llseek-size: SUCCESS (0.020s) [305.664696] [132/161] (760s left) prime_self_import (basic-with_fd_dup) [305.915458] Starting subtest: basic-with_fd_dup [305.928696] Subtest basic-with_fd_dup: SUCCESS (0.014s) [306.171804] [133/161] (760s left) prime_self_import (basic-with_one_bo) [306.425529] Starting subtest: basic-with_one_bo [306.444570] Subtest basic-with_one_bo: SUCCESS (0.017s) [306.689837] [134/161] (759s left) prime_self_import (basic-with_one_bo_two_files) [306.939638] Starting subtest: basic-with_one_bo_two_files [306.954861] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s) [307.191183] [135/161] (759s left) prime_self_import (basic-with_two_bos) [307.445982] Starting subtest: basic-with_two_bos [307.459930] Subtest basic-with_two_bos: SUCCESS (0.017s) [307.708676] [136/161] (759s left) prime_vgem (basic-fence-flip) [307.996237] Starting subtest: basic-fence-flip [308.898303] Subtest basic-fence-flip: SKIP (0.897s) [309.206591] [137/161] (757s left) prime_vgem (basic-fence-mmap) [309.516888] Starting subtest: basic-fence-mmap [309.637369] Subtest basic-fence-mmap: SUCCESS (0.123s) [309.879727] [138/161] (757s left) prime_vgem (basic-fence-read) [310.168355] Starting subtest: basic-fence-read [310.431423] Subtest basic-fence-read: SUCCESS (0.260s) [310.722761] [139/161] (756s left) prime_vgem (basic-gtt) [311.017307] Starting subtest: basic-gtt [311.067580] Subtest basic-gtt: SUCCESS (0.049s) [311.327545] [140/161] (756s left) prime_vgem (basic-read) [311.615217] Starting subtest: basic-read [311.731729] Subtest basic-read: SUCCESS (0.111s) [311.997711] [141/161] (755s left) prime_vgem (basic-write) [312.283908] Starting subtest: basic-write [312.441936] Subtest basic-write: SUCCESS (0.156s) [312.744825] [142/161] (755s left) vgem_basic (setversion) [313.008567] Starting subtest: setversion [313.014507] Subtest setversion: SUCCESS (0.000s) [313.263793] [143/161] (755s left) vgem_basic (create) [313.525386] Starting subtest: create [313.527083] Subtest create: SUCCESS (0.001s) [313.763402] [144/161] (754s left) vgem_basic (debugfs) [314.025269] Starting subtest: debugfs [314.028255] Subtest debugfs: SUCCESS (0.002s) [314.267975] [145/161] (754s left) vgem_basic (dmabuf-export) [314.527512] Starting subtest: dmabuf-export [314.542493] Subtest dmabuf-export: SUCCESS (0.012s) [314.787998] [146/161] (754s left) vgem_basic (dmabuf-fence) [315.060565] Starting subtest: dmabuf-fence [315.062563] Subtest dmabuf-fence: SUCCESS (0.002s) [315.314961] [147/161] (753s left) vgem_basic (dmabuf-fence-before) [315.580182] Starting subtest: dmabuf-fence-before [315.583918] Subtest dmabuf-fence-before: SUCCESS (0.003s) [315.904776] [148/161] (753s left) vgem_basic (dmabuf-mmap) [316.177467] Starting subtest: dmabuf-mmap [316.225321] Subtest dmabuf-mmap: SUCCESS (0.045s) [316.543707] [149/161] (753s left) vgem_basic (mmap) [316.814588] Starting subtest: mmap [316.845895] Subtest mmap: SUCCESS (0.033s) [317.105541] [150/161] (752s left) vgem_basic (second-client) [317.390853] Starting subtest: second-client [317.410858] Subtest second-client: SUCCESS (0.030s) [317.657236] [151/161] (752s left) vgem_basic (sysfs) [317.943075] Starting subtest: sysfs [317.945686] Subtest sysfs: SUCCESS (0.002s) [318.193155] [152/161] (752s left) core_hotunplug (unbind-rebind) [318.679634] Starting subtest: unbind-rebind [325.310067] Subtest unbind-rebind: SUCCESS (6.630s) [325.599475] [153/161] (745s left) vgem_basic (unload) [325.875246] Starting subtest: unload [355.184416] Subtest unload: SUCCESS (29.304s) [355.541456] [154/161] (715s left) i915_module_load (reload) [355.804365] Starting subtest: reload [363.649209] Subtest reload: SUCCESS (7.842s) [364.122136] [155/161] (707s left) gem_lmem_swapping (basic) [364.817178] Subtest basic: SKIP (0.000s) [365.134146] [156/161] (706s left) gem_lmem_swapping (parallel-random-engines) [365.525619] Subtest parallel-random-engines: SKIP (0.000s) [365.742944] [157/161] (706s left) gem_lmem_swapping (random-engines) [366.039278] Subtest random-engines: SKIP (0.000s) [366.255318] [158/161] (705s left) gem_lmem_swapping (verify-random) [366.538335] Subtest verify-random: SKIP (0.000s) [366.758711] [159/161] (705s left) i915_pm_rpm (module-reload) [369.341376] Starting subtest: module-reload [389.081166] Subtest module-reload: SUCCESS (19.732s) [389.211338] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [389.217346] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [389.228489] [160/161] (683s left) i915_selftest (live) [389.507619] Starting subtest: live [389.513856] Starting dynamic subtest: sanitycheck [394.043127] Dynamic subtest sanitycheck: SUCCESS (4.510s) [394.075707] Starting dynamic subtest: uncore [398.503172] Dynamic subtest uncore: SUCCESS (4.453s) [398.572921] Starting dynamic subtest: workarounds [403.070299] Dynamic subtest workarounds: SUCCESS (4.560s) [403.119115] Starting dynamic subtest: gt_engines [408.087559] Dynamic subtest gt_engines: SUCCESS (5.009s) [408.112970] Starting dynamic subtest: gt_timelines [440.804309] Dynamic subtest gt_timelines: SUCCESS (32.700s) [440.842105] Starting dynamic subtest: gt_contexts [445.402151] Dynamic subtest gt_contexts: SUCCESS (4.586s) [445.474187] Starting dynamic subtest: gt_lrc [453.381839] Dynamic subtest gt_lrc: SUCCESS (7.975s) [453.422130] Starting dynamic subtest: gt_mocs [457.745477] Dynamic subtest gt_mocs: SUCCESS (4.351s) [457.770717] Starting dynamic subtest: gt_pm [463.301299] Dynamic subtest gt_pm: SUCCESS (5.556s) [463.348432] Starting dynamic subtest: gt_heartbeat [467.728131] Dynamic subtest gt_heartbeat: SUCCESS (4.407s) [467.787550] Starting dynamic subtest: gt_tlb [472.549146] Dynamic subtest gt_tlb: SUCCESS (4.811s) [472.593354] Starting dynamic subtest: requests [483.760448] Dynamic subtest requests: SUCCESS (11.197s) [483.806926] Starting dynamic subtest: migrate [492.057192] Dynamic subtest migrate: SUCCESS (8.286s) [492.090801] Starting dynamic subtest: active [496.790609] Dynamic subtest active: SUCCESS (4.735s) [496.823454] Starting dynamic subtest: objects [503.510065] Dynamic subtest objects: SUCCESS (6.706s) [503.537293] Starting dynamic subtest: mman [515.022527] Dynamic subtest mman: SUCCESS (11.503s) [515.049194] Starting dynamic subtest: dmabuf [519.567183] Dynamic subtest dmabuf: SUCCESS (4.539s) [519.614422] Starting dynamic subtest: vma [524.145794] Dynamic subtest vma: SUCCESS (4.565s) [524.199467] Starting dynamic subtest: coherency [535.287910] Dynamic subtest coherency: SUCCESS (11.133s) [535.330322] Starting dynamic subtest: gtt [547.011230] Dynamic subtest gtt: SUCCESS (11.707s) [547.043140] Starting dynamic subtest: gem [552.499509] Dynamic subtest gem: SUCCESS (5.485s) [552.539187] Starting dynamic subtest: evict [566.753426] Dynamic subtest evict: SUCCESS (14.249s) [566.788215] Starting dynamic subtest: hugepages [571.650217] Dynamic subtest hugepages: SUCCESS (4.879s) [571.738119] Starting dynamic subtest: gem_contexts [604.190157] Dynamic subtest gem_contexts: SUCCESS (32.522s) [604.216243] Starting dynamic subtest: client [612.326445] Dynamic subtest client: SUCCESS (8.129s) [612.365952] Starting dynamic subtest: gem_migrate [616.896600] Dynamic subtest gem_migrate: SUCCESS (4.559s) [616.923241] Starting dynamic subtest: reset [632.519261] Dynamic subtest reset: SUCCESS (15.618s) [632.549613] Starting dynamic subtest: memory_region [636.989420] Dynamic subtest memory_region: SUCCESS (4.452s) [637.047179] Starting dynamic subtest: hangcheck [665.038296] Dynamic subtest hangcheck: SUCCESS (28.031s) [665.071398] Starting dynamic subtest: execlists [676.165251] Dynamic subtest execlists: SUCCESS (11.103s) [676.270619] Starting dynamic subtest: ring_submission [680.539343] Dynamic subtest ring_submission: SUCCESS (4.355s) [680.570151] Starting dynamic subtest: perf [685.228163] Dynamic subtest perf: SUCCESS (4.680s) [685.262904] Starting dynamic subtest: slpc [689.787582] Dynamic subtest slpc: SUCCESS (4.549s) [689.843294] Starting dynamic subtest: guc [694.238386] Dynamic subtest guc: SUCCESS (4.445s) [694.290948] Starting dynamic subtest: guc_multi_lrc [698.484853] Dynamic subtest guc_multi_lrc: SUCCESS (4.238s) [698.547405] Starting dynamic subtest: guc_hang [702.969099] Dynamic subtest guc_hang: SUCCESS (4.476s) [702.996999] Starting dynamic subtest: late_gt_pm [707.465796] Dynamic subtest late_gt_pm: SUCCESS (4.488s) [707.470070] Subtest live: SUCCESS (317.945s) [707.657764] [161/161] (364s left) dmabuf (all-tests) [707.954197] Starting subtest: all-tests [707.956171] Starting dynamic subtest: sanitycheck [708.028985] Dynamic subtest sanitycheck: SUCCESS (0.070s) [708.064926] Starting dynamic subtest: dma_fence [708.318660] Dynamic subtest dma_fence: SUCCESS (0.277s) [708.357315] Starting dynamic subtest: dma_fence_chain [732.428136] Dynamic subtest dma_fence_chain: SUCCESS (24.096s) [732.466972] Starting dynamic subtest: dma_fence_unwrap [732.496734] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s) [732.530439] Starting dynamic subtest: dma_resv [732.589392] Dynamic subtest dma_resv: SUCCESS (0.084s) [732.593766] Subtest all-tests: SUCCESS (24.640s) [732.743260] Closing watchdogs Done.