builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1507399395.64 results: success (0) revision: 21e3f04ae989fd57b7a4acfa948e8587784dcf4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.643189) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.644043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.644316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.713919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.714260) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-07 11:03:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2017-10-07 11:03:15 (47.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212804 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.987581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:15.987857) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.062534 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:16.064534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-07 11:03:16.064889) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 21e3f04ae989fd57b7a4acfa948e8587784dcf4b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 21e3f04ae989fd57b7a4acfa948e8587784dcf4b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-07 11:03:16,118 truncating revision to first 12 chars 2017-10-07 11:03:16,118 Setting DEBUG logging. 2017-10-07 11:03:16,118 attempt 1/10 2017-10-07 11:03:16,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/21e3f04ae989?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-07 11:03:16,965 unpacking tar archive at: mozilla-beta-21e3f04ae989/testing/mozharness/ program finished with exit code 0 elapsedTime=1.181777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-07 11:03:17.264465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:17.264864) ========= script_repo_revision: 21e3f04ae989fd57b7a4acfa948e8587784dcf4b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:17.265271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:17.265536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-07 11:03:17.279961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-07 11:03:17.280344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:17 INFO - MultiFileLogger online at 20171007 11:03:17 in /builds/slave/test 11:03:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:03:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:17 INFO - {'append_to_log': False, 11:03:17 INFO - 'base_work_dir': '/builds/slave/test', 11:03:17 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:17 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:17 INFO - 'code_coverage': False, 11:03:17 INFO - 'config_files': ('talos/linux_config.py',), 11:03:17 INFO - 'default_actions': ('clobber', 11:03:17 INFO - 'read-buildbot-config', 11:03:17 INFO - 'download-and-extract', 11:03:17 INFO - 'populate-webroot', 11:03:17 INFO - 'create-virtualenv', 11:03:17 INFO - 'install', 11:03:17 INFO - 'setup-mitmproxy', 11:03:17 INFO - 'run-tests'), 11:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:17 INFO - 'disable_ccov_upload': False, 11:03:17 INFO - 'disable_stylo': False, 11:03:17 INFO - 'download_minidump_stackwalk': True, 11:03:17 INFO - 'download_symbols': 'ondemand', 11:03:17 INFO - 'enable_stylo': False, 11:03:17 INFO - 'enable_webrender': False, 11:03:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:17 INFO - 'gecko_profile': False, 11:03:17 INFO - 'gecko_profile_interval': 0, 11:03:17 INFO - 'installer_path': 'installer.exe', 11:03:17 INFO - 'log_level': 'info', 11:03:17 INFO - 'log_name': 'talos', 11:03:17 INFO - 'log_to_console': True, 11:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:17 INFO - 'opt_config_files': (), 11:03:17 INFO - 'pip_index': False, 11:03:17 INFO - 'suite': 'dromaeojs-e10s', 11:03:17 INFO - 'system_bits': '32', 11:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:17 INFO - 'title': 'talos-linux64-ix-044', 11:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:17 INFO - 'use_talos_json': True, 11:03:17 INFO - 'verify': 'False', 11:03:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:17 INFO - 'work_dir': 'build'} 11:03:17 INFO - [mozharness: 2017-10-07 18:03:17.577785Z] Running clobber step. 11:03:17 INFO - Running pre-action listener: _resource_record_pre_action 11:03:17 INFO - Running main action method: clobber 11:03:17 INFO - rmtree: /builds/slave/test/build 11:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:19 INFO - Running post-action listener: _resource_record_post_action 11:03:19 INFO - [mozharness: 2017-10-07 18:03:19.649345Z] Finished clobber step (success) 11:03:19 INFO - [mozharness: 2017-10-07 18:03:19.649557Z] Running read-buildbot-config step. 11:03:19 INFO - Running pre-action listener: _resource_record_pre_action 11:03:19 INFO - Running main action method: read_buildbot_config 11:03:19 INFO - Using buildbot properties: 11:03:19 INFO - { 11:03:19 INFO - "project": "", 11:03:19 INFO - "product": "firefox", 11:03:19 INFO - "who": "ryanvm@gmail.com", 11:03:19 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:03:19 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:03:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:03:19 INFO - "stage_platform": "linux64", 11:03:19 INFO - "basedir": "/builds/slave/test", 11:03:19 INFO - "buildnumber": 126, 11:03:19 INFO - "platform": "ubuntu64_hw", 11:03:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:19 INFO - "slavebuilddir": "test", 11:03:19 INFO - "taskId": "K5s9qPyXTdyB03x2TZUW1w", 11:03:19 INFO - "branch": "mozilla-beta", 11:03:19 INFO - "script_repo_revision": "production", 11:03:19 INFO - "revision": "21e3f04ae989fd57b7a4acfa948e8587784dcf4b", 11:03:19 INFO - "slavename": "talos-linux64-ix-044", 11:03:19 INFO - "repo_path": "releases/mozilla-beta" 11:03:19 INFO - } 11:03:19 INFO - Finding installer, test and symbols from parent task. 11:03:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5s9qPyXTdyB03x2TZUW1w'}, attempt #1 11:03:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5s9qPyXTdyB03x2TZUW1w'}, attempt #1 11:03:20 INFO - Task dependencies: aLxoNRtvSgyM1KmySCeTgQ 11:03:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ'}, attempt #1 11:03:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 11:03:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.test_packages.json 11:03:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.crashreporter-symbols.zip 11:03:20 INFO - Running post-action listener: _resource_record_post_action 11:03:20 INFO - [mozharness: 2017-10-07 18:03:20.978117Z] Finished read-buildbot-config step (success) 11:03:20 INFO - [mozharness: 2017-10-07 18:03:20.978341Z] Running download-and-extract step. 11:03:20 INFO - Running pre-action listener: _resource_record_pre_action 11:03:20 INFO - Running main action method: download_and_extract 11:03:20 INFO - mkdir: /builds/slave/test/build/tests 11:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:20 INFO - trying https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.test_packages.json 11:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:21 INFO - Downloaded 989 bytes. 11:03:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:21 INFO - Using the following test package requirements: 11:03:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:21 INFO - u'common': [u'target.common.tests.zip'], 11:03:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:21 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:21 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:21 INFO - u'target.web-platform.tests.tar.gz'], 11:03:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.common.tests.zip 11:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.common.tests.zip into memory 11:03:22 INFO - Content-Length response header: 55178235 11:03:22 INFO - Bytes received: 55178235 11:03:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.talos.tests.zip 11:03:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:33 INFO - Fetch https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.talos.tests.zip into memory 11:03:34 INFO - Content-Length response header: 14509224 11:03:34 INFO - Bytes received: 14509224 11:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:35 INFO - trying https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 11:03:35 INFO - Downloading https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:37 INFO - Downloaded 53647954 bytes. 11:03:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 11:03:37 INFO - mkdir: /builds/slave/test/properties 11:03:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:37 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:37 INFO - Contents: 11:03:37 INFO - build_url:https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 11:03:37 INFO - Running post-action listener: _resource_record_post_action 11:03:37 INFO - Running post-action listener: find_tests_for_verification 11:03:37 INFO - Running post-action listener: set_extra_try_arguments 11:03:37 INFO - [mozharness: 2017-10-07 18:03:37.968324Z] Finished download-and-extract step (success) 11:03:37 INFO - [mozharness: 2017-10-07 18:03:37.968421Z] Running populate-webroot step. 11:03:37 INFO - Running pre-action listener: _resource_record_pre_action 11:03:37 INFO - Running main action method: populate_webroot 11:03:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['tresize', 11:03:37 INFO - 'tcanvasmark']}, 11:03:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['dromaeo_css', 11:03:37 INFO - 'kraken']}, 11:03:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'tests': ['damp', 'tps']}, 11:03:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['damp', 'tps']}, 11:03:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['dromaeo_dom']}, 11:03:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['basic_compositor_video', 11:03:37 INFO - 'glvideo']}, 11:03:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['ts_paint_webext', 11:03:37 INFO - 'tp5o_webext']}, 11:03:37 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:37 INFO - 'ts_paint', 11:03:37 INFO - 'tpaint', 11:03:37 INFO - 'sessionrestore', 11:03:37 INFO - 'sessionrestore_many_windows', 11:03:37 INFO - 'sessionrestore_no_auto_restore', 11:03:37 INFO - 'tabpaint']}, 11:03:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['a11yr', 11:03:37 INFO - 'ts_paint', 11:03:37 INFO - 'tpaint', 11:03:37 INFO - 'sessionrestore', 11:03:37 INFO - 'sessionrestore_many_windows', 11:03:37 INFO - 'sessionrestore_no_auto_restore', 11:03:37 INFO - 'tabpaint']}, 11:03:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:03:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['perf_reftest_singletons']}, 11:03:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['bloom_basic']}, 11:03:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:37 INFO - 'tsvgr_opacity', 11:03:37 INFO - 'tart', 11:03:37 INFO - 'tscrollx', 11:03:37 INFO - 'tsvg_static']}, 11:03:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['tsvgx', 11:03:37 INFO - 'tsvgr_opacity', 11:03:37 INFO - 'tart', 11:03:37 INFO - 'tscrollx', 11:03:37 INFO - 'tsvg_static']}, 11:03:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo'], 11:03:37 INFO - 'tests': ['tp5o']}, 11:03:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:37 INFO - 'talos_options': ['--mitmproxy', 11:03:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:37 INFO - '--firstNonBlankPaint'], 11:03:37 INFO - 'tests': ['tp6_google', 11:03:37 INFO - 'tp6_youtube', 11:03:37 INFO - 'tp6_amazon', 11:03:37 INFO - 'tp6_facebook']}, 11:03:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo', 11:03:37 INFO - '--mitmproxy', 11:03:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:37 INFO - '--firstNonBlankPaint'], 11:03:37 INFO - 'tests': ['tp6_google', 11:03:37 INFO - 'tp6_youtube', 11:03:37 INFO - 'tp6_amazon', 11:03:37 INFO - 'tp6_facebook']}, 11:03:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:37 INFO - 'talos_options': ['--stylo-threads=1', 11:03:37 INFO - '--mitmproxy', 11:03:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:37 INFO - '--firstNonBlankPaint'], 11:03:37 INFO - 'tests': ['tp6_google', 11:03:37 INFO - 'tp6_youtube', 11:03:37 INFO - 'tp6_amazon', 11:03:37 INFO - 'tp6_facebook']}, 11:03:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--xperf_path', 11:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:37 INFO - 'tests': ['tp5n']}, 11:03:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:37 INFO - 'talos_options': ['--disable-stylo', 11:03:37 INFO - '--xperf_path', 11:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:37 INFO - 'tests': ['tp5n']}}} 11:03:37 INFO - Running post-action listener: _resource_record_post_action 11:03:37 INFO - [mozharness: 2017-10-07 18:03:37.988403Z] Finished populate-webroot step (success) 11:03:37 INFO - [mozharness: 2017-10-07 18:03:37.988493Z] Running create-virtualenv step. 11:03:37 INFO - Running pre-action listener: _resource_record_pre_action 11:03:37 INFO - Running main action method: create_virtualenv 11:03:37 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:03:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:38 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:39 INFO - Installing pip...............done. 11:03:39 INFO - Return code: 0 11:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:39 INFO - Reading from file tmpfile_stdout 11:03:39 INFO - Output received: 11:03:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:03:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:03:39 INFO - Using env: {'DISPLAY': ':0', 11:03:39 INFO - 'HOME': '/home/cltbld', 11:03:39 INFO - 'LANG': 'en_US.UTF-8', 11:03:39 INFO - 'LANGUAGE': 'en_US:en', 11:03:39 INFO - 'LOGNAME': 'cltbld', 11:03:39 INFO - 'MAIL': '/var/mail/cltbld', 11:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:39 INFO - 'MOZ_NO_REMOTE': '1', 11:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:39 INFO - 'NO_EM_RESTART': '1', 11:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:39 INFO - 'PWD': '/builds/slave/test', 11:03:39 INFO - 'SHELL': '/bin/bash', 11:03:39 INFO - 'SHLVL': '1', 11:03:39 INFO - 'TERM': 'linux', 11:03:39 INFO - 'TMOUT': '86400', 11:03:39 INFO - 'USER': 'cltbld', 11:03:39 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:39 INFO - '_': '/tools/buildbot/bin/python'} 11:03:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:03:40 INFO - Downloading/unpacking pip>=1.5 11:03:40 INFO - Running setup.py egg_info for package pip 11:03:40 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:40 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:40 INFO - Installing collected packages: pip 11:03:40 INFO - Found existing installation: pip 1.1 11:03:40 INFO - Uninstalling pip: 11:03:40 INFO - Successfully uninstalled pip 11:03:40 INFO - Running setup.py install for pip 11:03:40 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:40 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:03:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:03:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:03:40 INFO - Successfully installed pip 11:03:40 INFO - Cleaning up... 11:03:40 INFO - Return code: 0 11:03:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:03:40 INFO - Using env: {'DISPLAY': ':0', 11:03:40 INFO - 'HOME': '/home/cltbld', 11:03:40 INFO - 'LANG': 'en_US.UTF-8', 11:03:40 INFO - 'LANGUAGE': 'en_US:en', 11:03:40 INFO - 'LOGNAME': 'cltbld', 11:03:40 INFO - 'MAIL': '/var/mail/cltbld', 11:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:40 INFO - 'MOZ_NO_REMOTE': '1', 11:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:40 INFO - 'NO_EM_RESTART': '1', 11:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:40 INFO - 'PWD': '/builds/slave/test', 11:03:40 INFO - 'SHELL': '/bin/bash', 11:03:40 INFO - 'SHLVL': '1', 11:03:40 INFO - 'TERM': 'linux', 11:03:40 INFO - 'TMOUT': '86400', 11:03:40 INFO - 'USER': 'cltbld', 11:03:40 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:40 INFO - '_': '/tools/buildbot/bin/python'} 11:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:40 INFO - Downloading/unpacking psutil>=3.1.1 11:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:42 INFO - Installing collected packages: psutil 11:03:42 INFO - Running setup.py install for psutil 11:03:42 INFO - building 'psutil._psutil_linux' extension 11:03:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:03:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:03:43 INFO - building 'psutil._psutil_posix' extension 11:03:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:03:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:03:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:44 INFO - Successfully installed psutil 11:03:44 INFO - Cleaning up... 11:03:44 INFO - Return code: 0 11:03:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:03:44 INFO - Using env: {'DISPLAY': ':0', 11:03:44 INFO - 'HOME': '/home/cltbld', 11:03:44 INFO - 'LANG': 'en_US.UTF-8', 11:03:44 INFO - 'LANGUAGE': 'en_US:en', 11:03:44 INFO - 'LOGNAME': 'cltbld', 11:03:44 INFO - 'MAIL': '/var/mail/cltbld', 11:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:44 INFO - 'MOZ_NO_REMOTE': '1', 11:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:44 INFO - 'NO_EM_RESTART': '1', 11:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:44 INFO - 'PWD': '/builds/slave/test', 11:03:44 INFO - 'SHELL': '/bin/bash', 11:03:44 INFO - 'SHLVL': '1', 11:03:44 INFO - 'TERM': 'linux', 11:03:44 INFO - 'TMOUT': '86400', 11:03:44 INFO - 'USER': 'cltbld', 11:03:44 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:44 INFO - '_': '/tools/buildbot/bin/python'} 11:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:45 INFO - Installing collected packages: mozsystemmonitor 11:03:45 INFO - Running setup.py install for mozsystemmonitor 11:03:45 INFO - Successfully installed mozsystemmonitor 11:03:45 INFO - Cleaning up... 11:03:45 INFO - Return code: 0 11:03:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:03:45 INFO - Using env: {'DISPLAY': ':0', 11:03:45 INFO - 'HOME': '/home/cltbld', 11:03:45 INFO - 'LANG': 'en_US.UTF-8', 11:03:45 INFO - 'LANGUAGE': 'en_US:en', 11:03:45 INFO - 'LOGNAME': 'cltbld', 11:03:45 INFO - 'MAIL': '/var/mail/cltbld', 11:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:45 INFO - 'MOZ_NO_REMOTE': '1', 11:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:45 INFO - 'NO_EM_RESTART': '1', 11:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:45 INFO - 'PWD': '/builds/slave/test', 11:03:45 INFO - 'SHELL': '/bin/bash', 11:03:45 INFO - 'SHLVL': '1', 11:03:45 INFO - 'TERM': 'linux', 11:03:45 INFO - 'TMOUT': '86400', 11:03:45 INFO - 'USER': 'cltbld', 11:03:45 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:45 INFO - '_': '/tools/buildbot/bin/python'} 11:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:45 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:47 INFO - warning: no files found matching '*.txt' 11:03:47 INFO - no previously-included directories found matching 'build' 11:03:47 INFO - no previously-included directories found matching 'dist' 11:03:47 INFO - no previously-included directories found matching '.git*' 11:03:47 INFO - Installing collected packages: jsonschema, functools32 11:03:47 INFO - Running setup.py install for functools32 11:03:47 INFO - warning: no files found matching '*.txt' 11:03:47 INFO - no previously-included directories found matching 'build' 11:03:47 INFO - no previously-included directories found matching 'dist' 11:03:47 INFO - no previously-included directories found matching '.git*' 11:03:47 INFO - Successfully installed jsonschema functools32 11:03:47 INFO - Cleaning up... 11:03:47 INFO - Return code: 0 11:03:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:03:47 INFO - Using env: {'DISPLAY': ':0', 11:03:47 INFO - 'HOME': '/home/cltbld', 11:03:47 INFO - 'LANG': 'en_US.UTF-8', 11:03:47 INFO - 'LANGUAGE': 'en_US:en', 11:03:47 INFO - 'LOGNAME': 'cltbld', 11:03:47 INFO - 'MAIL': '/var/mail/cltbld', 11:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:47 INFO - 'MOZ_NO_REMOTE': '1', 11:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:47 INFO - 'NO_EM_RESTART': '1', 11:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:47 INFO - 'PWD': '/builds/slave/test', 11:03:47 INFO - 'SHELL': '/bin/bash', 11:03:47 INFO - 'SHLVL': '1', 11:03:47 INFO - 'TERM': 'linux', 11:03:47 INFO - 'TMOUT': '86400', 11:03:47 INFO - 'USER': 'cltbld', 11:03:47 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:47 INFO - '_': '/tools/buildbot/bin/python'} 11:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:47 INFO - Cleaning up... 11:03:47 INFO - Return code: 0 11:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:47 INFO - Using env: {'DISPLAY': ':0', 11:03:47 INFO - 'HOME': '/home/cltbld', 11:03:47 INFO - 'LANG': 'en_US.UTF-8', 11:03:47 INFO - 'LANGUAGE': 'en_US:en', 11:03:47 INFO - 'LOGNAME': 'cltbld', 11:03:47 INFO - 'MAIL': '/var/mail/cltbld', 11:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:47 INFO - 'MOZ_NO_REMOTE': '1', 11:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:47 INFO - 'NO_EM_RESTART': '1', 11:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:47 INFO - 'PWD': '/builds/slave/test', 11:03:47 INFO - 'SHELL': '/bin/bash', 11:03:47 INFO - 'SHLVL': '1', 11:03:47 INFO - 'TERM': 'linux', 11:03:47 INFO - 'TMOUT': '86400', 11:03:47 INFO - 'USER': 'cltbld', 11:03:47 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:47 INFO - '_': '/tools/buildbot/bin/python'} 11:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:49 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:49 INFO - Downloading docopt-0.6.1.tar.gz 11:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:49 INFO - Running setup.py install for blobuploader 11:03:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:49 INFO - Running setup.py install for requests 11:03:50 INFO - Running setup.py install for docopt 11:03:50 INFO - Successfully installed blobuploader requests docopt 11:03:50 INFO - Cleaning up... 11:03:50 INFO - Return code: 0 11:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:50 INFO - Using env: {'DISPLAY': ':0', 11:03:50 INFO - 'HOME': '/home/cltbld', 11:03:50 INFO - 'LANG': 'en_US.UTF-8', 11:03:50 INFO - 'LANGUAGE': 'en_US:en', 11:03:50 INFO - 'LOGNAME': 'cltbld', 11:03:50 INFO - 'MAIL': '/var/mail/cltbld', 11:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:50 INFO - 'MOZ_NO_REMOTE': '1', 11:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:50 INFO - 'NO_EM_RESTART': '1', 11:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:50 INFO - 'PWD': '/builds/slave/test', 11:03:50 INFO - 'SHELL': '/bin/bash', 11:03:50 INFO - 'SHLVL': '1', 11:03:50 INFO - 'TERM': 'linux', 11:03:50 INFO - 'TMOUT': '86400', 11:03:50 INFO - 'USER': 'cltbld', 11:03:50 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:50 INFO - '_': '/tools/buildbot/bin/python'} 11:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:50 INFO - Running setup.py (path:/tmp/pip-sCoUF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:50 INFO - Running setup.py (path:/tmp/pip-mF1lPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:50 INFO - Running setup.py (path:/tmp/pip-nQDSH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:50 INFO - Running setup.py (path:/tmp/pip-fbfhmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:50 INFO - Running setup.py (path:/tmp/pip-UrbOHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:50 INFO - Running setup.py (path:/tmp/pip-UIeGaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:50 INFO - Running setup.py (path:/tmp/pip-wUVIdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:50 INFO - Running setup.py (path:/tmp/pip-z0H9Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:51 INFO - Running setup.py (path:/tmp/pip-vjwlK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:51 INFO - Running setup.py (path:/tmp/pip-9SR6Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:51 INFO - Running setup.py (path:/tmp/pip-B1LwFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:51 INFO - Running setup.py (path:/tmp/pip-9fKKYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:51 INFO - Running setup.py (path:/tmp/pip-gcWR6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:51 INFO - Running setup.py (path:/tmp/pip-ZJnf8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:51 INFO - Running setup.py (path:/tmp/pip-17pOmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:51 INFO - Running setup.py (path:/tmp/pip-2Pst02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:51 INFO - Running setup.py (path:/tmp/pip-e3fw76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:51 INFO - Running setup.py install for manifestparser 11:03:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:51 INFO - Running setup.py install for mozcrash 11:03:51 INFO - Running setup.py install for mozdebug 11:03:51 INFO - Running setup.py install for mozdevice 11:03:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozfile 11:03:52 INFO - Running setup.py install for mozhttpd 11:03:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozinfo 11:03:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozInstall 11:03:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozleak 11:03:52 INFO - Running setup.py install for mozlog 11:03:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for moznetwork 11:03:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozprocess 11:03:52 INFO - Running setup.py install for mozprofile 11:03:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:52 INFO - Running setup.py install for mozrunner 11:03:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:53 INFO - Running setup.py install for mozscreenshot 11:03:53 INFO - Running setup.py install for moztest 11:03:53 INFO - Running setup.py install for mozversion 11:03:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:53 INFO - Cleaning up... 11:03:53 INFO - Return code: 0 11:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:53 INFO - Using env: {'DISPLAY': ':0', 11:03:53 INFO - 'HOME': '/home/cltbld', 11:03:53 INFO - 'LANG': 'en_US.UTF-8', 11:03:53 INFO - 'LANGUAGE': 'en_US:en', 11:03:53 INFO - 'LOGNAME': 'cltbld', 11:03:53 INFO - 'MAIL': '/var/mail/cltbld', 11:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:53 INFO - 'MOZ_NO_REMOTE': '1', 11:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:53 INFO - 'NO_EM_RESTART': '1', 11:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:53 INFO - 'PWD': '/builds/slave/test', 11:03:53 INFO - 'SHELL': '/bin/bash', 11:03:53 INFO - 'SHLVL': '1', 11:03:53 INFO - 'TERM': 'linux', 11:03:53 INFO - 'TMOUT': '86400', 11:03:53 INFO - 'USER': 'cltbld', 11:03:53 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:53 INFO - '_': '/tools/buildbot/bin/python'} 11:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:53 INFO - Running setup.py (path:/tmp/pip-72lYSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:53 INFO - Running setup.py (path:/tmp/pip-A8Zxvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:53 INFO - Running setup.py (path:/tmp/pip-KFfpuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:53 INFO - Running setup.py (path:/tmp/pip-KmvYRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:53 INFO - Running setup.py (path:/tmp/pip-xKuPLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:53 INFO - Running setup.py (path:/tmp/pip-DbutYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:53 INFO - Running setup.py (path:/tmp/pip-3QGv_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:54 INFO - Running setup.py (path:/tmp/pip-nh3zOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:54 INFO - Running setup.py (path:/tmp/pip-SG_Eg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:54 INFO - Running setup.py (path:/tmp/pip-85UDaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:54 INFO - Running setup.py (path:/tmp/pip-jU63oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:54 INFO - Running setup.py (path:/tmp/pip-3X_Kpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:54 INFO - Running setup.py (path:/tmp/pip-9fIvUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:54 INFO - Running setup.py (path:/tmp/pip-rKLjHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:54 INFO - Running setup.py (path:/tmp/pip-gsbezC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:54 INFO - Running setup.py (path:/tmp/pip-9ei4LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:54 INFO - Running setup.py (path:/tmp/pip-0Nw1Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:55 INFO - Downloading blessings-1.6.tar.gz 11:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:55 INFO - Installing collected packages: blessings 11:03:55 INFO - Running setup.py install for blessings 11:03:56 INFO - Successfully installed blessings 11:03:56 INFO - Cleaning up... 11:03:56 INFO - Return code: 0 11:03:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:56 INFO - Reading from file tmpfile_stdout 11:03:56 INFO - Current package versions: 11:03:56 INFO - argparse == 1.2.1 11:03:56 INFO - blessings == 1.6 11:03:56 INFO - blobuploader == 1.2.4 11:03:56 INFO - docopt == 0.6.1 11:03:56 INFO - functools32 == 3.2.3-2 11:03:56 INFO - jsonschema == 2.5.1 11:03:56 INFO - manifestparser == 1.1 11:03:56 INFO - mozInstall == 1.13 11:03:56 INFO - mozcrash == 1.0 11:03:56 INFO - mozdebug == 0.1 11:03:56 INFO - mozdevice == 0.51 11:03:56 INFO - mozfile == 1.2 11:03:56 INFO - mozhttpd == 0.7 11:03:56 INFO - mozinfo == 0.10 11:03:56 INFO - mozleak == 0.1 11:03:56 INFO - mozlog == 3.5 11:03:56 INFO - moznetwork == 0.27 11:03:56 INFO - mozprocess == 0.25 11:03:56 INFO - mozprofile == 0.28 11:03:56 INFO - mozrunner == 6.13 11:03:56 INFO - mozscreenshot == 0.1 11:03:56 INFO - mozsystemmonitor == 0.3 11:03:56 INFO - moztest == 0.8 11:03:56 INFO - mozversion == 1.4 11:03:56 INFO - psutil == 3.1.1 11:03:56 INFO - requests == 1.2.3 11:03:56 INFO - wsgiref == 0.1.2 11:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:56 INFO - Using env: {'DISPLAY': ':0', 11:03:56 INFO - 'HOME': '/home/cltbld', 11:03:56 INFO - 'LANG': 'en_US.UTF-8', 11:03:56 INFO - 'LANGUAGE': 'en_US:en', 11:03:56 INFO - 'LOGNAME': 'cltbld', 11:03:56 INFO - 'MAIL': '/var/mail/cltbld', 11:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:56 INFO - 'MOZ_NO_REMOTE': '1', 11:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:56 INFO - 'NO_EM_RESTART': '1', 11:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:56 INFO - 'PWD': '/builds/slave/test', 11:03:56 INFO - 'SHELL': '/bin/bash', 11:03:56 INFO - 'SHLVL': '1', 11:03:56 INFO - 'TERM': 'linux', 11:03:56 INFO - 'TMOUT': '86400', 11:03:56 INFO - 'USER': 'cltbld', 11:03:56 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:56 INFO - '_': '/tools/buildbot/bin/python'} 11:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:03:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:03:57 INFO - Installing collected packages: simplejson 11:03:57 INFO - Running setup.py install for simplejson 11:03:57 INFO - building 'simplejson._speedups' extension 11:03:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:03:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:03:58 INFO - Successfully installed simplejson 11:03:58 INFO - Cleaning up... 11:03:58 INFO - Return code: 0 11:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1895a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:03:58 INFO - Using env: {'DISPLAY': ':0', 11:03:58 INFO - 'HOME': '/home/cltbld', 11:03:58 INFO - 'LANG': 'en_US.UTF-8', 11:03:58 INFO - 'LANGUAGE': 'en_US:en', 11:03:58 INFO - 'LOGNAME': 'cltbld', 11:03:58 INFO - 'MAIL': '/var/mail/cltbld', 11:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:58 INFO - 'MOZ_NO_REMOTE': '1', 11:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:58 INFO - 'NO_EM_RESTART': '1', 11:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:58 INFO - 'PWD': '/builds/slave/test', 11:03:58 INFO - 'SHELL': '/bin/bash', 11:03:58 INFO - 'SHLVL': '1', 11:03:58 INFO - 'TERM': 'linux', 11:03:58 INFO - 'TMOUT': '86400', 11:03:58 INFO - 'USER': 'cltbld', 11:03:58 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:58 INFO - '_': '/tools/buildbot/bin/python'} 11:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:03:59 INFO - Cleaning up... 11:03:59 INFO - Return code: 0 11:03:59 INFO - Running post-action listener: _resource_record_post_action 11:03:59 INFO - Running post-action listener: _start_resource_monitoring 11:03:59 INFO - Starting resource monitoring. 11:03:59 INFO - [mozharness: 2017-10-07 18:03:59.093443Z] Finished create-virtualenv step (success) 11:03:59 INFO - [mozharness: 2017-10-07 18:03:59.094334Z] Running install step. 11:03:59 INFO - Running pre-action listener: _resource_record_pre_action 11:03:59 INFO - Running main action method: install 11:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:59 INFO - Reading from file tmpfile_stdout 11:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:59 INFO - Reading from file tmpfile_stdout 11:03:59 INFO - Output received: 11:03:59 INFO - Usage: mozinstall [options] installer 11:03:59 INFO - Options: 11:03:59 INFO - -h, --help show this help message and exit 11:03:59 INFO - -d DEST, --destination=DEST 11:03:59 INFO - Directory to install application into. [default: 11:03:59 INFO - "/builds/slave/test"] 11:03:59 INFO - --app=APP Application being installed. [default: firefox] 11:03:59 INFO - mkdir: /builds/slave/test/build/application 11:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:14 INFO - Reading from file tmpfile_stdout 11:04:14 INFO - Output received: 11:04:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:14 INFO - Running post-action listener: _resource_record_post_action 11:04:14 INFO - [mozharness: 2017-10-07 18:04:14.031103Z] Finished install step (success) 11:04:14 INFO - [mozharness: 2017-10-07 18:04:14.031353Z] Running setup-mitmproxy step. 11:04:14 INFO - Running pre-action listener: _resource_record_pre_action 11:04:14 INFO - Running main action method: setup_mitmproxy 11:04:14 INFO - Skipping: mitmproxy is not required 11:04:14 INFO - Running post-action listener: _resource_record_post_action 11:04:14 INFO - [mozharness: 2017-10-07 18:04:14.032469Z] Finished setup-mitmproxy step (success) 11:04:14 INFO - [mozharness: 2017-10-07 18:04:14.032688Z] Running run-tests step. 11:04:14 INFO - Running pre-action listener: _resource_record_pre_action 11:04:14 INFO - Running pre-action listener: _set_gcov_prefix 11:04:14 INFO - Running main action method: run_tests 11:04:14 WARNING - Try message not found. 11:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:14 INFO - Python 2.7.3 11:04:14 INFO - Return code: 0 11:04:14 INFO - grabbing minidump binary from tooltool 11:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1899d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1893f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:04:14 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:04:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:04:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:14 INFO - Return code: 0 11:04:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:14 INFO - ENV: RUST_BACKTRACE is now full 11:04:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:04:14 INFO - Using env: {'DISPLAY': ':0', 11:04:14 INFO - 'HOME': '/home/cltbld', 11:04:14 INFO - 'LANG': 'en_US.UTF-8', 11:04:14 INFO - 'LANGUAGE': 'en_US:en', 11:04:14 INFO - 'LOGNAME': 'cltbld', 11:04:14 INFO - 'MAIL': '/var/mail/cltbld', 11:04:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:14 INFO - 'MOZ_NO_REMOTE': '1', 11:04:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:14 INFO - 'NO_EM_RESTART': '1', 11:04:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:14 INFO - 'PWD': '/builds/slave/test', 11:04:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:14 INFO - 'RUST_BACKTRACE': 'full', 11:04:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:14 INFO - 'SHELL': '/bin/bash', 11:04:14 INFO - 'SHLVL': '1', 11:04:14 INFO - 'TERM': 'linux', 11:04:14 INFO - 'TMOUT': '86400', 11:04:14 INFO - 'USER': 'cltbld', 11:04:14 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:14 INFO - '_': '/tools/buildbot/bin/python'} 11:04:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:04:14 INFO - mozversion application_buildid: 20171007164214 11:04:14 INFO - mozversion application_changeset: 21e3f04ae989fd57b7a4acfa948e8587784dcf4b 11:04:14 INFO - mozversion application_display_name: Firefox 11:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:14 INFO - mozversion application_name: Firefox 11:04:14 INFO - mozversion application_remotingname: firefox 11:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:04:14 INFO - mozversion application_vendor: Mozilla 11:04:14 INFO - mozversion application_version: 57.0 11:04:14 INFO - mozversion platform_buildid: 20171007164214 11:04:14 INFO - mozversion platform_changeset: 21e3f04ae989fd57b7a4acfa948e8587784dcf4b 11:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:04:14 INFO - mozversion platform_version: 57.0 11:04:14 INFO - using testdate: 1507399454 11:04:14 INFO - actual date: 1507399454 11:04:14 INFO - starting webserver on 'localhost:48502' 11:04:14 INFO - SUITE-START | Running 2 tests 11:04:14 INFO - TEST-START | dromaeo_css 11:04:14 INFO - Initialising browser for dromaeo_css test... 11:04:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48502/getInfo.html -profile /tmp/tmpfJ82xQ/profile 11:04:14 INFO - TEST-INFO | started process 3611 (/builds/slave/test/build/application/firefox/firefox http://localhost:48502/getInfo.html) 11:04:21 INFO - TEST-INFO | 3611: exit 0 11:04:21 INFO - Browser initialized. 11:04:21 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:21 INFO - Using env: {'DISPLAY': ':0', 11:04:21 INFO - 'HOME': '/home/cltbld', 11:04:21 INFO - 'JSGC_DISABLE_POISONING': '1', 11:04:21 INFO - 'LANG': 'en_US.UTF-8', 11:04:21 INFO - 'LANGUAGE': 'en_US:en', 11:04:21 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:04:21 INFO - 'LOGNAME': 'cltbld', 11:04:21 INFO - 'MAIL': '/var/mail/cltbld', 11:04:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:21 INFO - 'MOZ_CRASHREPORTER': '1', 11:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:21 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:04:21 INFO - 'MOZ_NO_REMOTE': '1', 11:04:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:21 INFO - 'NO_EM_RESTART': '1', 11:04:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:21 INFO - 'PWD': '/builds/slave/test', 11:04:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:21 INFO - 'RUST_BACKTRACE': 'full', 11:04:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:21 INFO - 'SHELL': '/bin/bash', 11:04:21 INFO - 'SHLVL': '1', 11:04:21 INFO - 'TERM': 'linux', 11:04:21 INFO - 'TMOUT': '86400', 11:04:21 INFO - 'USER': 'cltbld', 11:04:21 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:21 INFO - '_': '/tools/buildbot/bin/python'} 11:04:21 INFO - TEST-INFO | started process 3849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfJ82xQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:22 INFO - PID 3849 | 11:04:22 INFO - PID 3849 | (/builds/slave/test/build/application/firefox/firefox:3898): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:22 INFO - PID 3849 | 11:04:32 INFO - PID 3849 | RSS: Main: 141611008 11:04:32 INFO - PID 3849 | 11:07:30 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48502/tests/dromaeo/cssquery-ext.html) 11:07:31 INFO - PID 3849 | RSS: Main: 145084416 11:07:31 INFO - PID 3849 | 11:10:32 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-ext.html (next: http://localhost:48502/tests/dromaeo/cssquery-jquery.html) 11:10:33 INFO - PID 3849 | RSS: Main: 143302656 11:10:33 INFO - PID 3849 | 11:13:34 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48502/tests/dromaeo/cssquery-mootools.html) 11:13:35 INFO - PID 3849 | RSS: Main: 144973824 11:13:35 INFO - PID 3849 | 11:16:36 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48502/tests/dromaeo/cssquery-prototype.html) 11:16:37 INFO - PID 3849 | RSS: Main: 142446592 11:16:37 INFO - PID 3849 | 11:19:40 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48502/tests/dromaeo/cssquery-yui.html) 11:19:40 INFO - PID 3849 | RSS: Main: 145821696 11:19:40 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-yui.html (next: http://localhost:48502/tests/dromaeo/cssquery-dojo.html) 11:22:42 INFO - PID 3849 | RSS: Main: 148049920 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | __start_tp_report 11:22:42 INFO - PID 3849 | _x_x_mozilla_page_load 11:22:42 INFO - PID 3849 | _x_x_mozilla_page_load_details 11:22:42 INFO - PID 3849 | |i|pagename|runs| 11:22:42 INFO - PID 3849 | |0;dojo.html;4024.1549274652325;4033.8991525211886;4055.391691246313;4060.756354618723;4085.203385339858;6453.741850325987;6531.869362612745;6603.174603174603;6622.8675426491445;6638.568493047948;6478.708458119384;6548.27968923418;6567.8358041049;6599.076129341896;6625.204975402947;5848.883022339551;5938.673372964486;5951.166836642852;5969.0449528075405;5973.701314934257;5849.210356601868;5854.238948936653;5974.581779275452;5994.730237139339;6068.514518838482;5853.09277062056;5871.823845284648;5888.263967004124;5891.057430811071;5901.822945311647;5822;5838.854028649275;5877.5591830612875;5893.3222679391565;5896.262967129109;5918.822435326947;5926.674032928187;5963.403659634046;5996.1005849122985;6031.517478601745;6359.20509936258;6367.235931688181;6471.9029214561815;6544.280129185786;6655.600663960178;7042;7086.362227399559;7127.92872071283;7128.215896251409;7145.571265724073;7079.646017699094;7255.600941948191;7259.201487836333;7266.055412796355;7277.927220727778;6518.1200537927725;6555.6066636002;6627.73489060437;6632.568883022636;6638.6680665966505;7193.280671932869;7204.13550373948;7217.927820721726;7243.637818109179;7325.2308507607;6958.547694399847;6961.23426423093;6973.4072603829245;6975.093237879043;6996.8950465743055;7045;7086.326798954091;7222.602756848424;7244.311790379906;7251.56490610565;7052.753153639598;7062.964685176541;7070;7151.034610327643;7167.964160179165;6987.336203060701;7042.154941407064;7088.397486213729;7097.396721278646;7123.928760712431;5269.209618557247;5271.235670827785;5290.656107353087;5292.338457692788;5306.09796334624;4729.07782982322;4786.2581299898575;4812.51874812516;4813.3983252093485;4835.032993401333;6564.212294524687;6584.934150658528;6632.436242919406;6662.333766623396;6706.53054286205;6963.268856770068;7065.43476521877;7070.186928503185;7148.35664790161;7157.391621712109;6722.865542689119;6727.899081513781;6734.629595372204;6764.627945463047;6793.218779840382;5938.673372964528;5975.671338076448;5984.820455386345;6014.428629280212;6036;7270.818229544304;7336;7386.897453359599;7468.663910124057;7490.850182996419;7091.574505529685;7110.57336559808;7141.178764442156;7179.425645948416;7180.856382872209;7333.413326933725;7432.368248698921;7525.8118547036765;7537.8115547111765;7541.6229188539255;7060.6469676517;7144.821379465555;7156.749513766993;7175.856482870209;7190.892136618059;6962.965185174042;7041.43668506508;7053.929460705327;7057.400120989773;7085.291470852873;6893.517453778188;6930.930690693029;6949.861002780017;6970.163580370388;7003.6848341823725;6761.459083273425;6827.419669328163;6842.110525631835;6872.759453419107;6912.93087069143;6828.931710682829;6838.247792742694;6907.412869906114;6912.654367281515;6914.170299564084;6987.790366289019;7004.194517630334;7074.504784665024;7084.46866485026;7090.3618674317495;6531.608103513804;6612.338766123349;6703.396694297537;6760.1549806274215;6824.931750682628 11:22:42 INFO - PID 3849 | |1;ext.html;941.9481928493932;986.4180133721107;998.4857798233909;1045.4093437207982;1048.0619845238512;46223.53776462234;47441;47511.28733069002;47556.2866557001;47640.285395719;45372.54627453724;45921.85195370109;46246;46274.537254627445;46328.76835615817;7993.880091798627;8126.349892008655;8150.836983260331;8163.4285600008025;8198.38512111591;7866.488678235896;7869.409794265424;7923.683052677886;7929.207079292082;7959.801004974864;8151.8777218341775;8991.730248092568;9045.412048216846;9056.320775941798;9056.909430905705;8876.911230887674;8917.643294268253;8925.24135448491;8980.685676001309;9003.954980225122;8600.053994060649;8633.525156116411;8641.43830651012;8686.174813392718;8692.826143477158;42797.57202427998;43144.78427607842;43290.13419731588;43400.565994340286;43422.78288608537;3798.734088613798;3802.9429558556644;3813.427985802124;3831.67430768385;3857.267119247362;35350.29299414023;35815.10462238439;35849.46225806589;35888.64111358879;35917.82041089804;5673.943260567424;5687.74405151765;5707.77168913243;5720;5827.679477628729;223497;226631;233226;234605.99999999828;237250;54476;54873.725631371584;54915;55061.449385506436;55095.89808203813;57799;57838.71080644654;57914.7104264476;57972.42027579754;58162;17659.29362825498;17846.107694615217;18005.36981205678;18046.63906721858;18267;15086.849131508763;15101.773473397909;15107.244637768288;15112;15122.697546049238;15379.846201538065;15499.147546884804;15501.922490387477;15516.301766420313;15535.766963495556;6110.236220472441;6176.3514830943;6256.903937181004;6263.3736626337;6279.591826531261;1133.695278263868;1134.2740645986576;1147.397616251458;1161.9825702614467;1171.976560468786;26905.327366815596;26975.730242697715;26994;27018.459630807665;27248.59127113095;1246.8628450870397;1253.2668388992358;1255.5731051442372;1259.9370031498572;1279.8912092472244;14105.647358816112;14220.288985550682;14282.785758213635;14296.428142874169;14436.350364233635;286575;288483.2303353921;291253;293213;294481;54726.17910731342;55123.72438137783;55277.447225528034;55455.72272138613;55843.72078139583;1546.8530489603695;1581.667849751565;1598.0970751525351;1607.3731244814533;1619.902805831654;26049.869750651127;26376.736232638195;26495.867520662272;26537.86731066332;26685.199444015932;43193.3520997179;43195;43231.567684322756;43298.567014329456;43416.78291608522;242016;244285;244948;245405;245436;37948.81025594854;39469.40795888007;40062.39906401348;40401.39397909093;40529.189416210924;52724.472755271956;52942;53100.73449632727;53189;53239.733801330745;38131.618683812805;38286.42570361391;38390.424143638425;38411.2317753649;38507;38035.619643803206;38045.619543804205;38244.61755382411;38355.23289534138;38771.41842872416;43355.78322108369;45042.77478612586;45050;45137.097258054;45863;36379.818100909324;36403.27193456063;36764.44853327149;37024.44463333106;37236.627633723314;26664.20007399781;27739;27747.306317342227;27873.860630696716;28262 11:22:42 INFO - PID 3849 | |2;jquery.html;636.7077550228088;650.4225769782039;652.9387211544197;655.6853508715027;661.9772451562336;23681.881590592046;24275.63586546203;24286;24341.513169736594;24364.512709745795;26724;27039.053633122843;27039.594406083874;27062;27107.86446067772;6445.677716114199;6653.800385988404;6875.724971001154;6876.621785801779;6881.621510816903;6729.663516824164;6831.487638427113;6836.897446538306;6856.794296171123;6858.588484690909;6664.966675166617;6786.592804431725;6888.104546408985;6891.793246202622;6905.343992320722;6934.583924964493;6981.301869813029;6990.825229369256;6993.965030174867;7010.193827709828;6501.544891857572;6516.837079073014;6525.119108920282;6525.412712855818;6554.311797261266;29951.400971980656;30139.397212055854;30528.8473557633;30877.691223087706;30925;2347.5657003454417;2381;2382.285314405671;2382.785549300554;2383.4637206628545;20333.8983305084;21092.89453552738;21127;21260.36218913435;21273.255436059662;2540.1490500682294;2581.7934565234923;2657.8803953822126;2679.303381120903;2679.852608106573;141199;145235;163094.1845290778;173992;174445;15979.680406391806;16753.497395077924;16836.410725624788;17036.31854725822;17042.829571704126;26652.333691657477;26832.463350732876;26929.326766830985;26976.32559186036;27089.729102709116;10571.735706607396;10701.197410194267;10885.129189664807;10916.07213386855;10928.289661171999;9670.129688328085;9719;9805.411675299505;9821.852672209923;9822.312438129406;9681.806363872684;10139.746506337253;10217;10228.846567301496;10390.48047597617;2765.4330862173206;2822.731840475152;2842.616246806696;2870.665295403955;2905.753010994089;1069.2996087562658;1082.1937656445998;1089.1776708584969;1094.3871431998107;1100.5652767156928;22010.44973875666;22011.669824952318;22039.11843526273;22062.153529314743;22385.552288954128;1107.7950579142885;1153.6020073074776;1155.637096050489;1160.1530882455854;1164.7321116143335;11747.706307342214;11842.940785296018;11919.642410727693;11980.880191197977;12130.939345303394;651249;654561;671652;678602;692385;131465;134106;134297.32851335875;140585;143004;1261.6593519749615;1291.1542939374538;1298.6363818130937;1306.0922658752265;1307.5881097454271;19013.14440850193;19016.52458688544;19039.333623323117;19148.521286967938;19200.231990720215;62242.377576223655;62263.68868155812;62627.6868615654;63010;64252.35747642464;76474.23525764671;76622.23377766152;76628.23371766433;77982.61008694921;80729.19270807452;15745.842541574895;15903.045817251003;16013.67972640564;16059;16208.675826483168;24418.51162976766;24570.50858982846;24633.753662463147;24651.876740616182;24893;20186.39440816778;20323.390298291073;20437;20566.79433205649;20737.170513179906;17614.471565853044;17989.280428783226;18218.544536386165;18405.447836564923;18686.71969920425;19966;20348.796512035282;20457.590848183252;20734.688979665618;20994;15703.842961570239;15753;15896.205189740236;15921.044737315799;15937.12345820991;19612.411627651192;19728.70406943868;19772.802271977096;19926.202951882344;19966.30117945865 11:22:42 INFO - PID 3849 | |3;mootools.html;1421.1402101728454;1448.0587618048273;1465.648244421339;1469.5738235911585;1479.1494890437998;17405.477835664933;18104.094795260233;18122.5469363266;18162.18270177842;18220.81779182208;17631.206595703192;17701.55746106348;17722.291108355683;17900.910495447537;17909.552261193476;2925.9999999999945;3024.7882648214636;3068.171593669708;3072.6620071792086;3074.6617872034058;3025.3344264261827;3060.5715199872034;3071.3703690743346;3077.261457250266;3079.7844150909445;3053.7709671774705;3066.8006579572257;3072.9231769205835;3086.0124760076783;3086.3055812442135;2896.203544025389;2911.825290482567;2912.170031541011;2913.490139225627;2923.4007028559095;2869.253993961564;2872.784541159421;2887.3359127400818;2890.2629829393372;2892.898748543812;17148.314067437288;17266.050367229796;17392.21735021927;17515.386961456414;17518.21168047441;8801.867971980426;9221.17009469151;9225.492597907112;9229.815403691955;9230.169284764337;6176.289726681444;6247.562670613059;6249.937500624981;6332.936670633281;6344;2078.646630072876;2083.1875568528285;2105.494681276498;2158.6330323844827;2181.5527816797517;28647.14058578246;29674.406511869856;31615.20961975946;32081.358372832412;32276.51585226247;8066.798330041796;8186.345092392594;8278.254957053894;8401.243888050105;8418.705345313007;23755.1685691;23778.762212377656;23806.404839879142;23828.404289892544;23853.642195367083;9296.814063718688;9382.390144640576;9389.530523473799;9420.293477989178;9423.905760942303;8175.468594541336;8366.330693544502;8419.242268195769;8467.068622451525;8488.787780305418;6456.869233153048;6514.05546195799;6571.34286571339;6573.57271777333;6667.599944003376;1980.4751740788702;2004.128204231135;2008.7890771468785;2012.3761633893248;2053.4558342039372;1009.8788145422596;1019.9490025498695;1022.2741853284251;1040.5785656809005;1043.1289872956015;8936.151065648883;8954.328425368123;9026.548672566345;9043.77390565228;9191.816163676689;788.968441262343;804.9154838741965;817.3787921179946;827.9917200828035;838.5974732128612;5312;5340.519353258148;5396.379416367089;5437.374701909252;5464.644798088111;25930.611040834403;26010;26066.86966565193;26175.73824261771;26309.736902630728;25469;25886.870565647052;26414.6037809433;26422.339441514116;26562.203133905627;11183.496742646601;12985.610431687064;13198.340082995812;13370.799438008438;13374.598762037154;10169.389836609827;10206.285560011025;10488.10851077667;10586;10888.346699198073;22018.339449816533;22558.436039099153;23042.654360184944;23046.654300185844;23138.768612313663;22729.545409092058;23065.19271825478;23133.65299520475;23249.18627848017;23375.76624233736;16137.919310403373;16236.51290461288;16243.269052892412;16273.837261627707;16288.592785180464;15830.129342886252;16375.017498950101;16376.344946202018;16454.670906581563;16528;12311.876881231074;12463;12466.937665311616;12857.678558036125;12996.545120920722;12660.17708848922;12699.873001269869;12771.169873958162;12781.744365112832;12849.421776019915;11501.079913607058;11657.125715571536;11675.532978681098;11690.532378704756;11701.707457313636;8751.781205469913;8846.380753347461;8876.86684699743;8901.287896968097;9086.45481271126;8806.91193088061;8827.558622069;8879.822403551763;8973.641054357753;8981.326400519856 11:22:42 INFO - PID 3849 | |4;prototype.html;566.0914232656584;581.1718301420475;593.0777640768603;611.2481647573485;621.1769405537664;6308.653024083679;6374.713137908793;6405.167328247333;6415.903761443582;6421.711023003964;6315.652639104847;6342.904856427157;6350.587211831228;6380.649064301461;6387.041943708446;5238.214267859814;5255.369355677305;5260.5002524760275;5279.1817268323475;5282.630215884889;5211.296474975868;5239.10935141025;5242.2136679498;5245.501677340666;5265.709901074242;4962.851114466572;5072.112380333445;5072.644914855961;5075.299774575522;5097.286379906816;5003.724795136284;5028.094942910275;5050.6212034097225;5055;5081.568066714333;4607.9308810367875;4608.101420223058;4629.097326021427;4636.814527418899;4649;6213.502919766408;6222.5644204905675;6238.1266622672865;6287.49700023997;6299.496040316763;5980.55145864062;5998.940010599882;6014.578979471439;6020.939790602126;6023.668698221596;6581.30896255891;6644.468442524587;6683.030960510748;6792.117024786746;6797.796066118024;4943.604511639096;5114.641975061747;5129.871753206163;5130.614264367087;5132.974335128338;6947.270536593635;6970.686319115652;7082.893756593655;7126.643667816588;7144.285571442814;5250.766069973553;5266.815661451831;5270.127780359713;5287.867803304948;5347.625666203328;5425.484578964992;5428.371488553418;5434.157705555645;5434.157705555645;5438.755256013489;5992.910106348409;6006.909896351471;6039.396060393926;6040.7885724000325;6051.909221361683;6843.8973415398805;6847.383735463832;6880.827979300558;6890.758823441256;6899.379055884994;1858;1867.5797945462161;1870.064967516242;1870.579119698057;1876.221368132237;1298.5260379961246;1339.9146691180176;1342.6039318401095;1348.1439286053426;1351.986480135186;6270.49836013127;6410.583312084699;6437.774677886251;6455.677216139175;6467.482601391877;6707.1616047994;6773.424258937947;6831.555948863308;6843.8973415398805;6857.55425897315;6386.509261388062;6393.9360606394275;6399.55203135776;6461.515386346043;6464;3650.361186792301;3662.230931504414;3680.5399325084363;3699.853045555886;3701.555813302421;7283.817904552428;7315.451341149435;7316.195218525958;7326.3040011198855;7337.19290878003;7086.433085353263;7162.316855538944;7164.92835071653;7183.568985860865;7185.137783466018;7181.210066892638;7196.280371962866;7261.5280006799385;7297.635118244067;7327.853442931111;6900.860733172733;6965.199002114619;6971.407430368476;7008.7546935857;7022.157341119098;6769.1876974763345;6789.762358317435;6826.897596536155;6834.453243740588;6848.514223183823;7132.928670713434;7218.458615603746;7254.347108760237;7276.96361518189;7290.198078211499;5342.545883599938;5351.331083614548;5359.651622644516;5359.678419294854;5378.354597448331;6654.367835055662;6879.346462086094;6934.895976560457;6937.779910428614;7024.719011239493;6612.867742645217;6693.661267746567;6699.899501507579;6734.6632668367365;6775.898361524482;6696.531242812956;6702.329767023259;6716;6721.395074443128;6796.898046529405;6649.135612370361;6651.634160121046;6682.866342673022;6691.966540167268;6719.092922455406;6808.421284190899;6821.556598821061;6836.589804611739;6875.5874647521305;6876;6323.956547169665;6485.1465355243545;6534.575252608565;6571.244306904576;6635.668216589248 11:22:42 INFO - PID 3849 | |5;yui.html;1046.9581216751328;1052.8631277933866;1054.5360041581698;1067.0449947297163;1075.5321435175697;21218;21461.67807482885;21890.1243950242;21915.561688766236;22349.888250558724;21230.25694100707;21584.89207553964;21651.67522487164;21701.240456584022;21713.457163570918;1107.3189988157285;1114.6767437443132;1119.0208567503435;1119.882412346704;1121.904638105762;1091.143452389874;1137.527925910746;1140.6920131564473;1141.4463984967285;1142.1319796954292;1190.97618047639;1194.6595220362199;1198.7302856857182;1198.994005029978;1199.1545960098154;1178.263585259213;1184.2657552317532;1184.7689700508404;1186.7329850783592;1192.9642110736693;869.6608322754131;871.8997315308757;877.0177401310509;877.2499512916428;879.4020066354876;18879.528011799677;19176.904115479472;19556.413307600797;19617.901910490356;20260;23370.532589348288;23553.17563885273;23696.28911132669;23772.643410348857;23810.40473988147;18934.24263029477;19214.423567293004;19253.22987080515;19354.419367419;19357.51606209842;4178.979105104486;4253.553376895412;4254.574542545752;4254.574542545752;4255.404243405926;162447;169825;169889.45165822646;170311;173461.132694337;17869.910650446665;18210.36263730763;18233.270669173085;18308.816911830712;18374.265029398943;36528.26943461116;37488.625113748516;37522;37593.248135037145;37649.81175094107;9160.587773550205;9301.581428835718;9321.72034838956;9326.114019168168;9422;4948.752562371867;5008.874778130576;5033.6476446648385;5061.063703214917;5069.138246498104;6734.3602357775935;6806.4554835613035;6830.521863469509;6864.828379290558;6869.175698916162;1148.0930065248526;1155.4742592120565;1162.581470670558;1172.202902026613;1178.4461303187488;769.5305863423307;784.4861615641764;799.3165843203977;800.1718221640574;802.5385403393072;13636.454541818217;13885.37515811791;14437.927810360881;14820.110793352433;14963.70072598542;765.7587859824138;768.4582369429539;769.4575324396287;777.249953794591;783.8314762326128;6428;6509.674516274167;6520.15238019064;6578.934210657928;6585.6377899216;158452;159436.20281898748;159952;160090;166944.16527917283;138555;138607;140166.29916850553;140573;143850;123738;124971;125246;125375;127088.36455817662;11926.701832454259;12153.574624888086;12172.45223964906;12199.085068619712;12414.937925310316;56777.71611141918;56802.715986421455;57029.71485142548;58138.12792808027;58809.70595146997;73092.26907730855;73256.63371683107;74258;76175.23824761681;76206;15848.60378490547;15941.840581594035;16361.590960226089;16460.83539164593;16541.172941352645;19427.4171774847;19770.308039219133;19827.107780150218;19863.60272794565;19876.90061549683;17924.55188620243;18447.26210951547;18479.168437420078;18513.722294165327;18601;17536.298548057934;18007.279708812024;18051.368202112862;18223.726644100083;18228.635427291116;18692.906535467235;18743.156557955197;18937.242510299984;19080.618387632447;19137.52156196106;12282.570110046105;12448.190867593577;12471.93764031174;12537.749245015231;12956.546520871725;14171.787423188454;14179.64550886236;14182.14907105577;14207.246803394612;14245.928770356082 11:22:42 INFO - PID 3849 | __end_tp_report 11:22:42 INFO - PID 3849 | __start_cc_report 11:22:42 INFO - PID 3849 | _x_x_mozilla_cycle_collect,272 11:22:42 INFO - PID 3849 | __end_cc_report 11:22:42 INFO - PID 3849 | __startTimestamp1507400562599__endTimestamp 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | ------- Summary: start ------- 11:22:42 INFO - PID 3849 | Number of tests: 6 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#0] dojo.html Cycles:165 Average:6571.86 Median:6828.93 stddev:764.10 (11.2%) stddev-sans-first:739.85 11:22:42 INFO - PID 3849 | Values: 4024.2 4033.9 4055.4 4060.8 4085.2 6453.7 6531.9 6603.2 6622.9 6638.6 6478.7 6548.3 6567.8 6599.1 6625.2 5848.9 5938.7 5951.2 5969.0 5973.7 5849.2 5854.2 5974.6 5994.7 6068.5 5853.1 5871.8 5888.3 5891.1 5901.8 5822.0 5838.9 5877.6 5893.3 5896.3 5918.8 5926.7 5963.4 5996.1 6031.5 6359.2 6367.2 6471.9 6544.3 6655.6 7042.0 7086.4 7127.9 7128.2 7145.6 7079.6 7255.6 7259.2 7266.1 7277.9 6518.1 6555.6 6627.7 6632.6 6638.7 7193.3 7204.1 7217.9 7243.6 7325.2 6958.5 6961.2 6973.4 6975.1 6996.9 7045.0 7086.3 7222.6 7244.3 7251.6 7052.8 7063.0 7070.0 7151.0 7168.0 6987.3 7042.2 7088.4 7097.4 7123.9 5269.2 5271.2 5290.7 5292.3 5306.1 4729.1 4786.3 4812.5 4813.4 4835.0 6564.2 6584.9 6632.4 6662.3 6706.5 6963.3 7065.4 7070.2 7148.4 7157.4 6722.9 6727.9 6734.6 6764.6 6793.2 5938.7 5975.7 5984.8 6014.4 6036.0 7270.8 7336.0 7386.9 7468.7 7490.9 7091.6 7110.6 7141.2 7179.4 7180.9 7333.4 7432.4 7525.8 7537.8 7541.6 7060.6 7144.8 7156.7 7175.9 7190.9 6963.0 7041.4 7053.9 7057.4 7085.3 6893.5 6930.9 6949.9 6970.2 7003.7 6761.5 6827.4 6842.1 6872.8 6912.9 6828.9 6838.2 6907.4 6912.7 6914.2 6987.8 7004.2 7074.5 7084.5 7090.4 6531.6 6612.3 6703.4 6760.2 6824.9 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#1] ext.html Cycles:180 Average:44669.92 Median:21182.13 stddev:66647.99 (314.6%) stddev-sans-first:66754.07 11:22:42 INFO - PID 3849 | Values: 941.9 986.4 998.5 1045.4 1048.1 46223.5 47441.0 47511.3 47556.3 47640.3 45372.5 45921.9 46246.0 46274.5 46328.8 7993.9 8126.3 8150.8 8163.4 8198.4 7866.5 7869.4 7923.7 7929.2 7959.8 8151.9 8991.7 9045.4 9056.3 9056.9 8876.9 8917.6 8925.2 8980.7 9004.0 8600.1 8633.5 8641.4 8686.2 8692.8 42797.6 43144.8 43290.1 43400.6 43422.8 3798.7 3802.9 3813.4 3831.7 3857.3 35350.3 35815.1 35849.5 35888.6 35917.8 5673.9 5687.7 5707.8 5720.0 5827.7 223497.0 226631.0 233226.0 234606.0 237250.0 54476.0 54873.7 54915.0 55061.4 55095.9 57799.0 57838.7 57914.7 57972.4 58162.0 17659.3 17846.1 18005.4 18046.6 18267.0 15086.8 15101.8 15107.2 15112.0 15122.7 15379.8 15499.1 15501.9 15516.3 15535.8 6110.2 6176.4 6256.9 6263.4 6279.6 1133.7 1134.3 1147.4 1162.0 1172.0 26905.3 26975.7 26994.0 27018.5 27248.6 1246.9 1253.3 1255.6 1259.9 1279.9 14105.6 14220.3 14282.8 14296.4 14436.4 286575.0 288483.2 291253.0 293213.0 294481.0 54726.2 55123.7 55277.4 55455.7 55843.7 1546.9 1581.7 1598.1 1607.4 1619.9 26049.9 26376.7 26495.9 26537.9 26685.2 43193.4 43195.0 43231.6 43298.6 43416.8 242016.0 244285.0 244948.0 245405.0 245436.0 37948.8 39469.4 40062.4 40401.4 40529.2 52724.5 52942.0 53100.7 53189.0 53239.7 38131.6 38286.4 38390.4 38411.2 38507.0 38035.6 38045.6 38244.6 38355.2 38771.4 43355.8 45042.8 45050.0 45137.1 45863.0 36379.8 36403.3 36764.4 37024.4 37236.6 26664.2 27739.0 27747.3 27873.9 28262.0 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#2] jquery.html Cycles:180 Average:42166.31 Median:13031.44 stddev:111741.07 (857.5%) stddev-sans-first:112011.02 11:22:42 INFO - PID 3849 | Values: 636.7 650.4 652.9 655.7 662.0 23681.9 24275.6 24286.0 24341.5 24364.5 26724.0 27039.1 27039.6 27062.0 27107.9 6445.7 6653.8 6875.7 6876.6 6881.6 6729.7 6831.5 6836.9 6856.8 6858.6 6665.0 6786.6 6888.1 6891.8 6905.3 6934.6 6981.3 6990.8 6994.0 7010.2 6501.5 6516.8 6525.1 6525.4 6554.3 29951.4 30139.4 30528.8 30877.7 30925.0 2347.6 2381.0 2382.3 2382.8 2383.5 20333.9 21092.9 21127.0 21260.4 21273.3 2540.1 2581.8 2657.9 2679.3 2679.9 141199.0 145235.0 163094.2 173992.0 174445.0 15979.7 16753.5 16836.4 17036.3 17042.8 26652.3 26832.5 26929.3 26976.3 27089.7 10571.7 10701.2 10885.1 10916.1 10928.3 9670.1 9719.0 9805.4 9821.9 9822.3 9681.8 10139.7 10217.0 10228.8 10390.5 2765.4 2822.7 2842.6 2870.7 2905.8 1069.3 1082.2 1089.2 1094.4 1100.6 22010.4 22011.7 22039.1 22062.2 22385.6 1107.8 1153.6 1155.6 1160.2 1164.7 11747.7 11842.9 11919.6 11980.9 12130.9 651249.0 654561.0 671652.0 678602.0 692385.0 131465.0 134106.0 134297.3 140585.0 143004.0 1261.7 1291.2 1298.6 1306.1 1307.6 19013.1 19016.5 19039.3 19148.5 19200.2 62242.4 62263.7 62627.7 63010.0 64252.4 76474.2 76622.2 76628.2 77982.6 80729.2 15745.8 15903.0 16013.7 16059.0 16208.7 24418.5 24570.5 24633.8 24651.9 24893.0 20186.4 20323.4 20437.0 20566.8 20737.2 17614.5 17989.3 18218.5 18405.4 18686.7 19966.0 20348.8 20457.6 20734.7 20994.0 15703.8 15753.0 15896.2 15921.0 15937.1 19612.4 19728.7 19772.8 19926.2 19966.3 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#3] mootools.html Cycles:180 Average:11149.80 Median:26242.74 stddev:8163.28 (31.1%) stddev-sans-first:8153.45 11:22:42 INFO - PID 3849 | Values: 1421.1 1448.1 1465.6 1469.6 1479.1 17405.5 18104.1 18122.5 18162.2 18220.8 17631.2 17701.6 17722.3 17900.9 17909.6 2926.0 3024.8 3068.2 3072.7 3074.7 3025.3 3060.6 3071.4 3077.3 3079.8 3053.8 3066.8 3072.9 3086.0 3086.3 2896.2 2911.8 2912.2 2913.5 2923.4 2869.3 2872.8 2887.3 2890.3 2892.9 17148.3 17266.1 17392.2 17515.4 17518.2 8801.9 9221.2 9225.5 9229.8 9230.2 6176.3 6247.6 6249.9 6332.9 6344.0 2078.6 2083.2 2105.5 2158.6 2181.6 28647.1 29674.4 31615.2 32081.4 32276.5 8066.8 8186.3 8278.3 8401.2 8418.7 23755.2 23778.8 23806.4 23828.4 23853.6 9296.8 9382.4 9389.5 9420.3 9423.9 8175.5 8366.3 8419.2 8467.1 8488.8 6456.9 6514.1 6571.3 6573.6 6667.6 1980.5 2004.1 2008.8 2012.4 2053.5 1009.9 1019.9 1022.3 1040.6 1043.1 8936.2 8954.3 9026.5 9043.8 9191.8 789.0 804.9 817.4 828.0 838.6 5312.0 5340.5 5396.4 5437.4 5464.6 25930.6 26010.0 26066.9 26175.7 26309.7 25469.0 25886.9 26414.6 26422.3 26562.2 11183.5 12985.6 13198.3 13370.8 13374.6 10169.4 10206.3 10488.1 10586.0 10888.3 22018.3 22558.4 23042.7 23046.7 23138.8 22729.5 23065.2 23133.7 23249.2 23375.8 16137.9 16236.5 16243.3 16273.8 16288.6 15830.1 16375.0 16376.3 16454.7 16528.0 12311.9 12463.0 12466.9 12857.7 12996.5 12660.2 12699.9 12771.2 12781.7 12849.4 11501.1 11657.1 11675.5 11690.5 11701.7 8751.8 8846.4 8876.9 8901.3 9086.5 8806.9 8827.6 8879.8 8973.6 8981.3 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#4] prototype.html Cycles:180 Average:5784.87 Median:6396.74 stddev:1615.50 (25.3%) stddev-sans-first:1571.83 11:22:42 INFO - PID 3849 | Values: 566.1 581.2 593.1 611.2 621.2 6308.7 6374.7 6405.2 6415.9 6421.7 6315.7 6342.9 6350.6 6380.6 6387.0 5238.2 5255.4 5260.5 5279.2 5282.6 5211.3 5239.1 5242.2 5245.5 5265.7 4962.9 5072.1 5072.6 5075.3 5097.3 5003.7 5028.1 5050.6 5055.0 5081.6 4607.9 4608.1 4629.1 4636.8 4649.0 6213.5 6222.6 6238.1 6287.5 6299.5 5980.6 5998.9 6014.6 6020.9 6023.7 6581.3 6644.5 6683.0 6792.1 6797.8 4943.6 5114.6 5129.9 5130.6 5133.0 6947.3 6970.7 7082.9 7126.6 7144.3 5250.8 5266.8 5270.1 5287.9 5347.6 5425.5 5428.4 5434.2 5434.2 5438.8 5992.9 6006.9 6039.4 6040.8 6051.9 6843.9 6847.4 6880.8 6890.8 6899.4 1858.0 1867.6 1870.1 1870.6 1876.2 1298.5 1339.9 1342.6 1348.1 1352.0 6270.5 6410.6 6437.8 6455.7 6467.5 6707.2 6773.4 6831.6 6843.9 6857.6 6386.5 6393.9 6399.6 6461.5 6464.0 3650.4 3662.2 3680.5 3699.9 3701.6 7283.8 7315.5 7316.2 7326.3 7337.2 7086.4 7162.3 7164.9 7183.6 7185.1 7181.2 7196.3 7261.5 7297.6 7327.9 6900.9 6965.2 6971.4 7008.8 7022.2 6769.2 6789.8 6826.9 6834.5 6848.5 7132.9 7218.5 7254.3 7277.0 7290.2 5342.5 5351.3 5359.7 5359.7 5378.4 6654.4 6879.3 6934.9 6937.8 7024.7 6612.9 6693.7 6699.9 6734.7 6775.9 6696.5 6702.3 6716.0 6721.4 6796.9 6649.1 6651.6 6682.9 6692.0 6719.1 6808.4 6821.6 6836.6 6875.6 6876.0 6324.0 6485.1 6534.6 6571.2 6635.7 11:22:42 INFO - PID 3849 | 11:22:42 INFO - PID 3849 | [#5] yui.html Cycles:180 Average:29859.32 Median:18718.03 stddev:45257.89 (241.8%) stddev-sans-first:45333.14 11:22:42 INFO - PID 3849 | Values: 1047.0 1052.9 1054.5 1067.0 1075.5 21218.0 21461.7 21890.1 21915.6 22349.9 21230.3 21584.9 21651.7 21701.2 21713.5 1107.3 1114.7 1119.0 1119.9 1121.9 1091.1 1137.5 1140.7 1141.4 1142.1 1191.0 1194.7 1198.7 1199.0 1199.2 1178.3 1184.3 1184.8 1186.7 1193.0 869.7 871.9 877.0 877.2 879.4 18879.5 19176.9 19556.4 19617.9 20260.0 23370.5 23553.2 23696.3 23772.6 23810.4 18934.2 19214.4 19253.2 19354.4 19357.5 4179.0 4253.6 4254.6 4254.6 4255.4 162447.0 169825.0 169889.5 170311.0 173461.1 17869.9 18210.4 18233.3 18308.8 18374.3 36528.3 37488.6 37522.0 37593.2 37649.8 9160.6 9301.6 9321.7 9326.1 9422.0 4948.8 5008.9 5033.6 5061.1 5069.1 6734.4 6806.5 6830.5 6864.8 6869.2 1148.1 1155.5 1162.6 1172.2 1178.4 769.5 784.5 799.3 800.2 802.5 13636.5 13885.4 14437.9 14820.1 14963.7 765.8 768.5 769.5 777.2 783.8 6428.0 6509.7 6520.2 6578.9 6585.6 158452.0 159436.2 159952.0 160090.0 166944.2 138555.0 138607.0 140166.3 140573.0 143850.0 123738.0 124971.0 125246.0 125375.0 127088.4 11926.7 12153.6 12172.5 12199.1 12414.9 56777.7 56802.7 57029.7 58138.1 58809.7 73092.3 73256.6 74258.0 76175.2 76206.0 15848.6 15941.8 16361.6 16460.8 16541.2 19427.4 19770.3 19827.1 19863.6 19876.9 17924.6 18447.3 18479.2 18513.7 18601.0 17536.3 18007.3 18051.4 18223.7 18228.6 18692.9 18743.2 18937.2 19080.6 19137.5 12282.6 12448.2 12471.9 12537.7 12956.5 14171.8 14179.6 14182.1 14207.2 14245.9 11:22:42 INFO - PID 3849 | -------- Summary: end -------- 11:22:42 INFO - PID 3849 | 11:22:43 INFO - TEST-INFO | 3849: exit 0 11:22:43 INFO - TEST-OK | dromaeo_css | took 1108851ms 11:22:43 INFO - TEST-START | kraken 11:22:43 INFO - Initialising browser for kraken test... 11:22:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48502/getInfo.html -profile /tmp/tmpTIrwnm/profile 11:22:43 INFO - TEST-INFO | started process 4238 (/builds/slave/test/build/application/firefox/firefox http://localhost:48502/getInfo.html) 11:22:47 INFO - TEST-INFO | 4238: exit 0 11:22:48 INFO - Browser initialized. 11:22:48 INFO - Running cycle 1/1 for kraken test... 11:22:48 INFO - Using env: {'DISPLAY': ':0', 11:22:48 INFO - 'HOME': '/home/cltbld', 11:22:48 INFO - 'JSGC_DISABLE_POISONING': '1', 11:22:48 INFO - 'LANG': 'en_US.UTF-8', 11:22:48 INFO - 'LANGUAGE': 'en_US:en', 11:22:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:22:48 INFO - 'LOGNAME': 'cltbld', 11:22:48 INFO - 'MAIL': '/var/mail/cltbld', 11:22:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:48 INFO - 'MOZ_CRASHREPORTER': '1', 11:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:22:48 INFO - 'MOZ_NO_REMOTE': '1', 11:22:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:48 INFO - 'NO_EM_RESTART': '1', 11:22:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:48 INFO - 'PWD': '/builds/slave/test', 11:22:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:48 INFO - 'RUST_BACKTRACE': 'full', 11:22:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:48 INFO - 'SHELL': '/bin/bash', 11:22:48 INFO - 'SHLVL': '1', 11:22:48 INFO - 'TERM': 'linux', 11:22:48 INFO - 'TMOUT': '86400', 11:22:48 INFO - 'USER': 'cltbld', 11:22:48 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004', 11:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:48 INFO - '_': '/tools/buildbot/bin/python'} 11:22:48 INFO - TEST-INFO | started process 4474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIrwnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:48 INFO - PID 4474 | 11:22:48 INFO - PID 4474 | (/builds/slave/test/build/application/firefox/firefox:4523): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:48 INFO - PID 4474 | 11:22:59 INFO - PID 4474 | RSS: Main: 143630336 11:22:59 INFO - PID 4474 | 11:23:01 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:02 INFO - PID 4474 | RSS: Main: 150515712 11:23:02 INFO - PID 4474 | 11:23:05 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-dft) 11:23:05 INFO - PID 4474 | RSS: Main: 151134208 11:23:05 INFO - PID 4474 | 11:23:08 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-fft) 11:23:09 INFO - PID 4474 | RSS: Main: 152903680 11:23:09 INFO - PID 4474 | 11:23:11 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-oscillator) 11:23:11 INFO - PID 4474 | RSS: Main: 152698880 11:23:11 INFO - PID 4474 | 11:23:13 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:14 INFO - PID 4474 | RSS: Main: 153104384 11:23:14 INFO - PID 4474 | 11:23:17 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:18 INFO - PID 4474 | RSS: Main: 152248320 11:23:18 INFO - PID 4474 | 11:23:21 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:22 INFO - PID 4474 | RSS: Main: 152166400 11:23:22 INFO - PID 4474 | 11:23:25 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48502/tests/kraken/driver.html?testName=json-parse-financial) 11:23:25 INFO - PID 4474 | RSS: Main: 153784320 11:23:25 INFO - PID 4474 | 11:23:27 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:27 INFO - PID 4474 | RSS: Main: 154071040 11:23:27 INFO - PID 4474 | 11:23:29 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:29 INFO - PID 4474 | RSS: Main: 154415104 11:23:29 INFO - PID 4474 | 11:23:31 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:32 INFO - PID 4474 | RSS: Main: 150835200 11:23:32 INFO - PID 4474 | 11:23:35 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:35 INFO - PID 4474 | RSS: Main: 150839296 11:23:35 INFO - PID 4474 | 11:23:38 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:38 INFO - PID 4474 | RSS: Main: 151048192 11:23:38 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48502/tests/kraken/driver.html?testName=ai-astar) 11:23:40 INFO - PID 4474 | RSS: Main: 152502272 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | __start_tp_report 11:23:40 INFO - PID 4474 | _x_x_mozilla_page_load 11:23:40 INFO - PID 4474 | _x_x_mozilla_page_load_details 11:23:40 INFO - PID 4474 | |i|pagename|runs| 11:23:40 INFO - PID 4474 | |0;ai-astar;107;105;104;105;109;107;108;105;106;107 11:23:40 INFO - PID 4474 | |1;audio-beat-detection;117;113;111;110;111;110;111;110;138;123 11:23:40 INFO - PID 4474 | |2;audio-dft;163;164;163;160;161;162;162;162;161;161 11:23:40 INFO - PID 4474 | |3;audio-fft;72;73;72;73;72;73;74;73;73;81 11:23:40 INFO - PID 4474 | |4;audio-oscillator;78;77;77;76;78;77;78;77;78;77 11:23:40 INFO - PID 4474 | |5;imaging-gaussian-blur;110;114;110;114;113;114;117;114;110;115 11:23:40 INFO - PID 4474 | |6;imaging-darkroom;148;148;148;153;148;148;149;148;149;148 11:23:40 INFO - PID 4474 | |7;imaging-desaturate;94;96;95;94;94;95;94;94;94;94 11:23:40 INFO - PID 4474 | |8;json-parse-financial;43;44;48;44;45;44;43;44;43;48 11:23:40 INFO - PID 4474 | |9;json-stringify-tinderbox;36;36;37;36;36;36;36;36;36;36 11:23:40 INFO - PID 4474 | |10;stanford-crypto-aes;72;73;69;70;70;68;68;77;69;72 11:23:40 INFO - PID 4474 | |11;stanford-crypto-ccm;106;103;110;100;102;106;105;112;101;108 11:23:40 INFO - PID 4474 | |12;stanford-crypto-pbkdf2;153;153;146;146;149;146;149;151;152;152 11:23:40 INFO - PID 4474 | |13;stanford-crypto-sha256-iterative;56;55;58;56;57;59;57;62;60;57 11:23:40 INFO - PID 4474 | __end_tp_report 11:23:40 INFO - PID 4474 | __start_cc_report 11:23:40 INFO - PID 4474 | _x_x_mozilla_cycle_collect,674 11:23:40 INFO - PID 4474 | __end_cc_report 11:23:40 INFO - PID 4474 | __startTimestamp1507400620740__endTimestamp 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | ------- Summary: start ------- 11:23:40 INFO - PID 4474 | Number of tests: 14 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.00 stddev:1.57 (1.5%) stddev-sans-first:1.64 11:23:40 INFO - PID 4474 | Values: 107.0 105.0 104.0 105.0 109.0 107.0 108.0 105.0 106.0 107.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:112.00 stddev:8.96 (8.0%) stddev-sans-first:9.48 11:23:40 INFO - PID 4474 | Values: 117.0 113.0 111.0 110.0 111.0 110.0 111.0 110.0 138.0 123.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 11:23:40 INFO - PID 4474 | Values: 163.0 164.0 163.0 160.0 161.0 162.0 162.0 162.0 161.0 161.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.00 stddev:2.67 (3.7%) stddev-sans-first:2.77 11:23:40 INFO - PID 4474 | Values: 72.0 73.0 72.0 73.0 72.0 73.0 74.0 73.0 73.0 81.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:0.67 (0.9%) stddev-sans-first:0.67 11:23:40 INFO - PID 4474 | Values: 78.0 77.0 77.0 76.0 78.0 77.0 78.0 77.0 78.0 77.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:2.38 (2.1%) stddev-sans-first:2.24 11:23:40 INFO - PID 4474 | Values: 110.0 114.0 110.0 114.0 113.0 114.0 117.0 114.0 110.0 115.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:1.57 (1.1%) stddev-sans-first:1.64 11:23:40 INFO - PID 4474 | Values: 148.0 148.0 148.0 153.0 148.0 148.0 149.0 148.0 149.0 148.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:23:40 INFO - PID 4474 | Values: 94.0 96.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:44.00 stddev:1.90 (4.3%) stddev-sans-first:1.92 11:23:40 INFO - PID 4474 | Values: 43.0 44.0 48.0 44.0 45.0 44.0 43.0 44.0 43.0 48.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#9] json-stringify-tinderbox Cycles:10 Average:36.10 Median:36.00 stddev:0.32 (0.9%) stddev-sans-first:0.33 11:23:40 INFO - PID 4474 | Values: 36.0 36.0 37.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:71.00 stddev:2.78 (3.9%) stddev-sans-first:2.92 11:23:40 INFO - PID 4474 | Values: 72.0 73.0 69.0 70.0 70.0 68.0 68.0 77.0 69.0 72.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#11] stanford-crypto-ccm Cycles:10 Average:105.30 Median:106.00 stddev:3.92 (3.7%) stddev-sans-first:4.15 11:23:40 INFO - PID 4474 | Values: 106.0 103.0 110.0 100.0 102.0 106.0 105.0 112.0 101.0 108.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.50 stddev:2.91 (1.9%) stddev-sans-first:2.83 11:23:40 INFO - PID 4474 | Values: 153.0 153.0 146.0 146.0 149.0 146.0 149.0 151.0 152.0 152.0 11:23:40 INFO - PID 4474 | 11:23:40 INFO - PID 4474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:57.70 Median:57.50 stddev:2.11 (3.7%) stddev-sans-first:2.15 11:23:40 INFO - PID 4474 | Values: 56.0 55.0 58.0 56.0 57.0 59.0 57.0 62.0 60.0 57.0 11:23:40 INFO - PID 4474 | -------- Summary: end -------- 11:23:40 INFO - PID 4474 | 11:23:41 INFO - PID 4474 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:41 INFO - TEST-INFO | 4474: exit 0 11:23:41 INFO - TEST-OK | kraken | took 58104ms 11:23:41 INFO - SUITE-END | took 1166s 11:23:41 INFO - Completed test suite (00:19:26) 11:23:41 INFO - javascript benchmark 11:23:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9472.247073497503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4024.1549274652325, 4033.8991525211886, 4055.391691246313, 4060.756354618723, 4085.203385339858, 6453.741850325987, 6531.869362612745, 6603.174603174603, 6622.8675426491445, 6638.568493047948, 6478.708458119384, 6548.27968923418, 6567.8358041049, 6599.076129341896, 6625.204975402947, 5848.883022339551, 5938.673372964486, 5951.166836642852, 5969.0449528075405, 5973.701314934257, 5849.210356601868, 5854.238948936653, 5974.581779275452, 5994.730237139339, 6068.514518838482, 5853.09277062056, 5871.823845284648, 5888.263967004124, 5891.057430811071, 5901.822945311647, 5822.0, 5838.854028649275, 5877.5591830612875, 5893.3222679391565, 5896.262967129109, 5918.822435326947, 5926.674032928187, 5963.403659634046, 5996.1005849122985, 6031.517478601745, 6359.20509936258, 6367.235931688181, 6471.9029214561815, 6544.280129185786, 6655.600663960178, 7042.0, 7086.362227399559, 7127.92872071283, 7128.215896251409, 7145.571265724073, 7079.646017699094, 7255.600941948191, 7259.201487836333, 7266.055412796355, 7277.927220727778, 6518.1200537927725, 6555.6066636002, 6627.73489060437, 6632.568883022636, 6638.6680665966505, 7193.280671932869, 7204.13550373948, 7217.927820721726, 7243.637818109179, 7325.2308507607, 6958.547694399847, 6961.23426423093, 6973.4072603829245, 6975.093237879043, 6996.8950465743055, 7045.0, 7086.326798954091, 7222.602756848424, 7244.311790379906, 7251.56490610565, 7052.753153639598, 7062.964685176541, 7070.0, 7151.034610327643, 7167.964160179165, 6987.336203060701, 7042.154941407064, 7088.397486213729, 7097.396721278646, 7123.928760712431, 5269.209618557247, 5271.235670827785, 5290.656107353087, 5292.338457692788, 5306.09796334624, 4729.07782982322, 4786.2581299898575, 4812.51874812516, 4813.3983252093485, 4835.032993401333, 6564.212294524687, 6584.934150658528, 6632.436242919406, 6662.333766623396, 6706.53054286205, 6963.268856770068, 7065.43476521877, 7070.186928503185, 7148.35664790161, 7157.391621712109, 6722.865542689119, 6727.899081513781, 6734.629595372204, 6764.627945463047, 6793.218779840382, 5938.673372964528, 5975.671338076448, 5984.820455386345, 6014.428629280212, 6036.0, 7270.818229544304, 7336.0, 7386.897453359599, 7468.663910124057, 7490.850182996419, 7091.574505529685, 7110.57336559808, 7141.178764442156, 7179.425645948416, 7180.856382872209, 7333.413326933725, 7432.368248698921, 7525.8118547036765, 7537.8115547111765, 7541.6229188539255, 7060.6469676517, 7144.821379465555, 7156.749513766993, 7175.856482870209, 7190.892136618059, 6962.965185174042, 7041.43668506508, 7053.929460705327, 7057.400120989773, 7085.291470852873, 6893.517453778188, 6930.930690693029, 6949.861002780017, 6970.163580370388, 7003.6848341823725, 6761.459083273425, 6827.419669328163, 6842.110525631835, 6872.759453419107, 6912.93087069143, 6828.931710682829, 6838.247792742694, 6907.412869906114, 6912.654367281515, 6914.170299564084, 6987.790366289019, 7004.194517630334, 7074.504784665024, 7084.46866485026, 7090.3618674317495, 6531.608103513804, 6612.338766123349, 6703.396694297537, 6760.1549806274215, 6824.931750682628], "value": 6520.939818790701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.9481928493932, 986.4180133721107, 998.4857798233909, 1045.4093437207982, 1048.0619845238512, 46223.53776462234, 47441.0, 47511.28733069002, 47556.2866557001, 47640.285395719, 45372.54627453724, 45921.85195370109, 46246.0, 46274.537254627445, 46328.76835615817, 7993.880091798627, 8126.349892008655, 8150.836983260331, 8163.4285600008025, 8198.38512111591, 7866.488678235896, 7869.409794265424, 7923.683052677886, 7929.207079292082, 7959.801004974864, 8151.8777218341775, 8991.730248092568, 9045.412048216846, 9056.320775941798, 9056.909430905705, 8876.911230887674, 8917.643294268253, 8925.24135448491, 8980.685676001309, 9003.954980225122, 8600.053994060649, 8633.525156116411, 8641.43830651012, 8686.174813392718, 8692.826143477158, 42797.57202427998, 43144.78427607842, 43290.13419731588, 43400.565994340286, 43422.78288608537, 3798.734088613798, 3802.9429558556644, 3813.427985802124, 3831.67430768385, 3857.267119247362, 35350.29299414023, 35815.10462238439, 35849.46225806589, 35888.64111358879, 35917.82041089804, 5673.943260567424, 5687.74405151765, 5707.77168913243, 5720.0, 5827.679477628729, 223497.0, 226631.0, 233226.0, 234605.99999999828, 237250.0, 54476.0, 54873.725631371584, 54915.0, 55061.449385506436, 55095.89808203813, 57799.0, 57838.71080644654, 57914.7104264476, 57972.42027579754, 58162.0, 17659.29362825498, 17846.107694615217, 18005.36981205678, 18046.63906721858, 18267.0, 15086.849131508763, 15101.773473397909, 15107.244637768288, 15112.0, 15122.697546049238, 15379.846201538065, 15499.147546884804, 15501.922490387477, 15516.301766420313, 15535.766963495556, 6110.236220472441, 6176.3514830943, 6256.903937181004, 6263.3736626337, 6279.591826531261, 1133.695278263868, 1134.2740645986576, 1147.397616251458, 1161.9825702614467, 1171.976560468786, 26905.327366815596, 26975.730242697715, 26994.0, 27018.459630807665, 27248.59127113095, 1246.8628450870397, 1253.2668388992358, 1255.5731051442372, 1259.9370031498572, 1279.8912092472244, 14105.647358816112, 14220.288985550682, 14282.785758213635, 14296.428142874169, 14436.350364233635, 286575.0, 288483.2303353921, 291253.0, 293213.0, 294481.0, 54726.17910731342, 55123.72438137783, 55277.447225528034, 55455.72272138613, 55843.72078139583, 1546.8530489603695, 1581.667849751565, 1598.0970751525351, 1607.3731244814533, 1619.902805831654, 26049.869750651127, 26376.736232638195, 26495.867520662272, 26537.86731066332, 26685.199444015932, 43193.3520997179, 43195.0, 43231.567684322756, 43298.567014329456, 43416.78291608522, 242016.0, 244285.0, 244948.0, 245405.0, 245436.0, 37948.81025594854, 39469.40795888007, 40062.39906401348, 40401.39397909093, 40529.189416210924, 52724.472755271956, 52942.0, 53100.73449632727, 53189.0, 53239.733801330745, 38131.618683812805, 38286.42570361391, 38390.424143638425, 38411.2317753649, 38507.0, 38035.619643803206, 38045.619543804205, 38244.61755382411, 38355.23289534138, 38771.41842872416, 43355.78322108369, 45042.77478612586, 45050.0, 45137.097258054, 45863.0, 36379.818100909324, 36403.27193456063, 36764.44853327149, 37024.44463333106, 37236.627633723314, 26664.20007399781, 27739.0, 27747.306317342227, 27873.860630696716, 28262.0], "value": 19632.796362780184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.7077550228088, 650.4225769782039, 652.9387211544197, 655.6853508715027, 661.9772451562336, 23681.881590592046, 24275.63586546203, 24286.0, 24341.513169736594, 24364.512709745795, 26724.0, 27039.053633122843, 27039.594406083874, 27062.0, 27107.86446067772, 6445.677716114199, 6653.800385988404, 6875.724971001154, 6876.621785801779, 6881.621510816903, 6729.663516824164, 6831.487638427113, 6836.897446538306, 6856.794296171123, 6858.588484690909, 6664.966675166617, 6786.592804431725, 6888.104546408985, 6891.793246202622, 6905.343992320722, 6934.583924964493, 6981.301869813029, 6990.825229369256, 6993.965030174867, 7010.193827709828, 6501.544891857572, 6516.837079073014, 6525.119108920282, 6525.412712855818, 6554.311797261266, 29951.400971980656, 30139.397212055854, 30528.8473557633, 30877.691223087706, 30925.0, 2347.5657003454417, 2381.0, 2382.285314405671, 2382.785549300554, 2383.4637206628545, 20333.8983305084, 21092.89453552738, 21127.0, 21260.36218913435, 21273.255436059662, 2540.1490500682294, 2581.7934565234923, 2657.8803953822126, 2679.303381120903, 2679.852608106573, 141199.0, 145235.0, 163094.1845290778, 173992.0, 174445.0, 15979.680406391806, 16753.497395077924, 16836.410725624788, 17036.31854725822, 17042.829571704126, 26652.333691657477, 26832.463350732876, 26929.326766830985, 26976.32559186036, 27089.729102709116, 10571.735706607396, 10701.197410194267, 10885.129189664807, 10916.07213386855, 10928.289661171999, 9670.129688328085, 9719.0, 9805.411675299505, 9821.852672209923, 9822.312438129406, 9681.806363872684, 10139.746506337253, 10217.0, 10228.846567301496, 10390.48047597617, 2765.4330862173206, 2822.731840475152, 2842.616246806696, 2870.665295403955, 2905.753010994089, 1069.2996087562658, 1082.1937656445998, 1089.1776708584969, 1094.3871431998107, 1100.5652767156928, 22010.44973875666, 22011.669824952318, 22039.11843526273, 22062.153529314743, 22385.552288954128, 1107.7950579142885, 1153.6020073074776, 1155.637096050489, 1160.1530882455854, 1164.7321116143335, 11747.706307342214, 11842.940785296018, 11919.642410727693, 11980.880191197977, 12130.939345303394, 651249.0, 654561.0, 671652.0, 678602.0, 692385.0, 131465.0, 134106.0, 134297.32851335875, 140585.0, 143004.0, 1261.6593519749615, 1291.1542939374538, 1298.6363818130937, 1306.0922658752265, 1307.5881097454271, 19013.14440850193, 19016.52458688544, 19039.333623323117, 19148.521286967938, 19200.231990720215, 62242.377576223655, 62263.68868155812, 62627.6868615654, 63010.0, 64252.35747642464, 76474.23525764671, 76622.23377766152, 76628.23371766433, 77982.61008694921, 80729.19270807452, 15745.842541574895, 15903.045817251003, 16013.67972640564, 16059.0, 16208.675826483168, 24418.51162976766, 24570.50858982846, 24633.753662463147, 24651.876740616182, 24893.0, 20186.39440816778, 20323.390298291073, 20437.0, 20566.79433205649, 20737.170513179906, 17614.471565853044, 17989.280428783226, 18218.544536386165, 18405.447836564923, 18686.71969920425, 19966.0, 20348.796512035282, 20457.590848183252, 20734.688979665618, 20994.0, 15703.842961570239, 15753.0, 15896.205189740236, 15921.044737315799, 15937.12345820991, 19612.411627651192, 19728.70406943868, 19772.802271977096, 19926.202951882344, 19966.30117945865], "value": 13133.006414328316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.1402101728454, 1448.0587618048273, 1465.648244421339, 1469.5738235911585, 1479.1494890437998, 17405.477835664933, 18104.094795260233, 18122.5469363266, 18162.18270177842, 18220.81779182208, 17631.206595703192, 17701.55746106348, 17722.291108355683, 17900.910495447537, 17909.552261193476, 2925.9999999999945, 3024.7882648214636, 3068.171593669708, 3072.6620071792086, 3074.6617872034058, 3025.3344264261827, 3060.5715199872034, 3071.3703690743346, 3077.261457250266, 3079.7844150909445, 3053.7709671774705, 3066.8006579572257, 3072.9231769205835, 3086.0124760076783, 3086.3055812442135, 2896.203544025389, 2911.825290482567, 2912.170031541011, 2913.490139225627, 2923.4007028559095, 2869.253993961564, 2872.784541159421, 2887.3359127400818, 2890.2629829393372, 2892.898748543812, 17148.314067437288, 17266.050367229796, 17392.21735021927, 17515.386961456414, 17518.21168047441, 8801.867971980426, 9221.17009469151, 9225.492597907112, 9229.815403691955, 9230.169284764337, 6176.289726681444, 6247.562670613059, 6249.937500624981, 6332.936670633281, 6344.0, 2078.646630072876, 2083.1875568528285, 2105.494681276498, 2158.6330323844827, 2181.5527816797517, 28647.14058578246, 29674.406511869856, 31615.20961975946, 32081.358372832412, 32276.51585226247, 8066.798330041796, 8186.345092392594, 8278.254957053894, 8401.243888050105, 8418.705345313007, 23755.1685691, 23778.762212377656, 23806.404839879142, 23828.404289892544, 23853.642195367083, 9296.814063718688, 9382.390144640576, 9389.530523473799, 9420.293477989178, 9423.905760942303, 8175.468594541336, 8366.330693544502, 8419.242268195769, 8467.068622451525, 8488.787780305418, 6456.869233153048, 6514.05546195799, 6571.34286571339, 6573.57271777333, 6667.599944003376, 1980.4751740788702, 2004.128204231135, 2008.7890771468785, 2012.3761633893248, 2053.4558342039372, 1009.8788145422596, 1019.9490025498695, 1022.2741853284251, 1040.5785656809005, 1043.1289872956015, 8936.151065648883, 8954.328425368123, 9026.548672566345, 9043.77390565228, 9191.816163676689, 788.968441262343, 804.9154838741965, 817.3787921179946, 827.9917200828035, 838.5974732128612, 5312.0, 5340.519353258148, 5396.379416367089, 5437.374701909252, 5464.644798088111, 25930.611040834403, 26010.0, 26066.86966565193, 26175.73824261771, 26309.736902630728, 25469.0, 25886.870565647052, 26414.6037809433, 26422.339441514116, 26562.203133905627, 11183.496742646601, 12985.610431687064, 13198.340082995812, 13370.799438008438, 13374.598762037154, 10169.389836609827, 10206.285560011025, 10488.10851077667, 10586.0, 10888.346699198073, 22018.339449816533, 22558.436039099153, 23042.654360184944, 23046.654300185844, 23138.768612313663, 22729.545409092058, 23065.19271825478, 23133.65299520475, 23249.18627848017, 23375.76624233736, 16137.919310403373, 16236.51290461288, 16243.269052892412, 16273.837261627707, 16288.592785180464, 15830.129342886252, 16375.017498950101, 16376.344946202018, 16454.670906581563, 16528.0, 12311.876881231074, 12463.0, 12466.937665311616, 12857.678558036125, 12996.545120920722, 12660.17708848922, 12699.873001269869, 12771.169873958162, 12781.744365112832, 12849.421776019915, 11501.079913607058, 11657.125715571536, 11675.532978681098, 11690.532378704756, 11701.707457313636, 8751.781205469913, 8846.380753347461, 8876.86684699743, 8901.287896968097, 9086.45481271126, 8806.91193088061, 8827.558622069, 8879.822403551763, 8973.641054357753, 8981.326400519856], "value": 7772.838194312254, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0914232656584, 581.1718301420475, 593.0777640768603, 611.2481647573485, 621.1769405537664, 6308.653024083679, 6374.713137908793, 6405.167328247333, 6415.903761443582, 6421.711023003964, 6315.652639104847, 6342.904856427157, 6350.587211831228, 6380.649064301461, 6387.041943708446, 5238.214267859814, 5255.369355677305, 5260.5002524760275, 5279.1817268323475, 5282.630215884889, 5211.296474975868, 5239.10935141025, 5242.2136679498, 5245.501677340666, 5265.709901074242, 4962.851114466572, 5072.112380333445, 5072.644914855961, 5075.299774575522, 5097.286379906816, 5003.724795136284, 5028.094942910275, 5050.6212034097225, 5055.0, 5081.568066714333, 4607.9308810367875, 4608.101420223058, 4629.097326021427, 4636.814527418899, 4649.0, 6213.502919766408, 6222.5644204905675, 6238.1266622672865, 6287.49700023997, 6299.496040316763, 5980.55145864062, 5998.940010599882, 6014.578979471439, 6020.939790602126, 6023.668698221596, 6581.30896255891, 6644.468442524587, 6683.030960510748, 6792.117024786746, 6797.796066118024, 4943.604511639096, 5114.641975061747, 5129.871753206163, 5130.614264367087, 5132.974335128338, 6947.270536593635, 6970.686319115652, 7082.893756593655, 7126.643667816588, 7144.285571442814, 5250.766069973553, 5266.815661451831, 5270.127780359713, 5287.867803304948, 5347.625666203328, 5425.484578964992, 5428.371488553418, 5434.157705555645, 5434.157705555645, 5438.755256013489, 5992.910106348409, 6006.909896351471, 6039.396060393926, 6040.7885724000325, 6051.909221361683, 6843.8973415398805, 6847.383735463832, 6880.827979300558, 6890.758823441256, 6899.379055884994, 1858.0, 1867.5797945462161, 1870.064967516242, 1870.579119698057, 1876.221368132237, 1298.5260379961246, 1339.9146691180176, 1342.6039318401095, 1348.1439286053426, 1351.986480135186, 6270.49836013127, 6410.583312084699, 6437.774677886251, 6455.677216139175, 6467.482601391877, 6707.1616047994, 6773.424258937947, 6831.555948863308, 6843.8973415398805, 6857.55425897315, 6386.509261388062, 6393.9360606394275, 6399.55203135776, 6461.515386346043, 6464.0, 3650.361186792301, 3662.230931504414, 3680.5399325084363, 3699.853045555886, 3701.555813302421, 7283.817904552428, 7315.451341149435, 7316.195218525958, 7326.3040011198855, 7337.19290878003, 7086.433085353263, 7162.316855538944, 7164.92835071653, 7183.568985860865, 7185.137783466018, 7181.210066892638, 7196.280371962866, 7261.5280006799385, 7297.635118244067, 7327.853442931111, 6900.860733172733, 6965.199002114619, 6971.407430368476, 7008.7546935857, 7022.157341119098, 6769.1876974763345, 6789.762358317435, 6826.897596536155, 6834.453243740588, 6848.514223183823, 7132.928670713434, 7218.458615603746, 7254.347108760237, 7276.96361518189, 7290.198078211499, 5342.545883599938, 5351.331083614548, 5359.651622644516, 5359.678419294854, 5378.354597448331, 6654.367835055662, 6879.346462086094, 6934.895976560457, 6937.779910428614, 7024.719011239493, 6612.867742645217, 6693.661267746567, 6699.899501507579, 6734.6632668367365, 6775.898361524482, 6696.531242812956, 6702.329767023259, 6716.0, 6721.395074443128, 6796.898046529405, 6649.135612370361, 6651.634160121046, 6682.866342673022, 6691.966540167268, 6719.092922455406, 6808.421284190899, 6821.556598821061, 6836.589804611739, 6875.5874647521305, 6876.0, 6323.956547169665, 6485.1465355243545, 6534.575252608565, 6571.244306904576, 6635.668216589248], "value": 5324.958617549034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1046.9581216751328, 1052.8631277933866, 1054.5360041581698, 1067.0449947297163, 1075.5321435175697, 21218.0, 21461.67807482885, 21890.1243950242, 21915.561688766236, 22349.888250558724, 21230.25694100707, 21584.89207553964, 21651.67522487164, 21701.240456584022, 21713.457163570918, 1107.3189988157285, 1114.6767437443132, 1119.0208567503435, 1119.882412346704, 1121.904638105762, 1091.143452389874, 1137.527925910746, 1140.6920131564473, 1141.4463984967285, 1142.1319796954292, 1190.97618047639, 1194.6595220362199, 1198.7302856857182, 1198.994005029978, 1199.1545960098154, 1178.263585259213, 1184.2657552317532, 1184.7689700508404, 1186.7329850783592, 1192.9642110736693, 869.6608322754131, 871.8997315308757, 877.0177401310509, 877.2499512916428, 879.4020066354876, 18879.528011799677, 19176.904115479472, 19556.413307600797, 19617.901910490356, 20260.0, 23370.532589348288, 23553.17563885273, 23696.28911132669, 23772.643410348857, 23810.40473988147, 18934.24263029477, 19214.423567293004, 19253.22987080515, 19354.419367419, 19357.51606209842, 4178.979105104486, 4253.553376895412, 4254.574542545752, 4254.574542545752, 4255.404243405926, 162447.0, 169825.0, 169889.45165822646, 170311.0, 173461.132694337, 17869.910650446665, 18210.36263730763, 18233.270669173085, 18308.816911830712, 18374.265029398943, 36528.26943461116, 37488.625113748516, 37522.0, 37593.248135037145, 37649.81175094107, 9160.587773550205, 9301.581428835718, 9321.72034838956, 9326.114019168168, 9422.0, 4948.752562371867, 5008.874778130576, 5033.6476446648385, 5061.063703214917, 5069.138246498104, 6734.3602357775935, 6806.4554835613035, 6830.521863469509, 6864.828379290558, 6869.175698916162, 1148.0930065248526, 1155.4742592120565, 1162.581470670558, 1172.202902026613, 1178.4461303187488, 769.5305863423307, 784.4861615641764, 799.3165843203977, 800.1718221640574, 802.5385403393072, 13636.454541818217, 13885.37515811791, 14437.927810360881, 14820.110793352433, 14963.70072598542, 765.7587859824138, 768.4582369429539, 769.4575324396287, 777.249953794591, 783.8314762326128, 6428.0, 6509.674516274167, 6520.15238019064, 6578.934210657928, 6585.6377899216, 158452.0, 159436.20281898748, 159952.0, 160090.0, 166944.16527917283, 138555.0, 138607.0, 140166.29916850553, 140573.0, 143850.0, 123738.0, 124971.0, 125246.0, 125375.0, 127088.36455817662, 11926.701832454259, 12153.574624888086, 12172.45223964906, 12199.085068619712, 12414.937925310316, 56777.71611141918, 56802.715986421455, 57029.71485142548, 58138.12792808027, 58809.70595146997, 73092.26907730855, 73256.63371683107, 74258.0, 76175.23824761681, 76206.0, 15848.60378490547, 15941.840581594035, 16361.590960226089, 16460.83539164593, 16541.172941352645, 19427.4171774847, 19770.308039219133, 19827.107780150218, 19863.60272794565, 19876.90061549683, 17924.55188620243, 18447.26210951547, 18479.168437420078, 18513.722294165327, 18601.0, 17536.298548057934, 18007.279708812024, 18051.368202112862, 18223.726644100083, 18228.635427291116, 18692.906535467235, 18743.156557955197, 18937.242510299984, 19080.618387632447, 19137.52156196106, 12282.570110046105, 12448.190867593577, 12471.93764031174, 12537.749245015231, 12956.546520871725, 14171.787423188454, 14179.64550886236, 14182.14907105577, 14207.246803394612, 14245.928770356082], "value": 10378.623681738607, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1354.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 104.0, 105.0, 109.0, 107.0, 108.0, 105.0, 106.0, 107.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 138.0, 123.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 73.0, 74.0, 73.0, 73.0, 81.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 76.0, 78.0, 77.0, 78.0, 77.0, 78.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 110.0, 114.0, 113.0, 114.0, 117.0, 114.0, 110.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 153.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 48.0, 44.0, 45.0, 44.0, 43.0, 44.0, 43.0, 48.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0], "value": 36.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 69.0, 70.0, 70.0, 68.0, 68.0, 77.0, 69.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 103.0, 110.0, 100.0, 102.0, 106.0, 105.0, 112.0, 101.0, 108.0], "value": 105.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 146.0, 146.0, 149.0, 146.0, 149.0, 151.0, 152.0, 152.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 56.0, 57.0, 59.0, 57.0, 62.0, 60.0, 57.0], "value": 57.7, "unit": "score"}]}]} 11:23:41 INFO - Return code: 0 11:23:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:41 INFO - # TBPL SUCCESS # 11:23:41 INFO - Running post-action listener: _package_coverage_data 11:23:41 INFO - Running post-action listener: _resource_record_post_action 11:23:41 INFO - [mozharness: 2017-10-07 18:23:41.514163Z] Finished run-tests step (success) 11:23:41 INFO - Running post-run listener: _resource_record_post_run 11:23:41 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 9355264; Write bytes: 419782656; Read time: 3000; Write time: 347536 11:23:41 INFO - TinderboxPrint: CPU usage
13.1% 11:23:41 INFO - TinderboxPrint: I/O read bytes / time
9,355,264 / 3,000 11:23:41 INFO - TinderboxPrint: I/O write bytes / time
419,782,656 / 347,536 11:23:41 INFO - TinderboxPrint: CPU idle
8,191.2 (86.9%) 11:23:41 INFO - TinderboxPrint: CPU user
1,178.8 (12.5%) 11:23:41 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 3735552; Read time: 0; Write time: 216 11:23:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:41 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 9318400; Write bytes: 320618496; Read time: 2988; Write time: 278064 11:23:42 INFO - Running post-run listener: _upload_blobber_files 11:23:42 INFO - Blob upload gear active. 11:23:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:42 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:43 INFO - (blobuploader) - INFO - Done attempting. 11:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:50 INFO - (blobuploader) - INFO - Done attempting. 11:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:51 INFO - (blobuploader) - INFO - Done attempting. 11:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:52 INFO - (blobuploader) - INFO - Done attempting. 11:23:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:52 INFO - Return code: 0 11:23:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93be1e3fe51f4c514cbc89fad1c822527df3216547cfeb3c3138a39223e21ae979f673ebfca205d6f1aa4427903c1b4aa82633a9b1c3989dea1c74d7794ff2b7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1fb02925e9ab18579f5d4781a9b4076d7fe39cdaf0d7908ca24ce31db15c37631b078a5bd5693358cc1fd0176a5c78d451b592e330d0c7f24c90f1e83ffa84b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89aa7c38833f33834e80b246f8e7967bd76ebc6b658c14f2d269498fb73fc83b51720778b193a1ec803c3d4e76e7c9f311bab4b54c9915d70d8a442a9c376f41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad2eed0c460aca09d90ad2bf969e47c7b305715e3bcbcb0cec45d21d01ac80bb00158af874fac41772ffa9a19d50b9a2af45314f74cb09bd9425381932e5c51"} 11:23:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:52 INFO - Contents: 11:23:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93be1e3fe51f4c514cbc89fad1c822527df3216547cfeb3c3138a39223e21ae979f673ebfca205d6f1aa4427903c1b4aa82633a9b1c3989dea1c74d7794ff2b7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1fb02925e9ab18579f5d4781a9b4076d7fe39cdaf0d7908ca24ce31db15c37631b078a5bd5693358cc1fd0176a5c78d451b592e330d0c7f24c90f1e83ffa84b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89aa7c38833f33834e80b246f8e7967bd76ebc6b658c14f2d269498fb73fc83b51720778b193a1ec803c3d4e76e7c9f311bab4b54c9915d70d8a442a9c376f41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad2eed0c460aca09d90ad2bf969e47c7b305715e3bcbcb0cec45d21d01ac80bb00158af874fac41772ffa9a19d50b9a2af45314f74cb09bd9425381932e5c51"} 11:23:52 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:52 INFO - Copying logs to upload dir... 11:23:52 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.416097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-07 11:23:52.740568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-07 11:23:52.744007) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93be1e3fe51f4c514cbc89fad1c822527df3216547cfeb3c3138a39223e21ae979f673ebfca205d6f1aa4427903c1b4aa82633a9b1c3989dea1c74d7794ff2b7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1fb02925e9ab18579f5d4781a9b4076d7fe39cdaf0d7908ca24ce31db15c37631b078a5bd5693358cc1fd0176a5c78d451b592e330d0c7f24c90f1e83ffa84b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89aa7c38833f33834e80b246f8e7967bd76ebc6b658c14f2d269498fb73fc83b51720778b193a1ec803c3d4e76e7c9f311bab4b54c9915d70d8a442a9c376f41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad2eed0c460aca09d90ad2bf969e47c7b305715e3bcbcb0cec45d21d01ac80bb00158af874fac41772ffa9a19d50b9a2af45314f74cb09bd9425381932e5c51"} build_url:https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/aLxoNRtvSgyM1KmySCeTgQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93be1e3fe51f4c514cbc89fad1c822527df3216547cfeb3c3138a39223e21ae979f673ebfca205d6f1aa4427903c1b4aa82633a9b1c3989dea1c74d7794ff2b7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1fb02925e9ab18579f5d4781a9b4076d7fe39cdaf0d7908ca24ce31db15c37631b078a5bd5693358cc1fd0176a5c78d451b592e330d0c7f24c90f1e83ffa84b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/89aa7c38833f33834e80b246f8e7967bd76ebc6b658c14f2d269498fb73fc83b51720778b193a1ec803c3d4e76e7c9f311bab4b54c9915d70d8a442a9c376f41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad2eed0c460aca09d90ad2bf969e47c7b305715e3bcbcb0cec45d21d01ac80bb00158af874fac41772ffa9a19d50b9a2af45314f74cb09bd9425381932e5c51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-07 11:23:52.774791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:23:52.775139) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1507397809.601273-159506004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:23:52.860998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-07 11:23:52.861764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-07 11:23:52.862215) ========= ========= Total master_lag: 0.24 =========