builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1488460991.71 results: success (0) revision: 4cd258347baab9f8dbe1ffbdf0238cfe3686509f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:11.713960) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:11.714654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:11.714921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:11.748931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:11.749188) ========= 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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-02 05:23:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-03-02 05:23:12 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:12.036940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:12.037247) ========= 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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015708 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:12.097701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 05:23:12.098055) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4cd258347baab9f8dbe1ffbdf0238cfe3686509f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4cd258347baab9f8dbe1ffbdf0238cfe3686509f --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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-02 05:23:12,982 truncating revision to first 12 chars 2017-03-02 05:23:12,982 Setting DEBUG logging. 2017-03-02 05:23:12,982 attempt 1/10 2017-03-02 05:23:12,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4cd258347baa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 05:23:14,130 unpacking tar archive at: mozilla-aurora-4cd258347baa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470506 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 05:23:13.584415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:13.584720) ========= script_repo_revision: 4cd258347baab9f8dbe1ffbdf0238cfe3686509f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:13.585072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:13.585327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:23:13.593912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-03-02 05:23:13.594173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:14 INFO - MultiFileLogger online at 20170302 05:23:14 in /builds/slave/test 05:23:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 05:23:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:14 INFO - {'append_to_log': False, 05:23:14 INFO - 'base_work_dir': '/builds/slave/test', 05:23:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 05:23:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:14 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 05:23:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:14 INFO - 'config_files': ('talos/linux_config.py',), 05:23:14 INFO - 'default_actions': ('clobber', 05:23:14 INFO - 'read-buildbot-config', 05:23:14 INFO - 'download-and-extract', 05:23:14 INFO - 'populate-webroot', 05:23:14 INFO - 'create-virtualenv', 05:23:14 INFO - 'install', 05:23:14 INFO - 'run-tests'), 05:23:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:14 INFO - 'download_minidump_stackwalk': True, 05:23:14 INFO - 'download_symbols': 'ondemand', 05:23:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:14 INFO - 'installer_path': 'installer.exe', 05:23:14 INFO - 'log_level': 'info', 05:23:14 INFO - 'log_name': 'talos', 05:23:14 INFO - 'log_to_console': True, 05:23:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:14 INFO - 'opt_config_files': (), 05:23:14 INFO - 'pip_index': False, 05:23:14 INFO - 'sps_profile': False, 05:23:14 INFO - 'sps_profile_interval': 0, 05:23:14 INFO - 'suite': 'dromaeojs', 05:23:14 INFO - 'system_bits': '32', 05:23:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:14 INFO - 'title': 'talos-linux64-ix-050', 05:23:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:14 INFO - 'use_talos_json': True, 05:23:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:14 INFO - 'work_dir': 'build'} 05:23:14 INFO - [mozharness: 2017-03-02 13:23:14.572148Z] Running clobber step. 05:23:14 INFO - Running pre-action listener: _resource_record_pre_action 05:23:14 INFO - Running main action method: clobber 05:23:14 INFO - rmtree: /builds/slave/test/build 05:23:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:15 INFO - Running post-action listener: _resource_record_post_action 05:23:15 INFO - [mozharness: 2017-03-02 13:23:15.498672Z] Finished clobber step (success) 05:23:15 INFO - [mozharness: 2017-03-02 13:23:15.498775Z] Running read-buildbot-config step. 05:23:15 INFO - Running pre-action listener: _resource_record_pre_action 05:23:15 INFO - Running main action method: read_buildbot_config 05:23:15 INFO - Using buildbot properties: 05:23:15 INFO - { 05:23:15 INFO - "project": "", 05:23:15 INFO - "product": "firefox", 05:23:15 INFO - "who": "ryanvm@gmail.com", 05:23:15 INFO - "installer_path": "public/build/target.tar.bz2", 05:23:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:23:15 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 05:23:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 05:23:15 INFO - "stage_platform": "linux64", 05:23:15 INFO - "basedir": "/builds/slave/test", 05:23:15 INFO - "buildnumber": 55, 05:23:15 INFO - "platform": "ubuntu64_hw", 05:23:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:23:15 INFO - "slavebuilddir": "test", 05:23:15 INFO - "taskId": "Uw2gnvdfS3OH3jCsqSKtEA", 05:23:15 INFO - "branch": "mozilla-aurora", 05:23:15 INFO - "script_repo_revision": "production", 05:23:15 INFO - "revision": "4cd258347baab9f8dbe1ffbdf0238cfe3686509f", 05:23:15 INFO - "slavename": "talos-linux64-ix-050", 05:23:15 INFO - "repo_path": "releases/mozilla-aurora" 05:23:15 INFO - } 05:23:15 INFO - Finding installer, test and symbols from parent task. 05:23:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uw2gnvdfS3OH3jCsqSKtEA'}, attempt #1 05:23:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uw2gnvdfS3OH3jCsqSKtEA'}, attempt #1 05:23:16 INFO - Task dependencies: LQ8gXmQeTryEwGKN2kdMCQ 05:23:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ'}, attempt #1 05:23:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 05:23:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/test_packages.json 05:23:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.crashreporter-symbols.zip 05:23:16 INFO - Running post-action listener: _resource_record_post_action 05:23:16 INFO - [mozharness: 2017-03-02 13:23:16.998268Z] Finished read-buildbot-config step (success) 05:23:16 INFO - [mozharness: 2017-03-02 13:23:16.998486Z] Running download-and-extract step. 05:23:16 INFO - Running pre-action listener: _resource_record_pre_action 05:23:16 INFO - Running main action method: download_and_extract 05:23:16 INFO - mkdir: /builds/slave/test/build/tests 05:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:16 INFO - trying https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.test_packages.json 05:23:17 INFO - Downloading https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:23:17 INFO - Downloaded 896 bytes. 05:23:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:23:17 INFO - Using the following test package requirements: 05:23:17 INFO - {u'common': [u'target.common.tests.zip'], 05:23:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:23:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:23:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:23:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:23:17 INFO - u'mozbase': [u'target.common.tests.zip'], 05:23:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:23:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:23:17 INFO - u'web-platform': [u'target.common.tests.zip', 05:23:17 INFO - u'target.web-platform.tests.zip'], 05:23:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:23:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip 05:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip into memory 05:23:18 INFO - Expected file size: 21861836 05:23:18 INFO - Obtained file size: 21861836 05:23:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:23:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip 05:23:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:23:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.common.tests.zip into memory 05:23:23 INFO - Expected file size: 21861836 05:23:23 INFO - Obtained file size: 21861836 05:23:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.talos.tests.zip 05:23:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:23:27 INFO - Fetch https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.talos.tests.zip into memory 05:23:29 INFO - Expected file size: 14403472 05:23:29 INFO - Obtained file size: 14403472 05:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:29 INFO - trying https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 05:23:29 INFO - Downloading https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:23:31 INFO - Downloaded 66074358 bytes. 05:23:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 05:23:31 INFO - mkdir: /builds/slave/test/properties 05:23:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:31 INFO - Contents: 05:23:31 INFO - build_url:https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 05:23:31 INFO - Running post-action listener: _resource_record_post_action 05:23:31 INFO - Running post-action listener: set_extra_try_arguments 05:23:31 INFO - [mozharness: 2017-03-02 13:23:31.831423Z] Finished download-and-extract step (success) 05:23:31 INFO - [mozharness: 2017-03-02 13:23:31.831541Z] Running populate-webroot step. 05:23:31 INFO - Running pre-action listener: _resource_record_pre_action 05:23:31 INFO - Running main action method: populate_webroot 05:23:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:31 INFO - '--tppagecycles', 05:23:31 INFO - '7'], 05:23:31 INFO - 'tests': ['tsvgm']}}, 05:23:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['damp', 'tps']}, 05:23:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'tests': ['damp', 'tps']}, 05:23:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['dromaeo_dom']}, 05:23:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['basic_compositor_video']}, 05:23:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:23:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['a11yr', 05:23:31 INFO - 'ts_paint', 05:23:31 INFO - 'tpaint', 05:23:31 INFO - 'sessionrestore', 05:23:31 INFO - 'sessionrestore_no_auto_restore', 05:23:31 INFO - 'tabpaint']}, 05:23:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['tsvgx', 05:23:31 INFO - 'tsvgr_opacity', 05:23:31 INFO - 'tart', 05:23:31 INFO - 'tscrollx', 05:23:31 INFO - 'cart', 05:23:31 INFO - 'tsvg_static']}, 05:23:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:31 INFO - 'tsvgr_opacity', 05:23:31 INFO - 'tart', 05:23:31 INFO - 'tscrollx', 05:23:31 INFO - 'cart', 05:23:31 INFO - 'tsvg_static']}, 05:23:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'talos_options': ['--disable-e10s'], 05:23:31 INFO - 'tests': ['tp5o']}, 05:23:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:23:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'talos_options': ['--disable-e10s', 05:23:31 INFO - '--xperf_path', 05:23:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:31 INFO - 'tests': ['tp5n']}, 05:23:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:23:31 INFO - 'talos_options': ['--xperf_path', 05:23:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:31 INFO - 'tests': ['tp5n']}}, 05:23:31 INFO - 'talos.zip': {'path': '', 05:23:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:31 INFO - Running post-action listener: _resource_record_post_action 05:23:31 INFO - [mozharness: 2017-03-02 13:23:31.845510Z] Finished populate-webroot step (success) 05:23:31 INFO - [mozharness: 2017-03-02 13:23:31.845601Z] Running create-virtualenv step. 05:23:31 INFO - Running pre-action listener: _resource_record_pre_action 05:23:31 INFO - Running main action method: create_virtualenv 05:23:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:23:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:31 INFO - Using real prefix '/usr' 05:23:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:34 INFO - Installing pip.................done. 05:23:34 INFO - Return code: 0 05:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:23:34 INFO - Reading from file tmpfile_stdout 05:23:34 INFO - Output received: 05:23:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:23:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:23:34 INFO - Using env: {'DISPLAY': ':0', 05:23:34 INFO - 'HOME': '/home/cltbld', 05:23:34 INFO - 'LANG': 'en_US.UTF-8', 05:23:34 INFO - 'LANGUAGE': 'en_US:en', 05:23:34 INFO - 'LOGNAME': 'cltbld', 05:23:34 INFO - 'MAIL': '/var/mail/cltbld', 05:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:34 INFO - 'MOZ_NO_REMOTE': '1', 05:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:34 INFO - 'NO_EM_RESTART': '1', 05:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:34 INFO - 'PWD': '/builds/slave/test', 05:23:34 INFO - 'SHELL': '/bin/bash', 05:23:34 INFO - 'SHLVL': '1', 05:23:34 INFO - 'TERM': 'linux', 05:23:34 INFO - 'TMOUT': '86400', 05:23:34 INFO - 'USER': 'cltbld', 05:23:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:34 INFO - '_': '/tools/buildbot/bin/python'} 05:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:23:34 INFO - Cleaning up... 05:23:34 INFO - Return code: 0 05:23:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:23:34 INFO - Using env: {'DISPLAY': ':0', 05:23:34 INFO - 'HOME': '/home/cltbld', 05:23:34 INFO - 'LANG': 'en_US.UTF-8', 05:23:34 INFO - 'LANGUAGE': 'en_US:en', 05:23:34 INFO - 'LOGNAME': 'cltbld', 05:23:34 INFO - 'MAIL': '/var/mail/cltbld', 05:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:34 INFO - 'MOZ_NO_REMOTE': '1', 05:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:34 INFO - 'NO_EM_RESTART': '1', 05:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:34 INFO - 'PWD': '/builds/slave/test', 05:23:34 INFO - 'SHELL': '/bin/bash', 05:23:34 INFO - 'SHLVL': '1', 05:23:34 INFO - 'TERM': 'linux', 05:23:34 INFO - 'TMOUT': '86400', 05:23:34 INFO - 'USER': 'cltbld', 05:23:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:34 INFO - '_': '/tools/buildbot/bin/python'} 05:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:35 INFO - Downloading/unpacking psutil>=3.1.1 05:23:35 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 05:23:35 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 05:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:35 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 05:23:35 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 05:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:37 INFO - Installing collected packages: psutil 05:23:37 INFO - Running setup.py install for psutil 05:23:37 INFO - building 'psutil._psutil_linux' extension 05:23:37 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 05:23:37 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 05:23:37 INFO - building 'psutil._psutil_posix' extension 05:23:37 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 05:23:37 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 05:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:37 INFO - Successfully installed psutil 05:23:37 INFO - Cleaning up... 05:23:37 INFO - Return code: 0 05:23:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:23:37 INFO - Using env: {'DISPLAY': ':0', 05:23:37 INFO - 'HOME': '/home/cltbld', 05:23:37 INFO - 'LANG': 'en_US.UTF-8', 05:23:37 INFO - 'LANGUAGE': 'en_US:en', 05:23:37 INFO - 'LOGNAME': 'cltbld', 05:23:37 INFO - 'MAIL': '/var/mail/cltbld', 05:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:37 INFO - 'MOZ_NO_REMOTE': '1', 05:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:37 INFO - 'NO_EM_RESTART': '1', 05:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:37 INFO - 'PWD': '/builds/slave/test', 05:23:37 INFO - 'SHELL': '/bin/bash', 05:23:37 INFO - 'SHLVL': '1', 05:23:37 INFO - 'TERM': 'linux', 05:23:37 INFO - 'TMOUT': '86400', 05:23:37 INFO - 'USER': 'cltbld', 05:23:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:37 INFO - '_': '/tools/buildbot/bin/python'} 05:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:23:37 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 05:23:37 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 05:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:37 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 05:23:37 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 05:23:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:23:40 INFO - Installing collected packages: mozsystemmonitor 05:23:40 INFO - Running setup.py install for mozsystemmonitor 05:23:40 INFO - Successfully installed mozsystemmonitor 05:23:40 INFO - Cleaning up... 05:23:40 INFO - Return code: 0 05:23:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:23:40 INFO - Using env: {'DISPLAY': ':0', 05:23:40 INFO - 'HOME': '/home/cltbld', 05:23:40 INFO - 'LANG': 'en_US.UTF-8', 05:23:40 INFO - 'LANGUAGE': 'en_US:en', 05:23:40 INFO - 'LOGNAME': 'cltbld', 05:23:40 INFO - 'MAIL': '/var/mail/cltbld', 05:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:40 INFO - 'MOZ_NO_REMOTE': '1', 05:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:40 INFO - 'NO_EM_RESTART': '1', 05:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:40 INFO - 'PWD': '/builds/slave/test', 05:23:40 INFO - 'SHELL': '/bin/bash', 05:23:40 INFO - 'SHLVL': '1', 05:23:40 INFO - 'TERM': 'linux', 05:23:40 INFO - 'TMOUT': '86400', 05:23:40 INFO - 'USER': 'cltbld', 05:23:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:40 INFO - '_': '/tools/buildbot/bin/python'} 05:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:23:42 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 05:23:42 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 05:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:42 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 05:23:42 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 05:23:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:42 INFO - warning: no files found matching '*.txt' 05:23:42 INFO - no previously-included directories found matching 'build' 05:23:42 INFO - no previously-included directories found matching 'dist' 05:23:42 INFO - no previously-included directories found matching '.git*' 05:23:42 INFO - Installing collected packages: jsonschema, functools32 05:23:42 INFO - Running setup.py install for functools32 05:23:42 INFO - warning: no files found matching '*.txt' 05:23:42 INFO - no previously-included directories found matching 'build' 05:23:42 INFO - no previously-included directories found matching 'dist' 05:23:42 INFO - no previously-included directories found matching '.git*' 05:23:42 INFO - Successfully installed jsonschema functools32 05:23:42 INFO - Cleaning up... 05:23:43 INFO - Return code: 0 05:23:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:23:43 INFO - Using env: {'DISPLAY': ':0', 05:23:43 INFO - 'HOME': '/home/cltbld', 05:23:43 INFO - 'LANG': 'en_US.UTF-8', 05:23:43 INFO - 'LANGUAGE': 'en_US:en', 05:23:43 INFO - 'LOGNAME': 'cltbld', 05:23:43 INFO - 'MAIL': '/var/mail/cltbld', 05:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:43 INFO - 'MOZ_NO_REMOTE': '1', 05:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:43 INFO - 'NO_EM_RESTART': '1', 05:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:43 INFO - 'PWD': '/builds/slave/test', 05:23:43 INFO - 'SHELL': '/bin/bash', 05:23:43 INFO - 'SHLVL': '1', 05:23:43 INFO - 'TERM': 'linux', 05:23:43 INFO - 'TMOUT': '86400', 05:23:43 INFO - 'USER': 'cltbld', 05:23:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:43 INFO - '_': '/tools/buildbot/bin/python'} 05:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:23:43 INFO - Cleaning up... 05:23:43 INFO - Return code: 0 05:23:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:23:43 INFO - Using env: {'DISPLAY': ':0', 05:23:43 INFO - 'HOME': '/home/cltbld', 05:23:43 INFO - 'LANG': 'en_US.UTF-8', 05:23:43 INFO - 'LANGUAGE': 'en_US:en', 05:23:43 INFO - 'LOGNAME': 'cltbld', 05:23:43 INFO - 'MAIL': '/var/mail/cltbld', 05:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:43 INFO - 'MOZ_NO_REMOTE': '1', 05:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:43 INFO - 'NO_EM_RESTART': '1', 05:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:43 INFO - 'PWD': '/builds/slave/test', 05:23:43 INFO - 'SHELL': '/bin/bash', 05:23:43 INFO - 'SHLVL': '1', 05:23:43 INFO - 'TERM': 'linux', 05:23:43 INFO - 'TMOUT': '86400', 05:23:43 INFO - 'USER': 'cltbld', 05:23:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:43 INFO - '_': '/tools/buildbot/bin/python'} 05:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:43 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 05:23:43 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 05:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:43 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 05:23:43 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 05:23:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23: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 05:23: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 05:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23: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 05:23: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 05:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23: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 05:23: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 05:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23: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 05:23: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 05:23:46 INFO - Downloading docopt-0.6.1.tar.gz 05:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:46 INFO - Running setup.py install for blobuploader 05:23:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:46 INFO - Running setup.py install for requests 05:23:47 INFO - Running setup.py install for docopt 05:23:47 INFO - Successfully installed blobuploader requests docopt 05:23:47 INFO - Cleaning up... 05:23:47 INFO - Return code: 0 05:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:47 INFO - Using env: {'DISPLAY': ':0', 05:23:47 INFO - 'HOME': '/home/cltbld', 05:23:47 INFO - 'LANG': 'en_US.UTF-8', 05:23:47 INFO - 'LANGUAGE': 'en_US:en', 05:23:47 INFO - 'LOGNAME': 'cltbld', 05:23:47 INFO - 'MAIL': '/var/mail/cltbld', 05:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:47 INFO - 'MOZ_NO_REMOTE': '1', 05:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:47 INFO - 'NO_EM_RESTART': '1', 05:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:47 INFO - 'PWD': '/builds/slave/test', 05:23:47 INFO - 'SHELL': '/bin/bash', 05:23:47 INFO - 'SHLVL': '1', 05:23:47 INFO - 'TERM': 'linux', 05:23:47 INFO - 'TMOUT': '86400', 05:23:47 INFO - 'USER': 'cltbld', 05:23:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:47 INFO - '_': '/tools/buildbot/bin/python'} 05:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:47 INFO - Running setup.py (path:/tmp/pip-EtAWvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:47 INFO - Running setup.py (path:/tmp/pip-mE1T86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:47 INFO - Running setup.py (path:/tmp/pip-EEs1tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:47 INFO - Running setup.py (path:/tmp/pip-HCgrIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:47 INFO - Running setup.py (path:/tmp/pip-oHx6kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:47 INFO - Running setup.py (path:/tmp/pip-KcT8ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:48 INFO - Running setup.py (path:/tmp/pip-ZCGnlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:48 INFO - Running setup.py (path:/tmp/pip-xAwDLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:48 INFO - Running setup.py (path:/tmp/pip-VgEmH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:48 INFO - Running setup.py (path:/tmp/pip-Fe1WGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:48 INFO - Running setup.py (path:/tmp/pip-7i2kOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:48 INFO - Running setup.py (path:/tmp/pip-AfuAor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:48 INFO - Running setup.py (path:/tmp/pip-m3iSz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:48 INFO - Running setup.py (path:/tmp/pip-VgNlC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:48 INFO - Running setup.py (path:/tmp/pip-dXGoOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:48 INFO - Running setup.py (path:/tmp/pip-3BDt6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:48 INFO - Running setup.py (path:/tmp/pip-GeUABG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:48 INFO - Running setup.py install for manifestparser 05:23:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:48 INFO - Running setup.py install for mozcrash 05:23:49 INFO - Running setup.py install for mozdebug 05:23:49 INFO - Running setup.py install for mozdevice 05:23:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for mozfile 05:23:49 INFO - Running setup.py install for mozhttpd 05:23:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for mozinfo 05:23:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for mozInstall 05:23:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for mozleak 05:23:49 INFO - Running setup.py install for mozlog 05:23:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for moznetwork 05:23:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:49 INFO - Running setup.py install for mozprocess 05:23:50 INFO - Running setup.py install for mozprofile 05:23:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:50 INFO - Running setup.py install for mozrunner 05:23:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:50 INFO - Running setup.py install for mozscreenshot 05:23:50 INFO - Running setup.py install for moztest 05:23:50 INFO - Running setup.py install for mozversion 05:23:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:50 INFO - Cleaning up... 05:23:50 INFO - Return code: 0 05:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:50 INFO - Using env: {'DISPLAY': ':0', 05:23:50 INFO - 'HOME': '/home/cltbld', 05:23:50 INFO - 'LANG': 'en_US.UTF-8', 05:23:50 INFO - 'LANGUAGE': 'en_US:en', 05:23:50 INFO - 'LOGNAME': 'cltbld', 05:23:50 INFO - 'MAIL': '/var/mail/cltbld', 05:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:50 INFO - 'MOZ_NO_REMOTE': '1', 05:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:50 INFO - 'NO_EM_RESTART': '1', 05:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:50 INFO - 'PWD': '/builds/slave/test', 05:23:50 INFO - 'SHELL': '/bin/bash', 05:23:50 INFO - 'SHLVL': '1', 05:23:50 INFO - 'TERM': 'linux', 05:23:50 INFO - 'TMOUT': '86400', 05:23:50 INFO - 'USER': 'cltbld', 05:23:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:50 INFO - '_': '/tools/buildbot/bin/python'} 05:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:51 INFO - Running setup.py (path:/tmp/pip-jb1NVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:51 INFO - Running setup.py (path:/tmp/pip-LufKnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:51 INFO - Running setup.py (path:/tmp/pip-kgBYxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:51 INFO - Running setup.py (path:/tmp/pip-ZLwGdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:51 INFO - Running setup.py (path:/tmp/pip-GRywSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:51 INFO - Running setup.py (path:/tmp/pip-zl4_Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:51 INFO - Running setup.py (path:/tmp/pip-__1_Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:51 INFO - Running setup.py (path:/tmp/pip-7H2xce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:51 INFO - Running setup.py (path:/tmp/pip-Mqgm52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:51 INFO - Running setup.py (path:/tmp/pip-zZWU9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:51 INFO - Running setup.py (path:/tmp/pip-ULaEpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:51 INFO - Running setup.py (path:/tmp/pip-Ah7jGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:51 INFO - Running setup.py (path:/tmp/pip-2XgStl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:51 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)) 05:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:51 INFO - Running setup.py (path:/tmp/pip-BQ3J3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:52 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)) 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:52 INFO - Running setup.py (path:/tmp/pip-UT6vRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:52 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)) 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:52 INFO - Running setup.py (path:/tmp/pip-LqPU4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:52 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)) 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:52 INFO - Running setup.py (path:/tmp/pip-RjssrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:52 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)) 05:23:52 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)) 05:23:52 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)) 05:23:52 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)) 05:23:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23: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 05:23: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 05:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23: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 05:23: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 05:23:54 INFO - Downloading blessings-1.6.tar.gz 05:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:54 INFO - Installing collected packages: blessings 05:23:54 INFO - Running setup.py install for blessings 05:23:54 INFO - Successfully installed blessings 05:23:54 INFO - Cleaning up... 05:23:54 INFO - Return code: 0 05:23:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:54 INFO - Reading from file tmpfile_stdout 05:23:54 INFO - Current package versions: 05:23:54 INFO - argparse == 1.2.1 05:23:54 INFO - blessings == 1.6 05:23:54 INFO - blobuploader == 1.2.4 05:23:54 INFO - docopt == 0.6.1 05:23:54 INFO - functools32 == 3.2.3-2 05:23:54 INFO - jsonschema == 2.5.1 05:23:54 INFO - manifestparser == 1.1 05:23:54 INFO - mozInstall == 1.12 05:23:54 INFO - mozcrash == 1.0 05:23:54 INFO - mozdebug == 0.1 05:23:54 INFO - mozdevice == 0.49 05:23:54 INFO - mozfile == 1.2 05:23:54 INFO - mozhttpd == 0.7 05:23:54 INFO - mozinfo == 0.9 05:23:54 INFO - mozleak == 0.1 05:23:54 INFO - mozlog == 3.4 05:23:54 INFO - moznetwork == 0.27 05:23:54 INFO - mozprocess == 0.24 05:23:54 INFO - mozprofile == 0.28 05:23:54 INFO - mozrunner == 6.13 05:23:54 INFO - mozscreenshot == 0.1 05:23:54 INFO - mozsystemmonitor == 0.3 05:23:54 INFO - moztest == 0.8 05:23:54 INFO - mozversion == 1.4 05:23:54 INFO - psutil == 3.1.1 05:23:54 INFO - requests == 1.2.3 05:23:54 INFO - wsgiref == 0.1.2 05:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:23:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:54 INFO - Using env: {'DISPLAY': ':0', 05:23:54 INFO - 'HOME': '/home/cltbld', 05:23:54 INFO - 'LANG': 'en_US.UTF-8', 05:23:54 INFO - 'LANGUAGE': 'en_US:en', 05:23:54 INFO - 'LOGNAME': 'cltbld', 05:23:54 INFO - 'MAIL': '/var/mail/cltbld', 05:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:54 INFO - 'MOZ_NO_REMOTE': '1', 05:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:54 INFO - 'NO_EM_RESTART': '1', 05:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:54 INFO - 'PWD': '/builds/slave/test', 05:23:54 INFO - 'SHELL': '/bin/bash', 05:23:54 INFO - 'SHLVL': '1', 05:23:54 INFO - 'TERM': 'linux', 05:23:54 INFO - 'TMOUT': '86400', 05:23:54 INFO - 'USER': 'cltbld', 05:23:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:54 INFO - '_': '/tools/buildbot/bin/python'} 05:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:54 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)) 05:23:54 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)) 05:23:54 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)) 05:23:54 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 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)) 05:23:55 INFO - Cleaning up... 05:23:55 INFO - Return code: 0 05:23:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:55 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1fd61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2348980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', '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 05:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:23:55 INFO - Using env: {'DISPLAY': ':0', 05:23:55 INFO - 'HOME': '/home/cltbld', 05:23:55 INFO - 'LANG': 'en_US.UTF-8', 05:23:55 INFO - 'LANGUAGE': 'en_US:en', 05:23:55 INFO - 'LOGNAME': 'cltbld', 05:23:55 INFO - 'MAIL': '/var/mail/cltbld', 05:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:55 INFO - 'MOZ_NO_REMOTE': '1', 05:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:55 INFO - 'NO_EM_RESTART': '1', 05:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:55 INFO - 'PWD': '/builds/slave/test', 05:23:55 INFO - 'SHELL': '/bin/bash', 05:23:55 INFO - 'SHLVL': '1', 05:23:55 INFO - 'TERM': 'linux', 05:23:55 INFO - 'TMOUT': '86400', 05:23:55 INFO - 'USER': 'cltbld', 05:23:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:55 INFO - '_': '/tools/buildbot/bin/python'} 05:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:23:55 INFO - Cleaning up... 05:23:55 INFO - Return code: 0 05:23:55 INFO - Running post-action listener: _resource_record_post_action 05:23:55 INFO - Running post-action listener: _start_resource_monitoring 05:23:55 INFO - Starting resource monitoring. 05:23:55 INFO - [mozharness: 2017-03-02 13:23:55.281003Z] Finished create-virtualenv step (success) 05:23:55 INFO - [mozharness: 2017-03-02 13:23:55.281443Z] Running install step. 05:23:55 INFO - Running pre-action listener: _resource_record_pre_action 05:23:55 INFO - Running main action method: install 05:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:55 INFO - Reading from file tmpfile_stdout 05:23:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:55 INFO - Reading from file tmpfile_stdout 05:23:55 INFO - Output received: 05:23:55 INFO - Usage: mozinstall [options] installer 05:23:55 INFO - Options: 05:23:55 INFO - -h, --help show this help message and exit 05:23:55 INFO - -d DEST, --destination=DEST 05:23:55 INFO - Directory to install application into. [default: 05:23:55 INFO - "/builds/slave/test"] 05:23:55 INFO - --app=APP Application being installed. [default: firefox] 05:23:55 INFO - mkdir: /builds/slave/test/build/application 05:23:55 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'] 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:24:12 INFO - Reading from file tmpfile_stdout 05:24:12 INFO - Output received: 05:24:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:12 INFO - Running post-action listener: _resource_record_post_action 05:24:12 INFO - [mozharness: 2017-03-02 13:24:12.087230Z] Finished install step (success) 05:24:12 INFO - [mozharness: 2017-03-02 13:24:12.087507Z] Running run-tests step. 05:24:12 INFO - Running pre-action listener: _resource_record_pre_action 05:24:12 INFO - Running main action method: run_tests 05:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:12 INFO - Python 2.7.3 05:24:12 INFO - Return code: 0 05:24:12 INFO - grabbing minidump binary from tooltool 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 05:24:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2345d00>, '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 0x2346a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:24:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:24:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:24:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:12 INFO - Return code: 0 05:24:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:24:12 INFO - Using env: {'DISPLAY': ':0', 05:24:12 INFO - 'HOME': '/home/cltbld', 05:24:12 INFO - 'LANG': 'en_US.UTF-8', 05:24:12 INFO - 'LANGUAGE': 'en_US:en', 05:24:12 INFO - 'LOGNAME': 'cltbld', 05:24:12 INFO - 'MAIL': '/var/mail/cltbld', 05:24:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:12 INFO - 'MOZ_NO_REMOTE': '1', 05:24:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:12 INFO - 'NO_EM_RESTART': '1', 05:24:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:12 INFO - 'PWD': '/builds/slave/test', 05:24:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:12 INFO - 'SHELL': '/bin/bash', 05:24:12 INFO - 'SHLVL': '1', 05:24:12 INFO - 'TERM': 'linux', 05:24:12 INFO - 'TMOUT': '86400', 05:24:12 INFO - 'USER': 'cltbld', 05:24:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496', 05:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:12 INFO - '_': '/tools/buildbot/bin/python'} 05:24:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:24:12 INFO - mozversion application_buildid: 20170302122931 05:24:12 INFO - mozversion application_changeset: 4cd258347baab9f8dbe1ffbdf0238cfe3686509f 05:24:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:24:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:12 INFO - mozversion application_name: Firefox 05:24:12 INFO - mozversion application_remotingname: firefox-dev 05:24:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:24:12 INFO - mozversion application_vendor: Mozilla 05:24:12 INFO - mozversion application_version: 53.0a2 05:24:12 INFO - mozversion platform_buildid: 20170302122931 05:24:12 INFO - mozversion platform_changeset: 4cd258347baab9f8dbe1ffbdf0238cfe3686509f 05:24:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:24:12 INFO - mozversion platform_version: 53.0a2 05:24:12 INFO - using testdate: 1488461052 05:24:12 INFO - actual date: 1488461052 05:24:12 INFO - starting webserver on 'localhost:56250' 05:24:12 INFO - SUITE-START | Running 2 tests 05:24:12 INFO - TEST-START | dromaeo_css 05:24:12 INFO - operating with platform_type : linux_ 05:24:12 INFO - Initialising browser for dromaeo_css test... 05:24:12 INFO - TEST-INFO | started process 25668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp6614d/profile http://localhost:56250/getInfo.html) 05:24:16 INFO - PROCESS | 25668 | __metrics Screen width/height:1600/1200 05:24:16 INFO - PROCESS | 25668 | colorDepth:24 05:24:16 INFO - PROCESS | 25668 | Browser inner width/height: 1024/697 05:24:16 INFO - PROCESS | 25668 | __metrics 05:24:16 INFO - PROCESS | 25668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:16 INFO - PROCESS | 25668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:17 INFO - PROCESS | 25668 | console.error: PushService: 05:24:17 INFO - PROCESS | 25668 | stateChangeProcessEnqueue: Error transitioning state 05:24:17 INFO - PROCESS | 25668 | UnknownError 05:24:17 INFO - TEST-INFO | 25668: exit 0 05:24:17 INFO - Browser initialized. 05:24:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:17 INFO - TEST-INFO | started process 25761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp6614d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:29 INFO - PROCESS | 25761 | RSS: Main: 138272768 05:24:29 INFO - PROCESS | 25761 | 05:27:30 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56250/tests/dromaeo/cssquery-ext.html) 05:27:31 INFO - PROCESS | 25761 | RSS: Main: 246112256 05:27:31 INFO - PROCESS | 25761 | 05:29:20 INFO - PROCESS | 25761 | ************************* 05:29:20 INFO - PROCESS | 25761 | A coding exception was thrown and uncaught in a Task. 05:29:20 INFO - PROCESS | 25761 | 05:29:20 ERROR - PROCESS | 25761 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:29:20 INFO - PROCESS | 25761 | Full stack: 05:29:20 INFO - PROCESS | 25761 | ************************* 05:30:33 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-ext.html (next: http://localhost:56250/tests/dromaeo/cssquery-jquery.html) 05:30:34 INFO - PROCESS | 25761 | RSS: Main: 223117312 05:30:34 INFO - PROCESS | 25761 | 05:33:36 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56250/tests/dromaeo/cssquery-mootools.html) 05:33:36 INFO - PROCESS | 25761 | RSS: Main: 197943296 05:33:36 INFO - PROCESS | 25761 | 05:36:38 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56250/tests/dromaeo/cssquery-prototype.html) 05:36:39 INFO - PROCESS | 25761 | RSS: Main: 208183296 05:36:39 INFO - PROCESS | 25761 | 05:39:41 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56250/tests/dromaeo/cssquery-yui.html) 05:39:42 INFO - PROCESS | 25761 | RSS: Main: 179150848 05:39:42 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | Cycle 1(1): loaded http://localhost:56250/tests/dromaeo/cssquery-yui.html (next: http://localhost:56250/tests/dromaeo/cssquery-dojo.html) 05:42:44 INFO - PROCESS | 25761 | RSS: Main: 262631424 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | __start_tp_report 05:42:44 INFO - PROCESS | 25761 | _x_x_mozilla_page_load 05:42:44 INFO - PROCESS | 25761 | _x_x_mozilla_page_load_details 05:42:44 INFO - PROCESS | 25761 | |i|pagename|runs| 05:42:44 INFO - PROCESS | 25761 | |0;dojo.html;3285.934281314374;3328.334333133373;3335.249568847008;3345.715614172795;3373.865045398184;5362.892742145154;5407.351117865852;5439.129739241722;5443.156310771827;5457.945420545793;5464.6994415307145;5516.007118718629;5526.115821468566;5531.308586426697;5540.113581826909;4911.386076740417;4928.310036594879;4955.405351357842;4970.329005584236;5032.7735251913755;4862.4408193057725;4867.123917694814;4972.129877271481;5018.473060328668;5032.169692000815;4855.902881942359;4865.586425153866;4914.926276105862;4959.429665588449;4979.900401991958;4986.4514903360605;4986.850394488171;4988.65079444439;4992.226204938241;5022.045811295842;4737.2183589708;4913.975430122862;4925.679830810986;4934.55588996992;4958.801647934079;5290.629655924087;5306.522412982811;5390.056740070511;5401.945980540223;5450.018996580614;5797.826065218051;5800;5806.1000544915605;5809.796657116981;5818.272715910512;5796.072628379439;5829.096490044008;5844.211031510734;5845.7369418376275;5853.707314634294;5291.206319052173;5310.946890531122;5442.619016668795;5570.2201691762375;5582.944170558324;5984.700764961734;5994.520438364921;5999.220101386792;6012.729427175787;6033.849153771103;5737.85655358611;5791.131330300404;5796.478316951495;5800.9419905800405;5805.564582656318;5748.425157484302;5791.160281759206;5819.418058194231;5892.705364731746;5895.233619629421;5818.79634212809;5834.212381328552;5884.588078834526;5908;5918.940810591925;5851.414858514115;5853.239078919713;5858.091995740667;5861.824145275648;5865.970670146622;4417.779111044435;4450.866474005785;4570.542945705402;4571.862844114682;4589.0821835633005;4025.0742329264435;4027.577104404054;4047.534533528682;4080.1227736036894;4112.218678451144;5712.800051998243;5715.885682286331;5717.456841600041;5720.799772007959;5744.310682718101;5709.371969083398;5765.827025189251;5817.447342502455;5845.766169353264;5871.677057761779;5691.4877661010705;5694.08894576874;5696.51579615729;5715.797301816238;5725.2843394575675;4984.40187177541;4988.12707776145;4993.201087825931;5001.299818025479;5027.271045698353;5829.329627092854;5872.148538461814;6011.669358185167;6105.725242364104;6106.480949119375;5812.360640329476;5871.853203669772;5879.147523609138;5900.586958912835;5923.674197919156;6089.360617135137;6111.816645500642;6131.54013449002;6137.815865523863;6140.508759299156;5592.273004509388;5628.409017053151;5769.798057067983;5774.538036957118;5787.39232380594;5834.03738383162;5843.240378750906;5885.793997210077;5903.586748927705;5955.434233747787;5755.309362876482;5757.424257574209;5767.5385969121535;5771.365149833431;5776.566757493289;5565.053940829987;5749.511291540266;5753.913691294718;5757.539396848326;5764.913526297193;5505.642133261325;5640.238567793295;5699.116636921284;5704.258446401941;5754.367019627922;5793.826185214451;5802.4197580241635;5807.274090738658;5807.448292412214;5809.50619197373;5618.49433550966;5676.77292908279;5679.233303503974;5686.658800471985;5688.800891968761 05:42:44 INFO - PROCESS | 25761 | |1;ext.html;542.5211221861865;573.2347316332696;599.6851652882236;610.4749915073039;632.1402892066791;36582.45126323107;37381;40839.183216335696;48754.75622621882;50260.74869625656;51941.22088168671;52426.47573524264;52507.47492525074;52513;52536.73731631337;9528.237740980705;9721.270904682142;9727.075927786884;9731.36746111504;9732.562034708455;8991.865122023175;9203.263738900872;11146.442677866115;11395.48720307584;11404.885951140506;11135.554577816878;11183.217174797768;11183.384913829736;11184.832227516594;11188.216824822266;11492;11574.305541667527;11580.363080030595;11593.76812463746;11597.6520704379;11447.141464390204;11530.250533715282;11532.538698452136;11534.019608333218;11538.423078846025;49398.50601493975;49698;49731;49764;49806.252906206435;4436.356728274414;4436.689431739779;4591.770411479412;4598.425196850394;4784.234522476387;32497.837510812533;32616.673833261837;32708.182295442566;32893.835530822194;33780.49329260038;4331.220380331571;4338.522762496154;4375.234333991571;4399.560043995575;4457.531959144308;344248;346957;349433;350613;351773;59870.40129598735;60078;60279;60433;60870.69564652148;63395.36604633987;63460.68269658622;63510;63571.86782859099;63609;17968.640627187382;18511.259549617866;18536.25854965786;18546.629067418577;18567.628647426976;12678.619641410773;12708.428120734588;12744;12809.295488748208;12810.359482025862;19397.612047758965;19633.429325653913;19832;20330.593388132154;20651.070701818455;7237.421006319481;7346.816329591696;7399.6670149843385;7536.5101268417375;7598.278163574451;977.7018009507169;980.6616717232544;985.9901400986042;988.2588058955783;1006.5470538257813;34385.82807085948;34944.65055349465;34949.30101397958;35211.64788352135;35391.823040885145;1073.8442925775719;1143.3597185576104;1157.056998546182;1205.2888795610631;1213.2295992045115;17541.824581754274;18441.53896152607;18508.81491185098;18537.629247414978;18548.629027419374;507138;511142;512156;512735;513050;69692.30307696959;69899.30100698928;70108;70235.6488217566;70287.64856175687;1485.68057867559;1510.3731951240331;1527.1600619659143;1540.4839378808;1543.4520745135314;32669.836650816593;33875;34068.829655851565;34533.82733086318;34544;59656.40343596508;59775.40224597872;59880;60169.09746353896;60329.69835150796;406628;406907;408814;409392;409617;28268.858655707412;28991.855040724662;29400;31774.682253177172;32137.517937231427;50131.49868501268;54184;54525.72737136289;54636.72681636566;55720.72139639276;43669.56330436655;43891.78054109709;45103.54896450994;45712;46727;43807.561924380345;44544.554554454044;44623.98881454032;45667.314990274506;46137.307940381594;43756.34365484457;43839.34240986324;43896.34155487606;44046;44229.336559950985;37637.435438467895;40017.79991100142;40097;40259.19481610293;40676.1864762709;29222.772029789405;29702;29714;29974.85012574923;29986.250343740707 05:42:44 INFO - PROCESS | 25761 | |2;jquery.html;399.2374564581646;418.54587772267087;425.3768229543718;427.9743215407075;448.04566273836724;17105.82894171058;21315.36053918381;22628.8868555657;23031.769682303173;23273.534529309447;22827.77172228277;22949.311520654406;23342.64986025211;23438.64842027371;23704.407389815264;5904.0258357370985;6167.506599472032;6266.154069200645;6335.303116657164;6384.648844313561;6217.347178546255;6306.527010474233;6308;6313;6315;7815.687372505093;8058.234467725557;8120.9593952030455;8272;8311.792205194888;8044.597770111501;8223.629936652866;8225.629846656915;8265.710700125466;8276.213759692819;7898.368130549599;8030.839383212303;8110.63502142405;8111.878321825118;8140.185981401872;29454.70545294541;29789;30080.247993800112;30244.54633180482;30438.391232175454;3581.623929487392;3655.926881462356;3661.4324779659196;3697.2975134724584;3729.589745128034;16306.592335191597;17323;17369.7394539082;17603.647927041515;17871.374501892373;2128.7764784697692;2194.923177688773;2220.5114874727533;2226.2764601504578;2257.808086312665;111951;113243.86756132415;113708;116117;116238.41880790626;16166.838331616533;19702.60594788125;20686.68969965452;20944.26695065696;21572.137114515557;39882.40176397356;39984.400233996515;40037;41005.58994410077;41091.38362924558;11364.715882103013;11452.083833293316;11521.769564608661;11557.190996630155;11680.182387232811;9468.810623787485;9482.288828337902;9494;9518.286128540249;9750.658726944523;10613.57545698179;10738.78522429547;10877.456127193609;10893.455327233607;11004.449777511092;3577.373959557067;3923.9803800980812;3966.087799806003;3979.8408063677707;4080.0853924962034;934.1872570863393;947.8436058050345;955.1069749783974;956.2541217850088;963.8409662405625;19599.608007839764;20681.68977465339;20966.58066838655;20982.37052888416;21145.471363216042;955.1833182628891;960.6589660670501;966.1497881863914;974.9122578967927;977.0620204603518;10807.297525660806;11562.421878906189;11649.301041937511;11666.125040621988;11730;659153;660579;666119;680583;680849;111395.44302278598;112018;114495;115350;116086;1087.2280680716622;1111.1610733895857;1111.7943180511631;1119;1126.6620013995769;17178.141092945054;18767.249310027444;18984.905075474533;20043.799562004195;20047;42274;49213.75393123155;49852.50147498624;50016.49983500118;50716;66146.33853661401;66735;67249.32750672626;67300;67667.32332676808;9232.492212928353;9395.671151509665;9471.47906865129;9576.329656923948;9864.471006993928;12293.815592765937;13614.93192534031;13692.931535342259;13749.793753093913;13800.171989680652;11974.880251197377;11987.22083064598;12015.939920300343;12196.878031219574;12458.813117803058;11519.366434846164;11807.645770626896;11917.940410297893;12008.75982480363;12162.270263784201;12407.069469789622;12612.621621351374;12647.87352126467;12972;13128.540501082416;8179.468334558234;9355.4386736796;9633.662821801483;9714.319997600383;9775.266854985763;11773.587924422603;12648.6837829055;12719.87280127187;12741.10812243134;12800.35998200105 05:42:44 INFO - PROCESS | 25761 | |3;mootools.html;1480.4374337751653;1482.3477669825277;1495.1328229626818;1509.9773503397448;1520.460236616002;8767.167119123682;9089.091090890908;9094.226990705782;9096.772580685487;9099.863502047467;7939.364850811936;8139.552324622144;8146.144654811248;8373.330133589314;9000.909990900089;2410.1684918703018;2489.0417189382038;2490.0288887333954;2491.0907518755616;2500.6749122614033;2371.893264803088;2412.07135252928;2430.2952143878256;2455.6807615010025;2456.6192240202795;2386.642003699442;2408.2534414331526;2443.3280847766828;2450.2649205238445;2451.252368027751;2328.3946173994714;2343.4024323797407;2343.7539058398966;2345;2352.999975010622;2259;2368.839268758296;2371.97628023721;2373.4659701567184;2373.5134297468976;8851.867221991675;8931.687390941286;8938.4190027648;8940.46357218569;8942.64229430822;5407.107827208506;5612.607117501777;5614.326280846324;5618.325800903876;5618.353889302742;3277.8033318001;3332;3551.8224088795455;3569.8750543731103;3605.47720580517;1408.1621435246013;1424.551266351096;1462.0423622527262;1472.7790831375273;1483.4733669547263;12444.440000200013;12447.875521244761;12455.813162802566;12460.190087644365;12460.376981150906;4742.952570474251;4777.784999675023;4820.39745031871;4825.914169311947;4850.345203397566;10643.46782660864;10657.786844263072;10658.200634952409;10661.89338106609;10664.520096595672;5612.07400778875;5615.2700148981185;5615.775368985276;5623.0159722048475;5623.578231632644;4994.450610432849;5085.1355269604255;5110.744462776921;5128.205128205134;5213.426523082534;3924.646781789653;4052.068024354356;4076.30702780528;4081.673466122703;4131.049858532554;1175.3829239649253;1175.7178277213407;1194.146185477388;1200.2018657592778;1203.3141109567462;928.5960607135918;953.537534295866;958.3038022699922;958.7075941837807;984.6602921991902;5647.745851436695;5671.149327600893;5698.373178950312;5735.11105778605;5831.2127862738835;601.5939241012387;603.6408337039454;603.7524614907867;604.9848753781102;609.3479976425272;2936.2512559297243;2959.615250017484;2989.1480927935436;3038.194878357237;4238.809253583535;10469.895301046892;10667.893321066846;10915.345079295268;10921.617743378943;10929.398883061507;10712.464376781285;10845.295055821347;10871.45642717861;10885.18361122919;10928.781424371467;8368.121347258571;8427.188154546802;8536.103709110579;8685.088065753005;8701.869471957925;5682.460166284196;5784.7107644618445;5948.73230704628;6004.819855404345;6088.939110608837;9810.901890980998;9865.309428339948;9868.901310986797;9955.751106222402;9996.350237234847;9012.63949442015;9801.558929848032;9942.105210531086;9943.453110079015;10162.89837101649;7444.218357072429;8239.464434811718;8277.95861020691;8450.450720703135;8457.02744184402;8770.25452836516;8786.868196977179;8787.956060219658;8863.512506811929;8877.467351958903;7545.283198096172;7545.320921117126;7631.656575454229;7634.160242373446;7816.921830781619;7186.496945213785;7268.9273107270365;7276.854462910818;7327.487075904635;7374.889376659462;6366.490680745622;6428.614283143026;6462.547621666627;6477.805665830033;6501.349865013461;5024.271480635361;5097.15896877026;5145.948540514697;5161.535461808305;5194.065068287745;4959.181735013826;4963.230699241623;5118;5124.077666020152;5190.740462976912 05:42:44 INFO - PROCESS | 25761 | |4;prototype.html;384.99230015399695;406.9491313585802;412.41416319675636;414.8071146916685;416.6229562246168;5078.238264260358;5131.307273518083;5220.29526013988;5353.7590808413615;5410.647338165459;5142.485751424856;5261.526462618363;5278.604104692154;5288.99509093273;5306.469353064692;4237.682173836959;4240.597143271384;4243.490781106271;4248.2140803951215;4251.723637963522;4175.645070169039;4235.6187943085115;4243.151369726052;4249.44757181566;4254.170436764832;4198.91602167958;4239.894002649928;4245.872623821275;4250.872473825791;4251.978740106295;4214.452121224252;4218.3250679891225;4223.788810559459;4232.222466564051;4248.787560621957;3866.149447121629;3870.5161854768153;3875.418687196915;3877.836649005287;3878;5001.924971125436;5187.818426355059;5263.6841789492755;5268.894622107537;5272.18281166416;4808.951910480885;4815.66290359675;4821.108095002436;4834.758262086882;4847.709137451764;5325.520703136697;5535.474129957688;5598.860028499279;5599.916001259984;5603.355614104389;4072.6538244249273;4091.4476545666253;4096.5903409659095;4103.261412945669;4107.609777071173;5756.625819321773;5785.305763308388;5791.739371728282;5807.1869938208265;5816.389279125716;4084.7753373564146;4175.415441838145;4196.454460920061;4197.433346498245;4201.138766552849;4210.368444733314;4252.4046633471335;4252.702310838274;4254.489461264668;4258.552851950562;4728.361671174347;4732.881677958078;4774.570288674036;4789.808407663654;4812.639052071108;5376.193570964387;5565.916511252334;5584.46947539983;5612.550995920316;5627.086790491171;1411.4072089722342;1429.8784603308627;1433.6881753195917;1434.1395162902174;1437.7922545061988;958.2717134977468;962.2879069488667;988.5106872098214;990.0495524296756;997.1773287038078;5302.496262855023;5311.49540793624;5313.654612450178;5315.6013299002725;5319.813806516753;5502.239283429344;5517.227588137664;5537.778488860481;5585.469380408855;5598.692071936001;5156.278121063054;5364.766103796149;5393.703346315911;5398.406175320712;5446.346438427335;2948.5871977923107;2951.409718056397;2954.9704502955124;2962.3482833776534;2967.095036013993;5824.786581099155;5838.737256823453;5853.063509838491;5876.328318986416;5883.646321596734;5509.906235630515;5869.706514674249;5913.940860591339;5920.763169473259;5925.318588362394;6005.819825405245;6020.367861374581;6028;6049.969750151221;6053.303870055;5492.203630473479;5673.177389278614;5689.857753556194;5764.711764411679;5800.767969281182;5641.420402287366;5654.6324488908085;5678;5680.71596420169;5709.172170035238;5857.853553661193;5988.431099045583;5997.5501837363245;6006.369331220334;6024.608400453956;4410.558944105692;4466.59800617946;4508.233600287894;4512.255477846119;4514.25514790056;5743.253377060955;5757.596968212185;5760.913586296293;5784.363719990713;5798.072308430631;5462.808801691922;5625.240592519957;5630.5214056805635;5662.5469962402085;5678.971605141948;5560.638558493685;5576.33084029919;5581.995240856685;5584.748686309207;5588.6646801192055;5524.254225679482;5524.917126243029;5585.329760428612;5609.887802244014;5638.661680299195;5440.265564148789;5519.751611177587;5581.544120586928;5607.299087614048;5628.718564071862;5466.808661696821;5480.287257807411;5487.478689524489;5504.981578408007;5532.778688852401 05:42:44 INFO - PROCESS | 25761 | |5;yui.html;788.3259812860001;805.0822062848354;805.1666525146475;897.5377680494545;900.5542256582991;16256;17393.304267829288;17804.64390712185;17986.55033624157;18139.183736731844;16342.673146537061;17896.46310610684;18322.175502102404;18485;18501.259949602;707.6709330161474;841.2428814067342;857.4212406625503;859.1623167411786;859.1966511311912;731.1153504259826;745.6644509970508;745.9664315105833;818.5088946632003;834.4367551902471;882.8940527136753;883.9292856571491;884.5444596033049;884.849575572151;885.234272354412;880.5993273060742;881.1496905486205;881.391839630656;881.4755220643707;881.5636260051284;550.0429253099618;562.0753859900482;628.2994461175801;643.3887806583717;646.9450096741735;17067.97592144475;17287.049212293317;17345.826541734546;17350.65298694019;17361.47915562535;15582.22088895562;15627;15701.450449234337;15707.607309817231;15780;12338.753224935452;13262.204267743966;13271.601851944457;13409.195448273134;13464.5287414941;4032.3951407288846;4058.289799285113;4065.26825171469;4132.73137246081;4234.894127646833;83626.58186709088;83915.16084839196;84534.15465845325;86290;87960;11774.764504709858;11796.410179490991;11835.461390019242;11877.821832672516;12004.579839705742;23766.405839853796;23850.642240366407;24003.159889404138;24321.635175472384;24457.266282011213;8639.78400539979;8728.25809806161;8800.119988001148;8884.600192991331;8942.73171804847;4795.424549054136;4956.801727930842;5001.699898006132;5002.824901128443;5020.096382651085;3865.7873816939777;3973.443717879499;3979.2240513100246;3980.8407663693706;3981.482407287034;640.8942524483501;642.4956409218835;650.5641220382355;654.5908806995627;665.6205962601271;812.9918700813034;825.1130035212051;840.6763396092548;844.9619767110372;859.7162936231028;10669.1862383395;10992.835107473395;11222.831657524981;11976.88023119775;12102.334371609646;786.3473317146754;798.1499702816482;800;819.8524265632124;822.5558198572824;5433.918491222635;5443.673379597237;5529.391766905637;5545.77816887328;5557.499825015768;78067;78427;79344.60327698325;80674.5966270165;83670;57473.13790293149;70242.64878675574;70550;70718.64640676764;71531.28468715247;52236;62735;64296.357036429035;65819;66198.33801661922;9960.402375857471;10551;10569.841452378067;10572;10641.733956650836;43351.78324108359;43768.78115609402;43959.12081758283;44445.77777111094;44685.329720053574;51525;51548;51701.22448163356;52065.219021715464;52537.47462525326;12744.42650080767;12893.677658058623;12932.676683082998;13019.349032548524;13026;14055.648608784453;14072.929635351758;14341.282935852956;14502.274886255856;14811.629709257355;12075.396230188631;12125.454354553889;12256.693582660504;12364.938175309066;12560.309182995023;12475.313857737912;14319.498817541336;14416.711665766836;14678.77981830252;14766.852331476548;14297.928510357799;14540.636484087983;14794.038387505208;14832.703345932805;14848.034877732913;11015.339079655247;11189.817985492751;11551.298361146382;12110.394480275774;12126.090543209119;12381.257124572554;12602;12784.536010458261;12867.22796632205;13466.663333416744 05:42:44 INFO - PROCESS | 25761 | __end_tp_report 05:42:44 INFO - PROCESS | 25761 | __start_cc_report 05:42:44 INFO - PROCESS | 25761 | _x_x_mozilla_cycle_collect,959 05:42:44 INFO - PROCESS | 25761 | __end_cc_report 05:42:44 INFO - PROCESS | 25761 | __startTimestamp1488462164838__endTimestamp 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | ------- Summary: start ------- 05:42:44 INFO - PROCESS | 25761 | Number of tests: 6 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#0] dojo.html Cycles:165 Average:5448.19 Median:5715.80 stddev:602.17 (10.5%) stddev-sans-first:579.63 05:42:44 INFO - PROCESS | 25761 | Values: 3285.9 3328.3 3335.2 3345.7 3373.9 5362.9 5407.4 5439.1 5443.2 5457.9 5464.7 5516.0 5526.1 5531.3 5540.1 4911.4 4928.3 4955.4 4970.3 5032.8 4862.4 4867.1 4972.1 5018.5 5032.2 4855.9 4865.6 4914.9 4959.4 4979.9 4986.5 4986.9 4988.7 4992.2 5022.0 4737.2 4914.0 4925.7 4934.6 4958.8 5290.6 5306.5 5390.1 5401.9 5450.0 5797.8 5800.0 5806.1 5809.8 5818.3 5796.1 5829.1 5844.2 5845.7 5853.7 5291.2 5310.9 5442.6 5570.2 5582.9 5984.7 5994.5 5999.2 6012.7 6033.8 5737.9 5791.1 5796.5 5800.9 5805.6 5748.4 5791.2 5819.4 5892.7 5895.2 5818.8 5834.2 5884.6 5908.0 5918.9 5851.4 5853.2 5858.1 5861.8 5866.0 4417.8 4450.9 4570.5 4571.9 4589.1 4025.1 4027.6 4047.5 4080.1 4112.2 5712.8 5715.9 5717.5 5720.8 5744.3 5709.4 5765.8 5817.4 5845.8 5871.7 5691.5 5694.1 5696.5 5715.8 5725.3 4984.4 4988.1 4993.2 5001.3 5027.3 5829.3 5872.1 6011.7 6105.7 6106.5 5812.4 5871.9 5879.1 5900.6 5923.7 6089.4 6111.8 6131.5 6137.8 6140.5 5592.3 5628.4 5769.8 5774.5 5787.4 5834.0 5843.2 5885.8 5903.6 5955.4 5755.3 5757.4 5767.5 5771.4 5776.6 5565.1 5749.5 5753.9 5757.5 5764.9 5505.6 5640.2 5699.1 5704.3 5754.4 5793.8 5802.4 5807.3 5807.4 5809.5 5618.5 5676.8 5679.2 5686.7 5688.8 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#1] ext.html Cycles:180 Average:61122.14 Median:409504.50 stddev:112859.68 (27.6%) stddev-sans-first:113084.62 05:42:44 INFO - PROCESS | 25761 | Values: 542.5 573.2 599.7 610.5 632.1 36582.5 37381.0 40839.2 48754.8 50260.7 51941.2 52426.5 52507.5 52513.0 52536.7 9528.2 9721.3 9727.1 9731.4 9732.6 8991.9 9203.3 11146.4 11395.5 11404.9 11135.6 11183.2 11183.4 11184.8 11188.2 11492.0 11574.3 11580.4 11593.8 11597.7 11447.1 11530.3 11532.5 11534.0 11538.4 49398.5 49698.0 49731.0 49764.0 49806.3 4436.4 4436.7 4591.8 4598.4 4784.2 32497.8 32616.7 32708.2 32893.8 33780.5 4331.2 4338.5 4375.2 4399.6 4457.5 344248.0 346957.0 349433.0 350613.0 351773.0 59870.4 60078.0 60279.0 60433.0 60870.7 63395.4 63460.7 63510.0 63571.9 63609.0 17968.6 18511.3 18536.3 18546.6 18567.6 12678.6 12708.4 12744.0 12809.3 12810.4 19397.6 19633.4 19832.0 20330.6 20651.1 7237.4 7346.8 7399.7 7536.5 7598.3 977.7 980.7 986.0 988.3 1006.5 34385.8 34944.7 34949.3 35211.6 35391.8 1073.8 1143.4 1157.1 1205.3 1213.2 17541.8 18441.5 18508.8 18537.6 18548.6 507138.0 511142.0 512156.0 512735.0 513050.0 69692.3 69899.3 70108.0 70235.6 70287.6 1485.7 1510.4 1527.2 1540.5 1543.5 32669.8 33875.0 34068.8 34533.8 34544.0 59656.4 59775.4 59880.0 60169.1 60329.7 406628.0 406907.0 408814.0 409392.0 409617.0 28268.9 28991.9 29400.0 31774.7 32137.5 50131.5 54184.0 54525.7 54636.7 55720.7 43669.6 43891.8 45103.5 45712.0 46727.0 43807.6 44544.6 44624.0 45667.3 46137.3 43756.3 43839.3 43896.3 44046.0 44229.3 37637.4 40017.8 40097.0 40259.2 40676.2 29222.8 29702.0 29714.0 29974.9 29986.3 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#2] jquery.html Cycles:180 Average:38332.68 Median:29621.85 stddev:110232.58 (372.1%) stddev-sans-first:110505.01 05:42:44 INFO - PROCESS | 25761 | Values: 399.2 418.5 425.4 428.0 448.0 17105.8 21315.4 22628.9 23031.8 23273.5 22827.8 22949.3 23342.6 23438.6 23704.4 5904.0 6167.5 6266.2 6335.3 6384.6 6217.3 6306.5 6308.0 6313.0 6315.0 7815.7 8058.2 8121.0 8272.0 8311.8 8044.6 8223.6 8225.6 8265.7 8276.2 7898.4 8030.8 8110.6 8111.9 8140.2 29454.7 29789.0 30080.2 30244.5 30438.4 3581.6 3655.9 3661.4 3697.3 3729.6 16306.6 17323.0 17369.7 17603.6 17871.4 2128.8 2194.9 2220.5 2226.3 2257.8 111951.0 113243.9 113708.0 116117.0 116238.4 16166.8 19702.6 20686.7 20944.3 21572.1 39882.4 39984.4 40037.0 41005.6 41091.4 11364.7 11452.1 11521.8 11557.2 11680.2 9468.8 9482.3 9494.0 9518.3 9750.7 10613.6 10738.8 10877.5 10893.5 11004.4 3577.4 3924.0 3966.1 3979.8 4080.1 934.2 947.8 955.1 956.3 963.8 19599.6 20681.7 20966.6 20982.4 21145.5 955.2 960.7 966.1 974.9 977.1 10807.3 11562.4 11649.3 11666.1 11730.0 659153.0 660579.0 666119.0 680583.0 680849.0 111395.4 112018.0 114495.0 115350.0 116086.0 1087.2 1111.2 1111.8 1119.0 1126.7 17178.1 18767.2 18984.9 20043.8 20047.0 42274.0 49213.8 49852.5 50016.5 50716.0 66146.3 66735.0 67249.3 67300.0 67667.3 9232.5 9395.7 9471.5 9576.3 9864.5 12293.8 13614.9 13692.9 13749.8 13800.2 11974.9 11987.2 12015.9 12196.9 12458.8 11519.4 11807.6 11917.9 12008.8 12162.3 12407.1 12612.6 12647.9 12972.0 13128.5 8179.5 9355.4 9633.7 9714.3 9775.3 11773.6 12648.7 12719.9 12741.1 12800.4 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#3] mootools.html Cycles:180 Average:5804.89 Median:5137.08 stddev:3304.16 (64.3%) stddev-sans-first:3297.44 05:42:44 INFO - PROCESS | 25761 | Values: 1480.4 1482.3 1495.1 1510.0 1520.5 8767.2 9089.1 9094.2 9096.8 9099.9 7939.4 8139.6 8146.1 8373.3 9000.9 2410.2 2489.0 2490.0 2491.1 2500.7 2371.9 2412.1 2430.3 2455.7 2456.6 2386.6 2408.3 2443.3 2450.3 2451.3 2328.4 2343.4 2343.8 2345.0 2353.0 2259.0 2368.8 2372.0 2373.5 2373.5 8851.9 8931.7 8938.4 8940.5 8942.6 5407.1 5612.6 5614.3 5618.3 5618.4 3277.8 3332.0 3551.8 3569.9 3605.5 1408.2 1424.6 1462.0 1472.8 1483.5 12444.4 12447.9 12455.8 12460.2 12460.4 4743.0 4777.8 4820.4 4825.9 4850.3 10643.5 10657.8 10658.2 10661.9 10664.5 5612.1 5615.3 5615.8 5623.0 5623.6 4994.5 5085.1 5110.7 5128.2 5213.4 3924.6 4052.1 4076.3 4081.7 4131.0 1175.4 1175.7 1194.1 1200.2 1203.3 928.6 953.5 958.3 958.7 984.7 5647.7 5671.1 5698.4 5735.1 5831.2 601.6 603.6 603.8 605.0 609.3 2936.3 2959.6 2989.1 3038.2 4238.8 10469.9 10667.9 10915.3 10921.6 10929.4 10712.5 10845.3 10871.5 10885.2 10928.8 8368.1 8427.2 8536.1 8685.1 8701.9 5682.5 5784.7 5948.7 6004.8 6088.9 9810.9 9865.3 9868.9 9955.8 9996.4 9012.6 9801.6 9942.1 9943.5 10162.9 7444.2 8239.5 8278.0 8450.5 8457.0 8770.3 8786.9 8788.0 8863.5 8877.5 7545.3 7545.3 7631.7 7634.2 7816.9 7186.5 7268.9 7276.9 7327.5 7374.9 6366.5 6428.6 6462.5 6477.8 6501.3 5024.3 5097.2 5145.9 5161.5 5194.1 4959.2 4963.2 5118.0 5124.1 5190.7 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#4] prototype.html Cycles:180 Average:4738.61 Median:5359.26 stddev:1361.12 (25.4%) stddev-sans-first:1325.13 05:42:44 INFO - PROCESS | 25761 | Values: 385.0 406.9 412.4 414.8 416.6 5078.2 5131.3 5220.3 5353.8 5410.6 5142.5 5261.5 5278.6 5289.0 5306.5 4237.7 4240.6 4243.5 4248.2 4251.7 4175.6 4235.6 4243.2 4249.4 4254.2 4198.9 4239.9 4245.9 4250.9 4252.0 4214.5 4218.3 4223.8 4232.2 4248.8 3866.1 3870.5 3875.4 3877.8 3878.0 5001.9 5187.8 5263.7 5268.9 5272.2 4809.0 4815.7 4821.1 4834.8 4847.7 5325.5 5535.5 5598.9 5599.9 5603.4 4072.7 4091.4 4096.6 4103.3 4107.6 5756.6 5785.3 5791.7 5807.2 5816.4 4084.8 4175.4 4196.5 4197.4 4201.1 4210.4 4252.4 4252.7 4254.5 4258.6 4728.4 4732.9 4774.6 4789.8 4812.6 5376.2 5565.9 5584.5 5612.6 5627.1 1411.4 1429.9 1433.7 1434.1 1437.8 958.3 962.3 988.5 990.0 997.2 5302.5 5311.5 5313.7 5315.6 5319.8 5502.2 5517.2 5537.8 5585.5 5598.7 5156.3 5364.8 5393.7 5398.4 5446.3 2948.6 2951.4 2955.0 2962.3 2967.1 5824.8 5838.7 5853.1 5876.3 5883.6 5509.9 5869.7 5913.9 5920.8 5925.3 6005.8 6020.4 6028.0 6050.0 6053.3 5492.2 5673.2 5689.9 5764.7 5800.8 5641.4 5654.6 5678.0 5680.7 5709.2 5857.9 5988.4 5997.6 6006.4 6024.6 4410.6 4466.6 4508.2 4512.3 4514.3 5743.3 5757.6 5760.9 5784.4 5798.1 5462.8 5625.2 5630.5 5662.5 5679.0 5560.6 5576.3 5582.0 5584.7 5588.7 5524.3 5524.9 5585.3 5609.9 5638.7 5440.3 5519.8 5581.5 5607.3 5628.7 5466.8 5480.3 5487.5 5505.0 5532.8 05:42:44 INFO - PROCESS | 25761 | 05:42:44 INFO - PROCESS | 25761 | [#5] yui.html Cycles:180 Average:18280.47 Median:43863.95 stddev:22774.17 (51.9%) stddev-sans-first:22800.18 05:42:44 INFO - PROCESS | 25761 | Values: 788.3 805.1 805.2 897.5 900.6 16256.0 17393.3 17804.6 17986.6 18139.2 16342.7 17896.5 18322.2 18485.0 18501.3 707.7 841.2 857.4 859.2 859.2 731.1 745.7 746.0 818.5 834.4 882.9 883.9 884.5 884.8 885.2 880.6 881.1 881.4 881.5 881.6 550.0 562.1 628.3 643.4 646.9 17068.0 17287.0 17345.8 17350.7 17361.5 15582.2 15627.0 15701.5 15707.6 15780.0 12338.8 13262.2 13271.6 13409.2 13464.5 4032.4 4058.3 4065.3 4132.7 4234.9 83626.6 83915.2 84534.2 86290.0 87960.0 11774.8 11796.4 11835.5 11877.8 12004.6 23766.4 23850.6 24003.2 24321.6 24457.3 8639.8 8728.3 8800.1 8884.6 8942.7 4795.4 4956.8 5001.7 5002.8 5020.1 3865.8 3973.4 3979.2 3980.8 3981.5 640.9 642.5 650.6 654.6 665.6 813.0 825.1 840.7 845.0 859.7 10669.2 10992.8 11222.8 11976.9 12102.3 786.3 798.1 800.0 819.9 822.6 5433.9 5443.7 5529.4 5545.8 5557.5 78067.0 78427.0 79344.6 80674.6 83670.0 57473.1 70242.6 70550.0 70718.6 71531.3 52236.0 62735.0 64296.4 65819.0 66198.3 9960.4 10551.0 10569.8 10572.0 10641.7 43351.8 43768.8 43959.1 44445.8 44685.3 51525.0 51548.0 51701.2 52065.2 52537.5 12744.4 12893.7 12932.7 13019.3 13026.0 14055.6 14072.9 14341.3 14502.3 14811.6 12075.4 12125.5 12256.7 12364.9 12560.3 12475.3 14319.5 14416.7 14678.8 14766.9 14297.9 14540.6 14794.0 14832.7 14848.0 11015.3 11189.8 11551.3 12110.4 12126.1 12381.3 12602.0 12784.5 12867.2 13466.7 05:42:44 INFO - PROCESS | 25761 | -------- Summary: end -------- 05:42:44 INFO - PROCESS | 25761 | 05:42:45 INFO - TEST-INFO | 25761: exit 0 05:42:45 INFO - TEST-OK | dromaeo_css | took 1113210ms 05:42:45 INFO - TEST-START | kraken 05:42:45 INFO - operating with platform_type : linux_ 05:42:45 INFO - Initialising browser for kraken test... 05:42:45 INFO - TEST-INFO | started process 26078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz1lNk/profile http://localhost:56250/getInfo.html) 05:42:49 INFO - PROCESS | 26078 | __metrics Screen width/height:1600/1200 05:42:49 INFO - PROCESS | 26078 | colorDepth:24 05:42:49 INFO - PROCESS | 26078 | Browser inner width/height: 1024/697 05:42:49 INFO - PROCESS | 26078 | __metrics 05:42:50 INFO - PROCESS | 26078 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:42:50 INFO - PROCESS | 26078 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:51 INFO - TEST-INFO | 26078: exit 0 05:42:51 INFO - Browser initialized. 05:42:51 INFO - Running cycle 1/1 for kraken test... 05:42:51 INFO - TEST-INFO | started process 26170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz1lNk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:02 INFO - PROCESS | 26170 | RSS: Main: 138153984 05:43:02 INFO - PROCESS | 26170 | 05:43:05 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56250/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:06 INFO - PROCESS | 26170 | RSS: Main: 181186560 05:43:06 INFO - PROCESS | 26170 | 05:43:08 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56250/tests/kraken/driver.html?testName=audio-dft) 05:43:09 INFO - PROCESS | 26170 | RSS: Main: 172609536 05:43:09 INFO - PROCESS | 26170 | 05:43:12 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56250/tests/kraken/driver.html?testName=audio-fft) 05:43:12 INFO - PROCESS | 26170 | RSS: Main: 263573504 05:43:12 INFO - PROCESS | 26170 | 05:43:14 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56250/tests/kraken/driver.html?testName=audio-oscillator) 05:43:15 INFO - PROCESS | 26170 | RSS: Main: 170463232 05:43:15 INFO - PROCESS | 26170 | 05:43:17 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:18 INFO - PROCESS | 26170 | RSS: Main: 172879872 05:43:18 INFO - PROCESS | 26170 | 05:43:21 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56250/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:21 INFO - PROCESS | 26170 | RSS: Main: 211308544 05:43:21 INFO - PROCESS | 26170 | 05:43:24 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56250/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:25 INFO - PROCESS | 26170 | RSS: Main: 210579456 05:43:25 INFO - PROCESS | 26170 | 05:43:28 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56250/tests/kraken/driver.html?testName=json-parse-financial) 05:43:28 INFO - PROCESS | 26170 | RSS: Main: 208596992 05:43:28 INFO - PROCESS | 26170 | 05:43:30 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:30 INFO - PROCESS | 26170 | RSS: Main: 170729472 05:43:30 INFO - PROCESS | 26170 | 05:43:32 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:33 INFO - PROCESS | 26170 | RSS: Main: 178499584 05:43:33 INFO - PROCESS | 26170 | 05:43:35 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:35 INFO - PROCESS | 26170 | RSS: Main: 187097088 05:43:35 INFO - PROCESS | 26170 | 05:43:38 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:39 INFO - PROCESS | 26170 | RSS: Main: 197021696 05:43:39 INFO - PROCESS | 26170 | 05:43:41 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:42 INFO - PROCESS | 26170 | RSS: Main: 192372736 05:43:42 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | Cycle 1(1): loaded http://localhost:56250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56250/tests/kraken/driver.html?testName=ai-astar) 05:43:44 INFO - PROCESS | 26170 | RSS: Main: 244838400 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | __start_tp_report 05:43:44 INFO - PROCESS | 26170 | _x_x_mozilla_page_load 05:43:44 INFO - PROCESS | 26170 | _x_x_mozilla_page_load_details 05:43:44 INFO - PROCESS | 26170 | |i|pagename|runs| 05:43:44 INFO - PROCESS | 26170 | |0;ai-astar;111;112;111;112;113;111;112;112;110;112 05:43:44 INFO - PROCESS | 26170 | |1;audio-beat-detection;141;117;117;149;117;119;118;118;139;116 05:43:44 INFO - PROCESS | 26170 | |2;audio-dft;160;160;160;161;161;162;160;161;161;161 05:43:44 INFO - PROCESS | 26170 | |3;audio-fft;75;76;75;109;76;83;75;75;101;74 05:43:44 INFO - PROCESS | 26170 | |4;audio-oscillator;81;82;107;83;83;82;94;82;83;96 05:43:44 INFO - PROCESS | 26170 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:43:44 INFO - PROCESS | 26170 | |6;imaging-darkroom;146;146;147;146;147;146;147;147;146;146 05:43:44 INFO - PROCESS | 26170 | |7;imaging-desaturate;96;96;96;95;96;95;96;95;96;95 05:43:44 INFO - PROCESS | 26170 | |8;json-parse-financial;49;49;51;50;48;49;49;50;48;47 05:43:44 INFO - PROCESS | 26170 | |9;json-stringify-tinderbox;64;64;64;65;64;64;64;64;64;64 05:43:44 INFO - PROCESS | 26170 | |10;stanford-crypto-aes;76;77;80;77;81;81;79;75;75;76 05:43:44 INFO - PROCESS | 26170 | |11;stanford-crypto-ccm;127;121;122;120;118;118;118;118;164;126 05:43:44 INFO - PROCESS | 26170 | |12;stanford-crypto-pbkdf2;160;160;164;158;157;157;158;158;167;159 05:43:44 INFO - PROCESS | 26170 | |13;stanford-crypto-sha256-iterative;69;65;62;62;61;63;60;60;61;60 05:43:44 INFO - PROCESS | 26170 | __end_tp_report 05:43:44 INFO - PROCESS | 26170 | __start_cc_report 05:43:44 INFO - PROCESS | 26170 | _x_x_mozilla_cycle_collect,1539 05:43:44 INFO - PROCESS | 26170 | __end_cc_report 05:43:44 INFO - PROCESS | 26170 | __startTimestamp1488462224315__endTimestamp 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | ------- Summary: start ------- 05:43:44 INFO - PROCESS | 26170 | Number of tests: 14 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.84 (0.8%) stddev-sans-first:0.87 05:43:44 INFO - PROCESS | 26170 | Values: 111.0 112.0 111.0 112.0 113.0 111.0 112.0 112.0 110.0 112.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:118.50 stddev:12.63 (10.7%) stddev-sans-first:12.01 05:43:44 INFO - PROCESS | 26170 | Values: 141.0 117.0 117.0 149.0 117.0 119.0 118.0 118.0 139.0 116.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 05:43:44 INFO - PROCESS | 26170 | Values: 160.0 160.0 160.0 161.0 161.0 162.0 160.0 161.0 161.0 161.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:12.57 (16.8%) stddev-sans-first:13.09 05:43:44 INFO - PROCESS | 26170 | Values: 75.0 76.0 75.0 109.0 76.0 83.0 75.0 75.0 101.0 74.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:83.00 stddev:8.74 (10.5%) stddev-sans-first:8.97 05:43:44 INFO - PROCESS | 26170 | Values: 81.0 82.0 107.0 83.0 83.0 82.0 94.0 82.0 83.0 96.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:43:44 INFO - PROCESS | 26170 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:43:44 INFO - PROCESS | 26170 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:43:44 INFO - PROCESS | 26170 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.00 stddev:1.15 (2.4%) stddev-sans-first:1.22 05:43:44 INFO - PROCESS | 26170 | Values: 49.0 49.0 51.0 50.0 48.0 49.0 49.0 50.0 48.0 47.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:43:44 INFO - PROCESS | 26170 | Values: 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 64.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:2.36 (3.0%) stddev-sans-first:2.42 05:43:44 INFO - PROCESS | 26170 | Values: 76.0 77.0 80.0 77.0 81.0 81.0 79.0 75.0 75.0 76.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:121.50 stddev:14.03 (11.5%) stddev-sans-first:14.87 05:43:44 INFO - PROCESS | 26170 | Values: 127.0 121.0 122.0 120.0 118.0 118.0 118.0 118.0 164.0 126.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.50 stddev:3.26 (2.0%) stddev-sans-first:3.46 05:43:44 INFO - PROCESS | 26170 | Values: 160.0 160.0 164.0 158.0 157.0 157.0 158.0 158.0 167.0 159.0 05:43:44 INFO - PROCESS | 26170 | 05:43:44 INFO - PROCESS | 26170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:2.83 (4.6%) stddev-sans-first:1.67 05:43:44 INFO - PROCESS | 26170 | Values: 69.0 65.0 62.0 62.0 61.0 63.0 60.0 60.0 61.0 60.0 05:43:44 INFO - PROCESS | 26170 | -------- Summary: end -------- 05:43:44 INFO - PROCESS | 26170 | 05:43:45 INFO - TEST-INFO | 26170: exit 0 05:43:45 INFO - TEST-OK | kraken | took 59923ms 05:43:45 INFO - SUITE-END | took 1173s 05:43:45 INFO - Completed test suite (00:19:33) 05:43:45 INFO - javascript benchmark 05:43:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.934281314374, 3328.334333133373, 3335.249568847008, 3345.715614172795, 3373.865045398184, 5362.892742145154, 5407.351117865852, 5439.129739241722, 5443.156310771827, 5457.945420545793, 5464.6994415307145, 5516.007118718629, 5526.115821468566, 5531.308586426697, 5540.113581826909, 4911.386076740417, 4928.310036594879, 4955.405351357842, 4970.329005584236, 5032.7735251913755, 4862.4408193057725, 4867.123917694814, 4972.129877271481, 5018.473060328668, 5032.169692000815, 4855.902881942359, 4865.586425153866, 4914.926276105862, 4959.429665588449, 4979.900401991958, 4986.4514903360605, 4986.850394488171, 4988.65079444439, 4992.226204938241, 5022.045811295842, 4737.2183589708, 4913.975430122862, 4925.679830810986, 4934.55588996992, 4958.801647934079, 5290.629655924087, 5306.522412982811, 5390.056740070511, 5401.945980540223, 5450.018996580614, 5797.826065218051, 5800.0, 5806.1000544915605, 5809.796657116981, 5818.272715910512, 5796.072628379439, 5829.096490044008, 5844.211031510734, 5845.7369418376275, 5853.707314634294, 5291.206319052173, 5310.946890531122, 5442.619016668795, 5570.2201691762375, 5582.944170558324, 5984.700764961734, 5994.520438364921, 5999.220101386792, 6012.729427175787, 6033.849153771103, 5737.85655358611, 5791.131330300404, 5796.478316951495, 5800.9419905800405, 5805.564582656318, 5748.425157484302, 5791.160281759206, 5819.418058194231, 5892.705364731746, 5895.233619629421, 5818.79634212809, 5834.212381328552, 5884.588078834526, 5908.0, 5918.940810591925, 5851.414858514115, 5853.239078919713, 5858.091995740667, 5861.824145275648, 5865.970670146622, 4417.779111044435, 4450.866474005785, 4570.542945705402, 4571.862844114682, 4589.0821835633005, 4025.0742329264435, 4027.577104404054, 4047.534533528682, 4080.1227736036894, 4112.218678451144, 5712.800051998243, 5715.885682286331, 5717.456841600041, 5720.799772007959, 5744.310682718101, 5709.371969083398, 5765.827025189251, 5817.447342502455, 5845.766169353264, 5871.677057761779, 5691.4877661010705, 5694.08894576874, 5696.51579615729, 5715.797301816238, 5725.2843394575675, 4984.40187177541, 4988.12707776145, 4993.201087825931, 5001.299818025479, 5027.271045698353, 5829.329627092854, 5872.148538461814, 6011.669358185167, 6105.725242364104, 6106.480949119375, 5812.360640329476, 5871.853203669772, 5879.147523609138, 5900.586958912835, 5923.674197919156, 6089.360617135137, 6111.816645500642, 6131.54013449002, 6137.815865523863, 6140.508759299156, 5592.273004509388, 5628.409017053151, 5769.798057067983, 5774.538036957118, 5787.39232380594, 5834.03738383162, 5843.240378750906, 5885.793997210077, 5903.586748927705, 5955.434233747787, 5755.309362876482, 5757.424257574209, 5767.5385969121535, 5771.365149833431, 5776.566757493289, 5565.053940829987, 5749.511291540266, 5753.913691294718, 5757.539396848326, 5764.913526297193, 5505.642133261325, 5640.238567793295, 5699.116636921284, 5704.258446401941, 5754.367019627922, 5793.826185214451, 5802.4197580241635, 5807.274090738658, 5807.448292412214, 5809.50619197373, 5618.49433550966, 5676.77292908279, 5679.233303503974, 5686.658800471985, 5688.800891968761], "value": 5409.640436007107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.5211221861865, 573.2347316332696, 599.6851652882236, 610.4749915073039, 632.1402892066791, 36582.45126323107, 37381.0, 40839.183216335696, 48754.75622621882, 50260.74869625656, 51941.22088168671, 52426.47573524264, 52507.47492525074, 52513.0, 52536.73731631337, 9528.237740980705, 9721.270904682142, 9727.075927786884, 9731.36746111504, 9732.562034708455, 8991.865122023175, 9203.263738900872, 11146.442677866115, 11395.48720307584, 11404.885951140506, 11135.554577816878, 11183.217174797768, 11183.384913829736, 11184.832227516594, 11188.216824822266, 11492.0, 11574.305541667527, 11580.363080030595, 11593.76812463746, 11597.6520704379, 11447.141464390204, 11530.250533715282, 11532.538698452136, 11534.019608333218, 11538.423078846025, 49398.50601493975, 49698.0, 49731.0, 49764.0, 49806.252906206435, 4436.356728274414, 4436.689431739779, 4591.770411479412, 4598.425196850394, 4784.234522476387, 32497.837510812533, 32616.673833261837, 32708.182295442566, 32893.835530822194, 33780.49329260038, 4331.220380331571, 4338.522762496154, 4375.234333991571, 4399.560043995575, 4457.531959144308, 344248.0, 346957.0, 349433.0, 350613.0, 351773.0, 59870.40129598735, 60078.0, 60279.0, 60433.0, 60870.69564652148, 63395.36604633987, 63460.68269658622, 63510.0, 63571.86782859099, 63609.0, 17968.640627187382, 18511.259549617866, 18536.25854965786, 18546.629067418577, 18567.628647426976, 12678.619641410773, 12708.428120734588, 12744.0, 12809.295488748208, 12810.359482025862, 19397.612047758965, 19633.429325653913, 19832.0, 20330.593388132154, 20651.070701818455, 7237.421006319481, 7346.816329591696, 7399.6670149843385, 7536.5101268417375, 7598.278163574451, 977.7018009507169, 980.6616717232544, 985.9901400986042, 988.2588058955783, 1006.5470538257813, 34385.82807085948, 34944.65055349465, 34949.30101397958, 35211.64788352135, 35391.823040885145, 1073.8442925775719, 1143.3597185576104, 1157.056998546182, 1205.2888795610631, 1213.2295992045115, 17541.824581754274, 18441.53896152607, 18508.81491185098, 18537.629247414978, 18548.629027419374, 507138.0, 511142.0, 512156.0, 512735.0, 513050.0, 69692.30307696959, 69899.30100698928, 70108.0, 70235.6488217566, 70287.64856175687, 1485.68057867559, 1510.3731951240331, 1527.1600619659143, 1540.4839378808, 1543.4520745135314, 32669.836650816593, 33875.0, 34068.829655851565, 34533.82733086318, 34544.0, 59656.40343596508, 59775.40224597872, 59880.0, 60169.09746353896, 60329.69835150796, 406628.0, 406907.0, 408814.0, 409392.0, 409617.0, 28268.858655707412, 28991.855040724662, 29400.0, 31774.682253177172, 32137.517937231427, 50131.49868501268, 54184.0, 54525.72737136289, 54636.72681636566, 55720.72139639276, 43669.56330436655, 43891.78054109709, 45103.54896450994, 45712.0, 46727.0, 43807.561924380345, 44544.554554454044, 44623.98881454032, 45667.314990274506, 46137.307940381594, 43756.34365484457, 43839.34240986324, 43896.34155487606, 44046.0, 44229.336559950985, 37637.435438467895, 40017.79991100142, 40097.0, 40259.19481610293, 40676.1864762709, 29222.772029789405, 29702.0, 29714.0, 29974.85012574923, 29986.250343740707], "value": 21871.93476845866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.2374564581646, 418.54587772267087, 425.3768229543718, 427.9743215407075, 448.04566273836724, 17105.82894171058, 21315.36053918381, 22628.8868555657, 23031.769682303173, 23273.534529309447, 22827.77172228277, 22949.311520654406, 23342.64986025211, 23438.64842027371, 23704.407389815264, 5904.0258357370985, 6167.506599472032, 6266.154069200645, 6335.303116657164, 6384.648844313561, 6217.347178546255, 6306.527010474233, 6308.0, 6313.0, 6315.0, 7815.687372505093, 8058.234467725557, 8120.9593952030455, 8272.0, 8311.792205194888, 8044.597770111501, 8223.629936652866, 8225.629846656915, 8265.710700125466, 8276.213759692819, 7898.368130549599, 8030.839383212303, 8110.63502142405, 8111.878321825118, 8140.185981401872, 29454.70545294541, 29789.0, 30080.247993800112, 30244.54633180482, 30438.391232175454, 3581.623929487392, 3655.926881462356, 3661.4324779659196, 3697.2975134724584, 3729.589745128034, 16306.592335191597, 17323.0, 17369.7394539082, 17603.647927041515, 17871.374501892373, 2128.7764784697692, 2194.923177688773, 2220.5114874727533, 2226.2764601504578, 2257.808086312665, 111951.0, 113243.86756132415, 113708.0, 116117.0, 116238.41880790626, 16166.838331616533, 19702.60594788125, 20686.68969965452, 20944.26695065696, 21572.137114515557, 39882.40176397356, 39984.400233996515, 40037.0, 41005.58994410077, 41091.38362924558, 11364.715882103013, 11452.083833293316, 11521.769564608661, 11557.190996630155, 11680.182387232811, 9468.810623787485, 9482.288828337902, 9494.0, 9518.286128540249, 9750.658726944523, 10613.57545698179, 10738.78522429547, 10877.456127193609, 10893.455327233607, 11004.449777511092, 3577.373959557067, 3923.9803800980812, 3966.087799806003, 3979.8408063677707, 4080.0853924962034, 934.1872570863393, 947.8436058050345, 955.1069749783974, 956.2541217850088, 963.8409662405625, 19599.608007839764, 20681.68977465339, 20966.58066838655, 20982.37052888416, 21145.471363216042, 955.1833182628891, 960.6589660670501, 966.1497881863914, 974.9122578967927, 977.0620204603518, 10807.297525660806, 11562.421878906189, 11649.301041937511, 11666.125040621988, 11730.0, 659153.0, 660579.0, 666119.0, 680583.0, 680849.0, 111395.44302278598, 112018.0, 114495.0, 115350.0, 116086.0, 1087.2280680716622, 1111.1610733895857, 1111.7943180511631, 1119.0, 1126.6620013995769, 17178.141092945054, 18767.249310027444, 18984.905075474533, 20043.799562004195, 20047.0, 42274.0, 49213.75393123155, 49852.50147498624, 50016.49983500118, 50716.0, 66146.33853661401, 66735.0, 67249.32750672626, 67300.0, 67667.32332676808, 9232.492212928353, 9395.671151509665, 9471.47906865129, 9576.329656923948, 9864.471006993928, 12293.815592765937, 13614.93192534031, 13692.931535342259, 13749.793753093913, 13800.171989680652, 11974.880251197377, 11987.22083064598, 12015.939920300343, 12196.878031219574, 12458.813117803058, 11519.366434846164, 11807.645770626896, 11917.940410297893, 12008.75982480363, 12162.270263784201, 12407.069469789622, 12612.621621351374, 12647.87352126467, 12972.0, 13128.540501082416, 8179.468334558234, 9355.4386736796, 9633.662821801483, 9714.319997600383, 9775.266854985763, 11773.587924422603, 12648.6837829055, 12719.87280127187, 12741.10812243134, 12800.35998200105], "value": 11656.43556976102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.4374337751653, 1482.3477669825277, 1495.1328229626818, 1509.9773503397448, 1520.460236616002, 8767.167119123682, 9089.091090890908, 9094.226990705782, 9096.772580685487, 9099.863502047467, 7939.364850811936, 8139.552324622144, 8146.144654811248, 8373.330133589314, 9000.909990900089, 2410.1684918703018, 2489.0417189382038, 2490.0288887333954, 2491.0907518755616, 2500.6749122614033, 2371.893264803088, 2412.07135252928, 2430.2952143878256, 2455.6807615010025, 2456.6192240202795, 2386.642003699442, 2408.2534414331526, 2443.3280847766828, 2450.2649205238445, 2451.252368027751, 2328.3946173994714, 2343.4024323797407, 2343.7539058398966, 2345.0, 2352.999975010622, 2259.0, 2368.839268758296, 2371.97628023721, 2373.4659701567184, 2373.5134297468976, 8851.867221991675, 8931.687390941286, 8938.4190027648, 8940.46357218569, 8942.64229430822, 5407.107827208506, 5612.607117501777, 5614.326280846324, 5618.325800903876, 5618.353889302742, 3277.8033318001, 3332.0, 3551.8224088795455, 3569.8750543731103, 3605.47720580517, 1408.1621435246013, 1424.551266351096, 1462.0423622527262, 1472.7790831375273, 1483.4733669547263, 12444.440000200013, 12447.875521244761, 12455.813162802566, 12460.190087644365, 12460.376981150906, 4742.952570474251, 4777.784999675023, 4820.39745031871, 4825.914169311947, 4850.345203397566, 10643.46782660864, 10657.786844263072, 10658.200634952409, 10661.89338106609, 10664.520096595672, 5612.07400778875, 5615.2700148981185, 5615.775368985276, 5623.0159722048475, 5623.578231632644, 4994.450610432849, 5085.1355269604255, 5110.744462776921, 5128.205128205134, 5213.426523082534, 3924.646781789653, 4052.068024354356, 4076.30702780528, 4081.673466122703, 4131.049858532554, 1175.3829239649253, 1175.7178277213407, 1194.146185477388, 1200.2018657592778, 1203.3141109567462, 928.5960607135918, 953.537534295866, 958.3038022699922, 958.7075941837807, 984.6602921991902, 5647.745851436695, 5671.149327600893, 5698.373178950312, 5735.11105778605, 5831.2127862738835, 601.5939241012387, 603.6408337039454, 603.7524614907867, 604.9848753781102, 609.3479976425272, 2936.2512559297243, 2959.615250017484, 2989.1480927935436, 3038.194878357237, 4238.809253583535, 10469.895301046892, 10667.893321066846, 10915.345079295268, 10921.617743378943, 10929.398883061507, 10712.464376781285, 10845.295055821347, 10871.45642717861, 10885.18361122919, 10928.781424371467, 8368.121347258571, 8427.188154546802, 8536.103709110579, 8685.088065753005, 8701.869471957925, 5682.460166284196, 5784.7107644618445, 5948.73230704628, 6004.819855404345, 6088.939110608837, 9810.901890980998, 9865.309428339948, 9868.901310986797, 9955.751106222402, 9996.350237234847, 9012.63949442015, 9801.558929848032, 9942.105210531086, 9943.453110079015, 10162.89837101649, 7444.218357072429, 8239.464434811718, 8277.95861020691, 8450.450720703135, 8457.02744184402, 8770.25452836516, 8786.868196977179, 8787.956060219658, 8863.512506811929, 8877.467351958903, 7545.283198096172, 7545.320921117126, 7631.656575454229, 7634.160242373446, 7816.921830781619, 7186.496945213785, 7268.9273107270365, 7276.854462910818, 7327.487075904635, 7374.889376659462, 6366.490680745622, 6428.614283143026, 6462.547621666627, 6477.805665830033, 6501.349865013461, 5024.271480635361, 5097.15896877026, 5145.948540514697, 5161.535461808305, 5194.065068287745, 4959.181735013826, 4963.230699241623, 5118.0, 5124.077666020152, 5190.740462976912], "value": 4615.835131666765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.99230015399695, 406.9491313585802, 412.41416319675636, 414.8071146916685, 416.6229562246168, 5078.238264260358, 5131.307273518083, 5220.29526013988, 5353.7590808413615, 5410.647338165459, 5142.485751424856, 5261.526462618363, 5278.604104692154, 5288.99509093273, 5306.469353064692, 4237.682173836959, 4240.597143271384, 4243.490781106271, 4248.2140803951215, 4251.723637963522, 4175.645070169039, 4235.6187943085115, 4243.151369726052, 4249.44757181566, 4254.170436764832, 4198.91602167958, 4239.894002649928, 4245.872623821275, 4250.872473825791, 4251.978740106295, 4214.452121224252, 4218.3250679891225, 4223.788810559459, 4232.222466564051, 4248.787560621957, 3866.149447121629, 3870.5161854768153, 3875.418687196915, 3877.836649005287, 3878.0, 5001.924971125436, 5187.818426355059, 5263.6841789492755, 5268.894622107537, 5272.18281166416, 4808.951910480885, 4815.66290359675, 4821.108095002436, 4834.758262086882, 4847.709137451764, 5325.520703136697, 5535.474129957688, 5598.860028499279, 5599.916001259984, 5603.355614104389, 4072.6538244249273, 4091.4476545666253, 4096.5903409659095, 4103.261412945669, 4107.609777071173, 5756.625819321773, 5785.305763308388, 5791.739371728282, 5807.1869938208265, 5816.389279125716, 4084.7753373564146, 4175.415441838145, 4196.454460920061, 4197.433346498245, 4201.138766552849, 4210.368444733314, 4252.4046633471335, 4252.702310838274, 4254.489461264668, 4258.552851950562, 4728.361671174347, 4732.881677958078, 4774.570288674036, 4789.808407663654, 4812.639052071108, 5376.193570964387, 5565.916511252334, 5584.46947539983, 5612.550995920316, 5627.086790491171, 1411.4072089722342, 1429.8784603308627, 1433.6881753195917, 1434.1395162902174, 1437.7922545061988, 958.2717134977468, 962.2879069488667, 988.5106872098214, 990.0495524296756, 997.1773287038078, 5302.496262855023, 5311.49540793624, 5313.654612450178, 5315.6013299002725, 5319.813806516753, 5502.239283429344, 5517.227588137664, 5537.778488860481, 5585.469380408855, 5598.692071936001, 5156.278121063054, 5364.766103796149, 5393.703346315911, 5398.406175320712, 5446.346438427335, 2948.5871977923107, 2951.409718056397, 2954.9704502955124, 2962.3482833776534, 2967.095036013993, 5824.786581099155, 5838.737256823453, 5853.063509838491, 5876.328318986416, 5883.646321596734, 5509.906235630515, 5869.706514674249, 5913.940860591339, 5920.763169473259, 5925.318588362394, 6005.819825405245, 6020.367861374581, 6028.0, 6049.969750151221, 6053.303870055, 5492.203630473479, 5673.177389278614, 5689.857753556194, 5764.711764411679, 5800.767969281182, 5641.420402287366, 5654.6324488908085, 5678.0, 5680.71596420169, 5709.172170035238, 5857.853553661193, 5988.431099045583, 5997.5501837363245, 6006.369331220334, 6024.608400453956, 4410.558944105692, 4466.59800617946, 4508.233600287894, 4512.255477846119, 4514.25514790056, 5743.253377060955, 5757.596968212185, 5760.913586296293, 5784.363719990713, 5798.072308430631, 5462.808801691922, 5625.240592519957, 5630.5214056805635, 5662.5469962402085, 5678.971605141948, 5560.638558493685, 5576.33084029919, 5581.995240856685, 5584.748686309207, 5588.6646801192055, 5524.254225679482, 5524.917126243029, 5585.329760428612, 5609.887802244014, 5638.661680299195, 5440.265564148789, 5519.751611177587, 5581.544120586928, 5607.299087614048, 5628.718564071862, 5466.808661696821, 5480.287257807411, 5487.478689524489, 5504.981578408007, 5532.778688852401], "value": 4322.6875886062835, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.3259812860001, 805.0822062848354, 805.1666525146475, 897.5377680494545, 900.5542256582991, 16256.0, 17393.304267829288, 17804.64390712185, 17986.55033624157, 18139.183736731844, 16342.673146537061, 17896.46310610684, 18322.175502102404, 18485.0, 18501.259949602, 707.6709330161474, 841.2428814067342, 857.4212406625503, 859.1623167411786, 859.1966511311912, 731.1153504259826, 745.6644509970508, 745.9664315105833, 818.5088946632003, 834.4367551902471, 882.8940527136753, 883.9292856571491, 884.5444596033049, 884.849575572151, 885.234272354412, 880.5993273060742, 881.1496905486205, 881.391839630656, 881.4755220643707, 881.5636260051284, 550.0429253099618, 562.0753859900482, 628.2994461175801, 643.3887806583717, 646.9450096741735, 17067.97592144475, 17287.049212293317, 17345.826541734546, 17350.65298694019, 17361.47915562535, 15582.22088895562, 15627.0, 15701.450449234337, 15707.607309817231, 15780.0, 12338.753224935452, 13262.204267743966, 13271.601851944457, 13409.195448273134, 13464.5287414941, 4032.3951407288846, 4058.289799285113, 4065.26825171469, 4132.73137246081, 4234.894127646833, 83626.58186709088, 83915.16084839196, 84534.15465845325, 86290.0, 87960.0, 11774.764504709858, 11796.410179490991, 11835.461390019242, 11877.821832672516, 12004.579839705742, 23766.405839853796, 23850.642240366407, 24003.159889404138, 24321.635175472384, 24457.266282011213, 8639.78400539979, 8728.25809806161, 8800.119988001148, 8884.600192991331, 8942.73171804847, 4795.424549054136, 4956.801727930842, 5001.699898006132, 5002.824901128443, 5020.096382651085, 3865.7873816939777, 3973.443717879499, 3979.2240513100246, 3980.8407663693706, 3981.482407287034, 640.8942524483501, 642.4956409218835, 650.5641220382355, 654.5908806995627, 665.6205962601271, 812.9918700813034, 825.1130035212051, 840.6763396092548, 844.9619767110372, 859.7162936231028, 10669.1862383395, 10992.835107473395, 11222.831657524981, 11976.88023119775, 12102.334371609646, 786.3473317146754, 798.1499702816482, 800.0, 819.8524265632124, 822.5558198572824, 5433.918491222635, 5443.673379597237, 5529.391766905637, 5545.77816887328, 5557.499825015768, 78067.0, 78427.0, 79344.60327698325, 80674.5966270165, 83670.0, 57473.13790293149, 70242.64878675574, 70550.0, 70718.64640676764, 71531.28468715247, 52236.0, 62735.0, 64296.357036429035, 65819.0, 66198.33801661922, 9960.402375857471, 10551.0, 10569.841452378067, 10572.0, 10641.733956650836, 43351.78324108359, 43768.78115609402, 43959.12081758283, 44445.77777111094, 44685.329720053574, 51525.0, 51548.0, 51701.22448163356, 52065.219021715464, 52537.47462525326, 12744.42650080767, 12893.677658058623, 12932.676683082998, 13019.349032548524, 13026.0, 14055.648608784453, 14072.929635351758, 14341.282935852956, 14502.274886255856, 14811.629709257355, 12075.396230188631, 12125.454354553889, 12256.693582660504, 12364.938175309066, 12560.309182995023, 12475.313857737912, 14319.498817541336, 14416.711665766836, 14678.77981830252, 14766.852331476548, 14297.928510357799, 14540.636484087983, 14794.038387505208, 14832.703345932805, 14848.034877732913, 11015.339079655247, 11189.817985492751, 11551.298361146382, 12110.394480275774, 12126.090543209119, 12381.257124572554, 12602.0, 12784.536010458261, 12867.22796632205, 13466.663333416744], "value": 7686.975147832217, "unit": "score"}], "name": "dromaeo_css", "value": 7719.1943421489605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 112.0, 113.0, 111.0, 112.0, 112.0, 110.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 117.0, 149.0, 117.0, 119.0, 118.0, 118.0, 139.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 76.0, 83.0, 75.0, 75.0, 101.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 107.0, 83.0, 83.0, 82.0, 94.0, 82.0, 83.0, 96.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 50.0, 48.0, 49.0, 49.0, 50.0, 48.0, 47.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 80.0, 77.0, 81.0, 81.0, 79.0, 75.0, 75.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 122.0, 120.0, 118.0, 118.0, 118.0, 118.0, 164.0, 126.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 164.0, 158.0, 157.0, 157.0, 158.0, 158.0, 167.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 62.0, 62.0, 61.0, 63.0, 60.0, 60.0, 61.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1463.6999999999998, "alertThreshold": 2.0}]} 05:43:46 INFO - Return code: 0 05:43:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:43:46 ERROR - # TBPL SUCCESS # 05:43:46 INFO - Running post-action listener: _resource_record_post_action 05:43:46 INFO - [mozharness: 2017-03-02 13:43:46.131490Z] Finished run-tests step (success) 05:43:46 INFO - Running post-run listener: _resource_record_post_run 05:43:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366329856; Read time: 24; Write time: 226400 05:43:46 INFO - TinderboxPrint: CPU usage
13.0% 05:43:46 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 05:43:46 INFO - TinderboxPrint: I/O write bytes / time
366,329,856 / 226,400 05:43:46 INFO - TinderboxPrint: CPU idle
8,262.5 (87.0%) 05:43:46 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 05:43:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:43:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110018560; Read time: 0; Write time: 87028 05:43:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256311296; Read time: 24; Write time: 139372 05:43:46 INFO - Running post-run listener: _upload_blobber_files 05:43:46 INFO - Blob upload gear active. 05:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43: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 05:43: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-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43: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-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:47 INFO - (blobuploader) - INFO - Done attempting. 05:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:48 INFO - (blobuploader) - INFO - Done attempting. 05:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:51 INFO - (blobuploader) - INFO - Done attempting. 05:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:52 INFO - (blobuploader) - INFO - Done attempting. 05:43:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:52 INFO - Return code: 0 05:43:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79a97d1762976c5721d460fa23992512eb2cf5492bb02c94fea0304243ca114c30abd3eba2afab7c4ff64dcac68e5873242654c92282188ad9571ab609c47159", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d26f3d72301f0664ef43e7b27c9106e1f0722617722b897e923bd09b43cd99ce066937a7cf899cf58c2fd075f6686b1604563e88eae3bc6148ba6033e202b6c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b891c5410c9b2ad048a3fdf6da74f7a671e10f6470292e47e4a2985aba606356797734c95667df4be9fbbedf3aefa719872bf176885200a2ba7235d5c2398274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e6ac9f447a3f7d2e1936e322290587e3a58619ee57627a28353bf21f16e38eac54661be2b32f45a7da9c1e0ade6341f7c2817de427580cb224488f47a303667c"} 05:43:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:52 INFO - Contents: 05:43:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79a97d1762976c5721d460fa23992512eb2cf5492bb02c94fea0304243ca114c30abd3eba2afab7c4ff64dcac68e5873242654c92282188ad9571ab609c47159", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d26f3d72301f0664ef43e7b27c9106e1f0722617722b897e923bd09b43cd99ce066937a7cf899cf58c2fd075f6686b1604563e88eae3bc6148ba6033e202b6c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b891c5410c9b2ad048a3fdf6da74f7a671e10f6470292e47e4a2985aba606356797734c95667df4be9fbbedf3aefa719872bf176885200a2ba7235d5c2398274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e6ac9f447a3f7d2e1936e322290587e3a58619ee57627a28353bf21f16e38eac54661be2b32f45a7da9c1e0ade6341f7c2817de427580cb224488f47a303667c"} 05:43:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:52 INFO - Copying logs to upload dir... 05:43:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.081734 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-03-02 05:43:51.685799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 05:43:51.689355) ========= 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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79a97d1762976c5721d460fa23992512eb2cf5492bb02c94fea0304243ca114c30abd3eba2afab7c4ff64dcac68e5873242654c92282188ad9571ab609c47159", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d26f3d72301f0664ef43e7b27c9106e1f0722617722b897e923bd09b43cd99ce066937a7cf899cf58c2fd075f6686b1604563e88eae3bc6148ba6033e202b6c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b891c5410c9b2ad048a3fdf6da74f7a671e10f6470292e47e4a2985aba606356797734c95667df4be9fbbedf3aefa719872bf176885200a2ba7235d5c2398274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e6ac9f447a3f7d2e1936e322290587e3a58619ee57627a28353bf21f16e38eac54661be2b32f45a7da9c1e0ade6341f7c2817de427580cb224488f47a303667c"} build_url:https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/LQ8gXmQeTryEwGKN2kdMCQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79a97d1762976c5721d460fa23992512eb2cf5492bb02c94fea0304243ca114c30abd3eba2afab7c4ff64dcac68e5873242654c92282188ad9571ab609c47159", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/d26f3d72301f0664ef43e7b27c9106e1f0722617722b897e923bd09b43cd99ce066937a7cf899cf58c2fd075f6686b1604563e88eae3bc6148ba6033e202b6c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b891c5410c9b2ad048a3fdf6da74f7a671e10f6470292e47e4a2985aba606356797734c95667df4be9fbbedf3aefa719872bf176885200a2ba7235d5c2398274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e6ac9f447a3f7d2e1936e322290587e3a58619ee57627a28353bf21f16e38eac54661be2b32f45a7da9c1e0ade6341f7c2817de427580cb224488f47a303667c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 05:43:51.714946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:43:51.715320) ========= 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=6dbc10da6d83fee962c624be000001a8-1488452548.475207-1609821496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:43:51.801788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 05:43:51.802319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 05:43:51.802852) ========= ========= Total master_lag: 0.19 =========