builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1506961644.88 results: success (0) revision: 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:24.881734) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:24.882304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:24.882586) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:24.904293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:24.904738) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 09:27:25-- 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% 28.2M=0s 2017-10-02 09:27:25 (28.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:25.072170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:25.072597) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016637 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:25.122803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 09:27:25.123224) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 --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 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 --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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 09:27:25,572 truncating revision to first 12 chars 2017-10-02 09:27:25,572 Setting DEBUG logging. 2017-10-02 09:27:25,572 attempt 1/10 2017-10-02 09:27:25,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0b50c7250aa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 09:27:26,340 unpacking tar archive at: mozilla-beta-0b50c7250aa6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 09:27:26.215777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:26.216198) ========= script_repo_revision: 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:26.216654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:26.216937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 09:27:26.231868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-02 09:27:26.232322) ========= /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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:27:26 INFO - MultiFileLogger online at 20171002 09:27:26 in /builds/slave/test 09:27:26 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 09:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:27:26 INFO - {'append_to_log': False, 09:27:26 INFO - 'base_work_dir': '/builds/slave/test', 09:27:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:27:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:27:26 INFO - 'code_coverage': False, 09:27:26 INFO - 'config_files': ('talos/linux_config.py',), 09:27:26 INFO - 'default_actions': ('clobber', 09:27:26 INFO - 'read-buildbot-config', 09:27:26 INFO - 'download-and-extract', 09:27:26 INFO - 'populate-webroot', 09:27:26 INFO - 'create-virtualenv', 09:27:26 INFO - 'install', 09:27:26 INFO - 'setup-mitmproxy', 09:27:26 INFO - 'run-tests'), 09:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:27:26 INFO - 'disable_ccov_upload': False, 09:27:26 INFO - 'disable_stylo': False, 09:27:26 INFO - 'download_minidump_stackwalk': True, 09:27:26 INFO - 'download_symbols': 'ondemand', 09:27:26 INFO - 'enable_stylo': False, 09:27:26 INFO - 'enable_webrender': False, 09:27:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:27:26 INFO - 'gecko_profile': False, 09:27:26 INFO - 'gecko_profile_interval': 0, 09:27:26 INFO - 'installer_path': 'installer.exe', 09:27:26 INFO - 'log_level': 'info', 09:27:26 INFO - 'log_name': 'talos', 09:27:26 INFO - 'log_to_console': True, 09:27:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:27:26 INFO - 'opt_config_files': (), 09:27:26 INFO - 'pip_index': False, 09:27:26 INFO - 'suite': 'dromaeojs-e10s', 09:27:26 INFO - 'system_bits': '32', 09:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:27:26 INFO - 'title': 'talos-linux64-ix-011', 09:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:27:26 INFO - 'use_talos_json': True, 09:27:26 INFO - 'verify': 'False', 09:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:27:26 INFO - 'work_dir': 'build'} 09:27:26 INFO - [mozharness: 2017-10-02 16:27:26.816704Z] Running clobber step. 09:27:26 INFO - Running pre-action listener: _resource_record_pre_action 09:27:26 INFO - Running main action method: clobber 09:27:26 INFO - rmtree: /builds/slave/test/build 09:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:27:27 INFO - Running post-action listener: _resource_record_post_action 09:27:27 INFO - [mozharness: 2017-10-02 16:27:27.823717Z] Finished clobber step (success) 09:27:27 INFO - [mozharness: 2017-10-02 16:27:27.823815Z] Running read-buildbot-config step. 09:27:27 INFO - Running pre-action listener: _resource_record_pre_action 09:27:27 INFO - Running main action method: read_buildbot_config 09:27:27 INFO - Using buildbot properties: 09:27:27 INFO - { 09:27:27 INFO - "project": "", 09:27:27 INFO - "product": "firefox", 09:27:27 INFO - "who": "ryanvm@gmail.com", 09:27:27 INFO - "installer_path": "public/build/target.tar.bz2", 09:27:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:27:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:27:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:27:27 INFO - "stage_platform": "linux64", 09:27:27 INFO - "basedir": "/builds/slave/test", 09:27:27 INFO - "buildnumber": 147, 09:27:27 INFO - "platform": "ubuntu64_hw", 09:27:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:27:27 INFO - "slavebuilddir": "test", 09:27:27 INFO - "taskId": "DM0vdtWgS9SCvtHIl2h-9w", 09:27:27 INFO - "branch": "mozilla-beta", 09:27:27 INFO - "script_repo_revision": "production", 09:27:27 INFO - "revision": "0b50c7250aa635957c72a9e49eddc8b7cd65cdf6", 09:27:27 INFO - "slavename": "talos-linux64-ix-011", 09:27:27 INFO - "repo_path": "releases/mozilla-beta" 09:27:27 INFO - } 09:27:27 INFO - Finding installer, test and symbols from parent task. 09:27:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DM0vdtWgS9SCvtHIl2h-9w'}, attempt #1 09:27:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DM0vdtWgS9SCvtHIl2h-9w'}, attempt #1 09:27:28 INFO - Task dependencies: VfYCFd2PRVCP0O_0AkRJYQ 09:27:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ'}, attempt #1 09:27:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 09:27:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.test_packages.json 09:27:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.crashreporter-symbols.zip 09:27:29 INFO - Running post-action listener: _resource_record_post_action 09:27:29 INFO - [mozharness: 2017-10-02 16:27:29.270964Z] Finished read-buildbot-config step (success) 09:27:29 INFO - [mozharness: 2017-10-02 16:27:29.271182Z] Running download-and-extract step. 09:27:29 INFO - Running pre-action listener: _resource_record_pre_action 09:27:29 INFO - Running main action method: download_and_extract 09:27:29 INFO - mkdir: /builds/slave/test/build/tests 09:27:29 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')]} 09:27:29 INFO - trying https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.test_packages.json 09:27:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:27:29 INFO - Downloaded 989 bytes. 09:27:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:27:29 INFO - Using the following test package requirements: 09:27:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:27:29 INFO - u'common': [u'target.common.tests.zip'], 09:27:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:27:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:27:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:27:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:27:29 INFO - u'mozbase': [u'target.common.tests.zip'], 09:27:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:27:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:27:29 INFO - u'web-platform': [u'target.common.tests.zip', 09:27:29 INFO - u'target.web-platform.tests.tar.gz'], 09:27:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:27:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.common.tests.zip 09:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.common.tests.zip into memory 09:27:30 INFO - Content-Length response header: 55177854 09:27:30 INFO - Bytes received: 55177854 09:27:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.talos.tests.zip 09:27:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:27:41 INFO - Fetch https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.talos.tests.zip into memory 09:27:42 INFO - Content-Length response header: 14509184 09:27:42 INFO - Bytes received: 14509184 09:27:42 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')]} 09:27:42 INFO - trying https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 09:27:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:27:43 INFO - Downloaded 53566903 bytes. 09:27:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 09:27:43 INFO - mkdir: /builds/slave/test/properties 09:27:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:27:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:27:43 INFO - Contents: 09:27:43 INFO - build_url:https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 09:27:43 INFO - Running post-action listener: _resource_record_post_action 09:27:43 INFO - Running post-action listener: find_tests_for_verification 09:27:43 INFO - Running post-action listener: set_extra_try_arguments 09:27:43 INFO - [mozharness: 2017-10-02 16:27:43.781936Z] Finished download-and-extract step (success) 09:27:43 INFO - [mozharness: 2017-10-02 16:27:43.782033Z] Running populate-webroot step. 09:27:43 INFO - Running pre-action listener: _resource_record_pre_action 09:27:43 INFO - Running main action method: populate_webroot 09:27:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:27:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['tresize', 09:27:43 INFO - 'tcanvasmark']}, 09:27:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:27:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['dromaeo_css', 09:27:43 INFO - 'kraken']}, 09:27:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'tests': ['damp', 'tps']}, 09:27:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['damp', 'tps']}, 09:27:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:27:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['dromaeo_dom']}, 09:27:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:27:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['basic_compositor_video', 09:27:43 INFO - 'glvideo']}, 09:27:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:27:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['ts_paint_webext', 09:27:43 INFO - 'tp5o_webext']}, 09:27:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:27:43 INFO - 'ts_paint', 09:27:43 INFO - 'tpaint', 09:27:43 INFO - 'sessionrestore', 09:27:43 INFO - 'sessionrestore_many_windows', 09:27:43 INFO - 'sessionrestore_no_auto_restore', 09:27:43 INFO - 'tabpaint']}, 09:27:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['a11yr', 09:27:43 INFO - 'ts_paint', 09:27:43 INFO - 'tpaint', 09:27:43 INFO - 'sessionrestore', 09:27:43 INFO - 'sessionrestore_many_windows', 09:27:43 INFO - 'sessionrestore_no_auto_restore', 09:27:43 INFO - 'tabpaint']}, 09:27:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:27:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:27:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['perf_reftest_singletons']}, 09:27:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['bloom_basic']}, 09:27:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:27:43 INFO - 'tsvgr_opacity', 09:27:43 INFO - 'tart', 09:27:43 INFO - 'tscrollx', 09:27:43 INFO - 'tsvg_static']}, 09:27:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['tsvgx', 09:27:43 INFO - 'tsvgr_opacity', 09:27:43 INFO - 'tart', 09:27:43 INFO - 'tscrollx', 09:27:43 INFO - 'tsvg_static']}, 09:27:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:27:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo'], 09:27:43 INFO - 'tests': ['tp5o']}, 09:27:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:27:43 INFO - 'talos_options': ['--mitmproxy', 09:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:27:43 INFO - '--firstNonBlankPaint'], 09:27:43 INFO - 'tests': ['tp6_google', 09:27:43 INFO - 'tp6_youtube', 09:27:43 INFO - 'tp6_amazon', 09:27:43 INFO - 'tp6_facebook']}, 09:27:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo', 09:27:43 INFO - '--mitmproxy', 09:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:27:43 INFO - '--firstNonBlankPaint'], 09:27:43 INFO - 'tests': ['tp6_google', 09:27:43 INFO - 'tp6_youtube', 09:27:43 INFO - 'tp6_amazon', 09:27:43 INFO - 'tp6_facebook']}, 09:27:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:27:43 INFO - 'talos_options': ['--stylo-threads=1', 09:27:43 INFO - '--mitmproxy', 09:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:27:43 INFO - '--firstNonBlankPaint'], 09:27:43 INFO - 'tests': ['tp6_google', 09:27:43 INFO - 'tp6_youtube', 09:27:43 INFO - 'tp6_amazon', 09:27:43 INFO - 'tp6_facebook']}, 09:27:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--xperf_path', 09:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:43 INFO - 'tests': ['tp5n']}, 09:27:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:27:43 INFO - 'talos_options': ['--disable-stylo', 09:27:43 INFO - '--xperf_path', 09:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:43 INFO - 'tests': ['tp5n']}}} 09:27:43 INFO - Running post-action listener: _resource_record_post_action 09:27:43 INFO - [mozharness: 2017-10-02 16:27:43.797018Z] Finished populate-webroot step (success) 09:27:43 INFO - [mozharness: 2017-10-02 16:27:43.797120Z] Running create-virtualenv step. 09:27:43 INFO - Running pre-action listener: _resource_record_pre_action 09:27:43 INFO - Running main action method: create_virtualenv 09:27:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:27:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:27:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:27:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:27:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:27:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:27:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:27:44 INFO - Installing pip...............done. 09:27:44 INFO - Return code: 0 09:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:27:44 INFO - Reading from file tmpfile_stdout 09:27:44 INFO - Output received: 09:27:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:27:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27: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')]} 09:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27: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', 'pip>=1.5'] in /builds/slave/test/build 09:27: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 pip>=1.5 09:27:44 INFO - Using env: {'DISPLAY': ':0', 09:27:44 INFO - 'HOME': '/home/cltbld', 09:27:44 INFO - 'LANG': 'en_US.UTF-8', 09:27:44 INFO - 'LANGUAGE': 'en_US:en', 09:27:44 INFO - 'LOGNAME': 'cltbld', 09:27:44 INFO - 'MAIL': '/var/mail/cltbld', 09:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:44 INFO - 'MOZ_NO_REMOTE': '1', 09:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:44 INFO - 'NO_EM_RESTART': '1', 09:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:44 INFO - 'PWD': '/builds/slave/test', 09:27:44 INFO - 'SHELL': '/bin/bash', 09:27:44 INFO - 'SHLVL': '1', 09:27:44 INFO - 'TERM': 'linux', 09:27:44 INFO - 'TMOUT': '86400', 09:27:44 INFO - 'USER': 'cltbld', 09:27:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:44 INFO - '_': '/tools/buildbot/bin/python'} 09:27:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:27:46 INFO - Downloading/unpacking pip>=1.5 09:27:46 INFO - Running setup.py egg_info for package pip 09:27:46 INFO - warning: no files found matching 'pip/cacert.pem' 09:27:46 INFO - warning: no files found matching '*.html' under directory 'docs' 09:27:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:27:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:27:46 INFO - Installing collected packages: pip 09:27:46 INFO - Found existing installation: pip 1.1 09:27:46 INFO - Uninstalling pip: 09:27:46 INFO - Successfully uninstalled pip 09:27:46 INFO - Running setup.py install for pip 09:27:46 INFO - warning: no files found matching 'pip/cacert.pem' 09:27:46 INFO - warning: no files found matching '*.html' under directory 'docs' 09:27:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:27:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:27:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:27:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:27:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:27:46 INFO - Successfully installed pip 09:27:46 INFO - Cleaning up... 09:27:46 INFO - Return code: 0 09:27:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:27:46 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')]} 09:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:46 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')]} 09:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:46 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:46 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 09:27:46 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 09:27:46 INFO - Using env: {'DISPLAY': ':0', 09:27:46 INFO - 'HOME': '/home/cltbld', 09:27:46 INFO - 'LANG': 'en_US.UTF-8', 09:27:46 INFO - 'LANGUAGE': 'en_US:en', 09:27:46 INFO - 'LOGNAME': 'cltbld', 09:27:46 INFO - 'MAIL': '/var/mail/cltbld', 09:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:46 INFO - 'MOZ_NO_REMOTE': '1', 09:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:46 INFO - 'NO_EM_RESTART': '1', 09:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:46 INFO - 'PWD': '/builds/slave/test', 09:27:46 INFO - 'SHELL': '/bin/bash', 09:27:46 INFO - 'SHLVL': '1', 09:27:46 INFO - 'TERM': 'linux', 09:27:46 INFO - 'TMOUT': '86400', 09:27:46 INFO - 'USER': 'cltbld', 09:27:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:46 INFO - '_': '/tools/buildbot/bin/python'} 09:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:46 INFO - Downloading/unpacking psutil>=3.1.1 09:27:46 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 09:27:46 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 09:27:46 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 09:27:46 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 09:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:48 INFO - Installing collected packages: psutil 09:27:48 INFO - Running setup.py install for psutil 09:27:48 INFO - building 'psutil._psutil_linux' extension 09:27:48 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 09:27:48 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 09:27:48 INFO - building 'psutil._psutil_posix' extension 09:27:48 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 09:27:48 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 09:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:48 INFO - Successfully installed psutil 09:27:48 INFO - Cleaning up... 09:27:48 INFO - Return code: 0 09:27:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:27:48 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')]} 09:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:48 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')]} 09:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:48 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:48 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 09:27:48 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 09:27:48 INFO - Using env: {'DISPLAY': ':0', 09:27:48 INFO - 'HOME': '/home/cltbld', 09:27:48 INFO - 'LANG': 'en_US.UTF-8', 09:27:48 INFO - 'LANGUAGE': 'en_US:en', 09:27:48 INFO - 'LOGNAME': 'cltbld', 09:27:48 INFO - 'MAIL': '/var/mail/cltbld', 09:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:48 INFO - 'MOZ_NO_REMOTE': '1', 09:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:48 INFO - 'NO_EM_RESTART': '1', 09:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:48 INFO - 'PWD': '/builds/slave/test', 09:27:48 INFO - 'SHELL': '/bin/bash', 09:27:48 INFO - 'SHLVL': '1', 09:27:48 INFO - 'TERM': 'linux', 09:27:48 INFO - 'TMOUT': '86400', 09:27:48 INFO - 'USER': 'cltbld', 09:27:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:48 INFO - '_': '/tools/buildbot/bin/python'} 09:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:27:48 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 09:27:48 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 09:27:48 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 09:27:48 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 09:27:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:27:49 INFO - Installing collected packages: mozsystemmonitor 09:27:49 INFO - Running setup.py install for mozsystemmonitor 09:27:49 INFO - Successfully installed mozsystemmonitor 09:27:49 INFO - Cleaning up... 09:27:50 INFO - Return code: 0 09:27:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27: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')]} 09:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:50 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:50 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 09:27:50 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 09:27:50 INFO - Using env: {'DISPLAY': ':0', 09:27:50 INFO - 'HOME': '/home/cltbld', 09:27:50 INFO - 'LANG': 'en_US.UTF-8', 09:27:50 INFO - 'LANGUAGE': 'en_US:en', 09:27:50 INFO - 'LOGNAME': 'cltbld', 09:27:50 INFO - 'MAIL': '/var/mail/cltbld', 09:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:50 INFO - 'MOZ_NO_REMOTE': '1', 09:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:50 INFO - 'NO_EM_RESTART': '1', 09:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:50 INFO - 'PWD': '/builds/slave/test', 09:27:50 INFO - 'SHELL': '/bin/bash', 09:27:50 INFO - 'SHLVL': '1', 09:27:50 INFO - 'TERM': 'linux', 09:27:50 INFO - 'TMOUT': '86400', 09:27:50 INFO - 'USER': 'cltbld', 09:27:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:50 INFO - '_': '/tools/buildbot/bin/python'} 09:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:50 INFO - Downloading/unpacking jsonschema==2.5.1 09:27:50 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 09:27:50 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 09:27:50 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 09:27:50 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 09:27:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:27:51 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 09:27:51 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 09:27:51 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 09:27:51 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 09:27:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:52 INFO - warning: no files found matching '*.txt' 09:27:52 INFO - no previously-included directories found matching 'build' 09:27:52 INFO - no previously-included directories found matching 'dist' 09:27:52 INFO - no previously-included directories found matching '.git*' 09:27:52 INFO - Installing collected packages: jsonschema, functools32 09:27:52 INFO - Running setup.py install for functools32 09:27:52 INFO - warning: no files found matching '*.txt' 09:27:52 INFO - no previously-included directories found matching 'build' 09:27:52 INFO - no previously-included directories found matching 'dist' 09:27:52 INFO - no previously-included directories found matching '.git*' 09:27:52 INFO - Successfully installed jsonschema functools32 09:27:52 INFO - Cleaning up... 09:27:52 INFO - Return code: 0 09:27:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:27:52 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')]} 09:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:52 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')]} 09:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:52 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:52 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 09:27:52 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 09:27:52 INFO - Using env: {'DISPLAY': ':0', 09:27:52 INFO - 'HOME': '/home/cltbld', 09:27:52 INFO - 'LANG': 'en_US.UTF-8', 09:27:52 INFO - 'LANGUAGE': 'en_US:en', 09:27:52 INFO - 'LOGNAME': 'cltbld', 09:27:52 INFO - 'MAIL': '/var/mail/cltbld', 09:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:52 INFO - 'MOZ_NO_REMOTE': '1', 09:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:52 INFO - 'NO_EM_RESTART': '1', 09:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:52 INFO - 'PWD': '/builds/slave/test', 09:27:52 INFO - 'SHELL': '/bin/bash', 09:27:52 INFO - 'SHLVL': '1', 09:27:52 INFO - 'TERM': 'linux', 09:27:52 INFO - 'TMOUT': '86400', 09:27:52 INFO - 'USER': 'cltbld', 09:27:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:52 INFO - '_': '/tools/buildbot/bin/python'} 09:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:27:52 INFO - Cleaning up... 09:27:52 INFO - Return code: 0 09:27:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:27:52 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')]} 09:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:52 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')]} 09:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:52 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:52 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 09:27:52 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 09:27:52 INFO - Using env: {'DISPLAY': ':0', 09:27:52 INFO - 'HOME': '/home/cltbld', 09:27:52 INFO - 'LANG': 'en_US.UTF-8', 09:27:52 INFO - 'LANGUAGE': 'en_US:en', 09:27:52 INFO - 'LOGNAME': 'cltbld', 09:27:52 INFO - 'MAIL': '/var/mail/cltbld', 09:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:52 INFO - 'MOZ_NO_REMOTE': '1', 09:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:52 INFO - 'NO_EM_RESTART': '1', 09:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:52 INFO - 'PWD': '/builds/slave/test', 09:27:52 INFO - 'SHELL': '/bin/bash', 09:27:52 INFO - 'SHLVL': '1', 09:27:52 INFO - 'TERM': 'linux', 09:27:52 INFO - 'TMOUT': '86400', 09:27:52 INFO - 'USER': 'cltbld', 09:27:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:52 INFO - '_': '/tools/buildbot/bin/python'} 09:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:27:52 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 09:27:52 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 09:27:52 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 09:27:52 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 09:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:27:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:27: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 09:27: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 09:27: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 09:27: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 09:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:27: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 09:27: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 09:27: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 09:27: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 09:27:54 INFO - Downloading docopt-0.6.1.tar.gz 09:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:27:54 INFO - Running setup.py install for blobuploader 09:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:27:54 INFO - Running setup.py install for requests 09:27:55 INFO - Running setup.py install for docopt 09:27:55 INFO - Successfully installed blobuploader requests docopt 09:27:55 INFO - Cleaning up... 09:27:55 INFO - Return code: 0 09:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:55 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')]} 09:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:55 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')]} 09:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:55 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:55 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 09:27:55 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 09:27:55 INFO - Using env: {'DISPLAY': ':0', 09:27:55 INFO - 'HOME': '/home/cltbld', 09:27:55 INFO - 'LANG': 'en_US.UTF-8', 09:27:55 INFO - 'LANGUAGE': 'en_US:en', 09:27:55 INFO - 'LOGNAME': 'cltbld', 09:27:55 INFO - 'MAIL': '/var/mail/cltbld', 09:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:55 INFO - 'MOZ_NO_REMOTE': '1', 09:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:55 INFO - 'NO_EM_RESTART': '1', 09:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:55 INFO - 'PWD': '/builds/slave/test', 09:27:55 INFO - 'SHELL': '/bin/bash', 09:27:55 INFO - 'SHLVL': '1', 09:27:55 INFO - 'TERM': 'linux', 09:27:55 INFO - 'TMOUT': '86400', 09:27:55 INFO - 'USER': 'cltbld', 09:27:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:55 INFO - '_': '/tools/buildbot/bin/python'} 09:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:55 INFO - Running setup.py (path:/tmp/pip-QuU_n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:55 INFO - Running setup.py (path:/tmp/pip-RkO7ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:55 INFO - Running setup.py (path:/tmp/pip-Sq02w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:55 INFO - Running setup.py (path:/tmp/pip-uH4CUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:55 INFO - Running setup.py (path:/tmp/pip-s8iwZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:55 INFO - Running setup.py (path:/tmp/pip-TzYVZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:55 INFO - Running setup.py (path:/tmp/pip-AjQZKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:55 INFO - Running setup.py (path:/tmp/pip-8orCKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:55 INFO - Running setup.py (path:/tmp/pip-fLs6jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:55 INFO - Running setup.py (path:/tmp/pip-3WQdyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:56 INFO - Running setup.py (path:/tmp/pip-PfjxoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:56 INFO - Running setup.py (path:/tmp/pip-G5IzCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:56 INFO - Running setup.py (path:/tmp/pip-SKsiEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:56 INFO - Running setup.py (path:/tmp/pip-qSokrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:56 INFO - Running setup.py (path:/tmp/pip-qpCdk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:56 INFO - Running setup.py (path:/tmp/pip-GApV8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:56 INFO - Running setup.py (path:/tmp/pip-z8zHqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:27:56 INFO - Running setup.py install for manifestparser 09:27:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:27:56 INFO - Running setup.py install for mozcrash 09:27:56 INFO - Running setup.py install for mozdebug 09:27:56 INFO - Running setup.py install for mozdevice 09:27:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:27:56 INFO - Running setup.py install for mozfile 09:27:57 INFO - Running setup.py install for mozhttpd 09:27:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for mozinfo 09:27:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for mozInstall 09:27:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for mozleak 09:27:57 INFO - Running setup.py install for mozlog 09:27:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for moznetwork 09:27:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for mozprocess 09:27:57 INFO - Running setup.py install for mozprofile 09:27:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:27:57 INFO - Running setup.py install for mozrunner 09:27:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:27:58 INFO - Running setup.py install for mozscreenshot 09:27:58 INFO - Running setup.py install for moztest 09:27:58 INFO - Running setup.py install for mozversion 09:27:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:27:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:27:58 INFO - Cleaning up... 09:27:58 INFO - Return code: 0 09:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27: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')]} 09:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:58 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:27:58 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 09:27:58 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 09:27:58 INFO - Using env: {'DISPLAY': ':0', 09:27:58 INFO - 'HOME': '/home/cltbld', 09:27:58 INFO - 'LANG': 'en_US.UTF-8', 09:27:58 INFO - 'LANGUAGE': 'en_US:en', 09:27:58 INFO - 'LOGNAME': 'cltbld', 09:27:58 INFO - 'MAIL': '/var/mail/cltbld', 09:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:58 INFO - 'MOZ_NO_REMOTE': '1', 09:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:58 INFO - 'NO_EM_RESTART': '1', 09:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:58 INFO - 'PWD': '/builds/slave/test', 09:27:58 INFO - 'SHELL': '/bin/bash', 09:27:58 INFO - 'SHLVL': '1', 09:27:58 INFO - 'TERM': 'linux', 09:27:58 INFO - 'TMOUT': '86400', 09:27:58 INFO - 'USER': 'cltbld', 09:27:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:58 INFO - '_': '/tools/buildbot/bin/python'} 09:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:58 INFO - Running setup.py (path:/tmp/pip-6QrSma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:58 INFO - Running setup.py (path:/tmp/pip-xwN6Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:58 INFO - Running setup.py (path:/tmp/pip-WekpuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:58 INFO - Running setup.py (path:/tmp/pip-Zudy6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:58 INFO - Running setup.py (path:/tmp/pip-LJEPDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:58 INFO - Running setup.py (path:/tmp/pip-d0LGcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:58 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)) 09:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:58 INFO - Running setup.py (path:/tmp/pip-qNHz9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:59 INFO - Running setup.py (path:/tmp/pip-pTWLoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:59 INFO - Running setup.py (path:/tmp/pip-aDgvX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:59 INFO - Running setup.py (path:/tmp/pip-GpZSWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:59 INFO - Running setup.py (path:/tmp/pip-VLBwCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:59 INFO - Running setup.py (path:/tmp/pip-oU2ago-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:59 INFO - Running setup.py (path:/tmp/pip-Z5cPzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:59 INFO - Running setup.py (path:/tmp/pip-yZyNUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:59 INFO - Running setup.py (path:/tmp/pip-yDwIQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:59 INFO - Running setup.py (path:/tmp/pip-2I2hgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:59 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)) 09:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:59 INFO - Running setup.py (path:/tmp/pip-05nhD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:59 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)) 09:27:59 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)) 09:27:59 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)) 09:27:59 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)) 09:27:59 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)) 09:27:59 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)) 09:27:59 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)) 09:27:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:59 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 09:27:59 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 09:27:59 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 09:27:59 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 09:28:00 INFO - Downloading blessings-1.6.tar.gz 09:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:28:00 INFO - Installing collected packages: blessings 09:28:00 INFO - Running setup.py install for blessings 09:28:01 INFO - Successfully installed blessings 09:28:01 INFO - Cleaning up... 09:28:01 INFO - Return code: 0 09:28:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:01 INFO - Reading from file tmpfile_stdout 09:28:01 INFO - Current package versions: 09:28:01 INFO - argparse == 1.2.1 09:28:01 INFO - blessings == 1.6 09:28:01 INFO - blobuploader == 1.2.4 09:28:01 INFO - docopt == 0.6.1 09:28:01 INFO - functools32 == 3.2.3-2 09:28:01 INFO - jsonschema == 2.5.1 09:28:01 INFO - manifestparser == 1.1 09:28:01 INFO - mozInstall == 1.13 09:28:01 INFO - mozcrash == 1.0 09:28:01 INFO - mozdebug == 0.1 09:28:01 INFO - mozdevice == 0.51 09:28:01 INFO - mozfile == 1.2 09:28:01 INFO - mozhttpd == 0.7 09:28:01 INFO - mozinfo == 0.10 09:28:01 INFO - mozleak == 0.1 09:28:01 INFO - mozlog == 3.5 09:28:01 INFO - moznetwork == 0.27 09:28:01 INFO - mozprocess == 0.25 09:28:01 INFO - mozprofile == 0.28 09:28:01 INFO - mozrunner == 6.13 09:28:01 INFO - mozscreenshot == 0.1 09:28:01 INFO - mozsystemmonitor == 0.3 09:28:01 INFO - moztest == 0.8 09:28:01 INFO - mozversion == 1.4 09:28:01 INFO - psutil == 3.1.1 09:28:01 INFO - requests == 1.2.3 09:28:01 INFO - wsgiref == 0.1.2 09:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:01 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')]} 09:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:01 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')]} 09:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:01 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:28:01 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 09:28:01 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 09:28:01 INFO - Using env: {'DISPLAY': ':0', 09:28:01 INFO - 'HOME': '/home/cltbld', 09:28:01 INFO - 'LANG': 'en_US.UTF-8', 09:28:01 INFO - 'LANGUAGE': 'en_US:en', 09:28:01 INFO - 'LOGNAME': 'cltbld', 09:28:01 INFO - 'MAIL': '/var/mail/cltbld', 09:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:01 INFO - 'MOZ_NO_REMOTE': '1', 09:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:01 INFO - 'NO_EM_RESTART': '1', 09:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:01 INFO - 'PWD': '/builds/slave/test', 09:28:01 INFO - 'SHELL': '/bin/bash', 09:28:01 INFO - 'SHLVL': '1', 09:28:01 INFO - 'TERM': 'linux', 09:28:01 INFO - 'TMOUT': '86400', 09:28:01 INFO - 'USER': 'cltbld', 09:28:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:01 INFO - '_': '/tools/buildbot/bin/python'} 09:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 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)) 09:28:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:28:01 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 09:28:01 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 09:28:01 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 09:28:01 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 09:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:28:02 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)) 09:28:02 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)) 09:28:02 INFO - Installing collected packages: simplejson 09:28:02 INFO - Running setup.py install for simplejson 09:28:02 INFO - building 'simplejson._speedups' extension 09:28:02 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 09:28:03 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 09:28:03 INFO - Successfully installed simplejson 09:28:03 INFO - Cleaning up... 09:28:03 INFO - Return code: 0 09:28:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:28:03 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')]} 09:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:03 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')]} 09:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:03 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 0x22e61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24aea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2651a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', '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 09:28:03 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 09:28:03 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 09:28:03 INFO - Using env: {'DISPLAY': ':0', 09:28:03 INFO - 'HOME': '/home/cltbld', 09:28:03 INFO - 'LANG': 'en_US.UTF-8', 09:28:03 INFO - 'LANGUAGE': 'en_US:en', 09:28:03 INFO - 'LOGNAME': 'cltbld', 09:28:03 INFO - 'MAIL': '/var/mail/cltbld', 09:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:03 INFO - 'MOZ_NO_REMOTE': '1', 09:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:03 INFO - 'NO_EM_RESTART': '1', 09:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:03 INFO - 'PWD': '/builds/slave/test', 09:28:03 INFO - 'SHELL': '/bin/bash', 09:28:03 INFO - 'SHLVL': '1', 09:28:03 INFO - 'TERM': 'linux', 09:28:03 INFO - 'TMOUT': '86400', 09:28:03 INFO - 'USER': 'cltbld', 09:28:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:03 INFO - '_': '/tools/buildbot/bin/python'} 09:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:28:04 INFO - Cleaning up... 09:28:04 INFO - Return code: 0 09:28:04 INFO - Running post-action listener: _resource_record_post_action 09:28:04 INFO - Running post-action listener: _start_resource_monitoring 09:28:04 INFO - Starting resource monitoring. 09:28:04 INFO - [mozharness: 2017-10-02 16:28:04.047325Z] Finished create-virtualenv step (success) 09:28:04 INFO - [mozharness: 2017-10-02 16:28:04.047840Z] Running install step. 09:28:04 INFO - Running pre-action listener: _resource_record_pre_action 09:28:04 INFO - Running main action method: install 09:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:04 INFO - Reading from file tmpfile_stdout 09:28:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:28:04 INFO - Reading from file tmpfile_stdout 09:28:04 INFO - Output received: 09:28:04 INFO - Usage: mozinstall [options] installer 09:28:04 INFO - Options: 09:28:04 INFO - -h, --help show this help message and exit 09:28:04 INFO - -d DEST, --destination=DEST 09:28:04 INFO - Directory to install application into. [default: 09:28:04 INFO - "/builds/slave/test"] 09:28:04 INFO - --app=APP Application being installed. [default: firefox] 09:28:04 INFO - mkdir: /builds/slave/test/build/application 09:28:04 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'] 09:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:28:19 INFO - Reading from file tmpfile_stdout 09:28:19 INFO - Output received: 09:28:19 INFO - /builds/slave/test/build/application/firefox/firefox 09:28:19 INFO - Running post-action listener: _resource_record_post_action 09:28:19 INFO - [mozharness: 2017-10-02 16:28:19.011663Z] Finished install step (success) 09:28:19 INFO - [mozharness: 2017-10-02 16:28:19.011913Z] Running setup-mitmproxy step. 09:28:19 INFO - Running pre-action listener: _resource_record_pre_action 09:28:19 INFO - Running main action method: setup_mitmproxy 09:28:19 INFO - Skipping: mitmproxy is not required 09:28:19 INFO - Running post-action listener: _resource_record_post_action 09:28:19 INFO - [mozharness: 2017-10-02 16:28:19.013047Z] Finished setup-mitmproxy step (success) 09:28:19 INFO - [mozharness: 2017-10-02 16:28:19.013322Z] Running run-tests step. 09:28:19 INFO - Running pre-action listener: _resource_record_pre_action 09:28:19 INFO - Running pre-action listener: _set_gcov_prefix 09:28:19 INFO - Running main action method: run_tests 09:28:19 WARNING - Try message not found. 09:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:28:19 INFO - Python 2.7.3 09:28:19 INFO - Return code: 0 09:28:19 INFO - grabbing minidump binary from tooltool 09:28:19 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')]} 09:28:19 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 0x2655090>, '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 0x2655d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:28:19 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 09:28:19 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 09:28:19 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 09:28:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:28:19 INFO - Return code: 0 09:28:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:28:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:28:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:28:19 INFO - ENV: RUST_BACKTRACE is now full 09:28:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:28:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:28:19 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/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:28:19 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/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 09:28:19 INFO - Using env: {'DISPLAY': ':0', 09:28:19 INFO - 'HOME': '/home/cltbld', 09:28:19 INFO - 'LANG': 'en_US.UTF-8', 09:28:19 INFO - 'LANGUAGE': 'en_US:en', 09:28:19 INFO - 'LOGNAME': 'cltbld', 09:28:19 INFO - 'MAIL': '/var/mail/cltbld', 09:28:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:28:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:19 INFO - 'MOZ_NO_REMOTE': '1', 09:28:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:19 INFO - 'NO_EM_RESTART': '1', 09:28:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:19 INFO - 'PWD': '/builds/slave/test', 09:28:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:28:19 INFO - 'RUST_BACKTRACE': 'full', 09:28:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:28:19 INFO - 'SHELL': '/bin/bash', 09:28:19 INFO - 'SHLVL': '1', 09:28:19 INFO - 'TERM': 'linux', 09:28:19 INFO - 'TMOUT': '86400', 09:28:19 INFO - 'USER': 'cltbld', 09:28:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:19 INFO - '_': '/tools/buildbot/bin/python'} 09:28:19 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/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:28:19 INFO - mozversion application_buildid: 20171002150752 09:28:19 INFO - mozversion application_changeset: 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 09:28:19 INFO - mozversion application_display_name: Firefox 09:28:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:28:19 INFO - mozversion application_name: Firefox 09:28:19 INFO - mozversion application_remotingname: firefox 09:28:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:28:19 INFO - mozversion application_vendor: Mozilla 09:28:19 INFO - mozversion application_version: 57.0 09:28:19 INFO - mozversion platform_buildid: 20171002150752 09:28:19 INFO - mozversion platform_changeset: 0b50c7250aa635957c72a9e49eddc8b7cd65cdf6 09:28:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:28:19 INFO - mozversion platform_version: 57.0 09:28:19 INFO - using testdate: 1506961699 09:28:19 INFO - actual date: 1506961699 09:28:19 INFO - starting webserver on 'localhost:44805' 09:28:19 INFO - SUITE-START | Running 2 tests 09:28:19 INFO - TEST-START | dromaeo_css 09:28:19 INFO - Initialising browser for dromaeo_css test... 09:28:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44805/getInfo.html -profile /tmp/tmpzc0AKf/profile 09:28:19 INFO - TEST-INFO | started process 17571 (/builds/slave/test/build/application/firefox/firefox http://localhost:44805/getInfo.html) 09:28:25 INFO - TEST-INFO | 17571: exit 0 09:28:25 INFO - Browser initialized. 09:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:28:25 INFO - Using env: {'DISPLAY': ':0', 09:28:25 INFO - 'HOME': '/home/cltbld', 09:28:25 INFO - 'JSGC_DISABLE_POISONING': '1', 09:28:25 INFO - 'LANG': 'en_US.UTF-8', 09:28:25 INFO - 'LANGUAGE': 'en_US:en', 09:28:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:28:25 INFO - 'LOGNAME': 'cltbld', 09:28:25 INFO - 'MAIL': '/var/mail/cltbld', 09:28:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:28:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:28:25 INFO - 'MOZ_CRASHREPORTER': '1', 09:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:28:25 INFO - 'MOZ_NO_REMOTE': '1', 09:28:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:25 INFO - 'NO_EM_RESTART': '1', 09:28:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:25 INFO - 'PWD': '/builds/slave/test', 09:28:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:28:25 INFO - 'RUST_BACKTRACE': 'full', 09:28:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:28:25 INFO - 'SHELL': '/bin/bash', 09:28:25 INFO - 'SHLVL': '1', 09:28:25 INFO - 'TERM': 'linux', 09:28:25 INFO - 'TMOUT': '86400', 09:28:25 INFO - 'USER': 'cltbld', 09:28:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:25 INFO - '_': '/tools/buildbot/bin/python'} 09:28:25 INFO - TEST-INFO | started process 17761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzc0AKf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:25 INFO - PID 17761 | 09:28:25 INFO - PID 17761 | (/builds/slave/test/build/application/firefox/firefox:17809): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:28:25 INFO - PID 17761 | 09:28:36 INFO - PID 17761 | RSS: Main: 141287424 09:28:36 INFO - PID 17761 | 09:31:33 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44805/tests/dromaeo/cssquery-ext.html) 09:31:34 INFO - PID 17761 | RSS: Main: 144969728 09:31:34 INFO - PID 17761 | 09:34:36 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-ext.html (next: http://localhost:44805/tests/dromaeo/cssquery-jquery.html) 09:34:37 INFO - PID 17761 | RSS: Main: 143867904 09:34:37 INFO - PID 17761 | 09:37:38 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44805/tests/dromaeo/cssquery-mootools.html) 09:37:39 INFO - PID 17761 | RSS: Main: 145264640 09:37:39 INFO - PID 17761 | 09:40:40 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44805/tests/dromaeo/cssquery-prototype.html) 09:40:41 INFO - PID 17761 | RSS: Main: 144756736 09:40:41 INFO - PID 17761 | 09:43:44 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44805/tests/dromaeo/cssquery-yui.html) 09:43:44 INFO - PID 17761 | RSS: Main: 146350080 09:43:44 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | Cycle 1(1): loaded http://localhost:44805/tests/dromaeo/cssquery-yui.html (next: http://localhost:44805/tests/dromaeo/cssquery-dojo.html) 09:46:46 INFO - PID 17761 | RSS: Main: 148717568 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | __start_tp_report 09:46:46 INFO - PID 17761 | _x_x_mozilla_page_load 09:46:46 INFO - PID 17761 | _x_x_mozilla_page_load_details 09:46:46 INFO - PID 17761 | |i|pagename|runs| 09:46:46 INFO - PID 17761 | |0;dojo.html;3997.1206334606395;4008.7394319369237;4029.456023436837;4030.496187976503;4044.352903535435;6596.373344532268;6647.800565983016;6690.799276021715;6723.36128067834;6736.360045795642;6667.759742034207;6686.966565167168;6704.396604305612;6792.592444453337;6795.388415042645;5897.793577224798;5999.460048595625;6007.759689612421;6018.097285407181;6103.42017508336;5986.970065149668;6002.549808764338;6012.098185272201;6027.306859711145;6117.388261173869;6051.818445446622;6089.878202435949;6098.847528811771;6116.113163591299;6135.8772824543485;5988.041913293896;6078.270607527125;6086.2392200974655;6133.570650054498;6155.292141403729;5891.322497912709;5934.317553481319;5947.4052594740615;5951.256092988377;6022.78920237794;6555.541112122153;6648.268690444047;6716.093327400836;6720.22717387497;6760.492963027793;7272.8545429091655;7278.308560686726;7281.927180728231;7373.778786636356;7379.225181355988;7180.964095179543;7283.4537409694485;7288.1618613859555;7298.781036568911;7312.268773122699;6699;6740.662966851638;6794.422474089708;6799;6823.351781580742;7457.10514738224;7467.51461155034;7482;7541.472096953161;7584.924150758422;7170.426365890717;7210.819729506804;7260.92739072613;7282.817929551804;7311.0495635568095;7186.532875363085;7268;7278.09023872016;7279.4540409468445;7282.817929551804;7200.207977122513;7207.243239459781;7216.783496495009;7254.963725181446;7269.418446524265;7281.7087316507805;7302.415806735448;7306.853862922711;7330.266973302733;7339.229380915034;5371.409144994048;5374.113271310268;5436;5440.972795135999;5483.095289277225;4810.855674329776;4839.274108883626;4858.562729354375;4869.074875773592;4919.901601968012;6780.525363224527;6797.218319893177;6811.727530898807;6815.148106486689;6817.420519255918;7238.674259658328;7263.673134708951;7266.927330726625;7297.379722723522;7348.338649521569;6663.86672266552;6684.298148694317;6708.228553716288;6712.127423434922;6812.591244525344;6126.9387306127255;6190.690465476709;6193.411625895533;6209.099680546386;6225.035119556476;7395.963020184972;7486.6256687166515;7536.133344665324;7634.351080158138;7647.426443016796;7163.89254161188;7300.744473943387;7330.157031941395;7332.193458719643;7341.9632901837285;7522.811929701801;7551.471397002377;7554.2823431773895;7657.961710191414;7660.80847978805;7163.283671632795;7175.174854891754;7190.820229494096;7218.602976836114;7293.598852063187;7298.601325479319;7305.926940730737;7349.265073492608;7404.740834070782;7410.036695229585;7016.263292354433;7045.964770176116;7105;7118.822029449305;7127.073480447509;6931.133608298963;6985.26654701249;7000.929990700028;7006.5095443320515;7108.3602475777425;6964;6965.44276457872;6989.1962424321855;6996.930030699831;7001.229864714775;6996.510244283055;7133.571985680668;7144;7162.7493037743425;7170.067891174114;6779;6863.759768408082;6885.827854303682;6962.686679099352;6965.6168910708375 09:46:46 INFO - PID 17761 | |1;ext.html;977.188933185456;1004.9648262310818;1005.6681295172589;1009.7122320138762;1012.0587853296436;45725;46515;46875;46941.53058469423;47013.29480057802;43792;43993.12013759723;44086.55913440865;44093.33859992103;44119.11761764763;8048.959755201216;8265.090840007595;8310.335173186131;8313.459625124378;8319.417640765148;8067.3546116310845;8182.918170818275;8235;8238.340932725398;8249.587520623974;8227.42408031438;8852.8672069919;9085.909140908572;9086.59110340033;9097.590608422637;8972.820543589125;9034.548272586344;9035.683751068715;9038.141376569216;9041;8582.098879617613;8676.60955257015;8678.86981695275;8680.218780309802;8682.86975695365;41476.585234147875;41667.58332416668;41677.1664566707;41789;41936.79031604853;3891.3579259422445;3926.9410958835642;3935.9963209381426;3939.645431911113;3956.7032472564674;34883;35088.82455587706;35135.82432087823;35178.82410587931;35259.29481410383;5740.052891272935;5741.511971482429;5765.913511297334;5796.101604251347;5857.209276747627;222883;224301;224516.8774156135;224587;225028;48791.26813097807;49276.507234927194;54549.45450545523;54601;55522.16716749252;58642.4135758637;58668.70665646644;58757.41242587605;58959.115613265836;58976.70511647414;18105.275788968556;18132;18197.363092291707;18323.81676183221;18333.633327333646;14939.327730252166;14972.625684357978;14974.176420296988;15287.61780955485;15308;15932.362705491882;16068.67862642764;16070.839291607168;16140.19299035067;16144.515664530083;6198.380161983766;6261.8747625047245;6339.619622822645;6371.267304259976;6380.457661098766;1100.7193165742685;1110.650145204258;1130.3161587239601;1131.8868113188614;1139.0432037088885;26433.47133057328;26697.19908402712;26755.732442675326;26784.86607566989;27069.1879243623;1247.3451437994943;1249.2504497301547;1251.8122281657825;1256.849178098634;1258.8929940955122;14079.155250684787;14167.149971001772;14196.716065678835;14268.14391136535;14302.713945721027;288180;289098;290091;290585;290774;62075.689621552505;62187.689061555306;62376.376236237964;62537.68731156406;62680;1558.6726787374778;1573.8268790432815;1606.775051492792;1610.4202487104633;1614.5882799885953;25726.485470290863;26075.60886586665;26087.478250434506;26256;26470;43463;43565.78217108894;43729.34405983849;43784.343234850865;43792;247263;247343;248985;249142;250298;37967.62032379641;44057.55942440534;44210.115797683226;44870.3269450952;44932;54494.72752636211;54841.903161937335;54901;55100;55177.72411137919;39731.40402893901;40117.39823902585;40561.79719101504;40666;40944.1811163781;38964.012377461986;39239.41140882832;39919.40120898247;40087.39868902027;40661;46102.56843948559;46140.30789538092;46190.538094619966;46633;46662;37732.43401348927;37788.244235114595;37834.243315134096;38051;38374.80812595919;28164.43671126607;28281.57577636296;28500.57249141223;28767.280817979718;28970.7102928968 09:46:46 INFO - PID 17761 | |2;jquery.html;634.7642097330514;637.640150010175;649.7564653248286;651.9247656990332;656.2870906932901;23465;24078.518429631396;24171;24238.394040149004;24272.514549708994;25708.357291067732;25987.61018584718;26011.349716257057;26067.86966065172;26087.47825043498;6251.4061164189325;6463.967680161592;6586.736530538773;6626.701798419059;6634.0712300278;6581.144451221335;6644.966775166117;6671.966640166793;6687.899681504781;6695.732170713166;6617.536772425932;6621.6689165541775;6763.222229443603;7033.613151276678;7035.542689725152;7056.329648683392;7092.716291348365;7093.787186384365;7100.822479438004;7106.857862842766;6613.107230523866;6615.669216539154;6621.9006714899315;6627.668616569153;6641.7675381361905;29660.8516957416;30106.946256880903;30652.08043758691;30826.845865770527;30976.380472390425;2271.579757744806;2317.4322291038634;2317.6639387288747;2318.0843566791023;2319.3389883883183;20564;20923;20947.37157885266;21161.365159045254;21192.682109768364;2610.2821724025853;2643.7488438598493;2694.8787304571147;2711.769499592537;2723.482538317713;129508.35245823805;135912;157663;164113.17943410325;165674.17162914108;15577.299021544057;16366.754498682529;16420.589485262964;16573;16958.152092395332;26934.057307994128;27107.1867843965;27109.72890271072;27162.45675086527;27176.320591984964;11039.282446640942;11162.330260184415;11181.490498782723;11291.096712262999;11301.265417747985;10017.39895606266;10040.196784257241;10062.597496100074;10086.092251697382;10241.129503992244;10021.747281589802;10081.647142349982;10309.845352319571;10344.37933723979;10531.368117912949;2910.301527633395;2929.4580502607087;2963.170312312556;2978.910632681023;2992.7007299270335;1033.3283365812283;1047.2093569355088;1055.466989170464;1056.799208150449;1057.1595581512715;21320.36038918835;21533.353999380044;21659.891700541713;21958.89020554887;22040;1119.5074167366333;1134.7560274541013;1138.6754774889116;1142.6857614156174;1147.6729132197283;11987.580434684918;12007.03943684503;12070.69823254408;12127.09046821492;12166.330851803059;665830;682142;688664;691154;704299;132016;133212;136601;139185.304073479;139899;1152.1128730877178;1203.8374819399444;1243.589615426907;1264.89248413884;1288.5103660608909;22431.327060187567;22671.319860404215;22823.543529129656;22855.428614284778;22980.310590682308;61478.38521614727;61730;62597.68701156465;63823;64015.359846402804;78176;78540;79317.60341198256;79387.20612793799;79651;15775.368985240462;15814.683706325579;15934.68130637404;16025.919870400574;16037.599060023593;24615.63076553889;24736.752632474167;24757;24796.38009049788;25006.499870002863;20283.290084846958;20436.489087772923;20466.692999605315;20479.385618430875;20525.589488209855;16638.417655382487;16693.666126677155;17058.232379542704;17528.73706894372;17623.91188044103;20123.899380503004;20374.98125093769;20412.795872041683;20520.692189617468;20659.8967005164;15691.686166276839;15742.134182620066;15810.367585296919;15819.446319378767;15845.52463426099;19978.400647980583;20120.29578964729;20222.595548088662;20359.287424940056;20394.49013774608 09:46:46 INFO - PID 17761 | |3;mootools.html;1490.8956373053886;1526.0233450591622;1534.892557520974;1544.6987837371703;1573.2684301799663;17074.14629268538;17829;17837.732434013502;17837.732434013502;17866.91066544667;17247.137643117858;17418;17422.651546969053;17450.040247786368;17457.912710436463;3152.8738850445957;3167.3348596794644;3229.0474310078584;3233.1755402372364;3234.514822776579;3075.6463006754284;3105.7825952183357;3125.2968082181555;3135.7648176386747;3143.167060728909;3062.3569050499423;3064.356485138124;3183.060997005877;3185.7769956103084;3187.2509960159346;3198.8880389186384;3222.9194270143316;3235.7411407087375;3241.724453421462;3244.951325730116;2976.7469765069995;2991.072767442078;3026.772992025607;3028.7122723341467;3029.2124047747743;16936.915315423466;17298.740518892228;17299.13504324779;17313.56716082108;17318.307267709275;9029.413088149315;9256.305777066747;9300.674476393293;9303.883533975899;9310.348275620709;5771.88456230873;5996.220491336098;6133.202683651141;6204.503639708858;6207.782727604557;2067.793220677935;2141.0686351437175;2150.2689085710936;2169.6528555431214;2178.357384571555;28470;28662.14013579596;28740;28755.856220718764;28770.71229287701;7737.264959828807;7998.240167184108;8021.879671804811;8141.8371632568205;8188.385871059694;19984.90007549953;20062.699059514118;20068.297609583595;20071.59856802856;20096.296629617893;8482.915170848213;8564.143585641386;8564.272036876811;8571.699990500427;8592.613332400057;7819.726309579251;7843.803904902309;8029.397795165269;8232.012158541014;8249;6092.603980741238;6119.265688117454;6467.51493637979;6560.44236239925;6574.901376479356;1635.5093471958364;1684.4946516045138;1843.0692500287269;1879.5019319880244;1952.3654812185812;1012.3268026762121;1043.838205078214;1052.8420736889375;1053.1574740207802;1058.7088550648634;10211.438370889524;10252.38485690861;10373.948130259301;10394.272400932014;10398.636047738293;869.4565896314804;909.940853844498;1127.3912087472836;1128.6049882541045;1149.5516748468103;5938.8218353449465;6212.534059945522;6305.495560355161;6339.904901426482;6641.701123449457;24930.875345623157;26338.20985370442;26433.339166520607;26445.73554264433;26500.072497462497;24442.87778561096;25239.62140567893;25785.871070644527;25884;26011.219663410127;11987.76024479523;12034.338111403957;12051.096167787451;12090.879091208975;12091.153619246568;9810.558524866256;10036.698899033041;10211.183105351405;10316.381017138996;10462.476876156314;21229.893850530647;21317.680234796182;21364.572708546053;21593.35219943404;21768.56462870702;22326.10695572159;22440.66339004949;22450;22489.212877549206;22670.433239168495;12376.75246495083;12408.62774116778;12439.191452555555;12591.748165036832;12596.55912043074;15606.297716603007;15795.684086318439;15845;15874.52376428709;15883.761743574087;12474.688132796753;12486;12511.93744031274;12654.493820247088;12738.554150605056;12085.395730213279;12100.818487722867;12154.453049612965;12261.69345766363;12387.938060309642;10654.57381704723;10859.782804343711;10897.400642964712;10899.128069754559;10913.290636108628;8583.527905964982;8618.353623478139;8626.61180246903;8676.436031657922;8827.514486703292;8572.228499435081;8604.741857744277;8647.26498247656;8650.870236946324;8702.782430439036 09:46:46 INFO - PID 17761 | |4;prototype.html;579.9246098007259;582.8863371642528;596.8567543789491;600.5135839969628;626.3892704613003;6403.103565500828;6432.421082102615;6483.481321494287;6517.380848819366;6603;6420.678966051702;6422.261439934409;6449.967750161242;6468.805935821921;6505.284418713938;5307.787688492455;5307.840764777054;5310.840674779763;5320.308359913206;5325.653832500875;5299.258103865462;5307.575393968493;5330.760115794779;5350.946490535103;5364.758585863646;5051.444341122492;5130.846074617767;5191.87020324493;5199.740012999354;5211.3746350438005;5174.43081261061;5197.636165468419;5216.191490319006;5226.738663066832;5231.712255825947;4702.106599746072;4717.504662010474;4722.598579120779;4731.810727570927;4732.384789977315;6279.277883043463;6369.6815159242315;6381.904271435932;6395.616263024233;6446.967765161191;6133.938660613381;6168.907466388007;6179.443850053472;6197.721102550351;6204.720787564571;6713.630750308731;6756.797296081077;6898.241193468714;6956.721731130749;6963.825904352381;5263;5276.841694749125;5301.549368303698;5315.202719592092;5319;6962.825929351756;6970.930290697079;7093.609851458219;7151.7854464366155;7221.638918054076;5464.672119672832;5477.370102438271;5478.369987451494;5488.094464413327;5488.286522752097;5535.446455354513;5537.280153580089;5544.861378465571;5548.805791797267;5566.777328906798;6068.33248342682;6088.325710429667;6110.663913484801;6129.601575897553;6131;6885.4539911945385;6923.165361179292;6923.342282483156;6942.895856562156;6984.371406573433;1887.424335577662;1893.611809579033;1898.9620207595772;1908.4370110817342;1909.5321646196771;1289.4390939941156;1350.1291666875006;1351.797230415426;1353.3842101843834;1372.1286982765816;6272.8118156455375;6353.491720662336;6386.329435409308;6456.644884531302;6460.3862633049785;6696.46428285736;6823.601161761827;6864.4165245954655;6915.619640919797;6919.031335613018;6363.61818290904;6389.361063893573;6392.968035159794;6412.807615771534;6457.580257283262;3708.721845861571;3710.443433484999;3712.8514859405323;3720.5721342046013;3727.1800203955086;7237.565746055254;7260.382867456326;7304.452166087564;7318.597477138702;7403.185649578542;7177.282271772781;7177.7487787927175;7201.495895287384;7242.601656908815;7258.927410725931;7208.711651533985;7253.891191632129;7278.563286202739;7293.343599076109;7294.9270507295305;6933.306669333027;6946.37482626566;6977.918422644499;6982.371586557234;7006.229314775473;6890.965545172242;6950.443964482931;6979.930200698132;6982.930170698228;6993.5663189047145;7192.8921066183;7203.927960720326;7236.819079523054;7256.7822965311125;7337.633118343954;5396.271503346998;5436.809711660231;5439.782408703608;5439.918401224064;5450.345958485007;6915.757948471779;6927.618980956096;7011.6494175292055;7023.262557431396;7076.00935868989;6598.967005165136;6723.781152219658;6832.897506537505;6840.965795170992;6877.140357455318;6754.425873800782;6844.699507093636;6861;6863.176418829772;6886;6674.399304062657;6677.565958212701;6678;6719.126513553402;6744.932550674431;6777.695003724745;6829.6243706596615;6878.621675807879;6879.624075184883;6923.6192009439965;6435.22777266731;6576.572522786004;6608.173978252718;6667.199936007516;6717.2946840581035 09:46:46 INFO - PID 17761 | |5;yui.html;976.9364991275567;990.14847231381;994.1897353656765;998.7066748560616;1021.5760459409348;18047;18141.546461338472;18473.907630461847;18569.62860742786;18583.349582764607;19660.705089423634;19879.204831806746;19949.800501994974;19953.40139795805;19990.800091999114;1048.1509976918721;1054.667779649408;1060.6764936694306;1060.931039482435;1061.6337363609543;1068.1294744782977;1075.2741899218036;1084.69628504019;1087.1140020882956;1095.014486961733;1161.1465572803982;1163.052112528291;1164.2665120973775;1165.3648761425002;1167.2529581068122;1146.5700362364114;1157.2073129906041;1158.0503986730926;1160.6866146140494;1163.1683346407317;857.1728282207699;858.8797568340437;858.9055203927626;859.2395729779128;859.3426029087752;18118.728219076726;18146.45560633183;18161.7275740864;18163.63672726551;20251.79748202514;23436.17973370941;23905.88047059771;24144.154954576505;24161.637575436205;24164.637530437056;18801.717974230396;18910.716339254923;19163.137658805386;19188.232470701154;19200.231990720353;4022.577629348935;4089.4683691120263;4111.054457474767;4111.157212771374;4117.238310912461;154107.22946385195;154601;155570.22214888968;157537;159401;16318.34726610946;16624.3350265988;16671.833281667026;16682.666346673;16720.41478548245;34611;35006.299874002376;35345.82327088399;35487;35644.82177589095;8906.242969347548;8929.419587726778;8960.596773145224;9004.954975225082;9026.232770214474;4688.132695451352;4727.479977202505;4731.597814185764;4785.95214047862;4789.544993225638;6226.968865155736;6287;6292.716827742763;6326.43062124411;6347.365263473615;1099.1591432554103;1149.6378640728144;1149.6436104807538;1158.530795028015;1166.4401087478059;725.0936329588015;732.2531018361242;736.3777607921298;748.046241042675;759.7075126076501;12863.356832158355;13005.739885202433;13249;13928.303584820718;14164.716705665829;734.9191588925214;744.9441291903021;749.9512531685423;767.6353731977377;770.6686124966318;6197.163382943335;6346.809595712136;6348.238211414568;6360;6364.522660800459;148934;150604;151163;152474;156972.21513892585;135369;135739;135784.6421535792;136847;140736;118213.4089329565;118594.4070279643;118926;119441;119934.4003279978;11837.467313971065;11914.046876250053;11969.64091077269;12012.339321337235;12176.817347739969;56557.151642724566;56745.71627141838;56985.715071426035;57021;58380.4161958392;72170.55658886897;72219.27780722125;73439;73475;73912;15179.620509487351;15766.448174313844;15842.366305348118;15852.207389630703;15858.048517089012;17369.21838517295;17754.112294385486;17914.283428662708;18009.459716208534;18039.458816235532;17630;17643.55891102733;17740.11299435049;17747.645047099242;17889;16534.421295254608;16743.497695069167;16776.32894684199;16874.746878797072;16942.491725248263;16324.265408056428;16340.754888676442;16516.256768445688;16553.586160346087;16569.502914912573;11579.363135027654;11597.76804463923;11619.186656934271;11971.16201865861;12038.458269377725;11870;11983.161178717406;12112.818307725214;12466.688332791753;12522.37388130608 09:46:46 INFO - PID 17761 | __end_tp_report 09:46:46 INFO - PID 17761 | __start_cc_report 09:46:46 INFO - PID 17761 | _x_x_mozilla_cycle_collect,244 09:46:46 INFO - PID 17761 | __end_cc_report 09:46:46 INFO - PID 17761 | __startTimestamp1506962806498__endTimestamp 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | ------- Summary: start ------- 09:46:46 INFO - PID 17761 | Number of tests: 6 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#0] dojo.html Cycles:165 Average:6713.36 Median:6965.62 stddev:796.66 (11.4%) stddev-sans-first:770.08 09:46:46 INFO - PID 17761 | Values: 3997.1 4008.7 4029.5 4030.5 4044.4 6596.4 6647.8 6690.8 6723.4 6736.4 6667.8 6687.0 6704.4 6792.6 6795.4 5897.8 5999.5 6007.8 6018.1 6103.4 5987.0 6002.5 6012.1 6027.3 6117.4 6051.8 6089.9 6098.8 6116.1 6135.9 5988.0 6078.3 6086.2 6133.6 6155.3 5891.3 5934.3 5947.4 5951.3 6022.8 6555.5 6648.3 6716.1 6720.2 6760.5 7272.9 7278.3 7281.9 7373.8 7379.2 7181.0 7283.5 7288.2 7298.8 7312.3 6699.0 6740.7 6794.4 6799.0 6823.4 7457.1 7467.5 7482.0 7541.5 7584.9 7170.4 7210.8 7260.9 7282.8 7311.0 7186.5 7268.0 7278.1 7279.5 7282.8 7200.2 7207.2 7216.8 7255.0 7269.4 7281.7 7302.4 7306.9 7330.3 7339.2 5371.4 5374.1 5436.0 5441.0 5483.1 4810.9 4839.3 4858.6 4869.1 4919.9 6780.5 6797.2 6811.7 6815.1 6817.4 7238.7 7263.7 7266.9 7297.4 7348.3 6663.9 6684.3 6708.2 6712.1 6812.6 6126.9 6190.7 6193.4 6209.1 6225.0 7396.0 7486.6 7536.1 7634.4 7647.4 7163.9 7300.7 7330.2 7332.2 7342.0 7522.8 7551.5 7554.3 7658.0 7660.8 7163.3 7175.2 7190.8 7218.6 7293.6 7298.6 7305.9 7349.3 7404.7 7410.0 7016.3 7046.0 7105.0 7118.8 7127.1 6931.1 6985.3 7000.9 7006.5 7108.4 6964.0 6965.4 6989.2 6996.9 7001.2 6996.5 7133.6 7144.0 7162.7 7170.1 6779.0 6863.8 6885.8 6962.7 6965.6 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#1] ext.html Cycles:180 Average:44973.08 Median:40339.60 stddev:66378.52 (164.5%) stddev-sans-first:66482.52 09:46:46 INFO - PID 17761 | Values: 977.2 1005.0 1005.7 1009.7 1012.1 45725.0 46515.0 46875.0 46941.5 47013.3 43792.0 43993.1 44086.6 44093.3 44119.1 8049.0 8265.1 8310.3 8313.5 8319.4 8067.4 8182.9 8235.0 8238.3 8249.6 8227.4 8852.9 9085.9 9086.6 9097.6 8972.8 9034.5 9035.7 9038.1 9041.0 8582.1 8676.6 8678.9 8680.2 8682.9 41476.6 41667.6 41677.2 41789.0 41936.8 3891.4 3926.9 3936.0 3939.6 3956.7 34883.0 35088.8 35135.8 35178.8 35259.3 5740.1 5741.5 5765.9 5796.1 5857.2 222883.0 224301.0 224516.9 224587.0 225028.0 48791.3 49276.5 54549.5 54601.0 55522.2 58642.4 58668.7 58757.4 58959.1 58976.7 18105.3 18132.0 18197.4 18323.8 18333.6 14939.3 14972.6 14974.2 15287.6 15308.0 15932.4 16068.7 16070.8 16140.2 16144.5 6198.4 6261.9 6339.6 6371.3 6380.5 1100.7 1110.7 1130.3 1131.9 1139.0 26433.5 26697.2 26755.7 26784.9 27069.2 1247.3 1249.3 1251.8 1256.8 1258.9 14079.2 14167.1 14196.7 14268.1 14302.7 288180.0 289098.0 290091.0 290585.0 290774.0 62075.7 62187.7 62376.4 62537.7 62680.0 1558.7 1573.8 1606.8 1610.4 1614.6 25726.5 26075.6 26087.5 26256.0 26470.0 43463.0 43565.8 43729.3 43784.3 43792.0 247263.0 247343.0 248985.0 249142.0 250298.0 37967.6 44057.6 44210.1 44870.3 44932.0 54494.7 54841.9 54901.0 55100.0 55177.7 39731.4 40117.4 40561.8 40666.0 40944.2 38964.0 39239.4 39919.4 40087.4 40661.0 46102.6 46140.3 46190.5 46633.0 46662.0 37732.4 37788.2 37834.2 38051.0 38374.8 28164.4 28281.6 28500.6 28767.3 28970.7 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#2] jquery.html Cycles:180 Average:42451.32 Median:22551.32 stddev:114100.52 (506.0%) stddev-sans-first:114377.40 09:46:46 INFO - PID 17761 | Values: 634.8 637.6 649.8 651.9 656.3 23465.0 24078.5 24171.0 24238.4 24272.5 25708.4 25987.6 26011.3 26067.9 26087.5 6251.4 6464.0 6586.7 6626.7 6634.1 6581.1 6645.0 6672.0 6687.9 6695.7 6617.5 6621.7 6763.2 7033.6 7035.5 7056.3 7092.7 7093.8 7100.8 7106.9 6613.1 6615.7 6621.9 6627.7 6641.8 29660.9 30106.9 30652.1 30826.8 30976.4 2271.6 2317.4 2317.7 2318.1 2319.3 20564.0 20923.0 20947.4 21161.4 21192.7 2610.3 2643.7 2694.9 2711.8 2723.5 129508.4 135912.0 157663.0 164113.2 165674.2 15577.3 16366.8 16420.6 16573.0 16958.2 26934.1 27107.2 27109.7 27162.5 27176.3 11039.3 11162.3 11181.5 11291.1 11301.3 10017.4 10040.2 10062.6 10086.1 10241.1 10021.7 10081.6 10309.8 10344.4 10531.4 2910.3 2929.5 2963.2 2978.9 2992.7 1033.3 1047.2 1055.5 1056.8 1057.2 21320.4 21533.4 21659.9 21958.9 22040.0 1119.5 1134.8 1138.7 1142.7 1147.7 11987.6 12007.0 12070.7 12127.1 12166.3 665830.0 682142.0 688664.0 691154.0 704299.0 132016.0 133212.0 136601.0 139185.3 139899.0 1152.1 1203.8 1243.6 1264.9 1288.5 22431.3 22671.3 22823.5 22855.4 22980.3 61478.4 61730.0 62597.7 63823.0 64015.4 78176.0 78540.0 79317.6 79387.2 79651.0 15775.4 15814.7 15934.7 16025.9 16037.6 24615.6 24736.8 24757.0 24796.4 25006.5 20283.3 20436.5 20466.7 20479.4 20525.6 16638.4 16693.7 17058.2 17528.7 17623.9 20123.9 20375.0 20412.8 20520.7 20659.9 15691.7 15742.1 15810.4 15819.4 15845.5 19978.4 20120.3 20222.6 20359.3 20394.5 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#3] mootools.html Cycles:180 Average:10726.38 Median:22579.82 stddev:7648.82 (33.9%) stddev-sans-first:7638.80 09:46:46 INFO - PID 17761 | Values: 1490.9 1526.0 1534.9 1544.7 1573.3 17074.1 17829.0 17837.7 17837.7 17866.9 17247.1 17418.0 17422.7 17450.0 17457.9 3152.9 3167.3 3229.0 3233.2 3234.5 3075.6 3105.8 3125.3 3135.8 3143.2 3062.4 3064.4 3183.1 3185.8 3187.3 3198.9 3222.9 3235.7 3241.7 3245.0 2976.7 2991.1 3026.8 3028.7 3029.2 16936.9 17298.7 17299.1 17313.6 17318.3 9029.4 9256.3 9300.7 9303.9 9310.3 5771.9 5996.2 6133.2 6204.5 6207.8 2067.8 2141.1 2150.3 2169.7 2178.4 28470.0 28662.1 28740.0 28755.9 28770.7 7737.3 7998.2 8021.9 8141.8 8188.4 19984.9 20062.7 20068.3 20071.6 20096.3 8482.9 8564.1 8564.3 8571.7 8592.6 7819.7 7843.8 8029.4 8232.0 8249.0 6092.6 6119.3 6467.5 6560.4 6574.9 1635.5 1684.5 1843.1 1879.5 1952.4 1012.3 1043.8 1052.8 1053.2 1058.7 10211.4 10252.4 10373.9 10394.3 10398.6 869.5 909.9 1127.4 1128.6 1149.6 5938.8 6212.5 6305.5 6339.9 6641.7 24930.9 26338.2 26433.3 26445.7 26500.1 24442.9 25239.6 25785.9 25884.0 26011.2 11987.8 12034.3 12051.1 12090.9 12091.2 9810.6 10036.7 10211.2 10316.4 10462.5 21229.9 21317.7 21364.6 21593.4 21768.6 22326.1 22440.7 22450.0 22489.2 22670.4 12376.8 12408.6 12439.2 12591.7 12596.6 15606.3 15795.7 15845.0 15874.5 15883.8 12474.7 12486.0 12511.9 12654.5 12738.6 12085.4 12100.8 12154.5 12261.7 12387.9 10654.6 10859.8 10897.4 10899.1 10913.3 8583.5 8618.4 8626.6 8676.4 8827.5 8572.2 8604.7 8647.3 8650.9 8702.8 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#4] prototype.html Cycles:180 Average:5857.39 Median:6441.10 stddev:1619.78 (25.1%) stddev-sans-first:1575.14 09:46:46 INFO - PID 17761 | Values: 579.9 582.9 596.9 600.5 626.4 6403.1 6432.4 6483.5 6517.4 6603.0 6420.7 6422.3 6450.0 6468.8 6505.3 5307.8 5307.8 5310.8 5320.3 5325.7 5299.3 5307.6 5330.8 5350.9 5364.8 5051.4 5130.8 5191.9 5199.7 5211.4 5174.4 5197.6 5216.2 5226.7 5231.7 4702.1 4717.5 4722.6 4731.8 4732.4 6279.3 6369.7 6381.9 6395.6 6447.0 6133.9 6168.9 6179.4 6197.7 6204.7 6713.6 6756.8 6898.2 6956.7 6963.8 5263.0 5276.8 5301.5 5315.2 5319.0 6962.8 6970.9 7093.6 7151.8 7221.6 5464.7 5477.4 5478.4 5488.1 5488.3 5535.4 5537.3 5544.9 5548.8 5566.8 6068.3 6088.3 6110.7 6129.6 6131.0 6885.5 6923.2 6923.3 6942.9 6984.4 1887.4 1893.6 1899.0 1908.4 1909.5 1289.4 1350.1 1351.8 1353.4 1372.1 6272.8 6353.5 6386.3 6456.6 6460.4 6696.5 6823.6 6864.4 6915.6 6919.0 6363.6 6389.4 6393.0 6412.8 6457.6 3708.7 3710.4 3712.9 3720.6 3727.2 7237.6 7260.4 7304.5 7318.6 7403.2 7177.3 7177.7 7201.5 7242.6 7258.9 7208.7 7253.9 7278.6 7293.3 7294.9 6933.3 6946.4 6977.9 6982.4 7006.2 6891.0 6950.4 6979.9 6982.9 6993.6 7192.9 7203.9 7236.8 7256.8 7337.6 5396.3 5436.8 5439.8 5439.9 5450.3 6915.8 6927.6 7011.6 7023.3 7076.0 6599.0 6723.8 6832.9 6841.0 6877.1 6754.4 6844.7 6861.0 6863.2 6886.0 6674.4 6677.6 6678.0 6719.1 6744.9 6777.7 6829.6 6878.6 6879.6 6923.6 6435.2 6576.6 6608.2 6667.2 6717.3 09:46:46 INFO - PID 17761 | 09:46:46 INFO - PID 17761 | [#5] yui.html Cycles:180 Average:28312.77 Median:17750.88 stddev:42927.91 (241.8%) stddev-sans-first:42999.27 09:46:46 INFO - PID 17761 | Values: 976.9 990.1 994.2 998.7 1021.6 18047.0 18141.5 18473.9 18569.6 18583.3 19660.7 19879.2 19949.8 19953.4 19990.8 1048.2 1054.7 1060.7 1060.9 1061.6 1068.1 1075.3 1084.7 1087.1 1095.0 1161.1 1163.1 1164.3 1165.4 1167.3 1146.6 1157.2 1158.1 1160.7 1163.2 857.2 858.9 858.9 859.2 859.3 18118.7 18146.5 18161.7 18163.6 20251.8 23436.2 23905.9 24144.2 24161.6 24164.6 18801.7 18910.7 19163.1 19188.2 19200.2 4022.6 4089.5 4111.1 4111.2 4117.2 154107.2 154601.0 155570.2 157537.0 159401.0 16318.3 16624.3 16671.8 16682.7 16720.4 34611.0 35006.3 35345.8 35487.0 35644.8 8906.2 8929.4 8960.6 9005.0 9026.2 4688.1 4727.5 4731.6 4786.0 4789.5 6227.0 6287.0 6292.7 6326.4 6347.4 1099.2 1149.6 1149.6 1158.5 1166.4 725.1 732.3 736.4 748.0 759.7 12863.4 13005.7 13249.0 13928.3 14164.7 734.9 744.9 750.0 767.6 770.7 6197.2 6346.8 6348.2 6360.0 6364.5 148934.0 150604.0 151163.0 152474.0 156972.2 135369.0 135739.0 135784.6 136847.0 140736.0 118213.4 118594.4 118926.0 119441.0 119934.4 11837.5 11914.0 11969.6 12012.3 12176.8 56557.2 56745.7 56985.7 57021.0 58380.4 72170.6 72219.3 73439.0 73475.0 73912.0 15179.6 15766.4 15842.4 15852.2 15858.0 17369.2 17754.1 17914.3 18009.5 18039.5 17630.0 17643.6 17740.1 17747.6 17889.0 16534.4 16743.5 16776.3 16874.7 16942.5 16324.3 16340.8 16516.3 16553.6 16569.5 11579.4 11597.8 11619.2 11971.2 12038.5 11870.0 11983.2 12112.8 12466.7 12522.4 09:46:46 INFO - PID 17761 | -------- Summary: end -------- 09:46:46 INFO - PID 17761 | 09:46:47 INFO - TEST-INFO | 17761: exit 0 09:46:47 INFO - TEST-OK | dromaeo_css | took 1107727ms 09:46:47 INFO - TEST-START | kraken 09:46:47 INFO - Initialising browser for kraken test... 09:46:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44805/getInfo.html -profile /tmp/tmp5xmwK5/profile 09:46:47 INFO - TEST-INFO | started process 18120 (/builds/slave/test/build/application/firefox/firefox http://localhost:44805/getInfo.html) 09:46:52 INFO - TEST-INFO | 18120: exit 0 09:46:52 INFO - Browser initialized. 09:46:52 INFO - Running cycle 1/1 for kraken test... 09:46:52 INFO - Using env: {'DISPLAY': ':0', 09:46:52 INFO - 'HOME': '/home/cltbld', 09:46:52 INFO - 'JSGC_DISABLE_POISONING': '1', 09:46:52 INFO - 'LANG': 'en_US.UTF-8', 09:46:52 INFO - 'LANGUAGE': 'en_US:en', 09:46:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:46:52 INFO - 'LOGNAME': 'cltbld', 09:46:52 INFO - 'MAIL': '/var/mail/cltbld', 09:46:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:46:52 INFO - 'MOZ_CRASHREPORTER': '1', 09:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:46:52 INFO - 'MOZ_NO_REMOTE': '1', 09:46:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:52 INFO - 'NO_EM_RESTART': '1', 09:46:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:52 INFO - 'PWD': '/builds/slave/test', 09:46:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:52 INFO - 'RUST_BACKTRACE': 'full', 09:46:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:46:52 INFO - 'SHELL': '/bin/bash', 09:46:52 INFO - 'SHLVL': '1', 09:46:52 INFO - 'TERM': 'linux', 09:46:52 INFO - 'TMOUT': '86400', 09:46:52 INFO - 'USER': 'cltbld', 09:46:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333', 09:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:52 INFO - '_': '/tools/buildbot/bin/python'} 09:46:52 INFO - TEST-INFO | started process 18312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5xmwK5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:53 INFO - PID 18312 | 09:46:53 INFO - PID 18312 | (/builds/slave/test/build/application/firefox/firefox:18361): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:46:53 INFO - PID 18312 | 09:47:03 INFO - PID 18312 | RSS: Main: 141950976 09:47:03 INFO - PID 18312 | 09:47:06 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44805/tests/kraken/driver.html?testName=audio-beat-detection) 09:47:07 INFO - PID 18312 | RSS: Main: 147734528 09:47:07 INFO - PID 18312 | 09:47:09 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44805/tests/kraken/driver.html?testName=audio-dft) 09:47:10 INFO - PID 18312 | RSS: Main: 148094976 09:47:10 INFO - PID 18312 | 09:47:13 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44805/tests/kraken/driver.html?testName=audio-fft) 09:47:13 INFO - PID 18312 | RSS: Main: 150482944 09:47:13 INFO - PID 18312 | 09:47:15 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44805/tests/kraken/driver.html?testName=audio-oscillator) 09:47:16 INFO - PID 18312 | RSS: Main: 150065152 09:47:16 INFO - PID 18312 | 09:47:18 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:19 INFO - PID 18312 | RSS: Main: 149311488 09:47:19 INFO - PID 18312 | 09:47:22 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44805/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:22 INFO - PID 18312 | RSS: Main: 149475328 09:47:22 INFO - PID 18312 | 09:47:26 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44805/tests/kraken/driver.html?testName=imaging-desaturate) 09:47:26 INFO - PID 18312 | RSS: Main: 152453120 09:47:26 INFO - PID 18312 | 09:47:29 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44805/tests/kraken/driver.html?testName=json-parse-financial) 09:47:30 INFO - PID 18312 | RSS: Main: 153202688 09:47:30 INFO - PID 18312 | 09:47:31 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:47:32 INFO - PID 18312 | RSS: Main: 152989696 09:47:32 INFO - PID 18312 | 09:47:34 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:47:34 INFO - PID 18312 | RSS: Main: 152723456 09:47:34 INFO - PID 18312 | 09:47:36 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:47:37 INFO - PID 18312 | RSS: Main: 149774336 09:47:37 INFO - PID 18312 | 09:47:39 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:47:40 INFO - PID 18312 | RSS: Main: 149295104 09:47:40 INFO - PID 18312 | 09:47:42 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:47:43 INFO - PID 18312 | RSS: Main: 149905408 09:47:43 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | Cycle 1(1): loaded http://localhost:44805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44805/tests/kraken/driver.html?testName=ai-astar) 09:47:45 INFO - PID 18312 | RSS: Main: 151236608 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | __start_tp_report 09:47:45 INFO - PID 18312 | _x_x_mozilla_page_load 09:47:45 INFO - PID 18312 | _x_x_mozilla_page_load_details 09:47:45 INFO - PID 18312 | |i|pagename|runs| 09:47:45 INFO - PID 18312 | |0;ai-astar;104;105;103;104;105;106;104;106;106;104 09:47:45 INFO - PID 18312 | |1;audio-beat-detection;112;113;110;114;112;112;140;116;111;114 09:47:45 INFO - PID 18312 | |2;audio-dft;162;161;163;163;164;163;163;162;162;162 09:47:45 INFO - PID 18312 | |3;audio-fft;77;72;72;73;74;76;73;73;73;73 09:47:45 INFO - PID 18312 | |4;audio-oscillator;78;78;77;76;76;76;76;78;76;77 09:47:45 INFO - PID 18312 | |5;imaging-gaussian-blur;114;114;114;113;114;114;115;110;114;110 09:47:45 INFO - PID 18312 | |6;imaging-darkroom;149;148;148;148;149;146;148;148;147;149 09:47:45 INFO - PID 18312 | |7;imaging-desaturate;94;94;94;93;99;99;94;95;94;94 09:47:45 INFO - PID 18312 | |8;json-parse-financial;47;47;41;42;44;45;44;44;52;48 09:47:45 INFO - PID 18312 | |9;json-stringify-tinderbox;39;39;39;38;39;39;40;38;39;40 09:47:45 INFO - PID 18312 | |10;stanford-crypto-aes;72;70;70;69;68;70;70;71;69;70 09:47:45 INFO - PID 18312 | |11;stanford-crypto-ccm;101;105;110;105;103;100;100;105;101;100 09:47:45 INFO - PID 18312 | |12;stanford-crypto-pbkdf2;151;166;149;146;152;152;150;147;147;157 09:47:45 INFO - PID 18312 | |13;stanford-crypto-sha256-iterative;61;62;58;58;56;65;57;58;58;63 09:47:45 INFO - PID 18312 | __end_tp_report 09:47:45 INFO - PID 18312 | __start_cc_report 09:47:45 INFO - PID 18312 | _x_x_mozilla_cycle_collect,709 09:47:45 INFO - PID 18312 | __end_cc_report 09:47:45 INFO - PID 18312 | __startTimestamp1506962865428__endTimestamp 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | ------- Summary: start ------- 09:47:45 INFO - PID 18312 | Number of tests: 14 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#0] ai-astar Cycles:10 Average:104.70 Median:105.00 stddev:1.06 (1.0%) stddev-sans-first:1.09 09:47:45 INFO - PID 18312 | Values: 104.0 105.0 103.0 104.0 105.0 106.0 104.0 106.0 106.0 104.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:113.50 stddev:8.81 (7.8%) stddev-sans-first:9.26 09:47:45 INFO - PID 18312 | Values: 112.0 113.0 110.0 114.0 112.0 112.0 140.0 116.0 111.0 114.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:47:45 INFO - PID 18312 | Values: 162.0 161.0 163.0 163.0 164.0 163.0 163.0 162.0 162.0 162.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.00 stddev:1.65 (2.3%) stddev-sans-first:1.20 09:47:45 INFO - PID 18312 | Values: 77.0 72.0 72.0 73.0 74.0 76.0 73.0 73.0 73.0 73.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 09:47:45 INFO - PID 18312 | Values: 78.0 78.0 77.0 76.0 76.0 76.0 76.0 78.0 76.0 77.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.75 (1.5%) stddev-sans-first:1.83 09:47:45 INFO - PID 18312 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 115.0 110.0 114.0 110.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 09:47:45 INFO - PID 18312 | Values: 149.0 148.0 148.0 148.0 149.0 146.0 148.0 148.0 147.0 149.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.16 (2.3%) stddev-sans-first:2.26 09:47:45 INFO - PID 18312 | Values: 94.0 94.0 94.0 93.0 99.0 99.0 94.0 95.0 94.0 94.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:46.00 stddev:3.20 (7.0%) stddev-sans-first:3.35 09:47:45 INFO - PID 18312 | Values: 47.0 47.0 41.0 42.0 44.0 45.0 44.0 44.0 52.0 48.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:0.67 (1.7%) stddev-sans-first:0.71 09:47:45 INFO - PID 18312 | Values: 39.0 39.0 39.0 38.0 39.0 39.0 40.0 38.0 39.0 40.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#10] stanford-crypto-aes Cycles:10 Average:69.90 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:0.87 09:47:45 INFO - PID 18312 | Values: 72.0 70.0 70.0 69.0 68.0 70.0 70.0 71.0 69.0 70.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#11] stanford-crypto-ccm Cycles:10 Average:103.00 Median:104.00 stddev:3.27 (3.1%) stddev-sans-first:3.38 09:47:45 INFO - PID 18312 | Values: 101.0 105.0 110.0 105.0 103.0 100.0 100.0 105.0 101.0 100.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:151.50 stddev:5.96 (3.9%) stddev-sans-first:6.32 09:47:45 INFO - PID 18312 | Values: 151.0 166.0 149.0 146.0 152.0 152.0 150.0 147.0 147.0 157.0 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.50 stddev:2.95 (5.0%) stddev-sans-first:3.09 09:47:45 INFO - PID 18312 | Values: 61.0 62.0 58.0 58.0 56.0 65.0 57.0 58.0 58.0 63.0 09:47:45 INFO - PID 18312 | -------- Summary: end -------- 09:47:45 INFO - PID 18312 | 09:47:45 INFO - PID 18312 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:47:45 INFO - TEST-INFO | 18312: exit 0 09:47:46 INFO - TEST-OK | kraken | took 58884ms 09:47:46 INFO - SUITE-END | took 1166s 09:47:46 INFO - Completed test suite (00:19:26) 09:47:46 INFO - javascript benchmark 09:47:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9438.013183754689, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3997.1206334606395, 4008.7394319369237, 4029.456023436837, 4030.496187976503, 4044.352903535435, 6596.373344532268, 6647.800565983016, 6690.799276021715, 6723.36128067834, 6736.360045795642, 6667.759742034207, 6686.966565167168, 6704.396604305612, 6792.592444453337, 6795.388415042645, 5897.793577224798, 5999.460048595625, 6007.759689612421, 6018.097285407181, 6103.42017508336, 5986.970065149668, 6002.549808764338, 6012.098185272201, 6027.306859711145, 6117.388261173869, 6051.818445446622, 6089.878202435949, 6098.847528811771, 6116.113163591299, 6135.8772824543485, 5988.041913293896, 6078.270607527125, 6086.2392200974655, 6133.570650054498, 6155.292141403729, 5891.322497912709, 5934.317553481319, 5947.4052594740615, 5951.256092988377, 6022.78920237794, 6555.541112122153, 6648.268690444047, 6716.093327400836, 6720.22717387497, 6760.492963027793, 7272.8545429091655, 7278.308560686726, 7281.927180728231, 7373.778786636356, 7379.225181355988, 7180.964095179543, 7283.4537409694485, 7288.1618613859555, 7298.781036568911, 7312.268773122699, 6699.0, 6740.662966851638, 6794.422474089708, 6799.0, 6823.351781580742, 7457.10514738224, 7467.51461155034, 7482.0, 7541.472096953161, 7584.924150758422, 7170.426365890717, 7210.819729506804, 7260.92739072613, 7282.817929551804, 7311.0495635568095, 7186.532875363085, 7268.0, 7278.09023872016, 7279.4540409468445, 7282.817929551804, 7200.207977122513, 7207.243239459781, 7216.783496495009, 7254.963725181446, 7269.418446524265, 7281.7087316507805, 7302.415806735448, 7306.853862922711, 7330.266973302733, 7339.229380915034, 5371.409144994048, 5374.113271310268, 5436.0, 5440.972795135999, 5483.095289277225, 4810.855674329776, 4839.274108883626, 4858.562729354375, 4869.074875773592, 4919.901601968012, 6780.525363224527, 6797.218319893177, 6811.727530898807, 6815.148106486689, 6817.420519255918, 7238.674259658328, 7263.673134708951, 7266.927330726625, 7297.379722723522, 7348.338649521569, 6663.86672266552, 6684.298148694317, 6708.228553716288, 6712.127423434922, 6812.591244525344, 6126.9387306127255, 6190.690465476709, 6193.411625895533, 6209.099680546386, 6225.035119556476, 7395.963020184972, 7486.6256687166515, 7536.133344665324, 7634.351080158138, 7647.426443016796, 7163.89254161188, 7300.744473943387, 7330.157031941395, 7332.193458719643, 7341.9632901837285, 7522.811929701801, 7551.471397002377, 7554.2823431773895, 7657.961710191414, 7660.80847978805, 7163.283671632795, 7175.174854891754, 7190.820229494096, 7218.602976836114, 7293.598852063187, 7298.601325479319, 7305.926940730737, 7349.265073492608, 7404.740834070782, 7410.036695229585, 7016.263292354433, 7045.964770176116, 7105.0, 7118.822029449305, 7127.073480447509, 6931.133608298963, 6985.26654701249, 7000.929990700028, 7006.5095443320515, 7108.3602475777425, 6964.0, 6965.44276457872, 6989.1962424321855, 6996.930030699831, 7001.229864714775, 6996.510244283055, 7133.571985680668, 7144.0, 7162.7493037743425, 7170.067891174114, 6779.0, 6863.759768408082, 6885.827854303682, 6962.686679099352, 6965.6168910708375], "value": 6658.460323123943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.188933185456, 1004.9648262310818, 1005.6681295172589, 1009.7122320138762, 1012.0587853296436, 45725.0, 46515.0, 46875.0, 46941.53058469423, 47013.29480057802, 43792.0, 43993.12013759723, 44086.55913440865, 44093.33859992103, 44119.11761764763, 8048.959755201216, 8265.090840007595, 8310.335173186131, 8313.459625124378, 8319.417640765148, 8067.3546116310845, 8182.918170818275, 8235.0, 8238.340932725398, 8249.587520623974, 8227.42408031438, 8852.8672069919, 9085.909140908572, 9086.59110340033, 9097.590608422637, 8972.820543589125, 9034.548272586344, 9035.683751068715, 9038.141376569216, 9041.0, 8582.098879617613, 8676.60955257015, 8678.86981695275, 8680.218780309802, 8682.86975695365, 41476.585234147875, 41667.58332416668, 41677.1664566707, 41789.0, 41936.79031604853, 3891.3579259422445, 3926.9410958835642, 3935.9963209381426, 3939.645431911113, 3956.7032472564674, 34883.0, 35088.82455587706, 35135.82432087823, 35178.82410587931, 35259.29481410383, 5740.052891272935, 5741.511971482429, 5765.913511297334, 5796.101604251347, 5857.209276747627, 222883.0, 224301.0, 224516.8774156135, 224587.0, 225028.0, 48791.26813097807, 49276.507234927194, 54549.45450545523, 54601.0, 55522.16716749252, 58642.4135758637, 58668.70665646644, 58757.41242587605, 58959.115613265836, 58976.70511647414, 18105.275788968556, 18132.0, 18197.363092291707, 18323.81676183221, 18333.633327333646, 14939.327730252166, 14972.625684357978, 14974.176420296988, 15287.61780955485, 15308.0, 15932.362705491882, 16068.67862642764, 16070.839291607168, 16140.19299035067, 16144.515664530083, 6198.380161983766, 6261.8747625047245, 6339.619622822645, 6371.267304259976, 6380.457661098766, 1100.7193165742685, 1110.650145204258, 1130.3161587239601, 1131.8868113188614, 1139.0432037088885, 26433.47133057328, 26697.19908402712, 26755.732442675326, 26784.86607566989, 27069.1879243623, 1247.3451437994943, 1249.2504497301547, 1251.8122281657825, 1256.849178098634, 1258.8929940955122, 14079.155250684787, 14167.149971001772, 14196.716065678835, 14268.14391136535, 14302.713945721027, 288180.0, 289098.0, 290091.0, 290585.0, 290774.0, 62075.689621552505, 62187.689061555306, 62376.376236237964, 62537.68731156406, 62680.0, 1558.6726787374778, 1573.8268790432815, 1606.775051492792, 1610.4202487104633, 1614.5882799885953, 25726.485470290863, 26075.60886586665, 26087.478250434506, 26256.0, 26470.0, 43463.0, 43565.78217108894, 43729.34405983849, 43784.343234850865, 43792.0, 247263.0, 247343.0, 248985.0, 249142.0, 250298.0, 37967.62032379641, 44057.55942440534, 44210.115797683226, 44870.3269450952, 44932.0, 54494.72752636211, 54841.903161937335, 54901.0, 55100.0, 55177.72411137919, 39731.40402893901, 40117.39823902585, 40561.79719101504, 40666.0, 40944.1811163781, 38964.012377461986, 39239.41140882832, 39919.40120898247, 40087.39868902027, 40661.0, 46102.56843948559, 46140.30789538092, 46190.538094619966, 46633.0, 46662.0, 37732.43401348927, 37788.244235114595, 37834.243315134096, 38051.0, 38374.80812595919, 28164.43671126607, 28281.57577636296, 28500.57249141223, 28767.280817979718, 28970.7102928968], "value": 19844.500790995786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.7642097330514, 637.640150010175, 649.7564653248286, 651.9247656990332, 656.2870906932901, 23465.0, 24078.518429631396, 24171.0, 24238.394040149004, 24272.514549708994, 25708.357291067732, 25987.61018584718, 26011.349716257057, 26067.86966065172, 26087.47825043498, 6251.4061164189325, 6463.967680161592, 6586.736530538773, 6626.701798419059, 6634.0712300278, 6581.144451221335, 6644.966775166117, 6671.966640166793, 6687.899681504781, 6695.732170713166, 6617.536772425932, 6621.6689165541775, 6763.222229443603, 7033.613151276678, 7035.542689725152, 7056.329648683392, 7092.716291348365, 7093.787186384365, 7100.822479438004, 7106.857862842766, 6613.107230523866, 6615.669216539154, 6621.9006714899315, 6627.668616569153, 6641.7675381361905, 29660.8516957416, 30106.946256880903, 30652.08043758691, 30826.845865770527, 30976.380472390425, 2271.579757744806, 2317.4322291038634, 2317.6639387288747, 2318.0843566791023, 2319.3389883883183, 20564.0, 20923.0, 20947.37157885266, 21161.365159045254, 21192.682109768364, 2610.2821724025853, 2643.7488438598493, 2694.8787304571147, 2711.769499592537, 2723.482538317713, 129508.35245823805, 135912.0, 157663.0, 164113.17943410325, 165674.17162914108, 15577.299021544057, 16366.754498682529, 16420.589485262964, 16573.0, 16958.152092395332, 26934.057307994128, 27107.1867843965, 27109.72890271072, 27162.45675086527, 27176.320591984964, 11039.282446640942, 11162.330260184415, 11181.490498782723, 11291.096712262999, 11301.265417747985, 10017.39895606266, 10040.196784257241, 10062.597496100074, 10086.092251697382, 10241.129503992244, 10021.747281589802, 10081.647142349982, 10309.845352319571, 10344.37933723979, 10531.368117912949, 2910.301527633395, 2929.4580502607087, 2963.170312312556, 2978.910632681023, 2992.7007299270335, 1033.3283365812283, 1047.2093569355088, 1055.466989170464, 1056.799208150449, 1057.1595581512715, 21320.36038918835, 21533.353999380044, 21659.891700541713, 21958.89020554887, 22040.0, 1119.5074167366333, 1134.7560274541013, 1138.6754774889116, 1142.6857614156174, 1147.6729132197283, 11987.580434684918, 12007.03943684503, 12070.69823254408, 12127.09046821492, 12166.330851803059, 665830.0, 682142.0, 688664.0, 691154.0, 704299.0, 132016.0, 133212.0, 136601.0, 139185.304073479, 139899.0, 1152.1128730877178, 1203.8374819399444, 1243.589615426907, 1264.89248413884, 1288.5103660608909, 22431.327060187567, 22671.319860404215, 22823.543529129656, 22855.428614284778, 22980.310590682308, 61478.38521614727, 61730.0, 62597.68701156465, 63823.0, 64015.359846402804, 78176.0, 78540.0, 79317.60341198256, 79387.20612793799, 79651.0, 15775.368985240462, 15814.683706325579, 15934.68130637404, 16025.919870400574, 16037.599060023593, 24615.63076553889, 24736.752632474167, 24757.0, 24796.38009049788, 25006.499870002863, 20283.290084846958, 20436.489087772923, 20466.692999605315, 20479.385618430875, 20525.589488209855, 16638.417655382487, 16693.666126677155, 17058.232379542704, 17528.73706894372, 17623.91188044103, 20123.899380503004, 20374.98125093769, 20412.795872041683, 20520.692189617468, 20659.8967005164, 15691.686166276839, 15742.134182620066, 15810.367585296919, 15819.446319378767, 15845.52463426099, 19978.400647980583, 20120.29578964729, 20222.595548088662, 20359.287424940056, 20394.49013774608], "value": 13137.90922040177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.8956373053886, 1526.0233450591622, 1534.892557520974, 1544.6987837371703, 1573.2684301799663, 17074.14629268538, 17829.0, 17837.732434013502, 17837.732434013502, 17866.91066544667, 17247.137643117858, 17418.0, 17422.651546969053, 17450.040247786368, 17457.912710436463, 3152.8738850445957, 3167.3348596794644, 3229.0474310078584, 3233.1755402372364, 3234.514822776579, 3075.6463006754284, 3105.7825952183357, 3125.2968082181555, 3135.7648176386747, 3143.167060728909, 3062.3569050499423, 3064.356485138124, 3183.060997005877, 3185.7769956103084, 3187.2509960159346, 3198.8880389186384, 3222.9194270143316, 3235.7411407087375, 3241.724453421462, 3244.951325730116, 2976.7469765069995, 2991.072767442078, 3026.772992025607, 3028.7122723341467, 3029.2124047747743, 16936.915315423466, 17298.740518892228, 17299.13504324779, 17313.56716082108, 17318.307267709275, 9029.413088149315, 9256.305777066747, 9300.674476393293, 9303.883533975899, 9310.348275620709, 5771.88456230873, 5996.220491336098, 6133.202683651141, 6204.503639708858, 6207.782727604557, 2067.793220677935, 2141.0686351437175, 2150.2689085710936, 2169.6528555431214, 2178.357384571555, 28470.0, 28662.14013579596, 28740.0, 28755.856220718764, 28770.71229287701, 7737.264959828807, 7998.240167184108, 8021.879671804811, 8141.8371632568205, 8188.385871059694, 19984.90007549953, 20062.699059514118, 20068.297609583595, 20071.59856802856, 20096.296629617893, 8482.915170848213, 8564.143585641386, 8564.272036876811, 8571.699990500427, 8592.613332400057, 7819.726309579251, 7843.803904902309, 8029.397795165269, 8232.012158541014, 8249.0, 6092.603980741238, 6119.265688117454, 6467.51493637979, 6560.44236239925, 6574.901376479356, 1635.5093471958364, 1684.4946516045138, 1843.0692500287269, 1879.5019319880244, 1952.3654812185812, 1012.3268026762121, 1043.838205078214, 1052.8420736889375, 1053.1574740207802, 1058.7088550648634, 10211.438370889524, 10252.38485690861, 10373.948130259301, 10394.272400932014, 10398.636047738293, 869.4565896314804, 909.940853844498, 1127.3912087472836, 1128.6049882541045, 1149.5516748468103, 5938.8218353449465, 6212.534059945522, 6305.495560355161, 6339.904901426482, 6641.701123449457, 24930.875345623157, 26338.20985370442, 26433.339166520607, 26445.73554264433, 26500.072497462497, 24442.87778561096, 25239.62140567893, 25785.871070644527, 25884.0, 26011.219663410127, 11987.76024479523, 12034.338111403957, 12051.096167787451, 12090.879091208975, 12091.153619246568, 9810.558524866256, 10036.698899033041, 10211.183105351405, 10316.381017138996, 10462.476876156314, 21229.893850530647, 21317.680234796182, 21364.572708546053, 21593.35219943404, 21768.56462870702, 22326.10695572159, 22440.66339004949, 22450.0, 22489.212877549206, 22670.433239168495, 12376.75246495083, 12408.62774116778, 12439.191452555555, 12591.748165036832, 12596.55912043074, 15606.297716603007, 15795.684086318439, 15845.0, 15874.52376428709, 15883.761743574087, 12474.688132796753, 12486.0, 12511.93744031274, 12654.493820247088, 12738.554150605056, 12085.395730213279, 12100.818487722867, 12154.453049612965, 12261.69345766363, 12387.938060309642, 10654.57381704723, 10859.782804343711, 10897.400642964712, 10899.128069754559, 10913.290636108628, 8583.527905964982, 8618.353623478139, 8626.61180246903, 8676.436031657922, 8827.514486703292, 8572.228499435081, 8604.741857744277, 8647.26498247656, 8650.870236946324, 8702.782430439036], "value": 7676.402118771014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9246098007259, 582.8863371642528, 596.8567543789491, 600.5135839969628, 626.3892704613003, 6403.103565500828, 6432.421082102615, 6483.481321494287, 6517.380848819366, 6603.0, 6420.678966051702, 6422.261439934409, 6449.967750161242, 6468.805935821921, 6505.284418713938, 5307.787688492455, 5307.840764777054, 5310.840674779763, 5320.308359913206, 5325.653832500875, 5299.258103865462, 5307.575393968493, 5330.760115794779, 5350.946490535103, 5364.758585863646, 5051.444341122492, 5130.846074617767, 5191.87020324493, 5199.740012999354, 5211.3746350438005, 5174.43081261061, 5197.636165468419, 5216.191490319006, 5226.738663066832, 5231.712255825947, 4702.106599746072, 4717.504662010474, 4722.598579120779, 4731.810727570927, 4732.384789977315, 6279.277883043463, 6369.6815159242315, 6381.904271435932, 6395.616263024233, 6446.967765161191, 6133.938660613381, 6168.907466388007, 6179.443850053472, 6197.721102550351, 6204.720787564571, 6713.630750308731, 6756.797296081077, 6898.241193468714, 6956.721731130749, 6963.825904352381, 5263.0, 5276.841694749125, 5301.549368303698, 5315.202719592092, 5319.0, 6962.825929351756, 6970.930290697079, 7093.609851458219, 7151.7854464366155, 7221.638918054076, 5464.672119672832, 5477.370102438271, 5478.369987451494, 5488.094464413327, 5488.286522752097, 5535.446455354513, 5537.280153580089, 5544.861378465571, 5548.805791797267, 5566.777328906798, 6068.33248342682, 6088.325710429667, 6110.663913484801, 6129.601575897553, 6131.0, 6885.4539911945385, 6923.165361179292, 6923.342282483156, 6942.895856562156, 6984.371406573433, 1887.424335577662, 1893.611809579033, 1898.9620207595772, 1908.4370110817342, 1909.5321646196771, 1289.4390939941156, 1350.1291666875006, 1351.797230415426, 1353.3842101843834, 1372.1286982765816, 6272.8118156455375, 6353.491720662336, 6386.329435409308, 6456.644884531302, 6460.3862633049785, 6696.46428285736, 6823.601161761827, 6864.4165245954655, 6915.619640919797, 6919.031335613018, 6363.61818290904, 6389.361063893573, 6392.968035159794, 6412.807615771534, 6457.580257283262, 3708.721845861571, 3710.443433484999, 3712.8514859405323, 3720.5721342046013, 3727.1800203955086, 7237.565746055254, 7260.382867456326, 7304.452166087564, 7318.597477138702, 7403.185649578542, 7177.282271772781, 7177.7487787927175, 7201.495895287384, 7242.601656908815, 7258.927410725931, 7208.711651533985, 7253.891191632129, 7278.563286202739, 7293.343599076109, 7294.9270507295305, 6933.306669333027, 6946.37482626566, 6977.918422644499, 6982.371586557234, 7006.229314775473, 6890.965545172242, 6950.443964482931, 6979.930200698132, 6982.930170698228, 6993.5663189047145, 7192.8921066183, 7203.927960720326, 7236.819079523054, 7256.7822965311125, 7337.633118343954, 5396.271503346998, 5436.809711660231, 5439.782408703608, 5439.918401224064, 5450.345958485007, 6915.757948471779, 6927.618980956096, 7011.6494175292055, 7023.262557431396, 7076.00935868989, 6598.967005165136, 6723.781152219658, 6832.897506537505, 6840.965795170992, 6877.140357455318, 6754.425873800782, 6844.699507093636, 6861.0, 6863.176418829772, 6886.0, 6674.399304062657, 6677.565958212701, 6678.0, 6719.126513553402, 6744.932550674431, 6777.695003724745, 6829.6243706596615, 6878.621675807879, 6879.624075184883, 6923.6192009439965, 6435.22777266731, 6576.572522786004, 6608.173978252718, 6667.199936007516, 6717.2946840581035], "value": 5394.069366191618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.9364991275567, 990.14847231381, 994.1897353656765, 998.7066748560616, 1021.5760459409348, 18047.0, 18141.546461338472, 18473.907630461847, 18569.62860742786, 18583.349582764607, 19660.705089423634, 19879.204831806746, 19949.800501994974, 19953.40139795805, 19990.800091999114, 1048.1509976918721, 1054.667779649408, 1060.6764936694306, 1060.931039482435, 1061.6337363609543, 1068.1294744782977, 1075.2741899218036, 1084.69628504019, 1087.1140020882956, 1095.014486961733, 1161.1465572803982, 1163.052112528291, 1164.2665120973775, 1165.3648761425002, 1167.2529581068122, 1146.5700362364114, 1157.2073129906041, 1158.0503986730926, 1160.6866146140494, 1163.1683346407317, 857.1728282207699, 858.8797568340437, 858.9055203927626, 859.2395729779128, 859.3426029087752, 18118.728219076726, 18146.45560633183, 18161.7275740864, 18163.63672726551, 20251.79748202514, 23436.17973370941, 23905.88047059771, 24144.154954576505, 24161.637575436205, 24164.637530437056, 18801.717974230396, 18910.716339254923, 19163.137658805386, 19188.232470701154, 19200.231990720353, 4022.577629348935, 4089.4683691120263, 4111.054457474767, 4111.157212771374, 4117.238310912461, 154107.22946385195, 154601.0, 155570.22214888968, 157537.0, 159401.0, 16318.34726610946, 16624.3350265988, 16671.833281667026, 16682.666346673, 16720.41478548245, 34611.0, 35006.299874002376, 35345.82327088399, 35487.0, 35644.82177589095, 8906.242969347548, 8929.419587726778, 8960.596773145224, 9004.954975225082, 9026.232770214474, 4688.132695451352, 4727.479977202505, 4731.597814185764, 4785.95214047862, 4789.544993225638, 6226.968865155736, 6287.0, 6292.716827742763, 6326.43062124411, 6347.365263473615, 1099.1591432554103, 1149.6378640728144, 1149.6436104807538, 1158.530795028015, 1166.4401087478059, 725.0936329588015, 732.2531018361242, 736.3777607921298, 748.046241042675, 759.7075126076501, 12863.356832158355, 13005.739885202433, 13249.0, 13928.303584820718, 14164.716705665829, 734.9191588925214, 744.9441291903021, 749.9512531685423, 767.6353731977377, 770.6686124966318, 6197.163382943335, 6346.809595712136, 6348.238211414568, 6360.0, 6364.522660800459, 148934.0, 150604.0, 151163.0, 152474.0, 156972.21513892585, 135369.0, 135739.0, 135784.6421535792, 136847.0, 140736.0, 118213.4089329565, 118594.4070279643, 118926.0, 119441.0, 119934.4003279978, 11837.467313971065, 11914.046876250053, 11969.64091077269, 12012.339321337235, 12176.817347739969, 56557.151642724566, 56745.71627141838, 56985.715071426035, 57021.0, 58380.4161958392, 72170.55658886897, 72219.27780722125, 73439.0, 73475.0, 73912.0, 15179.620509487351, 15766.448174313844, 15842.366305348118, 15852.207389630703, 15858.048517089012, 17369.21838517295, 17754.112294385486, 17914.283428662708, 18009.459716208534, 18039.458816235532, 17630.0, 17643.55891102733, 17740.11299435049, 17747.645047099242, 17889.0, 16534.421295254608, 16743.497695069167, 16776.32894684199, 16874.746878797072, 16942.491725248263, 16324.265408056428, 16340.754888676442, 16516.256768445688, 16553.586160346087, 16569.502914912573, 11579.363135027654, 11597.76804463923, 11619.186656934271, 11971.16201865861, 12038.458269377725, 11870.0, 11983.161178717406, 12112.818307725214, 12466.688332791753, 12522.37388130608], "value": 9832.040425159405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 103.0, 104.0, 105.0, 106.0, 104.0, 106.0, 106.0, 104.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 110.0, 114.0, 112.0, 112.0, 140.0, 116.0, 111.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 164.0, 163.0, 163.0, 162.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 72.0, 73.0, 74.0, 76.0, 73.0, 73.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 76.0, 76.0, 76.0, 76.0, 78.0, 76.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 110.0, 114.0, 110.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 149.0, 146.0, 148.0, 148.0, 147.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 99.0, 99.0, 94.0, 95.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 41.0, 42.0, 44.0, 45.0, 44.0, 44.0, 52.0, 48.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 38.0, 39.0, 39.0, 40.0, 38.0, 39.0, 40.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 69.0, 68.0, 70.0, 70.0, 71.0, 69.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 105.0, 110.0, 105.0, 103.0, 100.0, 100.0, 105.0, 101.0, 100.0], "value": 103.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 166.0, 149.0, 146.0, 152.0, 152.0, 150.0, 147.0, 147.0, 157.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 58.0, 58.0, 56.0, 65.0, 57.0, 58.0, 58.0, 63.0], "value": 59.6, "unit": "score"}]}]} 09:47:46 INFO - Return code: 0 09:47:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:47:46 INFO - # TBPL SUCCESS # 09:47:46 INFO - Running post-action listener: _package_coverage_data 09:47:46 INFO - Running post-action listener: _resource_record_post_action 09:47:46 INFO - [mozharness: 2017-10-02 16:47:46.241491Z] Finished run-tests step (success) 09:47:46 INFO - Running post-run listener: _resource_record_post_run 09:47:46 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 155648; Write bytes: 281108480; Read time: 292; Write time: 177156 09:47:46 INFO - TinderboxPrint: CPU usage
13.0% 09:47:46 INFO - TinderboxPrint: I/O read bytes / time
155,648 / 292 09:47:46 INFO - TinderboxPrint: I/O write bytes / time
281,108,480 / 177,156 09:47:46 INFO - TinderboxPrint: CPU idle
8,195.5 (86.9%) 09:47:46 INFO - TinderboxPrint: CPU user
1,181.0 (12.5%) 09:47:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:47:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 487424; Read time: 0; Write time: 44 09:47:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:47:46 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 155648; Write bytes: 273031168; Read time: 292; Write time: 176196 09:47:46 INFO - Running post-run listener: _upload_blobber_files 09:47:46 INFO - Blob upload gear active. 09:47:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:47:46 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 09:47:46 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'] 09:47:46 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 09:47:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:48 INFO - (blobuploader) - INFO - Done attempting. 09:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:49 INFO - (blobuploader) - INFO - Done attempting. 09:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:57 INFO - (blobuploader) - INFO - Done attempting. 09:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:58 INFO - (blobuploader) - INFO - Done attempting. 09:47:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:58 INFO - Return code: 0 09:47:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e7f9bf4b060178d478eceb555e445a1b46b2d014001449bd5e5a316ebd626643c366891dd9b4ee40714d629f2bd0878679fd1e054572efa20ce119c950a0a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/547ddea2514437b35d940003aa64dfd4ef72b94a5e4f35479f3195b27ed6ea45604dbb3be87e4ac2054ccde215be7f457b4ecfe69355b0aa6a6bab484ca11020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea8b03541b4cb90c93dd796efd87489e21e3d34bd8efe73a2ed93010c013b630e98c2453bf540c33c357f3411ce68489232060571ec6fe0b35e78f1c9ca9efd5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3eb058308f1651bc66c0722b649c90eb7bb64226301b31775578ab76a5a6a178614124051f316f0f3e9e9c6f879bc7848fc6578f0487277e79f6f21a8f7fa532"} 09:47:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:58 INFO - Contents: 09:47:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e7f9bf4b060178d478eceb555e445a1b46b2d014001449bd5e5a316ebd626643c366891dd9b4ee40714d629f2bd0878679fd1e054572efa20ce119c950a0a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/547ddea2514437b35d940003aa64dfd4ef72b94a5e4f35479f3195b27ed6ea45604dbb3be87e4ac2054ccde215be7f457b4ecfe69355b0aa6a6bab484ca11020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea8b03541b4cb90c93dd796efd87489e21e3d34bd8efe73a2ed93010c013b630e98c2453bf540c33c357f3411ce68489232060571ec6fe0b35e78f1c9ca9efd5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3eb058308f1651bc66c0722b649c90eb7bb64226301b31775578ab76a5a6a178614124051f316f0f3e9e9c6f879bc7848fc6578f0487277e79f6f21a8f7fa532"} 09:47:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:58 INFO - Copying logs to upload dir... 09:47:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.231343 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-02 09:47:58.913994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 09:47:58.918553) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 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/0e7f9bf4b060178d478eceb555e445a1b46b2d014001449bd5e5a316ebd626643c366891dd9b4ee40714d629f2bd0878679fd1e054572efa20ce119c950a0a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/547ddea2514437b35d940003aa64dfd4ef72b94a5e4f35479f3195b27ed6ea45604dbb3be87e4ac2054ccde215be7f457b4ecfe69355b0aa6a6bab484ca11020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea8b03541b4cb90c93dd796efd87489e21e3d34bd8efe73a2ed93010c013b630e98c2453bf540c33c357f3411ce68489232060571ec6fe0b35e78f1c9ca9efd5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3eb058308f1651bc66c0722b649c90eb7bb64226301b31775578ab76a5a6a178614124051f316f0f3e9e9c6f879bc7848fc6578f0487277e79f6f21a8f7fa532"} build_url:https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/VfYCFd2PRVCP0O_0AkRJYQ/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/0e7f9bf4b060178d478eceb555e445a1b46b2d014001449bd5e5a316ebd626643c366891dd9b4ee40714d629f2bd0878679fd1e054572efa20ce119c950a0a0f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/547ddea2514437b35d940003aa64dfd4ef72b94a5e4f35479f3195b27ed6ea45604dbb3be87e4ac2054ccde215be7f457b4ecfe69355b0aa6a6bab484ca11020", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea8b03541b4cb90c93dd796efd87489e21e3d34bd8efe73a2ed93010c013b630e98c2453bf540c33c357f3411ce68489232060571ec6fe0b35e78f1c9ca9efd5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3eb058308f1651bc66c0722b649c90eb7bb64226301b31775578ab76a5a6a178614124051f316f0f3e9e9c6f879bc7848fc6578f0487277e79f6f21a8f7fa532"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 09:47:58.951818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:47:58.952192) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506960738.767092-672507333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 09:47:59.037365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 09:47:59.037783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 09:47:59.038215) ========= ========= Total master_lag: 0.63 =========