[77.560046] Initializing watchdogs [77.560219] /dev/watchdog0 [77.570372] [001/170] (960s left) i915_module_load (load) [77.715422] Starting subtest: load [80.216190] Subtest load: SUCCESS (2.501s) [80.252233] [002/170] (957s left) core_auth (basic-auth) [80.392437] Starting subtest: basic-auth [80.394862] Subtest basic-auth: SUCCESS (0.002s) [80.463372] [003/170] (957s left) debugfs_test (read_all_entries) [80.613798] Starting subtest: read_all_entries [80.684523] Subtest read_all_entries: SUCCESS (0.070s) [80.796859] [004/170] (957s left) debugfs_test (basic-hwmon) [80.936675] Starting subtest: basic-hwmon [80.938799] Subtest basic-hwmon: SKIP (0.000s) [81.049719] [005/170] (957s left) fbdev (eof) [81.217674] Starting subtest: eof [81.219632] Subtest eof: SUCCESS (0.000s) [81.281971] [006/170] (956s left) fbdev (info) [81.409361] Starting subtest: info [81.410518] Subtest info: SUCCESS (0.000s) [81.487156] [007/170] (956s left) fbdev (nullptr) [81.633535] Starting subtest: nullptr [81.634753] Subtest nullptr: SUCCESS (0.000s) [81.702101] [008/170] (956s left) fbdev (read) [81.851799] Starting subtest: read [88.959532] Subtest read: SUCCESS (7.073s) [89.000054] [009/170] (949s left) fbdev (write) [89.151636] Starting subtest: write [92.936182] Subtest write: SUCCESS (3.750s) [92.982258] [010/170] (945s left) gem_basic (bad-close) [93.114799] Starting subtest: bad-close [93.117220] Subtest bad-close: SUCCESS (0.000s) [93.198281] [011/170] (945s left) gem_basic (create-close) [93.332876] Starting subtest: create-close [93.335097] Subtest create-close: SUCCESS (0.000s) [93.431755] [012/170] (944s left) gem_basic (create-fd-close) [93.566259] Starting subtest: create-fd-close [93.568480] Subtest create-fd-close: SUCCESS (0.000s) [93.647964] [013/170] (944s left) gem_busy (busy@all-engines) [93.795545] Starting subtest: busy [93.796738] Starting dynamic subtest: all-engines [93.851391] Dynamic subtest all-engines: SUCCESS (0.056s) [93.852800] Subtest busy: SUCCESS (0.056s) [94.233659] [014/170] (944s left) gem_close_race (basic-process) [94.388464] Starting subtest: basic-process [94.460524] Subtest basic-process: SUCCESS (0.071s) [94.666769] [015/170] (943s left) gem_close_race (basic-threads) [94.821614] Starting subtest: basic-threads [95.997916] Subtest basic-threads: SUCCESS (1.176s) [96.219678] [016/170] (942s left) gem_ctx_create (basic) [96.387346] Starting subtest: basic [96.388672] Subtest basic: SUCCESS (0.000s) [96.584103] [017/170] (941s left) gem_ctx_create (basic-files) [96.733362] Starting subtest: basic-files [98.756405] Subtest basic-files: SUCCESS (2.023s) [99.026292] [018/170] (939s left) gem_ctx_exec (basic) [99.165262] Starting subtest: basic [99.170024] Subtest basic: SUCCESS (0.005s) [99.281890] [019/170] (939s left) gem_exec_basic (basic) [99.427475] Starting subtest: basic [99.428728] Starting dynamic subtest: rcs0-smem [99.429894] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [99.441068] Starting dynamic subtest: bcs0-smem [99.442269] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [99.452387] Starting dynamic subtest: vcs0-smem [99.453789] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [99.463781] Starting dynamic subtest: vecs0-smem [99.465052] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [99.466298] Subtest basic: SUCCESS (0.005s) [99.633208] [020/170] (938s left) gem_exec_create (basic) [99.781219] Starting subtest: basic [99.782399] Starting dynamic subtest: smem [101.850864] Dynamic subtest smem: SUCCESS (2.055s) [101.852319] Subtest basic: SUCCESS (2.056s) [102.060049] [021/170] (936s left) gem_exec_fence (basic-busy) [102.358056] Starting subtest: basic-busy [102.359415] Starting dynamic subtest: rcs0 [102.372063] Dynamic subtest rcs0: SUCCESS (0.023s) [102.383853] Starting dynamic subtest: bcs0 [102.400892] Dynamic subtest bcs0: SUCCESS (0.029s) [102.411539] Starting dynamic subtest: vcs0 [102.431973] Dynamic subtest vcs0: SUCCESS (0.031s) [102.445420] Starting dynamic subtest: vecs0 [102.471712] Dynamic subtest vecs0: SUCCESS (0.039s) [102.473847] Subtest basic-busy: SUCCESS (0.123s) [103.067117] [022/170] (935s left) gem_exec_fence (basic-wait) [103.372744] Starting subtest: basic-wait [103.374228] Starting dynamic subtest: rcs0 [103.386575] Dynamic subtest rcs0: SUCCESS (0.021s) [103.400369] Starting dynamic subtest: bcs0 [103.401451] Dynamic subtest bcs0: SUCCESS (0.015s) [103.414194] Starting dynamic subtest: vcs0 [103.419442] Dynamic subtest vcs0: SUCCESS (0.018s) [103.430766] Starting dynamic subtest: vecs0 [103.444468] Dynamic subtest vecs0: SUCCESS (0.025s) [103.445750] Subtest basic-wait: SUCCESS (0.079s) [104.033647] [023/170] (934s left) gem_exec_fence (basic-await) [104.328146] Starting subtest: basic-await [104.329268] Starting dynamic subtest: rcs0 [104.417503] Dynamic subtest rcs0: SUCCESS (0.096s) [104.444246] Starting dynamic subtest: bcs0 [104.543041] Dynamic subtest bcs0: SUCCESS (0.125s) [104.569422] Starting dynamic subtest: vcs0 [104.679975] Dynamic subtest vcs0: SUCCESS (0.128s) [104.705181] Starting dynamic subtest: vecs0 [104.800224] Dynamic subtest vecs0: SUCCESS (0.128s) [104.802375] Subtest basic-await: SUCCESS (0.480s) [105.400590] [024/170] (933s left) gem_exec_fence (nb-await) [105.691536] Starting subtest: nb-await [105.692645] Starting dynamic subtest: rcs0 [105.749990] Dynamic subtest rcs0: SUCCESS (0.066s) [105.767222] Starting dynamic subtest: bcs0 [105.818253] Dynamic subtest bcs0: SUCCESS (0.068s) [105.845220] Starting dynamic subtest: vcs0 [105.894379] Dynamic subtest vcs0: SUCCESS (0.076s) [105.920293] Starting dynamic subtest: vecs0 [105.968283] Dynamic subtest vecs0: SUCCESS (0.074s) [105.970219] Subtest nb-await: SUCCESS (0.285s) [106.534373] [025/170] (932s left) gem_exec_gttfill (basic) [106.684872] Starting subtest: basic [114.512309] Subtest basic: SUCCESS (7.819s) [114.702494] [026/170] (923s left) gem_exec_parallel (engines) [114.920745] Starting subtest: engines [114.922145] Starting dynamic subtest: basic [117.352416] Dynamic subtest basic: SUCCESS (2.405s) [117.364953] Starting dynamic subtest: contexts [120.723807] Dynamic subtest contexts: SUCCESS (3.389s) [120.737111] Starting dynamic subtest: fds [124.434096] Dynamic subtest fds: SUCCESS (3.719s) [124.447536] Starting dynamic subtest: userptr [126.996050] Dynamic subtest userptr: SUCCESS (2.540s) [126.998097] Subtest engines: SUCCESS (12.053s) [127.171759] [027/170] (911s left) gem_exec_store (basic) [127.324910] Starting subtest: basic [127.379969] Subtest basic: SUCCESS (0.055s) [127.586761] [028/170] (911s left) gem_flink_basic (bad-flink) [127.716799] Starting subtest: bad-flink [127.718071] Subtest bad-flink: SUCCESS (0.000s) [127.802749] [029/170] (910s left) gem_flink_basic (bad-open) [127.937563] Starting subtest: bad-open [127.938893] Subtest bad-open: SUCCESS (0.000s) [128.018806] [030/170] (910s left) gem_flink_basic (basic) [128.155091] Starting subtest: basic [128.156175] Subtest basic: SUCCESS (0.000s) [128.251619] [031/170] (910s left) gem_flink_basic (double-flink) [128.386792] Starting subtest: double-flink [128.387975] Subtest double-flink: SUCCESS (0.000s) [128.485329] [032/170] (910s left) gem_flink_basic (flink-lifetime) [128.629750] Starting subtest: flink-lifetime [128.631593] Subtest flink-lifetime: SUCCESS (0.002s) [128.720767] [033/170] (910s left) gem_huc_copy (huc-copy) [128.862683] Starting subtest: huc-copy [128.865021] Subtest huc-copy: SKIP (0.000s) [128.968598] [034/170] (909s left) gem_linear_blits (basic) [129.279977] Starting subtest: basic [129.293264] Subtest basic: SUCCESS (0.014s) [129.440486] [035/170] (909s left) gem_mmap (basic) [129.636863] Starting subtest: basic [129.643030] Subtest basic: SUCCESS (0.001s) [129.735687] [036/170] (909s left) gem_mmap_gtt (basic) [129.874830] Starting subtest: basic [129.876113] Subtest basic: SUCCESS (0.001s) [129.968726] [037/170] (908s left) gem_render_linear_blits (basic) [130.108746] Starting subtest: basic [130.162211] Subtest basic: SUCCESS (0.053s) [130.242396] [038/170] (908s left) gem_render_tiled_blits (basic) [130.384647] Starting subtest: basic [130.444220] Subtest basic: SUCCESS (0.060s) [130.501288] [039/170] (908s left) gem_ringfill (basic-all) [130.789841] Starting subtest: basic-all [132.018435] Subtest basic-all: SUCCESS (1.221s) [132.086713] [040/170] (906s left) gem_softpin (allocator-basic) [132.234243] Starting subtest: allocator-basic [132.401810] Subtest allocator-basic: SUCCESS (0.159s) [132.520066] [041/170] (906s left) gem_softpin (allocator-basic-reserve) [132.673334] Starting subtest: allocator-basic-reserve [132.837483] Subtest allocator-basic-reserve: SUCCESS (0.156s) [132.936373] [042/170] (906s left) gem_softpin (safe-alignment) [133.080846] Starting subtest: safe-alignment [133.097997] Subtest safe-alignment: SUCCESS (0.017s) [133.219203] [043/170] (905s left) gem_sync (basic-all) [133.362127] Starting subtest: basic-all [135.774060] Subtest basic-all: SUCCESS (2.388s) [135.953914] [044/170] (903s left) gem_sync (basic-each) [136.105692] Starting subtest: basic-each [138.409208] Subtest basic-each: SUCCESS (2.305s) [138.632591] [045/170] (900s left) gem_tiled_blits (basic) [138.921064] Starting subtest: basic [138.949530] Subtest basic: SUCCESS (0.029s) [139.069851] [046/170] (900s left) gem_tiled_fence_blits (basic) [139.430220] Starting subtest: basic [139.458248] Subtest basic: SUCCESS (0.028s) [139.583041] [047/170] (899s left) gem_tiled_pread_basic [140.119503] [048/170] (899s left) gem_wait (busy@all-engines) [140.294163] Starting subtest: busy [140.295544] Starting dynamic subtest: all-engines [140.830406] Dynamic subtest all-engines: SUCCESS (0.536s) [140.831531] Subtest busy: SUCCESS (0.537s) [141.070220] [049/170] (898s left) gem_wait (wait@all-engines) [141.228770] Starting subtest: wait [141.230066] Starting dynamic subtest: all-engines [142.261473] Dynamic subtest all-engines: SUCCESS (1.033s) [142.262586] Subtest wait: SUCCESS (1.033s) [142.504178] [050/170] (896s left) i915_getparams_basic (basic-eu-total) [142.638101] Starting subtest: basic-eu-total [142.640481] Subtest basic-eu-total: SUCCESS (0.000s) [142.718867] [051/170] (896s left) i915_getparams_basic (basic-subslice-total) [142.853985] Starting subtest: basic-subslice-total [142.856397] Subtest basic-subslice-total: SUCCESS (0.000s) [142.935571] [052/170] (896s left) i915_hangman (error-state-basic) [143.077139] Starting subtest: error-state-basic [143.089197] Subtest error-state-basic: SUCCESS (0.013s) [143.186363] [053/170] (896s left) i915_pciid [143.402453] [054/170] (896s left) kms_addfb_basic (addfb25-bad-modifier) [143.539418] Starting subtest: addfb25-bad-modifier [143.540558] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [143.668217] [055/170] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [143.803766] Starting subtest: addfb25-framebuffer-vs-set-tiling [143.804936] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [143.935977] [056/170] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [144.072270] Starting subtest: addfb25-modifier-no-flag [144.073352] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [144.185351] [057/170] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [144.322237] Starting subtest: addfb25-x-tiled-legacy [144.323388] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [144.452349] [058/170] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [144.586583] Starting subtest: addfb25-x-tiled-mismatch-legacy [144.587668] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [144.701960] [059/170] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [144.866456] Starting subtest: addfb25-yf-tiled-legacy [144.867496] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [144.969276] [060/170] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [145.131939] Starting subtest: addfb25-y-tiled-legacy [145.133210] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [145.235761] [061/170] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [145.399439] Starting subtest: addfb25-y-tiled-small-legacy [145.400549] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [145.502472] [062/170] (894s left) kms_addfb_basic (bad-pitch-0) [145.636516] Starting subtest: bad-pitch-0 [145.637739] Subtest bad-pitch-0: SUCCESS (0.000s) [145.769338] [063/170] (893s left) kms_addfb_basic (bad-pitch-1024) [145.903323] Starting subtest: bad-pitch-1024 [145.904382] Subtest bad-pitch-1024: SUCCESS (0.000s) [146.018067] [064/170] (893s left) kms_addfb_basic (bad-pitch-128) [146.152239] Starting subtest: bad-pitch-128 [146.153318] Subtest bad-pitch-128: SUCCESS (0.000s) [146.287440] [065/170] (893s left) kms_addfb_basic (bad-pitch-256) [146.415193] Starting subtest: bad-pitch-256 [146.416273] Subtest bad-pitch-256: SUCCESS (0.000s) [146.535085] [066/170] (893s left) kms_addfb_basic (bad-pitch-32) [146.668855] Starting subtest: bad-pitch-32 [146.670273] Subtest bad-pitch-32: SUCCESS (0.000s) [146.785179] [067/170] (892s left) kms_addfb_basic (bad-pitch-63) [146.919332] Starting subtest: bad-pitch-63 [146.920418] Subtest bad-pitch-63: SUCCESS (0.000s) [147.035633] [068/170] (892s left) kms_addfb_basic (bad-pitch-65536) [147.170373] Starting subtest: bad-pitch-65536 [147.171519] Subtest bad-pitch-65536: SUCCESS (0.000s) [147.285034] [069/170] (892s left) kms_addfb_basic (bad-pitch-999) [147.420212] Starting subtest: bad-pitch-999 [147.421369] Subtest bad-pitch-999: SUCCESS (0.000s) [147.553038] [070/170] (892s left) kms_addfb_basic (basic) [147.686618] Starting subtest: basic [147.687783] Subtest basic: SUCCESS (0.000s) [147.819365] [071/170] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [147.954371] Starting subtest: basic-x-tiled-legacy [147.955459] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [148.068658] [072/170] (891s left) kms_addfb_basic (basic-y-tiled-legacy) [148.203048] Starting subtest: basic-y-tiled-legacy [148.204269] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [148.336257] [073/170] (891s left) kms_addfb_basic (bo-too-small) [148.498923] Starting subtest: bo-too-small [148.500195] Subtest bo-too-small: SUCCESS (0.000s) [148.602373] [074/170] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [148.765170] Starting subtest: bo-too-small-due-to-tiling [148.766403] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [148.868888] [075/170] (891s left) kms_addfb_basic (clobberred-modifier) [149.003644] Starting subtest: clobberred-modifier [149.004817] Subtest clobberred-modifier: SUCCESS (0.000s) [149.136505] [076/170] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling) [149.270411] Starting subtest: framebuffer-vs-set-tiling [149.271476] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [149.385390] [077/170] (890s left) kms_addfb_basic (invalid-get-prop) [149.520235] Starting subtest: invalid-get-prop [149.521321] Subtest invalid-get-prop: SUCCESS (0.000s) [149.653469] [078/170] (890s left) kms_addfb_basic (invalid-get-prop-any) [149.788976] Starting subtest: invalid-get-prop-any [149.790061] Subtest invalid-get-prop-any: SUCCESS (0.000s) [149.919177] [079/170] (890s left) kms_addfb_basic (invalid-set-prop) [150.052674] Starting subtest: invalid-set-prop [150.053750] Subtest invalid-set-prop: SUCCESS (0.000s) [150.169025] [080/170] (889s left) kms_addfb_basic (invalid-set-prop-any) [150.304169] Starting subtest: invalid-set-prop-any [150.305241] Subtest invalid-set-prop-any: SUCCESS (0.000s) [150.418661] [081/170] (889s left) kms_addfb_basic (no-handle) [150.552914] Starting subtest: no-handle [150.554115] Subtest no-handle: SUCCESS (0.000s) [150.685255] [082/170] (889s left) kms_addfb_basic (size-max) [150.849168] Starting subtest: size-max [150.850305] Subtest size-max: SUCCESS (0.000s) [150.935138] [083/170] (889s left) kms_addfb_basic (small-bo) [151.097808] Starting subtest: small-bo [151.099048] Subtest small-bo: SUCCESS (0.000s) [151.185663] [084/170] (889s left) kms_addfb_basic (tile-pitch-mismatch) [151.322138] Starting subtest: tile-pitch-mismatch [151.323245] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [151.435051] [085/170] (888s left) kms_addfb_basic (too-high) [151.600297] Starting subtest: too-high [151.601445] Subtest too-high: SUCCESS (0.001s) [151.702481] [086/170] (888s left) kms_addfb_basic (too-wide) [151.867457] Starting subtest: too-wide [151.868603] Subtest too-wide: SUCCESS (0.000s) [151.951772] [087/170] (888s left) kms_addfb_basic (unused-handle) [152.086897] Starting subtest: unused-handle [152.088224] Subtest unused-handle: SUCCESS (0.000s) [152.201736] [088/170] (888s left) kms_addfb_basic (unused-modifier) [152.335643] Starting subtest: unused-modifier [152.336818] Subtest unused-modifier: SUCCESS (0.000s) [152.469868] [089/170] (887s left) kms_addfb_basic (unused-offsets) [152.595883] Starting subtest: unused-offsets [152.597092] Subtest unused-offsets: SUCCESS (0.000s) [152.718547] [090/170] (887s left) kms_addfb_basic (unused-pitches) [152.855206] Starting subtest: unused-pitches [152.856310] Subtest unused-pitches: SUCCESS (0.000s) [152.985530] [091/170] (887s left) kms_busy (basic) [153.162432] Starting subtest: basic [153.164884] Starting dynamic subtest: flip [154.152193] Dynamic subtest flip: SUCCESS (0.987s) [154.168612] Starting dynamic subtest: modeset [157.991332] Dynamic subtest modeset: SUCCESS (3.838s) [157.992418] Subtest basic: SUCCESS (4.828s) [158.960802] [092/170] (881s left) kms_chamelium_hpd (dp-hpd-fast) [159.445027] Subtest dp-hpd-fast: SKIP (0.000s) [160.315427] [093/170] (880s left) kms_chamelium_edid (dp-edid-read) [160.799846] Subtest dp-edid-read: SKIP (0.000s) [161.659717] [094/170] (878s left) kms_chamelium_frames (dp-crc-fast) [162.142104] Subtest dp-crc-fast: SKIP (0.000s) [163.003506] [095/170] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [163.486472] Subtest hdmi-hpd-fast: SKIP (0.000s) [164.347486] [096/170] (876s left) kms_chamelium_edid (hdmi-edid-read) [164.829612] Subtest hdmi-edid-read: SKIP (0.000s) [165.712709] [097/170] (874s left) kms_chamelium_frames (hdmi-crc-fast) [166.194333] Subtest hdmi-crc-fast: SKIP (0.000s) [167.101608] [098/170] (873s left) kms_chamelium_hpd (vga-hpd-fast) [167.568401] Subtest vga-hpd-fast: SKIP (0.000s) [168.445897] [099/170] (872s left) kms_chamelium_edid (vga-edid-read) [168.926183] Subtest vga-edid-read: SKIP (0.000s) [169.789782] [100/170] (870s left) kms_prop_blob (basic) [169.923767] Starting subtest: basic [169.925055] Subtest basic: SUCCESS (0.000s) [170.010772] [101/170] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [170.173514] Starting subtest: basic-busy-flip-before-cursor-atomic [170.175791] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [170.256048] [102/170] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [170.418719] Starting subtest: basic-busy-flip-before-cursor-legacy [170.420942] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [170.515155] [103/170] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [170.677838] Starting subtest: basic-flip-after-cursor-atomic [171.953342] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.276s) [172.909752] [104/170] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [173.071677] Starting subtest: basic-flip-after-cursor-legacy [174.370804] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.299s) [175.341664] [105/170] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [175.503240] Starting subtest: basic-flip-after-cursor-varying-size [176.800215] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.297s) [177.775610] [106/170] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [177.935655] Starting subtest: basic-flip-before-cursor-atomic [179.217241] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.288s) [180.157479] [107/170] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [180.320060] Starting subtest: basic-flip-before-cursor-legacy [181.623209] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.297s) [182.574442] [108/170] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [182.737399] Starting subtest: basic-flip-before-cursor-varying-size [184.024414] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.287s) [184.940063] [109/170] (855s left) kms_flip (basic-flip-vs-dpms) [185.083230] Starting subtest: basic-flip-vs-dpms [185.086112] Starting dynamic subtest: A-eDP1 [187.946528] Dynamic subtest A-eDP1: SUCCESS (2.859s) [187.962682] Starting dynamic subtest: B-eDP1 [190.298579] Dynamic subtest B-eDP1: SUCCESS (2.352s) [190.315753] Starting dynamic subtest: C-eDP1 [192.689113] Dynamic subtest C-eDP1: SUCCESS (2.387s) [192.690241] Subtest basic-flip-vs-dpms: SUCCESS (7.606s) [193.647525] [110/170] (847s left) kms_flip (basic-flip-vs-modeset) [193.790433] Starting subtest: basic-flip-vs-modeset [193.793506] Starting dynamic subtest: A-eDP1 [196.651802] Dynamic subtest A-eDP1: SUCCESS (2.855s) [196.667261] Starting dynamic subtest: B-eDP1 [199.016122] Dynamic subtest B-eDP1: SUCCESS (2.366s) [199.032352] Starting dynamic subtest: C-eDP1 [201.385166] Dynamic subtest C-eDP1: SUCCESS (2.368s) [201.386625] Subtest basic-flip-vs-modeset: SUCCESS (7.598s) [202.351450] [111/170] (838s left) kms_flip (basic-flip-vs-wf_vblank) [202.494950] Starting subtest: basic-flip-vs-wf_vblank [202.498213] Starting dynamic subtest: A-eDP1 [204.822241] Dynamic subtest A-eDP1: SUCCESS (2.319s) [204.837375] Starting dynamic subtest: B-eDP1 [207.104180] Dynamic subtest B-eDP1: SUCCESS (2.284s) [207.120572] Starting dynamic subtest: C-eDP1 [209.342404] Dynamic subtest C-eDP1: SUCCESS (2.239s) [209.345016] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.852s) [210.605711] [112/170] (830s left) kms_flip (basic-plain-flip) [210.748395] Starting subtest: basic-plain-flip [210.753576] Starting dynamic subtest: A-eDP1 [212.788225] Dynamic subtest A-eDP1: SUCCESS (2.036s) [212.804481] Starting dynamic subtest: B-eDP1 [214.756062] Dynamic subtest B-eDP1: SUCCESS (1.966s) [214.772437] Starting dynamic subtest: C-eDP1 [216.738106] Dynamic subtest C-eDP1: SUCCESS (1.982s) [216.740553] Subtest basic-plain-flip: SUCCESS (5.993s) [218.030606] [113/170] (823s left) kms_force_connector_basic (force-connector-state) [218.170679] Starting subtest: force-connector-state [219.865968] Subtest force-connector-state: SUCCESS (1.695s) [220.481425] [114/170] (820s left) kms_force_connector_basic (force-edid) [220.621757] Starting subtest: force-edid [220.884997] Subtest force-edid: SUCCESS (0.260s) [221.014536] [115/170] (820s left) kms_force_connector_basic (force-load-detect) [221.153193] Starting subtest: force-load-detect [221.155551] Subtest force-load-detect: SKIP (0.000s) [221.264575] [116/170] (819s left) kms_force_connector_basic (prune-stale-modes) [221.403701] Starting subtest: prune-stale-modes [221.714467] Subtest prune-stale-modes: SUCCESS (0.311s) [221.847473] [117/170] (819s left) kms_frontbuffer_tracking (basic) [222.019349] Starting subtest: basic [225.447260] Subtest basic: SUCCESS (3.428s) [225.549263] [118/170] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [225.718679] Starting subtest: compare-crc-sanitycheck [225.720385] Starting dynamic subtest: pipe-A-eDP-1 [226.393082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.672s) [226.412285] Starting dynamic subtest: pipe-B-eDP-1 [227.764307] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s) [227.782885] Starting dynamic subtest: pipe-C-eDP-1 [229.304747] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s) [229.310222] Subtest compare-crc-sanitycheck: SUCCESS (3.586s) [230.248465] [119/170] (810s left) kms_pipe_crc_basic (hang-read-crc) [230.414148] Starting subtest: hang-read-crc [230.415257] Starting dynamic subtest: pipe-A-eDP-1 [232.728895] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [232.747356] Starting dynamic subtest: pipe-B-eDP-1 [235.704856] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s) [235.723178] Starting dynamic subtest: pipe-C-eDP-1 [238.987344] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.278s) [238.988504] Subtest hang-read-crc: SUCCESS (8.574s) [239.912036] [120/170] (801s left) kms_pipe_crc_basic (nonblocking-crc) [240.076896] Starting subtest: nonblocking-crc [240.080071] Starting dynamic subtest: pipe-A-eDP-1 [240.939840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s) [240.957354] Starting dynamic subtest: pipe-B-eDP-1 [242.491349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [242.510482] Starting dynamic subtest: pipe-C-eDP-1 [244.191867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.694s) [244.193145] Subtest nonblocking-crc: SUCCESS (4.114s) [245.161339] [121/170] (796s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [245.326977] Starting subtest: nonblocking-crc-frame-sequence [245.328627] Starting dynamic subtest: pipe-A-eDP-1 [246.188974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s) [246.206674] Starting dynamic subtest: pipe-B-eDP-1 [247.740495] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s) [247.757997] Starting dynamic subtest: pipe-C-eDP-1 [249.455623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s) [249.456738] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.130s) [250.409146] [122/170] (790s left) kms_pipe_crc_basic (read-crc) [250.575685] Starting subtest: read-crc [250.578827] Starting dynamic subtest: pipe-A-eDP-1 [251.368882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s) [251.387426] Starting dynamic subtest: pipe-B-eDP-1 [252.856439] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [252.875193] Starting dynamic subtest: pipe-C-eDP-1 [254.496383] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.635s) [254.497636] Subtest read-crc: SUCCESS (3.920s) [255.401142] [123/170] (785s left) kms_pipe_crc_basic (read-crc-frame-sequence) [255.563660] Starting subtest: read-crc-frame-sequence [255.566744] Starting dynamic subtest: pipe-A-eDP-1 [256.362011] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [256.380422] Starting dynamic subtest: pipe-B-eDP-1 [257.855524] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [257.881331] Starting dynamic subtest: pipe-C-eDP-1 [259.483963] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.632s) [259.485220] Subtest read-crc-frame-sequence: SUCCESS (3.921s) [260.428769] [124/170] (780s left) kms_psr (primary_page_flip) [260.595478] Starting subtest: primary_page_flip [264.820549] Subtest primary_page_flip: SUCCESS (4.225s) [265.769254] [125/170] (775s left) kms_psr (cursor_plane_move) [265.935107] Starting subtest: cursor_plane_move [270.032359] Subtest cursor_plane_move: SUCCESS (4.095s) [270.953371] [126/170] (770s left) kms_psr (sprite_plane_onoff) [271.122938] Starting subtest: sprite_plane_onoff [275.386249] Subtest sprite_plane_onoff: SUCCESS (4.261s) [276.329111] [127/170] (765s left) kms_psr (primary_mmap_gtt) [276.496470] Starting subtest: primary_mmap_gtt [280.733898] Subtest primary_mmap_gtt: SUCCESS (4.236s) [281.640086] [128/170] (759s left) kms_setmode (basic-clone-single-crtc) [281.779688] Starting subtest: basic-clone-single-crtc [281.783021] Subtest basic-clone-single-crtc: SKIP (0.000s) [281.856718] [129/170] (759s left) i915_pm_backlight (basic-brightness) [282.024222] Starting subtest: basic-brightness [282.148186] Starting dynamic subtest: eDP-1 [282.684330] Dynamic subtest eDP-1: SUCCESS (0.543s) [282.685466] Subtest basic-brightness: SUCCESS (0.659s) [283.625053] [130/170] (757s left) i915_pm_rpm (basic-pci-d3-state) [285.513489] Starting subtest: basic-pci-d3-state [289.926397] Subtest basic-pci-d3-state: SUCCESS (4.412s) [290.125881] [131/170] (751s left) i915_pm_rpm (basic-rte) [290.255566] Starting subtest: basic-rte [296.388550] Subtest basic-rte: SUCCESS (6.132s) [301.699710] [132/170] (739s left) i915_pm_rps (basic-api) [301.844172] Starting subtest: basic-api [301.848209] Subtest basic-api: SUCCESS (0.004s) [301.937190] [133/170] (739s left) prime_self_import (basic-llseek-bad) [302.070085] Starting subtest: basic-llseek-bad [302.073488] Subtest basic-llseek-bad: SUCCESS (0.003s) [302.187977] [134/170] (739s left) prime_self_import (basic-llseek-size) [302.321545] Starting subtest: basic-llseek-size [302.325215] Subtest basic-llseek-size: SUCCESS (0.004s) [302.420263] [135/170] (739s left) prime_self_import (basic-with_fd_dup) [302.553726] Starting subtest: basic-with_fd_dup [302.559500] Subtest basic-with_fd_dup: SUCCESS (0.004s) [302.663301] [136/170] (739s left) prime_self_import (basic-with_one_bo) [302.796379] Starting subtest: basic-with_one_bo [302.802131] Subtest basic-with_one_bo: SUCCESS (0.005s) [302.891294] [137/170] (738s left) prime_self_import (basic-with_one_bo_two_files) [303.026399] Starting subtest: basic-with_one_bo_two_files [303.027737] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [303.136971] [138/170] (738s left) prime_self_import (basic-with_two_bos) [303.270872] Starting subtest: basic-with_two_bos [303.276753] Subtest basic-with_two_bos: SUCCESS (0.004s) [303.378613] [139/170] (738s left) prime_vgem (basic-fence-flip) [303.550491] Starting subtest: basic-fence-flip [304.095100] Subtest basic-fence-flip: SUCCESS (0.544s) [304.218449] [140/170] (737s left) prime_vgem (basic-fence-mmap) [304.369728] Starting subtest: basic-fence-mmap [304.416118] Subtest basic-fence-mmap: SUCCESS (0.046s) [304.537098] [141/170] (737s left) prime_vgem (basic-fence-read) [304.686246] Starting subtest: basic-fence-read [304.758919] Subtest basic-fence-read: SUCCESS (0.072s) [304.857054] [142/170] (737s left) prime_vgem (basic-gtt) [305.002550] Starting subtest: basic-gtt [305.025608] Subtest basic-gtt: SUCCESS (0.023s) [305.138543] [143/170] (736s left) prime_vgem (basic-read) [305.298811] Starting subtest: basic-read [305.333534] Subtest basic-read: SUCCESS (0.035s) [305.436764] [144/170] (736s left) prime_vgem (basic-write) [305.586207] Starting subtest: basic-write [305.627376] Subtest basic-write: SUCCESS (0.041s) [305.720707] [145/170] (736s left) vgem_basic (setversion) [305.861929] Starting subtest: setversion [305.864389] Subtest setversion: SUCCESS (0.000s) [305.934985] [146/170] (736s left) vgem_basic (create) [306.078773] Starting subtest: create [306.080238] Subtest create: SUCCESS (0.000s) [306.155204] [147/170] (735s left) vgem_basic (debugfs) [306.295205] Starting subtest: debugfs [306.296396] Subtest debugfs: SUCCESS (0.001s) [306.369528] [148/170] (735s left) vgem_basic (dmabuf-export) [306.511954] Starting subtest: dmabuf-export [306.533684] Subtest dmabuf-export: SUCCESS (0.020s) [306.657130] [149/170] (735s left) vgem_basic (dmabuf-fence) [306.796896] Starting subtest: dmabuf-fence [306.798116] Subtest dmabuf-fence: SUCCESS (0.001s) [306.866731] [150/170] (735s left) vgem_basic (dmabuf-fence-before) [307.014112] Starting subtest: dmabuf-fence-before [307.015238] Subtest dmabuf-fence-before: SUCCESS (0.001s) [307.083121] [151/170] (735s left) vgem_basic (dmabuf-mmap) [307.230483] Starting subtest: dmabuf-mmap [307.255894] Subtest dmabuf-mmap: SUCCESS (0.026s) [307.333675] [152/170] (734s left) vgem_basic (mmap) [307.480324] Starting subtest: mmap [307.496220] Subtest mmap: SUCCESS (0.017s) [307.569596] [153/170] (734s left) vgem_basic (second-client) [307.713842] Starting subtest: second-client [307.763623] Subtest second-client: SUCCESS (0.049s) [307.833229] [154/170] (734s left) vgem_basic (sysfs) [307.980519] Starting subtest: sysfs [307.981798] Subtest sysfs: SUCCESS (0.001s) [308.049767] [155/170] (734s left) core_hotunplug (unbind-rebind) [308.230335] Starting subtest: unbind-rebind [310.663553] Subtest unbind-rebind: SUCCESS (2.433s) [310.698343] [156/170] (731s left) vgem_basic (unload) [310.837774] Starting subtest: unload [339.827740] Subtest unload: SUCCESS (28.955s) [339.937865] [157/170] (702s left) i915_module_load (reload) [340.073915] Starting subtest: reload [343.572244] Subtest reload: SUCCESS (3.498s) [343.603864] [158/170] (698s left) gem_lmem_swapping (basic) [343.760129] Subtest basic: SKIP (0.000s) [343.806636] [159/170] (698s left) gem_lmem_swapping (parallel-random-engines) [343.949442] Subtest parallel-random-engines: SKIP (0.000s) [343.989454] [160/170] (698s left) gem_lmem_swapping (random-engines) [344.131268] Subtest random-engines: SKIP (0.000s) [344.172990] [161/170] (698s left) gem_lmem_swapping (verify-random) [344.316139] Subtest verify-random: SKIP (0.000s) [344.356299] [162/170] (698s left) i915_pm_rpm (module-reload) [356.856737] Starting subtest: module-reload [391.717790] Subtest module-reload: SUCCESS (34.853s) [391.741608] [163/170] (650s left) i915_selftest (live) [391.883704] Starting subtest: live [391.885229] Starting dynamic subtest: sanitycheck [393.735239] Dynamic subtest sanitycheck: SUCCESS (1.842s) [393.750026] Starting dynamic subtest: uncore [395.541303] Dynamic subtest uncore: SUCCESS (1.804s) [395.555801] Starting dynamic subtest: workarounds [397.575402] Dynamic subtest workarounds: SUCCESS (2.032s) [397.589951] Starting dynamic subtest: gt_engines [399.905790] Dynamic subtest gt_engines: SUCCESS (2.328s) [399.920310] Starting dynamic subtest: gt_timelines [411.780586] Dynamic subtest gt_timelines: SUCCESS (11.873s) [411.795165] Starting dynamic subtest: gt_contexts [413.651721] Dynamic subtest gt_contexts: SUCCESS (1.869s) [413.666226] Starting dynamic subtest: gt_lrc [418.005061] Dynamic subtest gt_lrc: SUCCESS (4.351s) [418.019560] Starting dynamic subtest: gt_mocs [419.920388] Dynamic subtest gt_mocs: SUCCESS (1.914s) [419.934902] Starting dynamic subtest: gt_pm [424.988042] Dynamic subtest gt_pm: SUCCESS (5.065s) [425.002798] Starting dynamic subtest: gt_heartbeat [426.900536] Dynamic subtest gt_heartbeat: SUCCESS (1.911s) [426.915203] Starting dynamic subtest: gt_tlb [429.986345] Dynamic subtest gt_tlb: SUCCESS (3.084s) [430.000900] Starting dynamic subtest: requests [437.568152] Dynamic subtest requests: SUCCESS (7.579s) [437.582922] Starting dynamic subtest: migrate [442.112504] Dynamic subtest migrate: SUCCESS (4.543s) [442.127190] Starting dynamic subtest: active [443.984736] Dynamic subtest active: SUCCESS (1.870s) [443.999451] Starting dynamic subtest: objects [447.302438] Dynamic subtest objects: SUCCESS (3.316s) [447.316969] Starting dynamic subtest: mman [454.200633] Dynamic subtest mman: SUCCESS (6.896s) [454.215283] Starting dynamic subtest: dmabuf [456.028574] Dynamic subtest dmabuf: SUCCESS (1.826s) [456.043269] Starting dynamic subtest: vma [457.861565] Dynamic subtest vma: SUCCESS (1.831s) [457.878904] Starting dynamic subtest: coherency [462.306440] Dynamic subtest coherency: SUCCESS (4.443s) [462.321129] Starting dynamic subtest: gtt [471.544767] Dynamic subtest gtt: SUCCESS (9.236s) [471.559791] Starting dynamic subtest: gem [473.499411] Dynamic subtest gem: SUCCESS (1.953s) [473.514109] Starting dynamic subtest: evict [477.210530] Dynamic subtest evict: SUCCESS (3.709s) [477.225113] Starting dynamic subtest: hugepages [484.137563] Dynamic subtest hugepages: SUCCESS (6.925s) [484.152752] Starting dynamic subtest: gem_contexts [499.215752] Dynamic subtest gem_contexts: SUCCESS (15.076s) [499.231096] Starting dynamic subtest: client [501.079163] Dynamic subtest client: SUCCESS (1.862s) [501.094336] Starting dynamic subtest: gem_migrate [502.858364] Dynamic subtest gem_migrate: SUCCESS (1.777s) [502.875616] Starting dynamic subtest: reset [508.232413] Dynamic subtest reset: SUCCESS (5.372s) [508.247677] Starting dynamic subtest: memory_region [510.022154] Dynamic subtest memory_region: SUCCESS (1.788s) [510.038466] Starting dynamic subtest: hangcheck [534.441742] Dynamic subtest hangcheck: SUCCESS (24.418s) [534.457166] Starting dynamic subtest: execlists [544.428541] Dynamic subtest execlists: SUCCESS (9.985s) [544.444272] Starting dynamic subtest: ring_submission [546.262835] Dynamic subtest ring_submission: SUCCESS (1.832s) [546.278374] Starting dynamic subtest: perf [548.187519] Dynamic subtest perf: SUCCESS (1.923s) [548.202872] Starting dynamic subtest: slpc [550.010566] Dynamic subtest slpc: SUCCESS (1.821s) [550.025885] Starting dynamic subtest: guc [551.829456] Dynamic subtest guc: SUCCESS (1.817s) [551.844972] Starting dynamic subtest: guc_multi_lrc [553.678095] Dynamic subtest guc_multi_lrc: SUCCESS (1.847s) [553.693602] Starting dynamic subtest: guc_hang [555.530537] Dynamic subtest guc_hang: SUCCESS (1.851s) [555.545974] Starting dynamic subtest: late_gt_pm [557.327536] Dynamic subtest late_gt_pm: SUCCESS (1.795s) [557.328829] Subtest live: SUCCESS (165.435s) [557.526642] [164/170] (485s left) dmabuf (all-tests) [557.661601] Starting subtest: all-tests [557.663081] Starting dynamic subtest: sanitycheck [557.730057] Dynamic subtest sanitycheck: SUCCESS (0.067s) [557.748120] Starting dynamic subtest: dma_fence [557.914931] Dynamic subtest dma_fence: SUCCESS (0.183s) [557.934559] Starting dynamic subtest: dma_fence_chain [575.639453] Dynamic subtest dma_fence_chain: SUCCESS (17.714s) [575.655457] Starting dynamic subtest: dma_fence_unwrap [575.700427] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s) [575.715373] Starting dynamic subtest: dma_resv [575.771717] Dynamic subtest dma_resv: SUCCESS (0.069s) [575.773919] Subtest all-tests: SUCCESS (18.109s) [575.803280] [165/170] (466s left) i915_suspend (basic-s2idle-without-i915) [575.936471] Starting subtest: basic-s2idle-without-i915 [598.929859] Subtest basic-s2idle-without-i915: SUCCESS (8.495s) [599.223631] [166/170] (457s left) i915_suspend (basic-s3-without-i915) [599.364530] Starting subtest: basic-s3-without-i915 [622.964521] Subtest basic-s3-without-i915: SUCCESS (7.044s) [623.255188] [167/170] (450s left) gem_exec_suspend (basic-s0) [623.406526] Starting subtest: basic-S0 [623.407685] Starting dynamic subtest: smem [642.995067] Dynamic subtest smem: SUCCESS (3.707s) [642.996091] Subtest basic-S0: SUCCESS (3.708s) [643.156537] [168/170] (446s left) gem_exec_suspend (basic-s3) [643.303902] Starting subtest: basic-S3 [643.305063] Starting dynamic subtest: smem [662.034903] Dynamic subtest smem: SUCCESS (3.550s) [662.035991] Subtest basic-S3: SUCCESS (3.551s) [662.197612] [169/170] (442s left) kms_chamelium_hpd (common-hpd-after-suspend) [662.681919] Subtest common-hpd-after-suspend: SKIP (0.000s) [663.589259] [170/170] (441s left) kms_pipe_crc_basic (suspend-read-crc) [663.747225] Starting subtest: suspend-read-crc [663.751194] Starting dynamic subtest: pipe-A-eDP-1 [682.043710] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [682.065764] Starting dynamic subtest: pipe-B-eDP-1 [700.972582] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.108s) [700.995095] Starting dynamic subtest: pipe-C-eDP-1 [719.980338] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.276s) [719.981489] Subtest suspend-read-crc: SUCCESS (8.892s) [720.854996] Closing watchdogs Done.