[75.424479] Initializing watchdogs [75.425084] /dev/watchdog0 [75.525247] [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 [75.556552] [001/161] (960s left) i915_module_load (load) [76.711543] Starting subtest: load [82.364242] Subtest load: SUCCESS (5.648s) [82.817943] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [82.846896] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [82.872488] [002/161] (953s left) core_auth (basic-auth) [83.220344] Starting subtest: basic-auth [83.232865] Subtest basic-auth: SUCCESS (0.012s) [83.508495] [003/161] (953s left) debugfs_test (read_all_entries) [83.904813] Starting subtest: read_all_entries [84.123612] Subtest read_all_entries: SUCCESS (0.221s) [84.816601] [004/161] (952s left) debugfs_test (basic-hwmon) [85.089332] Starting subtest: basic-hwmon [85.093613] Subtest basic-hwmon: SKIP (0.000s) [85.781138] [005/161] (951s left) debugfs_test (sysfs) [86.075166] Starting subtest: sysfs [86.456174] Subtest sysfs: SUCCESS (0.383s) [87.153797] [006/161] (950s left) fbdev (eof) [87.422512] Starting subtest: eof [87.424643] Subtest eof: SUCCESS (0.003s) [87.638713] [007/161] (949s left) fbdev (info) [87.888600] Starting subtest: info [87.891938] Subtest info: SUCCESS (0.000s) [88.108711] [008/161] (949s left) fbdev (nullptr) [88.390482] Starting subtest: nullptr [88.393073] Subtest nullptr: SUCCESS (0.000s) [88.591338] [009/161] (949s left) fbdev (read) [88.871269] Starting subtest: read [90.944978] Subtest read: SUCCESS (2.068s) [91.141885] [010/161] (946s left) fbdev (write) [91.404299] Starting subtest: write [92.509342] Subtest write: SUCCESS (1.099s) [92.716929] [011/161] (945s left) gem_basic (bad-close) [92.977799] Starting subtest: bad-close [92.982206] Subtest bad-close: SUCCESS (0.000s) [93.224096] [012/161] (945s left) gem_basic (create-close) [93.481570] Starting subtest: create-close [93.485122] Subtest create-close: SUCCESS (0.001s) [93.742449] [013/161] (944s left) gem_basic (create-fd-close) [93.999611] Starting subtest: create-fd-close [94.005958] Subtest create-fd-close: SUCCESS (0.001s) [94.221128] [014/161] (944s left) gem_busy (busy@all-engines) [94.541541] Starting subtest: busy [94.543241] Starting dynamic subtest: all-engines [94.746325] Dynamic subtest all-engines: SUCCESS (0.208s) [94.749529] Subtest busy: SUCCESS (0.210s) [95.313567] [015/161] (943s left) gem_close_race (basic-process) [95.640090] Starting subtest: basic-process [95.788491] Subtest basic-process: SUCCESS (0.150s) [96.171251] [016/161] (942s left) gem_close_race (basic-threads) [96.499076] Starting subtest: basic-threads [97.736327] Subtest basic-threads: SUCCESS (1.239s) [98.103884] [017/161] (941s left) gem_ctx_create (basic) [98.415078] Starting subtest: basic [98.416676] Subtest basic: SUCCESS (0.000s) [98.765997] [018/161] (940s left) gem_ctx_create (basic-files) [99.078073] Starting subtest: basic-files [101.161376] Subtest basic-files: SUCCESS (2.085s) [101.507233] [019/161] (938s left) gem_ctx_exec (basic) [101.770584] Starting subtest: basic [101.785645] Subtest basic: SUCCESS (0.012s) [102.003446] [020/161] (937s left) gem_exec_basic (basic) [102.304236] Starting subtest: basic [102.307438] Starting dynamic subtest: rcs0-smem [102.310972] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [102.334982] Starting dynamic subtest: bcs0-smem [102.337842] Dynamic subtest bcs0-smem: SUCCESS (0.025s) [102.362343] Starting dynamic subtest: vcs0-smem [102.364877] Dynamic subtest vcs0-smem: SUCCESS (0.024s) [102.390195] Starting dynamic subtest: vecs0-smem [102.393116] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [102.394796] Subtest basic: SUCCESS (0.071s) [102.721416] [021/161] (937s left) gem_exec_create (basic) [103.028735] Starting subtest: basic [103.033831] Starting dynamic subtest: smem [105.128549] Dynamic subtest smem: SUCCESS (2.099s) [105.129997] Subtest basic: SUCCESS (2.102s) [105.465054] [022/161] (934s left) gem_exec_fence (basic-busy) [105.954932] Starting subtest: basic-busy [105.956851] Starting dynamic subtest: rcs0 [105.980706] Dynamic subtest rcs0: SUCCESS (0.027s) [106.018963] Starting dynamic subtest: bcs0 [106.031689] Dynamic subtest bcs0: SUCCESS (0.047s) [106.059080] Starting dynamic subtest: vcs0 [106.065573] Dynamic subtest vcs0: SUCCESS (0.034s) [106.088969] Starting dynamic subtest: vecs0 [106.102452] Dynamic subtest vecs0: SUCCESS (0.036s) [106.108997] Subtest basic-busy: SUCCESS (0.155s) [107.131822] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [107.142131] [023/161] (933s left) gem_exec_fence (basic-wait) [107.647186] Starting subtest: basic-wait [107.650526] Starting dynamic subtest: rcs0 [107.687102] Dynamic subtest rcs0: SUCCESS (0.038s) [107.742616] Starting dynamic subtest: bcs0 [107.769851] Dynamic subtest bcs0: SUCCESS (0.069s) [107.805877] Starting dynamic subtest: vcs0 [107.851516] Dynamic subtest vcs0: SUCCESS (0.083s) [107.877833] Starting dynamic subtest: vecs0 [107.903069] Dynamic subtest vecs0: SUCCESS (0.048s) [107.905272] Subtest basic-wait: SUCCESS (0.257s) [108.776767] [024/161] (931s left) gem_exec_fence (basic-await) [109.271426] Starting subtest: basic-await [109.275202] Starting dynamic subtest: rcs0 [109.494867] Dynamic subtest rcs0: SUCCESS (0.221s) [109.519412] Starting dynamic subtest: bcs0 [109.734096] Dynamic subtest bcs0: SUCCESS (0.228s) [109.762356] Starting dynamic subtest: vcs0 [109.956802] Dynamic subtest vcs0: SUCCESS (0.218s) [109.981751] Starting dynamic subtest: vecs0 [110.174454] Dynamic subtest vecs0: SUCCESS (0.224s) [110.176176] Subtest basic-await: SUCCESS (0.902s) [111.184547] [025/161] (929s left) gem_exec_fence (nb-await) [111.689202] Starting subtest: nb-await [111.691904] Starting dynamic subtest: rcs0 [111.797871] Dynamic subtest rcs0: SUCCESS (0.108s) [111.838421] Starting dynamic subtest: bcs0 [111.911342] Dynamic subtest bcs0: SUCCESS (0.109s) [111.939795] Starting dynamic subtest: vcs0 [112.007546] Dynamic subtest vcs0: SUCCESS (0.096s) [112.035367] Starting dynamic subtest: vecs0 [112.103267] Dynamic subtest vecs0: SUCCESS (0.092s) [112.104814] Subtest nb-await: SUCCESS (0.413s) [112.984810] [026/161] (927s left) gem_exec_gttfill (basic) [113.292743] Starting subtest: basic [115.248854] Subtest basic: SKIP (1.925s) [115.630282] [027/161] (925s left) gem_exec_parallel (engines) [116.120446] Starting subtest: engines [116.123197] Starting dynamic subtest: basic [122.309238] Dynamic subtest basic: SUCCESS (6.187s) [122.336738] Starting dynamic subtest: contexts [131.945826] Dynamic subtest contexts: SUCCESS (9.637s) [131.974742] Starting dynamic subtest: fds [143.024609] Dynamic subtest fds: SUCCESS (11.076s) [143.057995] Starting dynamic subtest: userptr [149.242680] Dynamic subtest userptr: SUCCESS (6.215s) [149.244761] Subtest engines: SUCCESS (33.120s) [149.692490] [028/161] (891s left) gem_exec_store (basic) [150.011499] Starting subtest: basic [150.065444] Subtest basic: SUCCESS (0.063s) [150.478267] [029/161] (891s left) gem_flink_basic (bad-flink) [150.742156] Starting subtest: bad-flink [150.745884] Subtest bad-flink: SUCCESS (0.000s) [150.986753] [030/161] (890s left) gem_flink_basic (bad-open) [151.248270] Starting subtest: bad-open [151.252080] Subtest bad-open: SUCCESS (0.000s) [151.520646] [031/161] (890s left) gem_flink_basic (basic) [151.773983] Starting subtest: basic [151.776133] Subtest basic: SUCCESS (0.000s) [152.024158] [032/161] (890s left) gem_flink_basic (double-flink) [152.277058] Starting subtest: double-flink [152.279957] Subtest double-flink: SUCCESS (0.000s) [152.514797] [033/161] (889s left) gem_flink_basic (flink-lifetime) [152.784225] Starting subtest: flink-lifetime [152.806580] Subtest flink-lifetime: SUCCESS (0.012s) [153.036172] [034/161] (889s left) gem_huc_copy (huc-copy) [153.311123] Subtest huc-copy: SKIP (0.000s) [153.549628] [035/161] (889s left) gem_linear_blits (basic) [154.160338] Subtest basic: SKIP (0.000s) [154.400429] [036/161] (888s left) gem_mmap (basic) [154.838593] Starting subtest: basic [154.853539] Subtest basic: SUCCESS (0.002s) [155.089777] [037/161] (888s left) gem_mmap_gtt (basic) [155.343422] Starting subtest: basic [155.347899] Subtest basic: SUCCESS (0.004s) [155.607252] [038/161] (887s left) gem_render_linear_blits (basic) [155.883574] Starting subtest: basic [156.005144] Subtest basic: SUCCESS (0.110s) [156.221616] [039/161] (887s left) gem_render_tiled_blits (basic) [156.495268] Starting subtest: basic [156.639869] Subtest basic: SUCCESS (0.139s) [156.857152] [040/161] (886s left) gem_ringfill (basic-all) [157.386613] Starting subtest: basic-all [158.750049] Subtest basic-all: SUCCESS (1.357s) [159.018652] [041/161] (884s left) gem_softpin (allocator-basic) [159.297827] Starting subtest: allocator-basic [159.668923] Subtest allocator-basic: SUCCESS (0.369s) [159.978762] [042/161] (884s left) gem_softpin (allocator-basic-reserve) [160.247107] Starting subtest: allocator-basic-reserve [160.641211] Subtest allocator-basic-reserve: SUCCESS (0.364s) [160.907284] [043/161] (883s left) gem_softpin (safe-alignment) [161.180273] Starting subtest: safe-alignment [161.237796] Subtest safe-alignment: SUCCESS (0.054s) [161.470773] [044/161] (882s left) gem_sync (basic-all) [161.791359] Starting subtest: basic-all [164.833434] Subtest basic-all: SUCCESS (3.041s) [165.234964] [045/161] (879s left) gem_sync (basic-each) [165.552745] Starting subtest: basic-each [168.446150] Subtest basic-each: SUCCESS (2.894s) [168.821491] [046/161] (876s left) gem_tiled_blits (basic) [169.364719] Subtest basic: SKIP (0.000s) [169.570555] [047/161] (875s left) gem_tiled_fence_blits (basic) [170.240100] Starting subtest: basic [170.311608] Subtest basic: SUCCESS (0.070s) [170.608676] [048/161] (874s left) gem_tiled_pread_basic [172.206676] [049/161] (873s left) gem_wait (busy@all-engines) [172.551318] Starting subtest: busy [172.554690] Starting dynamic subtest: all-engines [173.091765] Dynamic subtest all-engines: SUCCESS (0.540s) [173.093686] Subtest busy: SUCCESS (0.543s) [173.602502] [050/161] (872s left) gem_wait (wait@all-engines) [173.946381] Starting subtest: wait [173.949954] Starting dynamic subtest: all-engines [174.995199] Dynamic subtest all-engines: SUCCESS (1.046s) [174.996770] Subtest wait: SUCCESS (1.047s) [175.455829] [051/161] (870s left) i915_getparams_basic (basic-eu-total) [175.706610] Starting subtest: basic-eu-total [175.713963] Subtest basic-eu-total: SUCCESS (0.000s) [175.947396] [052/161] (870s left) i915_getparams_basic (basic-subslice-total) [176.197767] Starting subtest: basic-subslice-total [176.203123] Subtest basic-subslice-total: SUCCESS (0.000s) [176.440728] [053/161] (869s left) i915_hangman (error-state-basic) [176.748821] Starting subtest: error-state-basic [176.769970] Subtest error-state-basic: SUCCESS (0.023s) [177.055633] [054/161] (869s left) i915_pciid [177.551604] [055/161] (869s left) kms_addfb_basic (addfb25-4-tiled) [178.262414] Starting subtest: addfb25-4-tiled [178.264221] Subtest addfb25-4-tiled: SUCCESS (0.002s) [178.536886] [056/161] (868s left) kms_addfb_basic (addfb25-bad-modifier) [179.254289] Starting subtest: addfb25-bad-modifier [179.256341] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [179.529169] [057/161] (867s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [180.237988] Starting subtest: addfb25-framebuffer-vs-set-tiling [180.242746] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [180.491656] [058/161] (866s left) kms_addfb_basic (addfb25-modifier-no-flag) [181.204281] Starting subtest: addfb25-modifier-no-flag [181.207372] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [181.457140] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy) [182.194968] Starting subtest: addfb25-x-tiled-legacy [182.197511] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [182.452922] [060/161] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [183.208782] Starting subtest: addfb25-x-tiled-mismatch-legacy [183.212707] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [183.470538] [061/161] (864s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [184.187356] Starting subtest: addfb25-yf-tiled-legacy [184.191142] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [184.426881] [062/161] (863s left) kms_addfb_basic (addfb25-y-tiled-legacy) [185.199869] Starting subtest: addfb25-y-tiled-legacy [185.202475] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [185.457934] [063/161] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [186.156272] Starting subtest: addfb25-y-tiled-small-legacy [186.160929] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [186.402410] [064/161] (862s left) kms_addfb_basic (bad-pitch-0) [186.668476] Starting subtest: bad-pitch-0 [186.671222] Subtest bad-pitch-0: SUCCESS (0.000s) [187.367986] [065/161] (861s left) kms_addfb_basic (bad-pitch-1024) [187.622530] Starting subtest: bad-pitch-1024 [187.624276] Subtest bad-pitch-1024: SUCCESS (0.000s) [188.325694] [066/161] (860s left) kms_addfb_basic (bad-pitch-128) [188.580318] Starting subtest: bad-pitch-128 [188.581761] Subtest bad-pitch-128: SUCCESS (0.000s) [189.278458] [067/161] (859s left) kms_addfb_basic (bad-pitch-256) [189.533711] Starting subtest: bad-pitch-256 [189.537665] Subtest bad-pitch-256: SUCCESS (0.000s) [190.250459] [068/161] (858s left) kms_addfb_basic (bad-pitch-32) [190.506224] Starting subtest: bad-pitch-32 [190.509578] Subtest bad-pitch-32: SUCCESS (0.000s) [191.244998] [069/161] (858s left) kms_addfb_basic (bad-pitch-63) [191.617177] Starting subtest: bad-pitch-63 [191.620217] Subtest bad-pitch-63: SUCCESS (0.000s) [192.509488] [070/161] (857s left) kms_addfb_basic (bad-pitch-65536) [192.942768] Starting subtest: bad-pitch-65536 [192.948075] Subtest bad-pitch-65536: SUCCESS (0.004s) [194.058439] [071/161] (855s left) kms_addfb_basic (bad-pitch-999) [194.378775] Starting subtest: bad-pitch-999 [194.381906] Subtest bad-pitch-999: SUCCESS (0.000s) [195.343835] [072/161] (854s left) kms_addfb_basic (basic) [195.661568] Starting subtest: basic [195.666121] Subtest basic: SUCCESS (0.000s) [196.434618] [073/161] (854s left) kms_addfb_basic (basic-x-tiled-legacy) [196.700969] Starting subtest: basic-x-tiled-legacy [196.702607] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [197.399477] [074/161] (853s left) kms_addfb_basic (basic-y-tiled-legacy) [197.709848] Starting subtest: basic-y-tiled-legacy [197.716103] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [198.446666] [075/161] (852s left) kms_addfb_basic (bo-too-small) [199.157644] Starting subtest: bo-too-small [199.161115] Subtest bo-too-small: SUCCESS (0.002s) [199.400252] [076/161] (851s left) kms_addfb_basic (bo-too-small-due-to-tiling) [200.124892] Starting subtest: bo-too-small-due-to-tiling [200.132488] Subtest bo-too-small-due-to-tiling: SUCCESS (0.004s) [200.369693] [077/161] (850s left) kms_addfb_basic (clobberred-modifier) [200.625592] Starting subtest: clobberred-modifier [200.629300] Subtest clobberred-modifier: SUCCESS (0.000s) [201.332285] [078/161] (850s left) kms_addfb_basic (framebuffer-vs-set-tiling) [201.592560] Starting subtest: framebuffer-vs-set-tiling [201.595167] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [202.303909] [079/161] (849s left) kms_addfb_basic (invalid-get-prop) [202.562609] Starting subtest: invalid-get-prop [202.566282] Subtest invalid-get-prop: SUCCESS (0.000s) [203.285628] [080/161] (848s left) kms_addfb_basic (invalid-get-prop-any) [203.554223] Starting subtest: invalid-get-prop-any [203.560129] Subtest invalid-get-prop-any: SUCCESS (0.000s) [204.276417] [081/161] (847s left) kms_addfb_basic (invalid-set-prop) [204.539818] Starting subtest: invalid-set-prop [204.543091] Subtest invalid-set-prop: SUCCESS (0.000s) [205.277340] [082/161] (846s left) kms_addfb_basic (invalid-set-prop-any) [205.545798] Starting subtest: invalid-set-prop-any [205.548669] Subtest invalid-set-prop-any: SUCCESS (0.000s) [206.321891] [083/161] (846s left) kms_addfb_basic (no-handle) [206.578933] Starting subtest: no-handle [206.582245] Subtest no-handle: SUCCESS (0.000s) [207.227721] [084/161] (845s left) kms_addfb_basic (size-max) [207.965922] Starting subtest: size-max [207.971704] Subtest size-max: SUCCESS (0.001s) [208.217470] [085/161] (844s left) kms_addfb_basic (small-bo) [208.947433] Starting subtest: small-bo [208.951155] Subtest small-bo: SUCCESS (0.000s) [209.194313] [086/161] (843s left) kms_addfb_basic (tile-pitch-mismatch) [209.453440] Starting subtest: tile-pitch-mismatch [209.456540] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [210.171639] [087/161] (843s left) kms_addfb_basic (too-high) [210.886447] Starting subtest: too-high [210.889490] Subtest too-high: SUCCESS (0.006s) [211.145614] [088/161] (842s left) kms_addfb_basic (too-wide) [211.861579] Starting subtest: too-wide [211.866508] Subtest too-wide: SUCCESS (0.000s) [212.105751] [089/161] (841s left) kms_addfb_basic (unused-handle) [212.358895] Starting subtest: unused-handle [212.362350] Subtest unused-handle: SUCCESS (0.000s) [213.179166] [090/161] (840s left) kms_addfb_basic (unused-modifier) [213.440664] Starting subtest: unused-modifier [213.446280] Subtest unused-modifier: SUCCESS (0.000s) [214.149489] [091/161] (839s left) kms_addfb_basic (unused-offsets) [214.408218] Starting subtest: unused-offsets [214.411402] Subtest unused-offsets: SUCCESS (0.000s) [215.152812] [092/161] (839s left) kms_addfb_basic (unused-pitches) [215.409575] Starting subtest: unused-pitches [215.412213] Subtest unused-pitches: SUCCESS (0.001s) [216.134930] [093/161] (838s left) kms_busy (basic) [216.880218] Starting subtest: basic [216.881815] Starting dynamic subtest: flip [217.804157] Dynamic subtest flip: SUCCESS (0.924s) [217.865213] Starting dynamic subtest: modeset [219.852116] Dynamic subtest modeset: SUCCESS (2.042s) [219.881134] Subtest basic: SUCCESS (2.992s) [220.584069] [094/161] (834s left) kms_prop_blob (basic) [220.847477] Starting subtest: basic [220.851269] Subtest basic: SUCCESS (0.000s) [221.097507] [095/161] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [221.814927] Starting subtest: basic-busy-flip-before-cursor-atomic [222.895087] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.075s) [223.511259] [096/161] (831s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [224.249789] Starting subtest: basic-busy-flip-before-cursor-legacy [225.319504] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.061s) [225.923247] [097/161] (829s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [226.664411] Starting subtest: basic-flip-after-cursor-atomic [227.723573] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.046s) [228.354716] [098/161] (827s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [229.283643] Starting subtest: basic-flip-after-cursor-legacy [230.374897] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.081s) [230.985270] [099/161] (824s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [231.713698] Starting subtest: basic-flip-after-cursor-varying-size [232.751889] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.033s) [233.366299] [100/161] (822s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [234.081570] Starting subtest: basic-flip-before-cursor-atomic [235.121152] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.039s) [235.718478] [101/161] (820s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [236.450984] Starting subtest: basic-flip-before-cursor-legacy [237.491865] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.038s) [238.108105] [102/161] (818s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [238.861842] Starting subtest: basic-flip-before-cursor-varying-size [239.897165] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.033s) [240.490976] [103/161] (815s left) kms_dsc (dsc-basic) [241.250245] Subtest dsc-basic: SKIP (0.000s) [241.466351] [104/161] (815s left) kms_flip (basic-flip-vs-dpms) [242.209899] Starting subtest: basic-flip-vs-dpms [242.228120] Starting dynamic subtest: C-HDMI-A2 [244.949740] Dynamic subtest C-HDMI-A2: SUCCESS (2.714s) [244.956411] Subtest basic-flip-vs-dpms: SUCCESS (2.742s) [245.672467] [105/161] (811s left) kms_flip (basic-flip-vs-modeset) [246.441926] Starting subtest: basic-flip-vs-modeset [246.459561] Starting dynamic subtest: C-HDMI-A2 [249.190123] Dynamic subtest C-HDMI-A2: SUCCESS (2.709s) [249.194902] Subtest basic-flip-vs-modeset: SUCCESS (2.734s) [249.857945] [106/161] (807s left) kms_flip (basic-flip-vs-wf_vblank) [250.634860] Starting subtest: basic-flip-vs-wf_vblank [250.644998] Starting dynamic subtest: C-HDMI-A2 [253.578667] Dynamic subtest C-HDMI-A2: SUCCESS (2.931s) [253.583030] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.949s) [253.893299] [107/161] (803s left) kms_flip (basic-plain-flip) [254.643207] Starting subtest: basic-plain-flip [254.649418] Starting dynamic subtest: C-HDMI-A2 [257.148696] Dynamic subtest C-HDMI-A2: SUCCESS (2.493s) [257.154896] Subtest basic-plain-flip: SUCCESS (2.512s) [257.471663] [108/161] (799s left) kms_force_connector_basic (force-connector-state) [257.935895] Starting subtest: force-connector-state [258.855162] Subtest force-connector-state: SUCCESS (0.914s) [260.414737] [109/161] (797s left) kms_force_connector_basic (force-edid) [260.845193] Starting subtest: force-edid [260.979913] Subtest force-edid: SUCCESS (0.121s) [261.889614] [110/161] (795s left) kms_force_connector_basic (force-load-detect) [262.299237] Starting subtest: force-load-detect [262.305364] Subtest force-load-detect: SKIP (0.000s) [262.941307] [111/161] (795s left) kms_force_connector_basic (prune-stale-modes) [263.365326] Starting subtest: prune-stale-modes [263.554175] Subtest prune-stale-modes: SUCCESS (0.191s) [264.487768] [112/161] (793s left) kms_frontbuffer_tracking (basic) [265.328097] Starting subtest: basic [270.379580] Subtest basic: SUCCESS (5.046s) [270.666397] [113/161] (787s left) kms_hdmi_inject (inject-audio) [271.045295] Starting subtest: inject-audio [271.635793] Subtest inject-audio: SUCCESS (0.595s) [272.425134] [114/161] (786s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [273.316103] Starting subtest: compare-crc-sanitycheck-xr24 [273.328900] Starting dynamic subtest: pipe-C-HDMI-A-2 [273.891471] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.558s) [273.896284] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.577s) [274.555677] [115/161] (784s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [275.346076] Starting subtest: compare-crc-sanitycheck-nv12 [275.359628] Starting dynamic subtest: pipe-C-HDMI-A-2 [275.362523] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [275.376571] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s) [275.640293] [116/161] (783s left) kms_pipe_crc_basic (hang-read-crc) [276.408165] Starting subtest: hang-read-crc [276.415241] Starting dynamic subtest: pipe-C-HDMI-A-2 [278.049999] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.631s) [278.051816] Subtest hang-read-crc: SUCCESS (1.647s) [278.695139] [117/161] (780s left) kms_pipe_crc_basic (nonblocking-crc) [279.443318] Starting subtest: nonblocking-crc [279.455094] Starting dynamic subtest: pipe-C-HDMI-A-2 [280.222553] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.759s) [280.224449] Subtest nonblocking-crc: SUCCESS (0.771s) [280.830867] [118/161] (778s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [281.615216] Starting subtest: nonblocking-crc-frame-sequence [281.625404] Starting dynamic subtest: pipe-C-HDMI-A-2 [282.397671] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.773s) [282.399808] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.786s) [283.021384] [119/161] (776s left) kms_pipe_crc_basic (read-crc) [283.801466] Starting subtest: read-crc [283.802899] Starting dynamic subtest: pipe-C-HDMI-A-2 [284.464902] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.662s) [284.469694] Subtest read-crc: SUCCESS (0.671s) [285.041229] [120/161] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence) [285.786575] Starting subtest: read-crc-frame-sequence [285.788302] Starting dynamic subtest: pipe-C-HDMI-A-2 [286.480648] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.685s) [286.482511] Subtest read-crc-frame-sequence: SUCCESS (0.697s) [287.105794] [121/161] (773s left) kms_pm_backlight (basic-brightness) [287.992879] Subtest basic-brightness: SKIP (0.000s) [288.218799] [122/161] (772s left) kms_pm_rpm (basic-pci-d3-state) [290.525594] Starting subtest: basic-pci-d3-state [290.870950] Subtest basic-pci-d3-state: SUCCESS (0.333s) [291.404160] [123/161] (769s left) kms_pm_rpm (basic-rte) [291.655513] Starting subtest: basic-rte [294.065703] Subtest basic-rte: SUCCESS (2.396s) [295.189633] [124/161] (765s left) kms_psr (psr-primary-page-flip) [295.948917] Subtest psr-primary-page-flip: SKIP (0.000s) [296.190841] [125/161] (764s left) kms_psr (psr-cursor-plane-move) [296.973183] Subtest psr-cursor-plane-move: SKIP (0.000s) [297.204498] [126/161] (763s left) kms_psr (psr-sprite-plane-onoff) [297.951094] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [298.152222] [127/161] (763s left) kms_psr (psr-primary-mmap-gtt) [298.961113] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [299.184273] [128/161] (762s left) kms_setmode (basic-clone-single-crtc) [299.458965] Starting subtest: basic-clone-single-crtc [299.465599] Subtest basic-clone-single-crtc: SKIP (0.001s) [299.724188] [129/161] (762s left) i915_pm_rps (basic-api) [300.017560] Starting subtest: basic-api [300.034351] Subtest basic-api: SUCCESS (0.020s) [300.296608] [130/161] (761s left) prime_self_import (basic-llseek-bad) [300.546423] Starting subtest: basic-llseek-bad [300.568906] Subtest basic-llseek-bad: SUCCESS (0.015s) [300.813940] [131/161] (761s left) prime_self_import (basic-llseek-size) [301.071964] Starting subtest: basic-llseek-size [301.090261] Subtest basic-llseek-size: SUCCESS (0.018s) [301.349461] [132/161] (761s left) prime_self_import (basic-with_fd_dup) [301.602245] Starting subtest: basic-with_fd_dup [301.616183] Subtest basic-with_fd_dup: SUCCESS (0.021s) [301.866100] [133/161] (760s left) prime_self_import (basic-with_one_bo) [302.129747] Starting subtest: basic-with_one_bo [302.142401] Subtest basic-with_one_bo: SUCCESS (0.021s) [302.404483] [134/161] (760s left) prime_self_import (basic-with_one_bo_two_files) [302.673988] Starting subtest: basic-with_one_bo_two_files [302.691279] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s) [302.972754] [135/161] (759s left) prime_self_import (basic-with_two_bos) [303.231205] Starting subtest: basic-with_two_bos [303.259617] Subtest basic-with_two_bos: SUCCESS (0.026s) [303.517805] [136/161] (759s left) prime_vgem (basic-fence-flip) [303.826663] Starting subtest: basic-fence-flip [304.590119] Subtest basic-fence-flip: SKIP (0.762s) [304.885767] [137/161] (758s left) prime_vgem (basic-fence-mmap) [305.187158] Starting subtest: basic-fence-mmap [305.321061] Subtest basic-fence-mmap: SUCCESS (0.129s) [305.593169] [138/161] (757s left) prime_vgem (basic-fence-read) [305.904230] Starting subtest: basic-fence-read [306.166189] Subtest basic-fence-read: SUCCESS (0.265s) [306.439177] [139/161] (757s left) prime_vgem (basic-gtt) [306.732883] Starting subtest: basic-gtt [306.791452] Subtest basic-gtt: SUCCESS (0.045s) [307.033331] [140/161] (756s left) prime_vgem (basic-read) [307.320588] Starting subtest: basic-read [307.429525] Subtest basic-read: SUCCESS (0.112s) [307.674878] [141/161] (756s left) prime_vgem (basic-write) [307.972407] Starting subtest: basic-write [308.133683] Subtest basic-write: SUCCESS (0.157s) [308.381446] [142/161] (755s left) vgem_basic (setversion) [308.661885] Starting subtest: setversion [308.667099] Subtest setversion: SUCCESS (0.000s) [308.903405] [143/161] (755s left) vgem_basic (create) [309.191306] Starting subtest: create [309.192896] Subtest create: SUCCESS (0.001s) [309.419889] [144/161] (755s left) vgem_basic (debugfs) [309.699920] Starting subtest: debugfs [309.701693] Subtest debugfs: SUCCESS (0.002s) [309.929942] [145/161] (755s left) vgem_basic (dmabuf-export) [310.191632] Starting subtest: dmabuf-export [310.216840] Subtest dmabuf-export: SUCCESS (0.018s) [310.484233] [146/161] (754s left) vgem_basic (dmabuf-fence) [310.766855] Starting subtest: dmabuf-fence [310.770284] Subtest dmabuf-fence: SUCCESS (0.002s) [310.996962] [147/161] (754s left) vgem_basic (dmabuf-fence-before) [311.288090] Starting subtest: dmabuf-fence-before [311.290593] Subtest dmabuf-fence-before: SUCCESS (0.006s) [311.522624] [148/161] (754s left) vgem_basic (dmabuf-mmap) [311.803645] Starting subtest: dmabuf-mmap [311.843441] Subtest dmabuf-mmap: SUCCESS (0.046s) [312.081300] [149/161] (753s left) vgem_basic (mmap) [312.360809] Starting subtest: mmap [312.397614] Subtest mmap: SUCCESS (0.035s) [312.635870] [150/161] (753s left) vgem_basic (second-client) [312.910423] Starting subtest: second-client [312.955829] Subtest second-client: SUCCESS (0.047s) [313.224921] [151/161] (752s left) vgem_basic (sysfs) [313.502739] Starting subtest: sysfs [313.505604] Subtest sysfs: SUCCESS (0.002s) [313.733905] [152/161] (752s left) core_hotunplug (unbind-rebind) [314.237532] Starting subtest: unbind-rebind [320.817635] Subtest unbind-rebind: SUCCESS (6.583s) [321.083381] [153/161] (745s left) vgem_basic (unload) [321.343160] Starting subtest: unload [350.649344] Subtest unload: SUCCESS (29.297s) [351.070465] [154/161] (715s left) i915_module_load (reload) [351.332647] Starting subtest: reload [358.547136] Subtest reload: SUCCESS (7.204s) [358.976281] [155/161] (708s left) gem_lmem_swapping (basic) [359.527720] Subtest basic: SKIP (0.000s) [359.927145] [156/161] (707s left) gem_lmem_swapping (parallel-random-engines) [360.333198] Subtest parallel-random-engines: SKIP (0.000s) [360.554466] [157/161] (707s left) gem_lmem_swapping (random-engines) [360.831543] Subtest random-engines: SKIP (0.000s) [361.035834] [158/161] (707s left) gem_lmem_swapping (verify-random) [361.315085] Subtest verify-random: SKIP (0.000s) [361.537430] [159/161] (706s left) i915_pm_rpm (module-reload) [364.392631] Starting subtest: module-reload [382.559172] Subtest module-reload: SUCCESS (18.163s) [382.686647] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [382.692098] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [382.706601] [160/161] (685s left) i915_selftest (live) [382.999991] Starting subtest: live [383.012946] Starting dynamic subtest: sanitycheck [387.433276] Dynamic subtest sanitycheck: SUCCESS (4.418s) [387.457552] Starting dynamic subtest: uncore [391.567583] Dynamic subtest uncore: SUCCESS (4.127s) [391.622238] Starting dynamic subtest: workarounds [396.117067] Dynamic subtest workarounds: SUCCESS (4.531s) [396.142608] Starting dynamic subtest: gt_engines [401.044580] Dynamic subtest gt_engines: SUCCESS (4.919s) [401.081192] Starting dynamic subtest: gt_timelines [432.389840] Dynamic subtest gt_timelines: SUCCESS (31.340s) [432.419916] Starting dynamic subtest: gt_contexts [436.960717] Dynamic subtest gt_contexts: SUCCESS (4.560s) [436.992770] Starting dynamic subtest: gt_lrc [444.632123] Dynamic subtest gt_lrc: SUCCESS (7.653s) [444.659457] Starting dynamic subtest: gt_mocs [449.086712] Dynamic subtest gt_mocs: SUCCESS (4.448s) [449.117569] Starting dynamic subtest: gt_pm [454.635644] Dynamic subtest gt_pm: SUCCESS (5.542s) [454.680525] Starting dynamic subtest: gt_heartbeat [458.986169] Dynamic subtest gt_heartbeat: SUCCESS (4.329s) [459.011100] Starting dynamic subtest: gt_tlb [463.623616] Dynamic subtest gt_tlb: SUCCESS (4.635s) [463.674378] Starting dynamic subtest: requests [474.359450] Dynamic subtest requests: SUCCESS (10.725s) [474.391386] Starting dynamic subtest: migrate [482.337077] Dynamic subtest migrate: SUCCESS (7.968s) [482.366910] Starting dynamic subtest: active [486.672451] Dynamic subtest active: SUCCESS (4.330s) [486.722553] Starting dynamic subtest: objects [492.900268] Dynamic subtest objects: SUCCESS (6.219s) [492.940356] Starting dynamic subtest: mman [504.472202] Dynamic subtest mman: SUCCESS (11.562s) [504.523271] Starting dynamic subtest: dmabuf [508.968664] Dynamic subtest dmabuf: SUCCESS (4.487s) [509.007600] Starting dynamic subtest: vma [513.250878] Dynamic subtest vma: SUCCESS (4.268s) [513.314080] Starting dynamic subtest: coherency [524.357341] Dynamic subtest coherency: SUCCESS (11.094s) [524.382456] Starting dynamic subtest: gtt [535.998316] Dynamic subtest gtt: SUCCESS (11.626s) [536.029192] Starting dynamic subtest: gem [541.449571] Dynamic subtest gem: SUCCESS (5.449s) [541.507949] Starting dynamic subtest: evict [552.701607] Dynamic subtest evict: SUCCESS (11.238s) [552.729855] Starting dynamic subtest: hugepages [557.534864] Dynamic subtest hugepages: SUCCESS (4.826s) [557.573880] Starting dynamic subtest: gem_contexts [586.993300] Dynamic subtest gem_contexts: SUCCESS (29.439s) [587.025425] Starting dynamic subtest: client [595.593805] Dynamic subtest client: SUCCESS (8.594s) [595.670474] Starting dynamic subtest: gem_migrate [599.998160] Dynamic subtest gem_migrate: SUCCESS (4.390s) [600.029965] Starting dynamic subtest: reset [611.686950] Dynamic subtest reset: SUCCESS (11.680s) [611.717571] Starting dynamic subtest: memory_region [616.086177] Dynamic subtest memory_region: SUCCESS (4.399s) [616.129241] Starting dynamic subtest: hangcheck [643.737238] Dynamic subtest hangcheck: SUCCESS (27.642s) [643.777062] Starting dynamic subtest: execlists [654.186363] Dynamic subtest execlists: SUCCESS (10.433s) [654.227748] Starting dynamic subtest: ring_submission [658.492872] Dynamic subtest ring_submission: SUCCESS (4.290s) [658.542234] Starting dynamic subtest: perf [663.276611] Dynamic subtest perf: SUCCESS (4.784s) [663.312472] Starting dynamic subtest: slpc [667.679947] Dynamic subtest slpc: SUCCESS (4.390s) [667.728697] Starting dynamic subtest: guc [671.999144] Dynamic subtest guc: SUCCESS (4.303s) [672.043676] Starting dynamic subtest: guc_multi_lrc [676.262433] Dynamic subtest guc_multi_lrc: SUCCESS (4.243s) [676.313549] Starting dynamic subtest: guc_hang [680.584531] Dynamic subtest guc_hang: SUCCESS (4.309s) [680.613804] Starting dynamic subtest: late_gt_pm [685.098079] Dynamic subtest late_gt_pm: SUCCESS (4.497s) [685.102141] Subtest live: SUCCESS (302.082s) [685.269710] [161/161] (383s left) dmabuf (all-tests) [685.555113] Starting subtest: all-tests [685.560226] Starting dynamic subtest: sanitycheck [685.622576] Dynamic subtest sanitycheck: SUCCESS (0.068s) [685.653662] Starting dynamic subtest: dma_fence [685.939899] Dynamic subtest dma_fence: SUCCESS (0.308s) [685.991634] Starting dynamic subtest: dma_fence_chain [710.086170] Dynamic subtest dma_fence_chain: SUCCESS (24.140s) [710.118210] Starting dynamic subtest: dma_fence_unwrap [710.212062] Dynamic subtest dma_fence_unwrap: SUCCESS (0.119s) [710.249060] Starting dynamic subtest: dma_resv [710.307654] Dynamic subtest dma_resv: SUCCESS (0.088s) [710.319589] Subtest all-tests: SUCCESS (24.766s) [710.445932] Closing watchdogs Done.