builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1492139633.56 results: success (0) revision: 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:53.564471) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:53.565662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:53.566643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:53.598744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:53.599054) ========= 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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-13 20:13:53-- 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% 229M=0s 2017-04-13 20:13:53 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.474050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:54.088723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:54.089079) ========= 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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014036 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:54.140822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 20:13:54.141194) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 --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 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 --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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-13 20:13:53,891 truncating revision to first 12 chars 2017-04-13 20:13:53,891 Setting DEBUG logging. 2017-04-13 20:13:53,891 attempt 1/10 2017-04-13 20:13:53,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/189ed7b2306f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 20:13:55,084 unpacking tar archive at: mozilla-aurora-189ed7b2306f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 20:13:55.676121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:55.679465) ========= script_repo_revision: 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:55.679835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:55.680096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 20:13:55.690029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-13 20:13:55.690377) ========= /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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:13:55 INFO - MultiFileLogger online at 20170413 20:13:55 in /builds/slave/test 20:13:55 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 20:13:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:13:55 INFO - {'append_to_log': False, 20:13:55 INFO - 'base_work_dir': '/builds/slave/test', 20:13:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 20:13:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:13:55 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 20:13:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:13:55 INFO - 'config_files': ('talos/linux_config.py',), 20:13:55 INFO - 'default_actions': ('clobber', 20:13:55 INFO - 'read-buildbot-config', 20:13:55 INFO - 'download-and-extract', 20:13:55 INFO - 'populate-webroot', 20:13:55 INFO - 'create-virtualenv', 20:13:55 INFO - 'install', 20:13:55 INFO - 'run-tests'), 20:13:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:13:55 INFO - 'download_minidump_stackwalk': True, 20:13:55 INFO - 'download_symbols': 'ondemand', 20:13:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:13:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:13:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:13:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:13:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:13:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:13:55 INFO - 'gecko_profile': False, 20:13:55 INFO - 'gecko_profile_interval': 0, 20:13:55 INFO - 'installer_path': 'installer.exe', 20:13:55 INFO - 'log_level': 'info', 20:13:55 INFO - 'log_name': 'talos', 20:13:55 INFO - 'log_to_console': True, 20:13:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:13:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:13:55 INFO - 'opt_config_files': (), 20:13:55 INFO - 'pip_index': False, 20:13:55 INFO - 'suite': 'dromaeojs', 20:13:55 INFO - 'system_bits': '32', 20:13:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:13:55 INFO - 'title': 'talos-linux64-ix-046', 20:13:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:13:55 INFO - 'use_talos_json': True, 20:13:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:13:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:13:55 INFO - 'work_dir': 'build'} 20:13:55 INFO - [mozharness: 2017-04-14 03:13:55.635458Z] Running clobber step. 20:13:55 INFO - Running pre-action listener: _resource_record_pre_action 20:13:55 INFO - Running main action method: clobber 20:13:55 INFO - rmtree: /builds/slave/test/build 20:13:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:13:56 INFO - Running post-action listener: _resource_record_post_action 20:13:56 INFO - [mozharness: 2017-04-14 03:13:56.535311Z] Finished clobber step (success) 20:13:56 INFO - [mozharness: 2017-04-14 03:13:56.535410Z] Running read-buildbot-config step. 20:13:56 INFO - Running pre-action listener: _resource_record_pre_action 20:13:56 INFO - Running main action method: read_buildbot_config 20:13:56 INFO - Using buildbot properties: 20:13:56 INFO - { 20:13:56 INFO - "project": "", 20:13:56 INFO - "product": "firefox", 20:13:56 INFO - "who": "ryanvm@gmail.com", 20:13:56 INFO - "installer_path": "public/build/target.tar.bz2", 20:13:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:13:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 20:13:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 20:13:56 INFO - "stage_platform": "linux64", 20:13:56 INFO - "basedir": "/builds/slave/test", 20:13:56 INFO - "buildnumber": 126, 20:13:56 INFO - "platform": "ubuntu64_hw", 20:13:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:13:56 INFO - "slavebuilddir": "test", 20:13:56 INFO - "taskId": "BBqVQVJ7QleCcYWUZqfc0w", 20:13:56 INFO - "branch": "mozilla-aurora", 20:13:56 INFO - "script_repo_revision": "production", 20:13:56 INFO - "revision": "189ed7b2306fcf0a7683df6959b78fdb94bb34e7", 20:13:56 INFO - "slavename": "talos-linux64-ix-046", 20:13:56 INFO - "repo_path": "releases/mozilla-aurora" 20:13:56 INFO - } 20:13:56 INFO - Finding installer, test and symbols from parent task. 20:13:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BBqVQVJ7QleCcYWUZqfc0w'}, attempt #1 20:13:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BBqVQVJ7QleCcYWUZqfc0w'}, attempt #1 20:13:57 INFO - Task dependencies: GQuYpU6JQ3GDJ7dEKuaJQA 20:13:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA'}, attempt #1 20:13:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 20:13:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/test_packages.json 20:13:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.crashreporter-symbols.zip 20:13:57 INFO - Running post-action listener: _resource_record_post_action 20:13:57 INFO - [mozharness: 2017-04-14 03:13:57.920419Z] Finished read-buildbot-config step (success) 20:13:57 INFO - [mozharness: 2017-04-14 03:13:57.920637Z] Running download-and-extract step. 20:13:57 INFO - Running pre-action listener: _resource_record_pre_action 20:13:57 INFO - Running main action method: download_and_extract 20:13:57 INFO - mkdir: /builds/slave/test/build/tests 20:13:57 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')]} 20:13:57 INFO - trying https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.test_packages.json 20:13:57 INFO - Downloading https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:13:58 INFO - Downloaded 896 bytes. 20:13:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:13:58 INFO - Using the following test package requirements: 20:13:58 INFO - {u'common': [u'target.common.tests.zip'], 20:13:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:13:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:13:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:13:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:13:58 INFO - u'mozbase': [u'target.common.tests.zip'], 20:13:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:13:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:13:58 INFO - u'web-platform': [u'target.common.tests.zip', 20:13:58 INFO - u'target.web-platform.tests.zip'], 20:13:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:13:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:13:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip 20:13:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:13:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip into memory 20:13:59 INFO - Expected file size: 59544572 20:13:59 INFO - Obtained file size: 59544572 20:14:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:14:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip 20:14:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:14:09 INFO - Fetch https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.common.tests.zip into memory 20:14:11 INFO - Expected file size: 59544572 20:14:11 INFO - Obtained file size: 59544572 20:14:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.talos.tests.zip 20:14:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:14:21 INFO - Fetch https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.talos.tests.zip into memory 20:14:22 INFO - Expected file size: 14404424 20:14:22 INFO - Obtained file size: 14404424 20:14:22 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')]} 20:14:22 INFO - trying https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 20:14:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:14:23 INFO - Downloaded 66755847 bytes. 20:14:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 20:14:23 INFO - mkdir: /builds/slave/test/properties 20:14:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:23 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:23 INFO - Contents: 20:14:23 INFO - build_url:https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 20:14:23 INFO - Running post-action listener: _resource_record_post_action 20:14:23 INFO - Running post-action listener: set_extra_try_arguments 20:14:23 INFO - [mozharness: 2017-04-14 03:14:23.640029Z] Finished download-and-extract step (success) 20:14:23 INFO - [mozharness: 2017-04-14 03:14:23.640126Z] Running populate-webroot step. 20:14:23 INFO - Running pre-action listener: _resource_record_pre_action 20:14:23 INFO - Running main action method: populate_webroot 20:14:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:23 INFO - '--tppagecycles', 20:14:23 INFO - '7'], 20:14:23 INFO - 'tests': ['tsvgm']}}, 20:14:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['damp', 'tps']}, 20:14:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'tests': ['damp', 'tps']}, 20:14:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['dromaeo_dom']}, 20:14:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['basic_compositor_video']}, 20:14:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['a11yr', 20:14:23 INFO - 'ts_paint', 20:14:23 INFO - 'tpaint', 20:14:23 INFO - 'sessionrestore', 20:14:23 INFO - 'sessionrestore_no_auto_restore', 20:14:23 INFO - 'tabpaint']}, 20:14:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['tsvgx', 20:14:23 INFO - 'tsvgr_opacity', 20:14:23 INFO - 'tart', 20:14:23 INFO - 'tscrollx', 20:14:23 INFO - 'cart', 20:14:23 INFO - 'tsvg_static']}, 20:14:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:23 INFO - 'tsvgr_opacity', 20:14:23 INFO - 'tart', 20:14:23 INFO - 'tscrollx', 20:14:23 INFO - 'cart', 20:14:23 INFO - 'tsvg_static']}, 20:14:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'talos_options': ['--disable-e10s'], 20:14:23 INFO - 'tests': ['tp5o']}, 20:14:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:14:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'talos_options': ['--disable-e10s', 20:14:23 INFO - '--xperf_path', 20:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:23 INFO - 'tests': ['tp5n']}, 20:14:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:14:23 INFO - 'talos_options': ['--xperf_path', 20:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:23 INFO - 'tests': ['tp5n']}}, 20:14:23 INFO - 'talos.zip': {'path': '', 20:14:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:23 INFO - Running post-action listener: _resource_record_post_action 20:14:23 INFO - [mozharness: 2017-04-14 03:14:23.653508Z] Finished populate-webroot step (success) 20:14:23 INFO - [mozharness: 2017-04-14 03:14:23.653598Z] Running create-virtualenv step. 20:14:23 INFO - Running pre-action listener: _resource_record_pre_action 20:14:23 INFO - Running main action method: create_virtualenv 20:14:23 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:23 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 20:14:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:24 INFO - Using real prefix '/usr' 20:14:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:28 INFO - Installing pip.................done. 20:14:28 INFO - Return code: 0 20:14:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:14:28 INFO - Reading from file tmpfile_stdout 20:14:28 INFO - Output received: 20:14:28 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) 20:14:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:28 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')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:28 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 20:14:28 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 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 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 20:14:28 INFO - Cleaning up... 20:14:28 INFO - Return code: 0 20:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:28 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')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:28 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 20:14:28 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 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 INFO - Downloading/unpacking psutil>=3.1.1 20:14:28 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 20:14:28 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 20:14:28 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 20:14:28 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 20:14:28 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 20:14:28 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 20:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:30 INFO - Installing collected packages: psutil 20:14:30 INFO - Running setup.py install for psutil 20:14:31 INFO - building 'psutil._psutil_linux' extension 20:14:31 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 20:14:32 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 20:14:32 INFO - building 'psutil._psutil_posix' extension 20:14:32 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 20:14:32 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 20:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:32 INFO - Successfully installed psutil 20:14:32 INFO - Cleaning up... 20:14:32 INFO - Return code: 0 20:14:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:32 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')]} 20:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:32 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')]} 20:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:32 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:32 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 20:14:32 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 20:14:32 INFO - Using env: {'DISPLAY': ':0', 20:14:32 INFO - 'HOME': '/home/cltbld', 20:14:32 INFO - 'LANG': 'en_US.UTF-8', 20:14:32 INFO - 'LANGUAGE': 'en_US:en', 20:14:32 INFO - 'LOGNAME': 'cltbld', 20:14:32 INFO - 'MAIL': '/var/mail/cltbld', 20:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:32 INFO - 'MOZ_NO_REMOTE': '1', 20:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:32 INFO - 'NO_EM_RESTART': '1', 20:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:32 INFO - 'PWD': '/builds/slave/test', 20:14:32 INFO - 'SHELL': '/bin/bash', 20:14:32 INFO - 'SHLVL': '1', 20:14:32 INFO - 'TERM': 'linux', 20:14:32 INFO - 'TMOUT': '86400', 20:14:32 INFO - 'USER': 'cltbld', 20:14:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:32 INFO - '_': '/tools/buildbot/bin/python'} 20:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:32 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 20:14:32 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 20:14:32 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 20:14:32 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 20:14:32 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 20:14:32 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 20:14:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:35 INFO - Installing collected packages: mozsystemmonitor 20:14:35 INFO - Running setup.py install for mozsystemmonitor 20:14:35 INFO - Successfully installed mozsystemmonitor 20:14:35 INFO - Cleaning up... 20:14:35 INFO - Return code: 0 20:14:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:35 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')]} 20:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:35 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')]} 20:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:35 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:35 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 20:14:35 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 20:14:35 INFO - Using env: {'DISPLAY': ':0', 20:14:35 INFO - 'HOME': '/home/cltbld', 20:14:35 INFO - 'LANG': 'en_US.UTF-8', 20:14:35 INFO - 'LANGUAGE': 'en_US:en', 20:14:35 INFO - 'LOGNAME': 'cltbld', 20:14:35 INFO - 'MAIL': '/var/mail/cltbld', 20:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:35 INFO - 'MOZ_NO_REMOTE': '1', 20:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:35 INFO - 'NO_EM_RESTART': '1', 20:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:35 INFO - 'PWD': '/builds/slave/test', 20:14:35 INFO - 'SHELL': '/bin/bash', 20:14:35 INFO - 'SHLVL': '1', 20:14:35 INFO - 'TERM': 'linux', 20:14:35 INFO - 'TMOUT': '86400', 20:14:35 INFO - 'USER': 'cltbld', 20:14:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:35 INFO - '_': '/tools/buildbot/bin/python'} 20:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:35 INFO - Downloading/unpacking jsonschema==2.5.1 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:37 INFO - warning: no files found matching '*.txt' 20:14:37 INFO - no previously-included directories found matching 'build' 20:14:37 INFO - no previously-included directories found matching 'dist' 20:14:37 INFO - no previously-included directories found matching '.git*' 20:14:37 INFO - Installing collected packages: jsonschema, functools32 20:14:37 INFO - Running setup.py install for functools32 20:14:37 INFO - warning: no files found matching '*.txt' 20:14:37 INFO - no previously-included directories found matching 'build' 20:14:37 INFO - no previously-included directories found matching 'dist' 20:14:37 INFO - no previously-included directories found matching '.git*' 20:14:37 INFO - Successfully installed jsonschema functools32 20:14:37 INFO - Cleaning up... 20:14:37 INFO - Return code: 0 20:14:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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', '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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:14: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 functools32==3.2.3-2 20:14:37 INFO - Using env: {'DISPLAY': ':0', 20:14:37 INFO - 'HOME': '/home/cltbld', 20:14:37 INFO - 'LANG': 'en_US.UTF-8', 20:14:37 INFO - 'LANGUAGE': 'en_US:en', 20:14:37 INFO - 'LOGNAME': 'cltbld', 20:14:37 INFO - 'MAIL': '/var/mail/cltbld', 20:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:37 INFO - 'MOZ_NO_REMOTE': '1', 20:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:37 INFO - 'NO_EM_RESTART': '1', 20:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:37 INFO - 'PWD': '/builds/slave/test', 20:14:37 INFO - 'SHELL': '/bin/bash', 20:14:37 INFO - 'SHLVL': '1', 20:14:37 INFO - 'TERM': 'linux', 20:14:37 INFO - 'TMOUT': '86400', 20:14:37 INFO - 'USER': 'cltbld', 20:14:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:37 INFO - '_': '/tools/buildbot/bin/python'} 20:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:14:38 INFO - Cleaning up... 20:14:38 INFO - Return code: 0 20:14:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14:38 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')]} 20:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:38 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')]} 20:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:38 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:38 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 20:14:38 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 20:14:38 INFO - Using env: {'DISPLAY': ':0', 20:14:38 INFO - 'HOME': '/home/cltbld', 20:14:38 INFO - 'LANG': 'en_US.UTF-8', 20:14:38 INFO - 'LANGUAGE': 'en_US:en', 20:14:38 INFO - 'LOGNAME': 'cltbld', 20:14:38 INFO - 'MAIL': '/var/mail/cltbld', 20:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:38 INFO - 'MOZ_NO_REMOTE': '1', 20:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:38 INFO - 'NO_EM_RESTART': '1', 20:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:38 INFO - 'PWD': '/builds/slave/test', 20:14:38 INFO - 'SHELL': '/bin/bash', 20:14:38 INFO - 'SHLVL': '1', 20:14:38 INFO - 'TERM': 'linux', 20:14:38 INFO - 'TMOUT': '86400', 20:14:38 INFO - 'USER': 'cltbld', 20:14:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:38 INFO - '_': '/tools/buildbot/bin/python'} 20:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:38 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 20:14:38 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 20:14:38 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 20:14:38 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 20:14:38 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 20:14:38 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 20:14:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:41 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 20:14:41 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 20:14:41 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 20:14:41 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 20:14:41 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 20:14:41 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 20:14:41 INFO - Downloading docopt-0.6.1.tar.gz 20:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:41 INFO - Running setup.py install for blobuploader 20:14:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:41 INFO - Running setup.py install for requests 20:14:41 INFO - Running setup.py install for docopt 20:14:41 INFO - Successfully installed blobuploader requests docopt 20:14:41 INFO - Cleaning up... 20:14:42 INFO - Return code: 0 20:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:42 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')]} 20:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:42 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')]} 20:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:42 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:42 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 20:14:42 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 20:14:42 INFO - Using env: {'DISPLAY': ':0', 20:14:42 INFO - 'HOME': '/home/cltbld', 20:14:42 INFO - 'LANG': 'en_US.UTF-8', 20:14:42 INFO - 'LANGUAGE': 'en_US:en', 20:14:42 INFO - 'LOGNAME': 'cltbld', 20:14:42 INFO - 'MAIL': '/var/mail/cltbld', 20:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:42 INFO - 'MOZ_NO_REMOTE': '1', 20:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:42 INFO - 'NO_EM_RESTART': '1', 20:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:42 INFO - 'PWD': '/builds/slave/test', 20:14:42 INFO - 'SHELL': '/bin/bash', 20:14:42 INFO - 'SHLVL': '1', 20:14:42 INFO - 'TERM': 'linux', 20:14:42 INFO - 'TMOUT': '86400', 20:14:42 INFO - 'USER': 'cltbld', 20:14:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:42 INFO - '_': '/tools/buildbot/bin/python'} 20:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:42 INFO - Running setup.py (path:/tmp/pip-XGdI6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:42 INFO - Running setup.py (path:/tmp/pip-JwU0iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:42 INFO - Running setup.py (path:/tmp/pip-UYRGJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:42 INFO - Running setup.py (path:/tmp/pip-rznztR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:42 INFO - Running setup.py (path:/tmp/pip-XhZh_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:42 INFO - Running setup.py (path:/tmp/pip-QP3L9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:42 INFO - Running setup.py (path:/tmp/pip-4hyZgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:42 INFO - Running setup.py (path:/tmp/pip-cS68om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:42 INFO - Running setup.py (path:/tmp/pip-fJTvio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:42 INFO - Running setup.py (path:/tmp/pip-3a7Baw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:42 INFO - Running setup.py (path:/tmp/pip-a5upHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:43 INFO - Running setup.py (path:/tmp/pip-bdlOyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:43 INFO - Running setup.py (path:/tmp/pip-f7NcO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:43 INFO - Running setup.py (path:/tmp/pip-sdjGag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:43 INFO - Running setup.py (path:/tmp/pip-w1dX8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:43 INFO - Running setup.py (path:/tmp/pip-pcbXP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:43 INFO - Running setup.py (path:/tmp/pip-4CIpqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:43 INFO - Running setup.py install for manifestparser 20:14:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Running setup.py install for mozcrash 20:14:43 INFO - Running setup.py install for mozdebug 20:14:43 INFO - Running setup.py install for mozdevice 20:14:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Running setup.py install for mozfile 20:14:44 INFO - Running setup.py install for mozhttpd 20:14:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozinfo 20:14:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozInstall 20:14:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozleak 20:14:44 INFO - Running setup.py install for mozlog 20:14:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for moznetwork 20:14:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozprocess 20:14:44 INFO - Running setup.py install for mozprofile 20:14:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozrunner 20:14:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:44 INFO - Running setup.py install for mozscreenshot 20:14:45 INFO - Running setup.py install for moztest 20:14:45 INFO - Running setup.py install for mozversion 20:14:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:45 INFO - Cleaning up... 20:14:45 INFO - Return code: 0 20:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:45 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')]} 20:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:45 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')]} 20:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:45 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:45 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 20:14:45 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 20:14:45 INFO - Using env: {'DISPLAY': ':0', 20:14:45 INFO - 'HOME': '/home/cltbld', 20:14:45 INFO - 'LANG': 'en_US.UTF-8', 20:14:45 INFO - 'LANGUAGE': 'en_US:en', 20:14:45 INFO - 'LOGNAME': 'cltbld', 20:14:45 INFO - 'MAIL': '/var/mail/cltbld', 20:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:45 INFO - 'MOZ_NO_REMOTE': '1', 20:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:45 INFO - 'NO_EM_RESTART': '1', 20:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:45 INFO - 'PWD': '/builds/slave/test', 20:14:45 INFO - 'SHELL': '/bin/bash', 20:14:45 INFO - 'SHLVL': '1', 20:14:45 INFO - 'TERM': 'linux', 20:14:45 INFO - 'TMOUT': '86400', 20:14:45 INFO - 'USER': 'cltbld', 20:14:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:45 INFO - '_': '/tools/buildbot/bin/python'} 20:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:45 INFO - Running setup.py (path:/tmp/pip-4OLzIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:45 INFO - Running setup.py (path:/tmp/pip-Hpkm3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:45 INFO - Running setup.py (path:/tmp/pip-en3RQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:45 INFO - Running setup.py (path:/tmp/pip-HBwQZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:45 INFO - Running setup.py (path:/tmp/pip-MUz9Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:45 INFO - Running setup.py (path:/tmp/pip-jHGyB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:45 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)) 20:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:45 INFO - Running setup.py (path:/tmp/pip-BFB8RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:46 INFO - Running setup.py (path:/tmp/pip-3D36RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:46 INFO - Running setup.py (path:/tmp/pip-pMiB6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:46 INFO - Running setup.py (path:/tmp/pip-PapPnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:46 INFO - Running setup.py (path:/tmp/pip-lkup3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:46 INFO - Running setup.py (path:/tmp/pip-wL0gBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:46 INFO - Running setup.py (path:/tmp/pip-sI4jCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:46 INFO - Running setup.py (path:/tmp/pip-5wR8Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:46 INFO - Running setup.py (path:/tmp/pip-PkMXoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:46 INFO - Running setup.py (path:/tmp/pip-NRWiJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:46 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)) 20:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:46 INFO - Running setup.py (path:/tmp/pip-UpHQcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:46 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)) 20:14:46 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)) 20:14:46 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)) 20:14:46 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)) 20:14:46 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)) 20:14:46 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)) 20:14:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:48 INFO - Downloading blessings-1.6.tar.gz 20:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:48 INFO - Installing collected packages: blessings 20:14:48 INFO - Running setup.py install for blessings 20:14:49 INFO - Successfully installed blessings 20:14:49 INFO - Cleaning up... 20:14:49 INFO - Return code: 0 20:14:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:49 INFO - Reading from file tmpfile_stdout 20:14:49 INFO - Current package versions: 20:14:49 INFO - argparse == 1.2.1 20:14:49 INFO - blessings == 1.6 20:14:49 INFO - blobuploader == 1.2.4 20:14:49 INFO - docopt == 0.6.1 20:14:49 INFO - functools32 == 3.2.3-2 20:14:49 INFO - jsonschema == 2.5.1 20:14:49 INFO - manifestparser == 1.1 20:14:49 INFO - mozInstall == 1.12 20:14:49 INFO - mozcrash == 1.0 20:14:49 INFO - mozdebug == 0.1 20:14:49 INFO - mozdevice == 0.49 20:14:49 INFO - mozfile == 1.2 20:14:49 INFO - mozhttpd == 0.7 20:14:49 INFO - mozinfo == 0.9 20:14:49 INFO - mozleak == 0.1 20:14:49 INFO - mozlog == 3.4 20:14:49 INFO - moznetwork == 0.27 20:14:49 INFO - mozprocess == 0.25 20:14:49 INFO - mozprofile == 0.28 20:14:49 INFO - mozrunner == 6.13 20:14:49 INFO - mozscreenshot == 0.1 20:14:49 INFO - mozsystemmonitor == 0.3 20:14:49 INFO - moztest == 0.8 20:14:49 INFO - mozversion == 1.4 20:14:49 INFO - psutil == 3.1.1 20:14:49 INFO - requests == 1.2.3 20:14:49 INFO - wsgiref == 0.1.2 20:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:49 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')]} 20:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:49 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')]} 20:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:49 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:49 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 20:14:49 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 20:14:49 INFO - Using env: {'DISPLAY': ':0', 20:14:49 INFO - 'HOME': '/home/cltbld', 20:14:49 INFO - 'LANG': 'en_US.UTF-8', 20:14:49 INFO - 'LANGUAGE': 'en_US:en', 20:14:49 INFO - 'LOGNAME': 'cltbld', 20:14:49 INFO - 'MAIL': '/var/mail/cltbld', 20:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:49 INFO - 'MOZ_NO_REMOTE': '1', 20:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:49 INFO - 'NO_EM_RESTART': '1', 20:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:49 INFO - 'PWD': '/builds/slave/test', 20:14:49 INFO - 'SHELL': '/bin/bash', 20:14:49 INFO - 'SHLVL': '1', 20:14:49 INFO - 'TERM': 'linux', 20:14:49 INFO - 'TMOUT': '86400', 20:14:49 INFO - 'USER': 'cltbld', 20:14:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:49 INFO - '_': '/tools/buildbot/bin/python'} 20:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 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)) 20:14:49 INFO - Cleaning up... 20:14:49 INFO - Return code: 0 20:14:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:49 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')]} 20:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:49 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')]} 20:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:49 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 0x22071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2245a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a5310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, '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': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', '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 20:14:49 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 20:14:49 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 20:14:49 INFO - Using env: {'DISPLAY': ':0', 20:14:49 INFO - 'HOME': '/home/cltbld', 20:14:49 INFO - 'LANG': 'en_US.UTF-8', 20:14:49 INFO - 'LANGUAGE': 'en_US:en', 20:14:49 INFO - 'LOGNAME': 'cltbld', 20:14:49 INFO - 'MAIL': '/var/mail/cltbld', 20:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:49 INFO - 'MOZ_NO_REMOTE': '1', 20:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:49 INFO - 'NO_EM_RESTART': '1', 20:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:49 INFO - 'PWD': '/builds/slave/test', 20:14:49 INFO - 'SHELL': '/bin/bash', 20:14:49 INFO - 'SHLVL': '1', 20:14:49 INFO - 'TERM': 'linux', 20:14:49 INFO - 'TMOUT': '86400', 20:14:49 INFO - 'USER': 'cltbld', 20:14:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:49 INFO - '_': '/tools/buildbot/bin/python'} 20:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:49 INFO - Cleaning up... 20:14:49 INFO - Return code: 0 20:14:49 INFO - Running post-action listener: _resource_record_post_action 20:14:49 INFO - Running post-action listener: _start_resource_monitoring 20:14:49 INFO - Starting resource monitoring. 20:14:49 INFO - [mozharness: 2017-04-14 03:14:49.795904Z] Finished create-virtualenv step (success) 20:14:49 INFO - [mozharness: 2017-04-14 03:14:49.796840Z] Running install step. 20:14:49 INFO - Running pre-action listener: _resource_record_pre_action 20:14:49 INFO - Running main action method: install 20:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:50 INFO - Reading from file tmpfile_stdout 20:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:50 INFO - Reading from file tmpfile_stdout 20:14:50 INFO - Output received: 20:14:50 INFO - Usage: mozinstall [options] installer 20:14:50 INFO - Options: 20:14:50 INFO - -h, --help show this help message and exit 20:14:50 INFO - -d DEST, --destination=DEST 20:14:50 INFO - Directory to install application into. [default: 20:14:50 INFO - "/builds/slave/test"] 20:14:50 INFO - --app=APP Application being installed. [default: firefox] 20:14:50 INFO - mkdir: /builds/slave/test/build/application 20:14:50 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'] 20:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:15:06 INFO - Reading from file tmpfile_stdout 20:15:06 INFO - Output received: 20:15:06 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:06 INFO - Running post-action listener: _resource_record_post_action 20:15:06 INFO - [mozharness: 2017-04-14 03:15:06.649317Z] Finished install step (success) 20:15:06 INFO - [mozharness: 2017-04-14 03:15:06.649593Z] Running run-tests step. 20:15:06 INFO - Running pre-action listener: _resource_record_pre_action 20:15:06 INFO - Running main action method: run_tests 20:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:06 INFO - Python 2.7.3 20:15:06 INFO - Return code: 0 20:15:06 INFO - grabbing minidump binary from tooltool 20:15:06 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')]} 20:15:06 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 0x24a2400>, '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 0x24a33b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a3840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:06 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 20:15:06 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 20:15:06 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 20:15:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:06 INFO - Return code: 0 20:15:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:06 INFO - ENV: RUST_BACKTRACE is now 1 20:15:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:06 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/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:15:06 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/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 20:15:06 INFO - Using env: {'DISPLAY': ':0', 20:15:06 INFO - 'HOME': '/home/cltbld', 20:15:06 INFO - 'LANG': 'en_US.UTF-8', 20:15:06 INFO - 'LANGUAGE': 'en_US:en', 20:15:06 INFO - 'LOGNAME': 'cltbld', 20:15:06 INFO - 'MAIL': '/var/mail/cltbld', 20:15:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:06 INFO - 'MOZ_NO_REMOTE': '1', 20:15:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:06 INFO - 'NO_EM_RESTART': '1', 20:15:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:06 INFO - 'PWD': '/builds/slave/test', 20:15:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:06 INFO - 'RUST_BACKTRACE': '1', 20:15:06 INFO - 'SHELL': '/bin/bash', 20:15:06 INFO - 'SHLVL': '1', 20:15:06 INFO - 'TERM': 'linux', 20:15:06 INFO - 'TMOUT': '86400', 20:15:06 INFO - 'USER': 'cltbld', 20:15:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018', 20:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:06 INFO - '_': '/tools/buildbot/bin/python'} 20:15:06 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/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:15:07 INFO - mozversion application_buildid: 20170414021900 20:15:07 INFO - mozversion application_changeset: 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 20:15:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:15:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:07 INFO - mozversion application_name: Firefox 20:15:07 INFO - mozversion application_remotingname: firefox-dev 20:15:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:15:07 INFO - mozversion application_vendor: Mozilla 20:15:07 INFO - mozversion application_version: 54.0a2 20:15:07 INFO - mozversion platform_buildid: 20170414021900 20:15:07 INFO - mozversion platform_changeset: 189ed7b2306fcf0a7683df6959b78fdb94bb34e7 20:15:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:15:07 INFO - mozversion platform_version: 54.0a2 20:15:07 INFO - using testdate: 1492139707 20:15:07 INFO - actual date: 1492139707 20:15:07 INFO - starting webserver on 'localhost:49760' 20:15:07 INFO - SUITE-START | Running 2 tests 20:15:07 INFO - TEST-START | dromaeo_css 20:15:07 INFO - operating with platform_type : linux_ 20:15:07 INFO - Initialising browser for dromaeo_css test... 20:15:07 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPgT9dO/profile http://localhost:49760/getInfo.html) 20:15:13 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 20:15:13 INFO - PROCESS | 3309 | colorDepth:24 20:15:13 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 20:15:13 INFO - PROCESS | 3309 | __metrics 20:15:14 INFO - PROCESS | 3309 | 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" 20:15:14 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:14 INFO - TEST-INFO | 3309: exit 0 20:15:14 INFO - Browser initialized. 20:15:14 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:14 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPgT9dO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:26 INFO - PROCESS | 3402 | RSS: Main: 140083200 20:15:26 INFO - PROCESS | 3402 | 20:18:28 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49760/tests/dromaeo/cssquery-ext.html) 20:18:30 INFO - PROCESS | 3402 | RSS: Main: 233086976 20:18:30 INFO - PROCESS | 3402 | 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | A coding exception was thrown and uncaught in a Task. 20:20:16 INFO - PROCESS | 3402 | 20:20:16 ERROR - PROCESS | 3402 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:20:16 INFO - PROCESS | 3402 | Full stack: 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | A coding exception was thrown and uncaught in a Task. 20:20:16 INFO - PROCESS | 3402 | 20:20:16 ERROR - PROCESS | 3402 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:20:16 INFO - PROCESS | 3402 | Full stack: 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | A coding exception was thrown and uncaught in a Task. 20:20:16 INFO - PROCESS | 3402 | 20:20:16 ERROR - PROCESS | 3402 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:20:16 INFO - PROCESS | 3402 | Full stack: 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | ************************* 20:20:16 INFO - PROCESS | 3402 | A coding exception was thrown and uncaught in a Task. 20:20:16 INFO - PROCESS | 3402 | 20:20:16 ERROR - PROCESS | 3402 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:20:16 INFO - PROCESS | 3402 | Full stack: 20:20:16 INFO - PROCESS | 3402 | ************************* 20:21:32 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-ext.html (next: http://localhost:49760/tests/dromaeo/cssquery-jquery.html) 20:21:32 INFO - PROCESS | 3402 | RSS: Main: 228872192 20:21:32 INFO - PROCESS | 3402 | 20:24:34 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49760/tests/dromaeo/cssquery-mootools.html) 20:24:35 INFO - PROCESS | 3402 | RSS: Main: 169455616 20:24:35 INFO - PROCESS | 3402 | 20:27:37 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49760/tests/dromaeo/cssquery-prototype.html) 20:27:37 INFO - PROCESS | 3402 | RSS: Main: 210997248 20:27:37 INFO - PROCESS | 3402 | 20:30:40 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49760/tests/dromaeo/cssquery-yui.html) 20:30:41 INFO - PROCESS | 3402 | RSS: Main: 175263744 20:30:41 INFO - PROCESS | 3402 | 20:33:43 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-yui.html (next: http://localhost:49760/tests/dromaeo/cssquery-dojo.html) 20:33:44 INFO - PROCESS | 3402 | RSS: Main: 255713280 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | __start_tp_report 20:33:44 INFO - PROCESS | 3402 | _x_x_mozilla_page_load 20:33:44 INFO - PROCESS | 3402 | _x_x_mozilla_page_load_details 20:33:44 INFO - PROCESS | 3402 | |i|pagename|runs| 20:33:44 INFO - PROCESS | 3402 | |0;dojo.html;3367.730581553476;3395.7453191010673;3399.7110245629137;3413.180836599217;3446.517487551742;5688.857778555538;5726.255586773714;5726.942730572693;5731.971340143304;5742.741576629051;5802.941970580293;5846.912296315559;5876.177335173079;5878.382769809162;5881.294244690643;5283.445238249986;5290.365156181264;5315.734213289339;5379.5696344292555;5383.946160538403;5086.796528138889;5168;5377.166539186433;5384.273123128367;5388.78444862205;5171.043356978952;5274.709890955995;5275.57795376369;5363.517283444489;5376.973115134439;5346.03771321162;5364.222187782789;5372.059889519319;5377.489138531852;5385.757640906129;5243.9213411798855;5274.287971123926;5289.947100528984;5349.037173308803;5355.223492593591;5589.916151257735;5608.5793565482345;5659.688717120557;5716.1711551825165;5733.312002559678;6155.384461553854;6161.476274516672;6161.7227224775;6167.7532898684;6178.165947597062;6193.0710393440895;6196.256449226076;6237.1891654084675;6269.7178626961895;6271;5604.243427137366;5624.6343987641085;5777.480026797609;5818.854528636733;5824.504917082053;6318.494520438354;6354.745810167541;6368.64972426521;6376.904346434807;6379.3620637936765;6134.631922084689;6142.04798256271;6145.10895920098;6148.538859585549;6151.384861513813;5970.582059255898;5997.310309314485;6142.897836592492;6150.876982460326;6294.087357333253;6184.6598437085495;6192.752289908353;6201.875962480725;6206.472449841724;6222.782202622977;5951.464368206795;6008.459238668541;6020.518358531394;6049;6200.224971878515;4688.2733176357715;4690.038542098861;4701.553352431513;4732.5977291929885;4756.809727610926;4139.544650088488;4140.68944829139;4152.647025002848;4157.168566286755;4219.957800421957;5992.0712289595185;6036.486898613579;6042.063480160582;6048.939510604838;6084.330723620398;6257.346056537229;6283.120363149163;6297.118403423525;6301.212348456443;6303.590266632654;5842.065269556851;5884.852878677982;5963.612365196248;6051.939480605138;6057.697115144225;5313.681179129265;5330.840074797762;5351;5362.061639213122;5362.570994320445;6545.967270163619;6552.770653027121;6554.180727409074;6554.606723596695;6559;5935.376785437467;6046.395360463918;6261.8747625046335;6294.464970477561;6299.590526615755;6478.967605161944;6511.576747511396;6547.050677651809;6613.5370524062855;6641.833954151185;6167.722452489559;6174.320824709189;6182.505399567934;6187.938120618916;6196.194494715658;6031.517478601789;6206.348333424925;6282.2147231596055;6286.18279623646;6290.968545157245;5952.553558483044;6067.605605635619;6079.452849243589;6141.148492690724;6145.863015342176;6120.548409105651;6125.357545073132;6134.4172303631085;6136.718146525597;6148.47737942262;5823.82528524145;5867.794627188028;6127.375193257265;6135.753292002278;6144.832481828438;6016.909746353896;6022.939770602238;6133.3866613338305;6158.599691020069;6172.2901866284155;6051.848703782264;6056;6068.848278793065;6070.6357618543025;6081.452669259788 20:33:44 INFO - PROCESS | 3402 | |1;ext.html;779.6335722210559;829.7261903571822;847.3517758914429;910.4355299714178;917.284518075901;30720;44850.77574612127;45263.32105018419;45348.54651453484;45494.545054549446;45380.3192952106;45588;45634;45749.54250457494;45846.54153458473;7685.6157192140445;7802.258785415376;9143.542822858864;9283.58223879927;9290.25677945766;10517.211209159306;10720.571177152904;11027.062699670538;11053.115750739962;11059.612913548028;10867.130629549618;10894.128469722404;10898.727531811688;10908.727281817979;10917.23579349446;10811.35131892089;10836;10838.945805271002;10842.132629389629;10860.239783215178;10311.742206444824;10367.170626349875;10424.5830166794;10433.321834080836;10440.425776582286;43858;43867.341989870176;44072.779636101615;44089.559104409185;44185;4169.517406867549;4208.410822484854;4234.13200293939;4315.029118448356;4339.1104823511105;30016.776358239695;30415.087547373616;30618.387632247453;31119.533207001914;31910.521342179887;4261.637760790337;4328.350747387885;4343.174796788631;4348.412964249817;4438.178936896652;234217;235042;235368;235800;236024;56087.15869261965;56305.43694563002;56387.43612563822;56498;56515.71742141263;56861.715691422105;57034.7148264256;57273;57325;57359;16339.18304084791;16786.328546858233;16792.412265570645;16794.496165115066;16795.328186872634;12182.878171218352;12388.752224955451;14674.779878301833;14687.706245875022;14692;11349.978501934866;11408.600698975495;11424.028957538536;13843.792343114861;13856.722865542633;5477.616566840363;5583.832485025456;5590.552755779528;5607.158926161027;5614.1859430382365;1206.4932728254155;1214;1236.4250623460134;1238.0961897814466;1252.4301442843484;28066.29834254119;28300.433991320057;28413.147605571867;28565.428691426056;28741.56887646687;1313.8678904351073;1347.2926713475308;1365.4401695304878;1369.2195448594405;1372.8421231558498;14994.925025374803;15038.097714137186;15126.319315630823;15345.6163595911;15415.691686166214;286635;287114;288487;289033;298778;50023.74988125036;55658;55786;63415;63540.682296588224;1488.8660020598197;1499.437710858428;1527.6486408126193;1550.3256083603444;1553.8057742782153;32032.5195122078;33178.5023224647;33343.1664208387;33434.1468283683;33822.323553529284;46100;46125.76937115293;46138;46185.53814461813;46203;314068;316279;316329;317425;317781;37613.623863762106;38377.80811095927;38402.807985959895;38444.23111537698;38447.615523844404;44263.778681106385;44907.55092449034;45040.324395133444;45251.7737411324;46222.07555848931;33760.324793504486;33868.32263354769;34094.65905341014;34259.14352141117;34511.82744086264;33256;33920;33924.56656493612;34085.65914340924;34529.13677158091;38685;39028.6097139025;39047.6095239044;39510.40734389044;39653;32426.35147297088;32660.673393266712;32826.34347313088;32889.34221315513;33329.50005749867;23055.6541651872;24163.51672966566;24254.63618045766;24258;24403.877980609985 20:33:44 INFO - PROCESS | 3402 | |2;jquery.html;401.38187191724745;450.90530988492435;452.35765213396974;458.4200985753022;484.1648156929296;17847.991465347914;18783.906080469595;20786.480337991557;20988.26541071063;21201.257955971545;15076.47232346868;20739.377818665427;21856.344309670694;21878.781212187874;22035.77964220357;6779.728810847572;7033.683484243222;7046.189688185873;7047.85904281914;7193.280671932791;7432.777016689508;7523.811904702399;7532.322091011808;7534.2089080646565;7535.359494442979;7445.4415918806035;7477.626118694071;7543.3211011009;7556.50882692626;7588.658510367047;7281.308275713799;7287.125544934589;7322.524035937647;7333.559986400806;7342.9632851835395;7118.216996130422;7316.561006339637;7319.231480694503;7327.450441216877;7330.486865919388;24707.382315442257;24857.5028499429;24979.62530562043;25201.49597008068;25398.36504087394;3116.5948426704385;3164.0666003529013;3201.055688571877;3220.0822765511716;3243.6431992480807;15302.693946121126;15424.614384640361;15924.681506369807;15943.521694349189;16280.674386512323;2218.922337718172;2234.597772400967;2251.0770584060456;2313.9652905206435;2319.5360927814336;107972;110909.44545277303;111094;112152;114223;17670.293188272324;17797.1991260391;17876.463706088838;17919.641607167785;18369.908150459163;31604.841975789976;31654.208644784063;31680.683193168235;31709.682903170673;31991;8665.480071195749;9214.401063930824;9762.316637835283;10194.541245643815;10241.795164096677;8573.74278771638;8590.570471476402;8595.527246001406;8711.433756805787;8753.255973242218;9004.774880628036;9386.436813791195;9454.480003599869;9456.385334953206;9510.952445237868;3772.924541509209;3889.546469292644;3916.784576848244;4053.858114965962;4054.675625949917;1005.1606908231709;1016.2885979814159;1021.356545376423;1035.1615191694752;1036.259074761549;19887.195942242834;19938.90030549838;20061.197552098045;20084.096215670328;20140.39578812638;1021.596469394585;1036.99481502592;1057.154276578734;1068.5458680060942;1069.3583849690124;9986.750331241632;10897.891021089847;10899.727506812393;10933.453327333602;10995.34027958325;653821;669859;670845;675234;676773;106167.4691626537;106984.8603027935;109248.4537577307;111421;111786;1268.923864568129;1288.3365066990507;1301.947922083106;1303.0552849184267;1306.2554344024006;16293.429729959395;16809.831901680827;17504.649907002044;17569.560760980567;17697.29210831604;47871.76064119657;49102.5089749098;50772.52982899856;51370;55879.72060139673;67611.66194168998;67713.66143169449;68015.91904485747;68480.3151968474;68751.65624171848;12158.817617735564;12572.937135314265;12581.420808734005;12585.022218479076;12892.64627214129;13565.660858478617;13599.59201223965;13637.153769363133;13724.725505490034;13779.862201378259;12406.25562466255;12515.624531264077;12622.305773182563;12680.23918564889;12928.095033347952;10903.618373356894;10998.450077496253;11155.498002590066;11325.093992480746;11437.42812859337;10895.836562451412;11189.272697274651;11447.370394628375;11710.414479275832;12587.370631468208;12414.751704966031;12418.130730848754;12445.688857778629;12450.190737602026;12505.749885002431;12069.155159138776;12100.818487722867;12102;12181.512739490321;12238.449269782703 20:33:44 INFO - PROCESS | 3402 | |3;mootools.html;1572.6618776962957;1587.9047257164564;1602.9278682459287;1613.975790363144;1618.182817677073;10764.892351076487;11407.429628518561;11407.942960285207;11417.31496110234;11425.08599312055;10747.946260268687;11011.504482298296;11251.54993800247;11277.605283815068;11286.887131128686;2417.721961974378;2441.389652586853;2453.251758213744;2456.5946618807875;2456.778889899909;2365.787079162875;2435.1720415058876;2453.865037422941;2455.4843482868528;2455.668484754562;2397.137030668958;2431.0154387473103;2431.8297719159664;2467.3091534370405;2468.568000599897;2347.307544274443;2368.455255291284;2389.4145934246135;2391.7727815857465;2424.854508729482;2335.801456876168;2346.988265058681;2347.9882600587057;2356.5640356534095;2361.303415492434;11235.04502117321;11416.086713062936;11432.199746017783;11442.084633229322;11447.713807154805;5536.723163841792;5739.139129130622;5746.339170995348;5748.080307150877;5757.740901659436;3270.3459308138467;3409.556757621518;3444.4144495435835;3475.94786078209;3480.6171321154907;1230.0897335971406;1252.4238850128952;1278.552506622684;1284.5311461316646;1418.9148651080866;13978.161310321413;14337.068090574183;15493.070415774977;16772;16929.3228270869;4555.63554915606;4665.880188754674;4666.463356714022;4686.578207961232;4709.846087708534;10578.682639520826;13236.933815330862;13253.801192982113;13272.601821945356;13288.667783305495;4868.391451068616;5484.725763711878;5583.190437386637;5607.915881261784;5608.915866262009;4998.600111991032;5135.922961155586;5197.532222100029;5207.713575753294;5355.544778693855;3884.892805550461;3951.130751234781;3985.7807820570147;4016.979915100464;4026.4564283821896;1048.1928914735763;1053.2890299048265;1056.7569459024467;1060.48566445274;1067.295584913953;931.2038207332769;932.2681694869494;939.7274790310734;972.6206779356057;1101.9338839669645;7233.240509746506;7253.891191632129;7415.703371865065;7493.3630641395;7705.499142555716;1106.1372129738816;1123.326004397355;1125.234840308598;1127.312339472921;1140.2816225777872;4903.754812259373;5036.194208926628;5039.4377742899815;5071.492850714899;5105.259737338065;14267.85732142686;14874.479393221185;14915.776263356058;14952.925235373754;15032.62418439526;14682.192479413521;14688.485902993558;14696.26518674062;14804.407823687146;14862.479813206703;10542.631007914686;10679.252452328417;10706.678799636024;10845.349279043283;10853.240273180802;7356.190819009797;7387.335139837441;7434.516756410816;7574.394048475999;7585.469017168966;9821.85267220978;12010.459529321377;12662.290590770128;12805.295708735735;12831.807522886977;12424;12745.980321574067;12796.872031279569;12804.61586152417;12930.741385172056;8912.242459390765;9004;9086.182243597843;9093.909060909305;9116.954415227881;10169.542370593193;10181.440020798631;10293.43386113771;10293.948530257301;10298.17614590846;8658.91341086581;8746.562671866508;8784.165504277084;8933.374663773733;9169.816603668023;8998.820023599623;9176.587053582738;9177.08229177077;9306.534673266175;9390.389624674373;8233.83532329362;8364.790880228044;8373.33013358942;8373.455725377831;8376.53929033909;6275.592086514362;6277.591956522811;6369.267534233622;6385.29761726219;6425.775097871552;6504.642244676588;6519.185101862267;6581;6630.53586248958;6678.3989440950545 20:33:44 INFO - PROCESS | 3402 | |4;prototype.html;401.53221496956047;416.07838637418115;429.42671533502755;438.98902527436815;442.23493356493265;5261.8421447356595;5336.30628018357;5348.3152806865855;5389.191621256813;5415.485528874756;5121.743912804363;5139.306193663863;5150.1759718445055;5195.662281951671;5226.2944502492155;4425.982024134451;4435.713643043514;4437.489688685794;4460.30865215892;4490.528494508078;4480.395146655193;4488.371627972087;4491.505934347236;4498.730076195438;4535.954640453603;4242.618164365206;4407;4412.3602077698715;4437.6671749618745;4450.777461126947;4410.86767396977;4417.823287068513;4422.059330545184;4432.20220360335;4434.290513517822;4204.663626909871;4229;4232.513260974996;4256.851010214658;4263.914721705549;4931;5076.746162691888;5081.28861959326;5096.439391666913;5199.740012999373;5046.596272298208;5068.175456835536;5085;5094.6433749637545;5101.285819985205;5529.585281103933;5540.899734196706;5560.582956278296;5568.860778480571;5602.355729091166;4367.039251364695;4571.1771881061395;4573.954260457386;4575.679702420832;4614.661748093049;5502.706863886983;5538.889222215533;5621.634593751393;5728.79949201776;5752.626079304831;4637.536246375335;4640.86077417678;4651.581357677757;4656.278276867091;4677.456439374998;4625.32932724753;4691.217337411762;4716.882077948078;4744.501827308152;4747.216709243005;5040.445550989388;5049.82325618609;5080.974595127001;5140.198591767496;5140.537351638371;5522.585806064561;5535.861603459945;5537.944620553743;5543.867714741158;5575.494616453616;1597.9280932358072;1645.5556999610037;1647.3328302037694;1675.7067513185143;1683.7053515634716;1241.9813702794465;1272.7781329923378;1273.8853503184573;1286.8032729561598;1301.7526669932872;5319.117044557417;5352.946470535245;5404.405700318415;5451.182322651554;5455.61810673257;5639.351474580476;5641.617803638135;5647.774089036475;5659.887062115902;5677.77288908439;5258.526732594085;5394.651337165708;5485.4788795064405;5497.202905578669;5501.092319767194;2946.543285790706;2950.6574508598537;2962.4667559839004;2979.940401191964;2992.521196608576;5501.679596896796;5813.476787089182;5828.504577110908;5874.296454028369;5974.699740599814;5739.298152691491;5782.277215348082;5784.3926387729525;5811.244538210006;5837.241158649348;5742.971285143548;5801.3328467225965;5871.4715675589405;5873.970630146822;5894.646321220741;5368;5558.555315574825;5595.63628364155;5727.5417966561745;5749.9712501437225;5457.481539253765;5509.173623956439;5535.474129957647;5694;5697.857553561194;5911.733971971185;5920.684416726647;5963.254593175853;5965.343812180743;6052.788152414821;4527.479339875957;4667.669714131456;4675.672702910763;4710;4725.834595789131;5639.605227634191;5656.5757568181725;5660.122680984454;5671.801486947937;5673.290838645169;5497.340319161726;5512.283403157564;5526.45259327389;5544.08935308966;5615.775368985195;5327.760250788801;5446.836594902159;5553.916691249715;5557.638753481011;5572.554195664418;5458.699771512605;5533.253010843646;5563.527100196528;5596.776128954796;5741.5406767459335;5331.306930099062;5566.4990150886615;5569.303837020372;5600.85997850057;5705.400932902152;5381.919271210857;5424.755885985219;5468.808591699271;5470.288862447856;5497.47773961473 20:33:44 INFO - PROCESS | 3402 | |5;yui.html;878.617801256453;880.5729221327655;897.7261935109793;924.4284715982828;929.6932012435901;16447.177641117956;18207.18067686954;18633.440996770103;19252.807471925276;19533;17435.21541530631;18393.54016149597;19217.711734323995;19377.90311048446;19381;873.6025108575583;898.2095755734961;904.6607522179182;905.7871400220943;906.1618003346911;888.205056474455;895.6283142495856;896.8520194167954;903.4850135422812;903.9141281578239;944.834653935562;945.5225111318808;946.0586716217373;946.8627049077879;947.3321308477541;943.235978857121;943.9622415103388;944.5418971798672;944.551338114397;944.6740874398356;692.0518889121935;692.4979389942301;697.15992229364;698.1622053535777;698.1970733656285;18443.907780461013;18472.168752406174;18736.812631873643;18943.052847357576;19143;14858;15094.698106037928;15118.168500732456;15349.07905525672;15513.612159696098;13188.934055329662;13667.521636742666;13717.45130194791;13799.86200138006;13970.231637259947;3757;3764.5482542095124;3792.0709426190483;3850.9614903850884;4009.7594144351433;53717.731411343084;55092.72453637706;55277;71141;79329.20670793334;13076.869231307755;13152.40814163365;13163.53927612529;13203.207807531579;13596.660083497794;21037;21714.89142554277;22807;22927.312180634606;23179.420514486934;8918.375713700108;9237.676681316256;9272.536373181314;9295.209907157832;9304.674336398193;4920.6801557898625;4957.3307603473795;4965.627577931597;5174.818881339135;5300.522952934178;3568.7323450741296;3632.1282892106233;3676.209614932802;3676.522052133259;3693.8707145250323;606.1090197409801;612.2989177391861;612.586504109733;625.9248890133122;626.5426238845669;839.6767244610869;848.1306660672859;851.3359579527978;851.4933614499363;861.763015170833;10719.785604288027;11453.19827612059;11815.113866459878;11944.64166075019;12206.816897746541;803.5580430763057;814.8777683347427;822.3051521464473;827.1769589258726;840.8276303357796;5226.973865130726;5304.443033481506;5310.123829568155;5379.246905433164;5393.13709806437;80813.59593202114;81313.59343203246;81614.18385816185;82528;83636;53425.46574534205;63754;64904.35095649077;65006.34993650098;71998.64000679963;56916;57646.423535764945;58870;60109.39890601126;62516.68741656263;11231.18121387717;12248.265104093784;12324.815127772912;12361.93819030899;12678.746425071631;43948.26439752657;44345;44939.55060449484;45106.77446612746;45486.317705233785;51854.48145518496;51915;51951.740241298554;52494;53941.730291349864;14863.628409289855;15292.923535382697;15322.540323790305;15539.844601554292;15910;16447.588810279838;16696.83303166953;16763.1618419081;16943;17061.658766824345;15845.445409411077;15846.68306633884;16082.35670573164;16327.510174694778;16539.66920661556;15123.697526049638;15257.160856153017;15657.843421565638;15705.371785128924;16210.918945405198;15229.314680839167;15313.310901009705;15454.381824727334;16650.50048498547;16747.497575072768;10800.492426696628;10880.45597720095;11156.553737850396;11162.832557511807;11382.715432114263;11900.04799616046;12231.30306826544;12330.938345308576;12346.259224446561;12419.130660853654 20:33:44 INFO - PROCESS | 3402 | __end_tp_report 20:33:44 INFO - PROCESS | 3402 | __start_cc_report 20:33:44 INFO - PROCESS | 3402 | _x_x_mozilla_cycle_collect,1342 20:33:44 INFO - PROCESS | 3402 | __end_cc_report 20:33:44 INFO - PROCESS | 3402 | __startTimestamp1492140824085__endTimestamp 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | ------- Summary: start ------- 20:33:44 INFO - PROCESS | 3402 | Number of tests: 6 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#0] dojo.html Cycles:165 Average:5781.82 Median:6042.06 stddev:665.84 (11.0%) stddev-sans-first:640.38 20:33:44 INFO - PROCESS | 3402 | Values: 3367.7 3395.7 3399.7 3413.2 3446.5 5688.9 5726.3 5726.9 5732.0 5742.7 5802.9 5846.9 5876.2 5878.4 5881.3 5283.4 5290.4 5315.7 5379.6 5383.9 5086.8 5168.0 5377.2 5384.3 5388.8 5171.0 5274.7 5275.6 5363.5 5377.0 5346.0 5364.2 5372.1 5377.5 5385.8 5243.9 5274.3 5289.9 5349.0 5355.2 5589.9 5608.6 5659.7 5716.2 5733.3 6155.4 6161.5 6161.7 6167.8 6178.2 6193.1 6196.3 6237.2 6269.7 6271.0 5604.2 5624.6 5777.5 5818.9 5824.5 6318.5 6354.7 6368.6 6376.9 6379.4 6134.6 6142.0 6145.1 6148.5 6151.4 5970.6 5997.3 6142.9 6150.9 6294.1 6184.7 6192.8 6201.9 6206.5 6222.8 5951.5 6008.5 6020.5 6049.0 6200.2 4688.3 4690.0 4701.6 4732.6 4756.8 4139.5 4140.7 4152.6 4157.2 4220.0 5992.1 6036.5 6042.1 6048.9 6084.3 6257.3 6283.1 6297.1 6301.2 6303.6 5842.1 5884.9 5963.6 6051.9 6057.7 5313.7 5330.8 5351.0 5362.1 5362.6 6546.0 6552.8 6554.2 6554.6 6559.0 5935.4 6046.4 6261.9 6294.5 6299.6 6479.0 6511.6 6547.1 6613.5 6641.8 6167.7 6174.3 6182.5 6187.9 6196.2 6031.5 6206.3 6282.2 6286.2 6291.0 5952.6 6067.6 6079.5 6141.1 6145.9 6120.5 6125.4 6134.4 6136.7 6148.5 5823.8 5867.8 6127.4 6135.8 6144.8 6016.9 6022.9 6133.4 6158.6 6172.3 6051.8 6056.0 6068.8 6070.6 6081.5 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#1] ext.html Cycles:180 Average:46101.97 Median:33033.92 stddev:73647.12 (222.9%) stddev-sans-first:73775.10 20:33:44 INFO - PROCESS | 3402 | Values: 779.6 829.7 847.4 910.4 917.3 30720.0 44850.8 45263.3 45348.5 45494.5 45380.3 45588.0 45634.0 45749.5 45846.5 7685.6 7802.3 9143.5 9283.6 9290.3 10517.2 10720.6 11027.1 11053.1 11059.6 10867.1 10894.1 10898.7 10908.7 10917.2 10811.4 10836.0 10838.9 10842.1 10860.2 10311.7 10367.2 10424.6 10433.3 10440.4 43858.0 43867.3 44072.8 44089.6 44185.0 4169.5 4208.4 4234.1 4315.0 4339.1 30016.8 30415.1 30618.4 31119.5 31910.5 4261.6 4328.4 4343.2 4348.4 4438.2 234217.0 235042.0 235368.0 235800.0 236024.0 56087.2 56305.4 56387.4 56498.0 56515.7 56861.7 57034.7 57273.0 57325.0 57359.0 16339.2 16786.3 16792.4 16794.5 16795.3 12182.9 12388.8 14674.8 14687.7 14692.0 11350.0 11408.6 11424.0 13843.8 13856.7 5477.6 5583.8 5590.6 5607.2 5614.2 1206.5 1214.0 1236.4 1238.1 1252.4 28066.3 28300.4 28413.1 28565.4 28741.6 1313.9 1347.3 1365.4 1369.2 1372.8 14994.9 15038.1 15126.3 15345.6 15415.7 286635.0 287114.0 288487.0 289033.0 298778.0 50023.7 55658.0 55786.0 63415.0 63540.7 1488.9 1499.4 1527.6 1550.3 1553.8 32032.5 33178.5 33343.2 33434.1 33822.3 46100.0 46125.8 46138.0 46185.5 46203.0 314068.0 316279.0 316329.0 317425.0 317781.0 37613.6 38377.8 38402.8 38444.2 38447.6 44263.8 44907.6 45040.3 45251.8 46222.1 33760.3 33868.3 34094.7 34259.1 34511.8 33256.0 33920.0 33924.6 34085.7 34529.1 38685.0 39028.6 39047.6 39510.4 39653.0 32426.4 32660.7 32826.3 32889.3 33329.5 23055.7 24163.5 24254.6 24258.0 24403.9 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#2] jquery.html Cycles:180 Average:37530.54 Median:20887.37 stddev:110146.44 (527.3%) stddev-sans-first:110420.14 20:33:44 INFO - PROCESS | 3402 | Values: 401.4 450.9 452.4 458.4 484.2 17848.0 18783.9 20786.5 20988.3 21201.3 15076.5 20739.4 21856.3 21878.8 22035.8 6779.7 7033.7 7046.2 7047.9 7193.3 7432.8 7523.8 7532.3 7534.2 7535.4 7445.4 7477.6 7543.3 7556.5 7588.7 7281.3 7287.1 7322.5 7333.6 7343.0 7118.2 7316.6 7319.2 7327.5 7330.5 24707.4 24857.5 24979.6 25201.5 25398.4 3116.6 3164.1 3201.1 3220.1 3243.6 15302.7 15424.6 15924.7 15943.5 16280.7 2218.9 2234.6 2251.1 2314.0 2319.5 107972.0 110909.4 111094.0 112152.0 114223.0 17670.3 17797.2 17876.5 17919.6 18369.9 31604.8 31654.2 31680.7 31709.7 31991.0 8665.5 9214.4 9762.3 10194.5 10241.8 8573.7 8590.6 8595.5 8711.4 8753.3 9004.8 9386.4 9454.5 9456.4 9511.0 3772.9 3889.5 3916.8 4053.9 4054.7 1005.2 1016.3 1021.4 1035.2 1036.3 19887.2 19938.9 20061.2 20084.1 20140.4 1021.6 1037.0 1057.2 1068.5 1069.4 9986.8 10897.9 10899.7 10933.5 10995.3 653821.0 669859.0 670845.0 675234.0 676773.0 106167.5 106984.9 109248.5 111421.0 111786.0 1268.9 1288.3 1301.9 1303.1 1306.3 16293.4 16809.8 17504.6 17569.6 17697.3 47871.8 49102.5 50772.5 51370.0 55879.7 67611.7 67713.7 68015.9 68480.3 68751.7 12158.8 12572.9 12581.4 12585.0 12892.6 13565.7 13599.6 13637.2 13724.7 13779.9 12406.3 12515.6 12622.3 12680.2 12928.1 10903.6 10998.5 11155.5 11325.1 11437.4 10895.8 11189.3 11447.4 11710.4 12587.4 12414.8 12418.1 12445.7 12450.2 12505.7 12069.2 12100.8 12102.0 12181.5 12238.4 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#3] mootools.html Cycles:180 Average:7002.32 Median:2438.28 stddev:4406.24 (180.7%) stddev-sans-first:4399.71 20:33:44 INFO - PROCESS | 3402 | Values: 1572.7 1587.9 1602.9 1614.0 1618.2 10764.9 11407.4 11407.9 11417.3 11425.1 10747.9 11011.5 11251.5 11277.6 11286.9 2417.7 2441.4 2453.3 2456.6 2456.8 2365.8 2435.2 2453.9 2455.5 2455.7 2397.1 2431.0 2431.8 2467.3 2468.6 2347.3 2368.5 2389.4 2391.8 2424.9 2335.8 2347.0 2348.0 2356.6 2361.3 11235.0 11416.1 11432.2 11442.1 11447.7 5536.7 5739.1 5746.3 5748.1 5757.7 3270.3 3409.6 3444.4 3475.9 3480.6 1230.1 1252.4 1278.6 1284.5 1418.9 13978.2 14337.1 15493.1 16772.0 16929.3 4555.6 4665.9 4666.5 4686.6 4709.8 10578.7 13236.9 13253.8 13272.6 13288.7 4868.4 5484.7 5583.2 5607.9 5608.9 4998.6 5135.9 5197.5 5207.7 5355.5 3884.9 3951.1 3985.8 4017.0 4026.5 1048.2 1053.3 1056.8 1060.5 1067.3 931.2 932.3 939.7 972.6 1101.9 7233.2 7253.9 7415.7 7493.4 7705.5 1106.1 1123.3 1125.2 1127.3 1140.3 4903.8 5036.2 5039.4 5071.5 5105.3 14267.9 14874.5 14915.8 14952.9 15032.6 14682.2 14688.5 14696.3 14804.4 14862.5 10542.6 10679.3 10706.7 10845.3 10853.2 7356.2 7387.3 7434.5 7574.4 7585.5 9821.9 12010.5 12662.3 12805.3 12831.8 12424.0 12746.0 12796.9 12804.6 12930.7 8912.2 9004.0 9086.2 9093.9 9117.0 10169.5 10181.4 10293.4 10293.9 10298.2 8658.9 8746.6 8784.2 8933.4 9169.8 8998.8 9176.6 9177.1 9306.5 9390.4 8233.8 8364.8 8373.3 8373.5 8376.5 6275.6 6277.6 6369.3 6385.3 6425.8 6504.6 6519.2 6581.0 6630.5 6678.4 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#4] prototype.html Cycles:180 Average:4824.76 Median:5342.31 stddev:1282.88 (24.0%) stddev-sans-first:1242.78 20:33:44 INFO - PROCESS | 3402 | Values: 401.5 416.1 429.4 439.0 442.2 5261.8 5336.3 5348.3 5389.2 5415.5 5121.7 5139.3 5150.2 5195.7 5226.3 4426.0 4435.7 4437.5 4460.3 4490.5 4480.4 4488.4 4491.5 4498.7 4536.0 4242.6 4407.0 4412.4 4437.7 4450.8 4410.9 4417.8 4422.1 4432.2 4434.3 4204.7 4229.0 4232.5 4256.9 4263.9 4931.0 5076.7 5081.3 5096.4 5199.7 5046.6 5068.2 5085.0 5094.6 5101.3 5529.6 5540.9 5560.6 5568.9 5602.4 4367.0 4571.2 4574.0 4575.7 4614.7 5502.7 5538.9 5621.6 5728.8 5752.6 4637.5 4640.9 4651.6 4656.3 4677.5 4625.3 4691.2 4716.9 4744.5 4747.2 5040.4 5049.8 5081.0 5140.2 5140.5 5522.6 5535.9 5537.9 5543.9 5575.5 1597.9 1645.6 1647.3 1675.7 1683.7 1242.0 1272.8 1273.9 1286.8 1301.8 5319.1 5352.9 5404.4 5451.2 5455.6 5639.4 5641.6 5647.8 5659.9 5677.8 5258.5 5394.7 5485.5 5497.2 5501.1 2946.5 2950.7 2962.5 2979.9 2992.5 5501.7 5813.5 5828.5 5874.3 5974.7 5739.3 5782.3 5784.4 5811.2 5837.2 5743.0 5801.3 5871.5 5874.0 5894.6 5368.0 5558.6 5595.6 5727.5 5750.0 5457.5 5509.2 5535.5 5694.0 5697.9 5911.7 5920.7 5963.3 5965.3 6052.8 4527.5 4667.7 4675.7 4710.0 4725.8 5639.6 5656.6 5660.1 5671.8 5673.3 5497.3 5512.3 5526.5 5544.1 5615.8 5327.8 5446.8 5553.9 5557.6 5572.6 5458.7 5533.3 5563.5 5596.8 5741.5 5331.3 5566.5 5569.3 5600.9 5705.4 5381.9 5424.8 5468.8 5470.3 5497.5 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - PROCESS | 3402 | [#5] yui.html Cycles:180 Average:17972.33 Median:44146.63 stddev:20923.47 (47.4%) stddev-sans-first:20942.79 20:33:44 INFO - PROCESS | 3402 | Values: 878.6 880.6 897.7 924.4 929.7 16447.2 18207.2 18633.4 19252.8 19533.0 17435.2 18393.5 19217.7 19377.9 19381.0 873.6 898.2 904.7 905.8 906.2 888.2 895.6 896.9 903.5 903.9 944.8 945.5 946.1 946.9 947.3 943.2 944.0 944.5 944.6 944.7 692.1 692.5 697.2 698.2 698.2 18443.9 18472.2 18736.8 18943.1 19143.0 14858.0 15094.7 15118.2 15349.1 15513.6 13188.9 13667.5 13717.5 13799.9 13970.2 3757.0 3764.5 3792.1 3851.0 4009.8 53717.7 55092.7 55277.0 71141.0 79329.2 13076.9 13152.4 13163.5 13203.2 13596.7 21037.0 21714.9 22807.0 22927.3 23179.4 8918.4 9237.7 9272.5 9295.2 9304.7 4920.7 4957.3 4965.6 5174.8 5300.5 3568.7 3632.1 3676.2 3676.5 3693.9 606.1 612.3 612.6 625.9 626.5 839.7 848.1 851.3 851.5 861.8 10719.8 11453.2 11815.1 11944.6 12206.8 803.6 814.9 822.3 827.2 840.8 5227.0 5304.4 5310.1 5379.2 5393.1 80813.6 81313.6 81614.2 82528.0 83636.0 53425.5 63754.0 64904.4 65006.3 71998.6 56916.0 57646.4 58870.0 60109.4 62516.7 11231.2 12248.3 12324.8 12361.9 12678.7 43948.3 44345.0 44939.6 45106.8 45486.3 51854.5 51915.0 51951.7 52494.0 53941.7 14863.6 15292.9 15322.5 15539.8 15910.0 16447.6 16696.8 16763.2 16943.0 17061.7 15845.4 15846.7 16082.4 16327.5 16539.7 15123.7 15257.2 15657.8 15705.4 16210.9 15229.3 15313.3 15454.4 16650.5 16747.5 10800.5 10880.5 11156.6 11162.8 11382.7 11900.0 12231.3 12330.9 12346.3 12419.1 20:33:44 INFO - PROCESS | 3402 | -------- Summary: end -------- 20:33:44 INFO - PROCESS | 3402 | 20:33:44 INFO - TEST-INFO | 3402: exit 0 20:33:44 INFO - TEST-OK | dromaeo_css | took 1117789ms 20:33:44 INFO - TEST-START | kraken 20:33:44 INFO - operating with platform_type : linux_ 20:33:44 INFO - Initialising browser for kraken test... 20:33:44 INFO - TEST-INFO | started process 3731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7pORv/profile http://localhost:49760/getInfo.html) 20:33:48 INFO - PROCESS | 3731 | __metrics Screen width/height:1600/1200 20:33:48 INFO - PROCESS | 3731 | colorDepth:24 20:33:48 INFO - PROCESS | 3731 | Browser inner width/height: 1024/697 20:33:48 INFO - PROCESS | 3731 | __metrics 20:33:49 INFO - PROCESS | 3731 | 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" 20:33:49 INFO - PROCESS | 3731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:33:49 INFO - PROCESS | 3731 | console.error: PushService: 20:33:49 INFO - PROCESS | 3731 | stateChangeProcessEnqueue: Error transitioning state 20:33:49 INFO - PROCESS | 3731 | UnknownError 20:33:50 INFO - TEST-INFO | 3731: exit 0 20:33:50 INFO - Browser initialized. 20:33:50 INFO - Running cycle 1/1 for kraken test... 20:33:50 INFO - TEST-INFO | started process 3825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7pORv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:02 INFO - PROCESS | 3825 | RSS: Main: 140222464 20:34:02 INFO - PROCESS | 3825 | 20:34:04 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:05 INFO - PROCESS | 3825 | RSS: Main: 183504896 20:34:05 INFO - PROCESS | 3825 | 20:34:08 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-dft) 20:34:08 INFO - PROCESS | 3825 | RSS: Main: 174292992 20:34:08 INFO - PROCESS | 3825 | 20:34:11 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-fft) 20:34:12 INFO - PROCESS | 3825 | RSS: Main: 266170368 20:34:12 INFO - PROCESS | 3825 | 20:34:14 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-oscillator) 20:34:14 INFO - PROCESS | 3825 | RSS: Main: 172236800 20:34:14 INFO - PROCESS | 3825 | 20:34:17 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:17 INFO - PROCESS | 3825 | RSS: Main: 174141440 20:34:17 INFO - PROCESS | 3825 | 20:34:20 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:21 INFO - PROCESS | 3825 | RSS: Main: 213745664 20:34:21 INFO - PROCESS | 3825 | 20:34:24 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:25 INFO - PROCESS | 3825 | RSS: Main: 212385792 20:34:25 INFO - PROCESS | 3825 | 20:34:27 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49760/tests/kraken/driver.html?testName=json-parse-financial) 20:34:28 INFO - PROCESS | 3825 | RSS: Main: 210702336 20:34:28 INFO - PROCESS | 3825 | 20:34:30 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:30 INFO - PROCESS | 3825 | RSS: Main: 173641728 20:34:30 INFO - PROCESS | 3825 | 20:34:32 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:32 INFO - PROCESS | 3825 | RSS: Main: 179273728 20:34:32 INFO - PROCESS | 3825 | 20:34:34 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:35 INFO - PROCESS | 3825 | RSS: Main: 189968384 20:34:35 INFO - PROCESS | 3825 | 20:34:38 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:38 INFO - PROCESS | 3825 | RSS: Main: 198217728 20:34:38 INFO - PROCESS | 3825 | 20:34:41 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:42 INFO - PROCESS | 3825 | RSS: Main: 195502080 20:34:42 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49760/tests/kraken/driver.html?testName=ai-astar) 20:34:43 INFO - PROCESS | 3825 | RSS: Main: 245678080 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | __start_tp_report 20:34:43 INFO - PROCESS | 3825 | _x_x_mozilla_page_load 20:34:43 INFO - PROCESS | 3825 | _x_x_mozilla_page_load_details 20:34:43 INFO - PROCESS | 3825 | |i|pagename|runs| 20:34:43 INFO - PROCESS | 3825 | |0;ai-astar;105;116;115;114;115;114;114;113;114;114 20:34:43 INFO - PROCESS | 3825 | |1;audio-beat-detection;144;119;118;167;118;122;115;117;143;116 20:34:43 INFO - PROCESS | 3825 | |2;audio-dft;161;160;162;161;160;161;160;159;161;161 20:34:43 INFO - PROCESS | 3825 | |3;audio-fft;75;75;74;110;76;75;77;76;97;75 20:34:43 INFO - PROCESS | 3825 | |4;audio-oscillator;82;83;109;83;83;84;100;82;83;113 20:34:43 INFO - PROCESS | 3825 | |5;imaging-gaussian-blur;113;113;113;113;113;113;114;113;112;113 20:34:43 INFO - PROCESS | 3825 | |6;imaging-darkroom;146;146;147;147;146;146;147;147;146;146 20:34:43 INFO - PROCESS | 3825 | |7;imaging-desaturate;94;94;93;94;94;94;94;94;94;94 20:34:43 INFO - PROCESS | 3825 | |8;json-parse-financial;55;54;54;54;55;54;65;55;55;55 20:34:43 INFO - PROCESS | 3825 | |9;json-stringify-tinderbox;55;54;54;53;53;54;54;54;55;54 20:34:43 INFO - PROCESS | 3825 | |10;stanford-crypto-aes;75;77;78;79;84;84;78;76;81;79 20:34:43 INFO - PROCESS | 3825 | |11;stanford-crypto-ccm;122;121;120;121;121;126;127;119;156;127 20:34:43 INFO - PROCESS | 3825 | |12;stanford-crypto-pbkdf2;161;168;160;158;160;159;159;158;156;157 20:34:43 INFO - PROCESS | 3825 | |13;stanford-crypto-sha256-iterative;60;60;60;59;59;61;60;60;61;62 20:34:43 INFO - PROCESS | 3825 | __end_tp_report 20:34:43 INFO - PROCESS | 3825 | __start_cc_report 20:34:43 INFO - PROCESS | 3825 | _x_x_mozilla_cycle_collect,1689 20:34:43 INFO - PROCESS | 3825 | __end_cc_report 20:34:43 INFO - PROCESS | 3825 | __startTimestamp1492140883963__endTimestamp 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | ------- Summary: start ------- 20:34:43 INFO - PROCESS | 3825 | Number of tests: 14 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 20:34:43 INFO - PROCESS | 3825 | Values: 105.0 116.0 115.0 114.0 115.0 114.0 114.0 113.0 114.0 114.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:120.50 stddev:17.49 (14.5%) stddev-sans-first:17.55 20:34:43 INFO - PROCESS | 3825 | Values: 144.0 119.0 118.0 167.0 118.0 122.0 115.0 117.0 143.0 116.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 20:34:43 INFO - PROCESS | 3825 | Values: 161.0 160.0 162.0 161.0 160.0 161.0 160.0 159.0 161.0 161.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:12.27 (16.3%) stddev-sans-first:12.83 20:34:43 INFO - PROCESS | 3825 | Values: 75.0 75.0 74.0 110.0 76.0 75.0 77.0 76.0 97.0 75.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.00 stddev:12.25 (14.8%) stddev-sans-first:12.62 20:34:43 INFO - PROCESS | 3825 | Values: 82.0 83.0 109.0 83.0 83.0 84.0 100.0 82.0 83.0 113.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:34:43 INFO - PROCESS | 3825 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 112.0 113.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:34:43 INFO - PROCESS | 3825 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:34:43 INFO - PROCESS | 3825 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.34 (6.1%) stddev-sans-first:3.54 20:34:43 INFO - PROCESS | 3825 | Values: 55.0 54.0 54.0 54.0 55.0 54.0 65.0 55.0 55.0 55.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 20:34:43 INFO - PROCESS | 3825 | Values: 55.0 54.0 54.0 53.0 53.0 54.0 54.0 54.0 55.0 54.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:3.07 (3.9%) stddev-sans-first:2.88 20:34:43 INFO - PROCESS | 3825 | Values: 75.0 77.0 78.0 79.0 84.0 84.0 78.0 76.0 81.0 79.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:124.00 stddev:10.94 (8.8%) stddev-sans-first:11.51 20:34:43 INFO - PROCESS | 3825 | Values: 122.0 121.0 120.0 121.0 121.0 126.0 127.0 119.0 156.0 127.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:159.50 stddev:3.31 (2.1%) stddev-sans-first:3.47 20:34:43 INFO - PROCESS | 3825 | Values: 161.0 168.0 160.0 158.0 160.0 159.0 159.0 158.0 156.0 157.0 20:34:43 INFO - PROCESS | 3825 | 20:34:43 INFO - PROCESS | 3825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 20:34:43 INFO - PROCESS | 3825 | Values: 60.0 60.0 60.0 59.0 59.0 61.0 60.0 60.0 61.0 62.0 20:34:43 INFO - PROCESS | 3825 | -------- Summary: end -------- 20:34:43 INFO - PROCESS | 3825 | 20:34:45 INFO - TEST-INFO | 3825: exit 0 20:34:45 INFO - TEST-OK | kraken | took 60218ms 20:34:45 INFO - SUITE-END | took 1178s 20:34:45 INFO - Completed test suite (00:19:38) 20:34:45 INFO - javascript benchmark 20:34:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7892.103775495454, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.730581553476, 3395.7453191010673, 3399.7110245629137, 3413.180836599217, 3446.517487551742, 5688.857778555538, 5726.255586773714, 5726.942730572693, 5731.971340143304, 5742.741576629051, 5802.941970580293, 5846.912296315559, 5876.177335173079, 5878.382769809162, 5881.294244690643, 5283.445238249986, 5290.365156181264, 5315.734213289339, 5379.5696344292555, 5383.946160538403, 5086.796528138889, 5168.0, 5377.166539186433, 5384.273123128367, 5388.78444862205, 5171.043356978952, 5274.709890955995, 5275.57795376369, 5363.517283444489, 5376.973115134439, 5346.03771321162, 5364.222187782789, 5372.059889519319, 5377.489138531852, 5385.757640906129, 5243.9213411798855, 5274.287971123926, 5289.947100528984, 5349.037173308803, 5355.223492593591, 5589.916151257735, 5608.5793565482345, 5659.688717120557, 5716.1711551825165, 5733.312002559678, 6155.384461553854, 6161.476274516672, 6161.7227224775, 6167.7532898684, 6178.165947597062, 6193.0710393440895, 6196.256449226076, 6237.1891654084675, 6269.7178626961895, 6271.0, 5604.243427137366, 5624.6343987641085, 5777.480026797609, 5818.854528636733, 5824.504917082053, 6318.494520438354, 6354.745810167541, 6368.64972426521, 6376.904346434807, 6379.3620637936765, 6134.631922084689, 6142.04798256271, 6145.10895920098, 6148.538859585549, 6151.384861513813, 5970.582059255898, 5997.310309314485, 6142.897836592492, 6150.876982460326, 6294.087357333253, 6184.6598437085495, 6192.752289908353, 6201.875962480725, 6206.472449841724, 6222.782202622977, 5951.464368206795, 6008.459238668541, 6020.518358531394, 6049.0, 6200.224971878515, 4688.2733176357715, 4690.038542098861, 4701.553352431513, 4732.5977291929885, 4756.809727610926, 4139.544650088488, 4140.68944829139, 4152.647025002848, 4157.168566286755, 4219.957800421957, 5992.0712289595185, 6036.486898613579, 6042.063480160582, 6048.939510604838, 6084.330723620398, 6257.346056537229, 6283.120363149163, 6297.118403423525, 6301.212348456443, 6303.590266632654, 5842.065269556851, 5884.852878677982, 5963.612365196248, 6051.939480605138, 6057.697115144225, 5313.681179129265, 5330.840074797762, 5351.0, 5362.061639213122, 5362.570994320445, 6545.967270163619, 6552.770653027121, 6554.180727409074, 6554.606723596695, 6559.0, 5935.376785437467, 6046.395360463918, 6261.8747625046335, 6294.464970477561, 6299.590526615755, 6478.967605161944, 6511.576747511396, 6547.050677651809, 6613.5370524062855, 6641.833954151185, 6167.722452489559, 6174.320824709189, 6182.505399567934, 6187.938120618916, 6196.194494715658, 6031.517478601789, 6206.348333424925, 6282.2147231596055, 6286.18279623646, 6290.968545157245, 5952.553558483044, 6067.605605635619, 6079.452849243589, 6141.148492690724, 6145.863015342176, 6120.548409105651, 6125.357545073132, 6134.4172303631085, 6136.718146525597, 6148.47737942262, 5823.82528524145, 5867.794627188028, 6127.375193257265, 6135.753292002278, 6144.832481828438, 6016.909746353896, 6022.939770602238, 6133.3866613338305, 6158.599691020069, 6172.2901866284155, 6051.848703782264, 6056.0, 6068.848278793065, 6070.6357618543025, 6081.452669259788], "value": 5736.611385844374, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.6335722210559, 829.7261903571822, 847.3517758914429, 910.4355299714178, 917.284518075901, 30720.0, 44850.77574612127, 45263.32105018419, 45348.54651453484, 45494.545054549446, 45380.3192952106, 45588.0, 45634.0, 45749.54250457494, 45846.54153458473, 7685.6157192140445, 7802.258785415376, 9143.542822858864, 9283.58223879927, 9290.25677945766, 10517.211209159306, 10720.571177152904, 11027.062699670538, 11053.115750739962, 11059.612913548028, 10867.130629549618, 10894.128469722404, 10898.727531811688, 10908.727281817979, 10917.23579349446, 10811.35131892089, 10836.0, 10838.945805271002, 10842.132629389629, 10860.239783215178, 10311.742206444824, 10367.170626349875, 10424.5830166794, 10433.321834080836, 10440.425776582286, 43858.0, 43867.341989870176, 44072.779636101615, 44089.559104409185, 44185.0, 4169.517406867549, 4208.410822484854, 4234.13200293939, 4315.029118448356, 4339.1104823511105, 30016.776358239695, 30415.087547373616, 30618.387632247453, 31119.533207001914, 31910.521342179887, 4261.637760790337, 4328.350747387885, 4343.174796788631, 4348.412964249817, 4438.178936896652, 234217.0, 235042.0, 235368.0, 235800.0, 236024.0, 56087.15869261965, 56305.43694563002, 56387.43612563822, 56498.0, 56515.71742141263, 56861.715691422105, 57034.7148264256, 57273.0, 57325.0, 57359.0, 16339.18304084791, 16786.328546858233, 16792.412265570645, 16794.496165115066, 16795.328186872634, 12182.878171218352, 12388.752224955451, 14674.779878301833, 14687.706245875022, 14692.0, 11349.978501934866, 11408.600698975495, 11424.028957538536, 13843.792343114861, 13856.722865542633, 5477.616566840363, 5583.832485025456, 5590.552755779528, 5607.158926161027, 5614.1859430382365, 1206.4932728254155, 1214.0, 1236.4250623460134, 1238.0961897814466, 1252.4301442843484, 28066.29834254119, 28300.433991320057, 28413.147605571867, 28565.428691426056, 28741.56887646687, 1313.8678904351073, 1347.2926713475308, 1365.4401695304878, 1369.2195448594405, 1372.8421231558498, 14994.925025374803, 15038.097714137186, 15126.319315630823, 15345.6163595911, 15415.691686166214, 286635.0, 287114.0, 288487.0, 289033.0, 298778.0, 50023.74988125036, 55658.0, 55786.0, 63415.0, 63540.682296588224, 1488.8660020598197, 1499.437710858428, 1527.6486408126193, 1550.3256083603444, 1553.8057742782153, 32032.5195122078, 33178.5023224647, 33343.1664208387, 33434.1468283683, 33822.323553529284, 46100.0, 46125.76937115293, 46138.0, 46185.53814461813, 46203.0, 314068.0, 316279.0, 316329.0, 317425.0, 317781.0, 37613.623863762106, 38377.80811095927, 38402.807985959895, 38444.23111537698, 38447.615523844404, 44263.778681106385, 44907.55092449034, 45040.324395133444, 45251.7737411324, 46222.07555848931, 33760.324793504486, 33868.32263354769, 34094.65905341014, 34259.14352141117, 34511.82744086264, 33256.0, 33920.0, 33924.56656493612, 34085.65914340924, 34529.13677158091, 38685.0, 39028.6097139025, 39047.6095239044, 39510.40734389044, 39653.0, 32426.35147297088, 32660.673393266712, 32826.34347313088, 32889.34221315513, 33329.50005749867, 23055.6541651872, 24163.51672966566, 24254.63618045766, 24258.0, 24403.877980609985], "value": 19572.007364089997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.38187191724745, 450.90530988492435, 452.35765213396974, 458.4200985753022, 484.1648156929296, 17847.991465347914, 18783.906080469595, 20786.480337991557, 20988.26541071063, 21201.257955971545, 15076.47232346868, 20739.377818665427, 21856.344309670694, 21878.781212187874, 22035.77964220357, 6779.728810847572, 7033.683484243222, 7046.189688185873, 7047.85904281914, 7193.280671932791, 7432.777016689508, 7523.811904702399, 7532.322091011808, 7534.2089080646565, 7535.359494442979, 7445.4415918806035, 7477.626118694071, 7543.3211011009, 7556.50882692626, 7588.658510367047, 7281.308275713799, 7287.125544934589, 7322.524035937647, 7333.559986400806, 7342.9632851835395, 7118.216996130422, 7316.561006339637, 7319.231480694503, 7327.450441216877, 7330.486865919388, 24707.382315442257, 24857.5028499429, 24979.62530562043, 25201.49597008068, 25398.36504087394, 3116.5948426704385, 3164.0666003529013, 3201.055688571877, 3220.0822765511716, 3243.6431992480807, 15302.693946121126, 15424.614384640361, 15924.681506369807, 15943.521694349189, 16280.674386512323, 2218.922337718172, 2234.597772400967, 2251.0770584060456, 2313.9652905206435, 2319.5360927814336, 107972.0, 110909.44545277303, 111094.0, 112152.0, 114223.0, 17670.293188272324, 17797.1991260391, 17876.463706088838, 17919.641607167785, 18369.908150459163, 31604.841975789976, 31654.208644784063, 31680.683193168235, 31709.682903170673, 31991.0, 8665.480071195749, 9214.401063930824, 9762.316637835283, 10194.541245643815, 10241.795164096677, 8573.74278771638, 8590.570471476402, 8595.527246001406, 8711.433756805787, 8753.255973242218, 9004.774880628036, 9386.436813791195, 9454.480003599869, 9456.385334953206, 9510.952445237868, 3772.924541509209, 3889.546469292644, 3916.784576848244, 4053.858114965962, 4054.675625949917, 1005.1606908231709, 1016.2885979814159, 1021.356545376423, 1035.1615191694752, 1036.259074761549, 19887.195942242834, 19938.90030549838, 20061.197552098045, 20084.096215670328, 20140.39578812638, 1021.596469394585, 1036.99481502592, 1057.154276578734, 1068.5458680060942, 1069.3583849690124, 9986.750331241632, 10897.891021089847, 10899.727506812393, 10933.453327333602, 10995.34027958325, 653821.0, 669859.0, 670845.0, 675234.0, 676773.0, 106167.4691626537, 106984.8603027935, 109248.4537577307, 111421.0, 111786.0, 1268.923864568129, 1288.3365066990507, 1301.947922083106, 1303.0552849184267, 1306.2554344024006, 16293.429729959395, 16809.831901680827, 17504.649907002044, 17569.560760980567, 17697.29210831604, 47871.76064119657, 49102.5089749098, 50772.52982899856, 51370.0, 55879.72060139673, 67611.66194168998, 67713.66143169449, 68015.91904485747, 68480.3151968474, 68751.65624171848, 12158.817617735564, 12572.937135314265, 12581.420808734005, 12585.022218479076, 12892.64627214129, 13565.660858478617, 13599.59201223965, 13637.153769363133, 13724.725505490034, 13779.862201378259, 12406.25562466255, 12515.624531264077, 12622.305773182563, 12680.23918564889, 12928.095033347952, 10903.618373356894, 10998.450077496253, 11155.498002590066, 11325.093992480746, 11437.42812859337, 10895.836562451412, 11189.272697274651, 11447.370394628375, 11710.414479275832, 12587.370631468208, 12414.751704966031, 12418.130730848754, 12445.688857778629, 12450.190737602026, 12505.749885002431, 12069.155159138776, 12100.818487722867, 12102.0, 12181.512739490321, 12238.449269782703], "value": 11416.540051410078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1572.6618776962957, 1587.9047257164564, 1602.9278682459287, 1613.975790363144, 1618.182817677073, 10764.892351076487, 11407.429628518561, 11407.942960285207, 11417.31496110234, 11425.08599312055, 10747.946260268687, 11011.504482298296, 11251.54993800247, 11277.605283815068, 11286.887131128686, 2417.721961974378, 2441.389652586853, 2453.251758213744, 2456.5946618807875, 2456.778889899909, 2365.787079162875, 2435.1720415058876, 2453.865037422941, 2455.4843482868528, 2455.668484754562, 2397.137030668958, 2431.0154387473103, 2431.8297719159664, 2467.3091534370405, 2468.568000599897, 2347.307544274443, 2368.455255291284, 2389.4145934246135, 2391.7727815857465, 2424.854508729482, 2335.801456876168, 2346.988265058681, 2347.9882600587057, 2356.5640356534095, 2361.303415492434, 11235.04502117321, 11416.086713062936, 11432.199746017783, 11442.084633229322, 11447.713807154805, 5536.723163841792, 5739.139129130622, 5746.339170995348, 5748.080307150877, 5757.740901659436, 3270.3459308138467, 3409.556757621518, 3444.4144495435835, 3475.94786078209, 3480.6171321154907, 1230.0897335971406, 1252.4238850128952, 1278.552506622684, 1284.5311461316646, 1418.9148651080866, 13978.161310321413, 14337.068090574183, 15493.070415774977, 16772.0, 16929.3228270869, 4555.63554915606, 4665.880188754674, 4666.463356714022, 4686.578207961232, 4709.846087708534, 10578.682639520826, 13236.933815330862, 13253.801192982113, 13272.601821945356, 13288.667783305495, 4868.391451068616, 5484.725763711878, 5583.190437386637, 5607.915881261784, 5608.915866262009, 4998.600111991032, 5135.922961155586, 5197.532222100029, 5207.713575753294, 5355.544778693855, 3884.892805550461, 3951.130751234781, 3985.7807820570147, 4016.979915100464, 4026.4564283821896, 1048.1928914735763, 1053.2890299048265, 1056.7569459024467, 1060.48566445274, 1067.295584913953, 931.2038207332769, 932.2681694869494, 939.7274790310734, 972.6206779356057, 1101.9338839669645, 7233.240509746506, 7253.891191632129, 7415.703371865065, 7493.3630641395, 7705.499142555716, 1106.1372129738816, 1123.326004397355, 1125.234840308598, 1127.312339472921, 1140.2816225777872, 4903.754812259373, 5036.194208926628, 5039.4377742899815, 5071.492850714899, 5105.259737338065, 14267.85732142686, 14874.479393221185, 14915.776263356058, 14952.925235373754, 15032.62418439526, 14682.192479413521, 14688.485902993558, 14696.26518674062, 14804.407823687146, 14862.479813206703, 10542.631007914686, 10679.252452328417, 10706.678799636024, 10845.349279043283, 10853.240273180802, 7356.190819009797, 7387.335139837441, 7434.516756410816, 7574.394048475999, 7585.469017168966, 9821.85267220978, 12010.459529321377, 12662.290590770128, 12805.295708735735, 12831.807522886977, 12424.0, 12745.980321574067, 12796.872031279569, 12804.61586152417, 12930.741385172056, 8912.242459390765, 9004.0, 9086.182243597843, 9093.909060909305, 9116.954415227881, 10169.542370593193, 10181.440020798631, 10293.43386113771, 10293.948530257301, 10298.17614590846, 8658.91341086581, 8746.562671866508, 8784.165504277084, 8933.374663773733, 9169.816603668023, 8998.820023599623, 9176.587053582738, 9177.08229177077, 9306.534673266175, 9390.389624674373, 8233.83532329362, 8364.790880228044, 8373.33013358942, 8373.455725377831, 8376.53929033909, 6275.592086514362, 6277.591956522811, 6369.267534233622, 6385.29761726219, 6425.775097871552, 6504.642244676588, 6519.185101862267, 6581.0, 6630.53586248958, 6678.3989440950545], "value": 5332.21216996816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.53221496956047, 416.07838637418115, 429.42671533502755, 438.98902527436815, 442.23493356493265, 5261.8421447356595, 5336.30628018357, 5348.3152806865855, 5389.191621256813, 5415.485528874756, 5121.743912804363, 5139.306193663863, 5150.1759718445055, 5195.662281951671, 5226.2944502492155, 4425.982024134451, 4435.713643043514, 4437.489688685794, 4460.30865215892, 4490.528494508078, 4480.395146655193, 4488.371627972087, 4491.505934347236, 4498.730076195438, 4535.954640453603, 4242.618164365206, 4407.0, 4412.3602077698715, 4437.6671749618745, 4450.777461126947, 4410.86767396977, 4417.823287068513, 4422.059330545184, 4432.20220360335, 4434.290513517822, 4204.663626909871, 4229.0, 4232.513260974996, 4256.851010214658, 4263.914721705549, 4931.0, 5076.746162691888, 5081.28861959326, 5096.439391666913, 5199.740012999373, 5046.596272298208, 5068.175456835536, 5085.0, 5094.6433749637545, 5101.285819985205, 5529.585281103933, 5540.899734196706, 5560.582956278296, 5568.860778480571, 5602.355729091166, 4367.039251364695, 4571.1771881061395, 4573.954260457386, 4575.679702420832, 4614.661748093049, 5502.706863886983, 5538.889222215533, 5621.634593751393, 5728.79949201776, 5752.626079304831, 4637.536246375335, 4640.86077417678, 4651.581357677757, 4656.278276867091, 4677.456439374998, 4625.32932724753, 4691.217337411762, 4716.882077948078, 4744.501827308152, 4747.216709243005, 5040.445550989388, 5049.82325618609, 5080.974595127001, 5140.198591767496, 5140.537351638371, 5522.585806064561, 5535.861603459945, 5537.944620553743, 5543.867714741158, 5575.494616453616, 1597.9280932358072, 1645.5556999610037, 1647.3328302037694, 1675.7067513185143, 1683.7053515634716, 1241.9813702794465, 1272.7781329923378, 1273.8853503184573, 1286.8032729561598, 1301.7526669932872, 5319.117044557417, 5352.946470535245, 5404.405700318415, 5451.182322651554, 5455.61810673257, 5639.351474580476, 5641.617803638135, 5647.774089036475, 5659.887062115902, 5677.77288908439, 5258.526732594085, 5394.651337165708, 5485.4788795064405, 5497.202905578669, 5501.092319767194, 2946.543285790706, 2950.6574508598537, 2962.4667559839004, 2979.940401191964, 2992.521196608576, 5501.679596896796, 5813.476787089182, 5828.504577110908, 5874.296454028369, 5974.699740599814, 5739.298152691491, 5782.277215348082, 5784.3926387729525, 5811.244538210006, 5837.241158649348, 5742.971285143548, 5801.3328467225965, 5871.4715675589405, 5873.970630146822, 5894.646321220741, 5368.0, 5558.555315574825, 5595.63628364155, 5727.5417966561745, 5749.9712501437225, 5457.481539253765, 5509.173623956439, 5535.474129957647, 5694.0, 5697.857553561194, 5911.733971971185, 5920.684416726647, 5963.254593175853, 5965.343812180743, 6052.788152414821, 4527.479339875957, 4667.669714131456, 4675.672702910763, 4710.0, 4725.834595789131, 5639.605227634191, 5656.5757568181725, 5660.122680984454, 5671.801486947937, 5673.290838645169, 5497.340319161726, 5512.283403157564, 5526.45259327389, 5544.08935308966, 5615.775368985195, 5327.760250788801, 5446.836594902159, 5553.916691249715, 5557.638753481011, 5572.554195664418, 5458.699771512605, 5533.253010843646, 5563.527100196528, 5596.776128954796, 5741.5406767459335, 5331.306930099062, 5566.4990150886615, 5569.303837020372, 5600.85997850057, 5705.400932902152, 5381.919271210857, 5424.755885985219, 5468.808591699271, 5470.288862447856, 5497.47773961473], "value": 4453.147726969962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.617801256453, 880.5729221327655, 897.7261935109793, 924.4284715982828, 929.6932012435901, 16447.177641117956, 18207.18067686954, 18633.440996770103, 19252.807471925276, 19533.0, 17435.21541530631, 18393.54016149597, 19217.711734323995, 19377.90311048446, 19381.0, 873.6025108575583, 898.2095755734961, 904.6607522179182, 905.7871400220943, 906.1618003346911, 888.205056474455, 895.6283142495856, 896.8520194167954, 903.4850135422812, 903.9141281578239, 944.834653935562, 945.5225111318808, 946.0586716217373, 946.8627049077879, 947.3321308477541, 943.235978857121, 943.9622415103388, 944.5418971798672, 944.551338114397, 944.6740874398356, 692.0518889121935, 692.4979389942301, 697.15992229364, 698.1622053535777, 698.1970733656285, 18443.907780461013, 18472.168752406174, 18736.812631873643, 18943.052847357576, 19143.0, 14858.0, 15094.698106037928, 15118.168500732456, 15349.07905525672, 15513.612159696098, 13188.934055329662, 13667.521636742666, 13717.45130194791, 13799.86200138006, 13970.231637259947, 3757.0, 3764.5482542095124, 3792.0709426190483, 3850.9614903850884, 4009.7594144351433, 53717.731411343084, 55092.72453637706, 55277.0, 71141.0, 79329.20670793334, 13076.869231307755, 13152.40814163365, 13163.53927612529, 13203.207807531579, 13596.660083497794, 21037.0, 21714.89142554277, 22807.0, 22927.312180634606, 23179.420514486934, 8918.375713700108, 9237.676681316256, 9272.536373181314, 9295.209907157832, 9304.674336398193, 4920.6801557898625, 4957.3307603473795, 4965.627577931597, 5174.818881339135, 5300.522952934178, 3568.7323450741296, 3632.1282892106233, 3676.209614932802, 3676.522052133259, 3693.8707145250323, 606.1090197409801, 612.2989177391861, 612.586504109733, 625.9248890133122, 626.5426238845669, 839.6767244610869, 848.1306660672859, 851.3359579527978, 851.4933614499363, 861.763015170833, 10719.785604288027, 11453.19827612059, 11815.113866459878, 11944.64166075019, 12206.816897746541, 803.5580430763057, 814.8777683347427, 822.3051521464473, 827.1769589258726, 840.8276303357796, 5226.973865130726, 5304.443033481506, 5310.123829568155, 5379.246905433164, 5393.13709806437, 80813.59593202114, 81313.59343203246, 81614.18385816185, 82528.0, 83636.0, 53425.46574534205, 63754.0, 64904.35095649077, 65006.34993650098, 71998.64000679963, 56916.0, 57646.423535764945, 58870.0, 60109.39890601126, 62516.68741656263, 11231.18121387717, 12248.265104093784, 12324.815127772912, 12361.93819030899, 12678.746425071631, 43948.26439752657, 44345.0, 44939.55060449484, 45106.77446612746, 45486.317705233785, 51854.48145518496, 51915.0, 51951.740241298554, 52494.0, 53941.730291349864, 14863.628409289855, 15292.923535382697, 15322.540323790305, 15539.844601554292, 15910.0, 16447.588810279838, 16696.83303166953, 16763.1618419081, 16943.0, 17061.658766824345, 15845.445409411077, 15846.68306633884, 16082.35670573164, 16327.510174694778, 16539.66920661556, 15123.697526049638, 15257.160856153017, 15657.843421565638, 15705.371785128924, 16210.918945405198, 15229.314680839167, 15313.310901009705, 15454.381824727334, 16650.50048498547, 16747.497575072768, 10800.492426696628, 10880.45597720095, 11156.553737850396, 11162.832557511807, 11382.715432114263, 11900.04799616046, 12231.30306826544, 12330.938345308576, 12346.259224446561, 12419.130660853654], "value": 7938.116327234007, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 115.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 118.0, 167.0, 118.0, 122.0, 115.0, 117.0, 143.0, 116.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 110.0, 76.0, 75.0, 77.0, 76.0, 97.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 109.0, 83.0, 83.0, 84.0, 100.0, 82.0, 83.0, 113.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.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": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 65.0, 55.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 79.0, 84.0, 84.0, 78.0, 76.0, 81.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 121.0, 121.0, 126.0, 127.0, 119.0, 156.0, 127.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 168.0, 160.0, 158.0, 160.0, 159.0, 159.0, 158.0, 156.0, 157.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 61.0, 62.0], "value": 60.2, "unit": "score"}]}]} 20:34:45 INFO - Return code: 0 20:34:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:34:45 ERROR - # TBPL SUCCESS # 20:34:45 INFO - Running post-action listener: _resource_record_post_action 20:34:45 INFO - [mozharness: 2017-04-14 03:34:45.310641Z] Finished run-tests step (success) 20:34:45 INFO - Running post-run listener: _resource_record_post_run 20:34:45 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7606272; Write bytes: 366067712; Read time: 1248; Write time: 312172 20:34:45 INFO - TinderboxPrint: CPU usage
13.1% 20:34:45 INFO - TinderboxPrint: I/O read bytes / time
7,606,272 / 1,248 20:34:45 INFO - TinderboxPrint: I/O write bytes / time
366,067,712 / 312,172 20:34:45 INFO - TinderboxPrint: CPU idle
8,283.2 (86.8%) 20:34:45 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 20:34:45 INFO - TinderboxPrint: Swap in / out
0 / 0 20:34:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110952448; Read time: 0; Write time: 106868 20:34:45 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5861376; Write bytes: 255115264; Read time: 1184; Write time: 205304 20:34:45 INFO - Running post-run listener: _upload_blobber_files 20:34:45 INFO - Blob upload gear active. 20:34:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:34:45 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 20:34:45 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'] 20:34:45 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 20:34:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:47 INFO - (blobuploader) - INFO - Done attempting. 20:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:47 INFO - (blobuploader) - INFO - Done attempting. 20:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:48 INFO - (blobuploader) - INFO - Done attempting. 20:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:51 INFO - (blobuploader) - INFO - Done attempting. 20:34:51 INFO - (blobuploader) - INFO - Iteration through files over. 20:34:51 INFO - Return code: 0 20:34:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:34:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:34:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa4330c8690e2f30d849cceb4a26d688bd36fb313ecf9d985af18e142867bae1a04494474fb5416d4d97ccff39ae4bcfc7651995a16f63af42506ed54c65f4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/98ffc69df7db824b0ab88086beb2dfcd86768122375b5a452ec6f826966081e69174ce04588fae2aded38e0f10a0a3396b57c9b4f2441f544cfba1cd2bd65227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bf22ded95e0de8e3bc05e8f809aedd1435802a883a20dafc120a8cb1b379e29d076329e186b6fcbfd7b21887e333392e8b1bc056999ce18fb70269d4abd9cc18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cf5bbcccbc97d86ca3e9e9251ef739c93d0c71c5b7441a87a28d5221190e2e900ce553ff52c535f11f7b61695847949ac9318a450f4d6626a83df3c14b3947f4"} 20:34:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:34:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:34:51 INFO - Contents: 20:34:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa4330c8690e2f30d849cceb4a26d688bd36fb313ecf9d985af18e142867bae1a04494474fb5416d4d97ccff39ae4bcfc7651995a16f63af42506ed54c65f4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/98ffc69df7db824b0ab88086beb2dfcd86768122375b5a452ec6f826966081e69174ce04588fae2aded38e0f10a0a3396b57c9b4f2441f544cfba1cd2bd65227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bf22ded95e0de8e3bc05e8f809aedd1435802a883a20dafc120a8cb1b379e29d076329e186b6fcbfd7b21887e333392e8b1bc056999ce18fb70269d4abd9cc18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cf5bbcccbc97d86ca3e9e9251ef739c93d0c71c5b7441a87a28d5221190e2e900ce553ff52c535f11f7b61695847949ac9318a450f4d6626a83df3c14b3947f4"} 20:34:51 INFO - Running post-run listener: copy_logs_to_upload_dir 20:34:51 INFO - Copying logs to upload dir... 20:34:51 INFO - mkdir: /builds/slave/test/build/upload/logs 20:34:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.444932 ========= master_lag: -0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-13 20:34:51.819242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 20:34:51.822581) ========= 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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa4330c8690e2f30d849cceb4a26d688bd36fb313ecf9d985af18e142867bae1a04494474fb5416d4d97ccff39ae4bcfc7651995a16f63af42506ed54c65f4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/98ffc69df7db824b0ab88086beb2dfcd86768122375b5a452ec6f826966081e69174ce04588fae2aded38e0f10a0a3396b57c9b4f2441f544cfba1cd2bd65227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bf22ded95e0de8e3bc05e8f809aedd1435802a883a20dafc120a8cb1b379e29d076329e186b6fcbfd7b21887e333392e8b1bc056999ce18fb70269d4abd9cc18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cf5bbcccbc97d86ca3e9e9251ef739c93d0c71c5b7441a87a28d5221190e2e900ce553ff52c535f11f7b61695847949ac9318a450f4d6626a83df3c14b3947f4"} build_url:https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/GQuYpU6JQ3GDJ7dEKuaJQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa4330c8690e2f30d849cceb4a26d688bd36fb313ecf9d985af18e142867bae1a04494474fb5416d4d97ccff39ae4bcfc7651995a16f63af42506ed54c65f4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/98ffc69df7db824b0ab88086beb2dfcd86768122375b5a452ec6f826966081e69174ce04588fae2aded38e0f10a0a3396b57c9b4f2441f544cfba1cd2bd65227", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bf22ded95e0de8e3bc05e8f809aedd1435802a883a20dafc120a8cb1b379e29d076329e186b6fcbfd7b21887e333392e8b1bc056999ce18fb70269d4abd9cc18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cf5bbcccbc97d86ca3e9e9251ef739c93d0c71c5b7441a87a28d5221190e2e900ce553ff52c535f11f7b61695847949ac9318a450f4d6626a83df3c14b3947f4"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 20:34:51.888127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:34:51.888499) ========= 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=652eb03db935cfc1c15ebda0000001ad-1492139631.206715-1399132018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 20:34:51.905463) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 20:34:51.905800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 20:34:51.906121) ========= ========= Total master_lag: -0.18 =========