builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1463106485.16 results: success (0) buildid: 20160512164135 builduid: eeb75bc655234fba80413feef7b75f7e revision: 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.162013) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.162826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.163149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.187572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.188400) ========= 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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 19:28:05-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.4M=0s 2016-05-12 19:28:05 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201983 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.424039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.424377) ========= 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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.114213 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.566848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:05.567206) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 --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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 19:28:05,780 truncating revision to first 12 chars 2016-05-12 19:28:05,780 Setting DEBUG logging. 2016-05-12 19:28:05,780 attempt 1/10 2016-05-12 19:28:05,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/20fb337ac107?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 19:28:06,097 unpacking tar archive at: mozilla-aurora-20fb337ac107/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:06.216326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:06.216658) ========= script_repo_revision: 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:06.217158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:06.217511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 19:28:06.228876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-12 19:28:06.229226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:28:06 INFO - MultiFileLogger online at 20160512 19:28:06 in /builds/slave/test 19:28:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:28:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:28:06 INFO - {'append_to_log': False, 19:28:06 INFO - 'base_work_dir': '/builds/slave/test', 19:28:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:28:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:28:06 INFO - 'branch': 'Mozilla-Aurora', 19:28:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:28:06 INFO - 'config_files': ('talos/linux_config.py',), 19:28:06 INFO - 'default_actions': ('clobber', 19:28:06 INFO - 'read-buildbot-config', 19:28:06 INFO - 'download-and-extract', 19:28:06 INFO - 'populate-webroot', 19:28:06 INFO - 'create-virtualenv', 19:28:06 INFO - 'install', 19:28:06 INFO - 'run-tests'), 19:28:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:28:06 INFO - 'download_minidump_stackwalk': True, 19:28:06 INFO - 'download_symbols': 'ondemand', 19:28:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:28:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:28:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:28:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:28:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:28:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:28:06 INFO - 'installer_path': 'installer.exe', 19:28:06 INFO - 'log_level': 'info', 19:28:06 INFO - 'log_name': 'talos', 19:28:06 INFO - 'log_to_console': True, 19:28:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:28:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:28:06 INFO - 'opt_config_files': (), 19:28:06 INFO - 'pip_index': False, 19:28:06 INFO - 'sps_profile': False, 19:28:06 INFO - 'sps_profile_interval': 0, 19:28:06 INFO - 'suite': 'dromaeojs-e10s', 19:28:06 INFO - 'system_bits': '32', 19:28:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:28:06 INFO - 'title': 'talos-linux64-ix-056', 19:28:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:28:06 INFO - 'use_talos_json': True, 19:28:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:28:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:28:06 INFO - 'work_dir': 'build'} 19:28:06 INFO - ##### 19:28:06 INFO - ##### Running clobber step. 19:28:06 INFO - ##### 19:28:06 INFO - Running pre-action listener: _resource_record_pre_action 19:28:06 INFO - Running main action method: clobber 19:28:06 INFO - rmtree: /builds/slave/test/build 19:28:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:28:08 INFO - Running post-action listener: _resource_record_post_action 19:28:08 INFO - ##### 19:28:08 INFO - ##### Running read-buildbot-config step. 19:28:08 INFO - ##### 19:28:08 INFO - Running pre-action listener: _resource_record_pre_action 19:28:08 INFO - Running main action method: read_buildbot_config 19:28:08 INFO - Using buildbot properties: 19:28:08 INFO - { 19:28:08 INFO - "project": "", 19:28:08 INFO - "product": "firefox", 19:28:08 INFO - "script_repo_revision": "production", 19:28:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:28:08 INFO - "repository": "", 19:28:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:28:08 INFO - "buildid": "20160512164135", 19:28:08 INFO - "pgo_build": "True", 19:28:08 INFO - "basedir": "/builds/slave/test", 19:28:08 INFO - "buildnumber": 265, 19:28:08 INFO - "slavename": "talos-linux64-ix-056", 19:28:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:28:08 INFO - "platform": "ubuntu64_hw", 19:28:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:28:08 INFO - "branch": "mozilla-aurora", 19:28:08 INFO - "repo_path": "releases/mozilla-aurora", 19:28:08 INFO - "revision": "20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6", 19:28:08 INFO - "stage_platform": "linux64-pgo", 19:28:08 INFO - "builduid": "eeb75bc655234fba80413feef7b75f7e", 19:28:08 INFO - "slavebuilddir": "test" 19:28:08 INFO - } 19:28:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:28:08 INFO - Running post-action listener: _resource_record_post_action 19:28:08 INFO - ##### 19:28:08 INFO - ##### Running download-and-extract step. 19:28:08 INFO - ##### 19:28:08 INFO - Running pre-action listener: _resource_record_pre_action 19:28:08 INFO - Running main action method: download_and_extract 19:28:08 INFO - mkdir: /builds/slave/test/build/tests 19:28:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:08 INFO - https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:28:13 INFO - Downloaded 1361 bytes. 19:28:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:28:13 INFO - Using the following test package requirements: 19:28:13 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:28:13 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:28:13 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:28:13 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'jsshell-linux-x86_64.zip'], 19:28:13 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:28:13 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:28:13 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:28:13 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:28:13 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:28:13 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:28:13 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:28:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:28:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:13 INFO - https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:28:16 INFO - Downloaded 23799387 bytes. 19:28:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:28:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:28:17 INFO - Return code: 0 19:28:17 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:28:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:17 INFO - https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:28:25 INFO - Downloaded 23799387 bytes. 19:28:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:28:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:28:27 INFO - Return code: 0 19:28:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:27 INFO - https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:28:28 INFO - Downloaded 10840145 bytes. 19:28:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:28:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:28:28 INFO - Return code: 0 19:28: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:28 INFO - https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:28:30 INFO - Downloaded 62688181 bytes. 19:28:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:28:30 INFO - mkdir: /builds/slave/test/properties 19:28:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:28:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:28:30 INFO - Contents: 19:28:30 INFO - build_url:https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:28:30 INFO - Running post-action listener: _resource_record_post_action 19:28:30 INFO - Running post-action listener: set_extra_try_arguments 19:28:30 INFO - ##### 19:28:30 INFO - ##### Running populate-webroot step. 19:28:30 INFO - ##### 19:28:30 INFO - Running pre-action listener: _resource_record_pre_action 19:28:30 INFO - Running main action method: populate_webroot 19:28:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:28:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:28:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:28:30 INFO - '--tppagecycles', 19:28:30 INFO - '7'], 19:28:30 INFO - 'tests': ['tsvgm']}}, 19:28:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:28:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:28:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:28:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:28:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['damp', 'tps']}, 19:28:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'tests': ['damp', 'tps']}, 19:28:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['dromaeo_dom']}, 19:28:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:28:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['a11yr', 19:28:30 INFO - 'ts_paint', 19:28:30 INFO - 'tpaint', 19:28:30 INFO - 'sessionrestore', 19:28:30 INFO - 'sessionrestore_no_auto_restore', 19:28:30 INFO - 'tabpaint']}, 19:28:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['tsvgx', 19:28:30 INFO - 'tsvgr_opacity', 19:28:30 INFO - 'tart', 19:28:30 INFO - 'tscrollx', 19:28:30 INFO - 'cart']}, 19:28:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:28:30 INFO - 'tsvgr_opacity', 19:28:30 INFO - 'tart', 19:28:30 INFO - 'tscrollx', 19:28:30 INFO - 'cart']}, 19:28:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'talos_options': ['--disable-e10s'], 19:28:30 INFO - 'tests': ['tp5o']}, 19:28:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'tests': ['tp5o']}, 19:28:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'talos_options': ['--disable-e10s', 19:28:30 INFO - '--xperf_path', 19:28:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:30 INFO - 'tests': ['tp5n']}, 19:28:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:28:30 INFO - 'talos_options': ['--xperf_path', 19:28:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:30 INFO - 'tests': ['tp5n']}}, 19:28:30 INFO - 'talos.zip': {'path': '', 19:28:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:28:30 INFO - Running post-action listener: _resource_record_post_action 19:28:30 INFO - ##### 19:28:30 INFO - ##### Running create-virtualenv step. 19:28:30 INFO - ##### 19:28:30 INFO - Running pre-action listener: _resource_record_pre_action 19:28:30 INFO - Running main action method: create_virtualenv 19:28:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:28:30 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 19:28:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:28:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:28:31 INFO - Using real prefix '/usr' 19:28:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:28:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:28:34 INFO - Installing pip.................done. 19:28:34 INFO - Return code: 0 19:28:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:28:34 INFO - Using env: {'DISPLAY': ':0', 19:28:34 INFO - 'HOME': '/home/cltbld', 19:28:34 INFO - 'LANG': 'en_US.UTF-8', 19:28:34 INFO - 'LANGUAGE': 'en_US:en', 19:28:34 INFO - 'LOGNAME': 'cltbld', 19:28:34 INFO - 'MAIL': '/var/mail/cltbld', 19:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:34 INFO - 'MOZ_NO_REMOTE': '1', 19:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:34 INFO - 'NO_EM_RESTART': '1', 19:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:34 INFO - 'PWD': '/builds/slave/test', 19:28:34 INFO - 'SHELL': '/bin/bash', 19:28:34 INFO - 'SHLVL': '1', 19:28:34 INFO - 'TERM': 'linux', 19:28:34 INFO - 'TMOUT': '86400', 19:28:34 INFO - 'USER': 'cltbld', 19:28:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:34 INFO - '_': '/tools/buildbot/bin/python'} 19:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:28:34 INFO - Cleaning up... 19:28:34 INFO - Return code: 0 19:28:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:28:34 INFO - Using env: {'DISPLAY': ':0', 19:28:34 INFO - 'HOME': '/home/cltbld', 19:28:34 INFO - 'LANG': 'en_US.UTF-8', 19:28:34 INFO - 'LANGUAGE': 'en_US:en', 19:28:34 INFO - 'LOGNAME': 'cltbld', 19:28:34 INFO - 'MAIL': '/var/mail/cltbld', 19:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:34 INFO - 'MOZ_NO_REMOTE': '1', 19:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:34 INFO - 'NO_EM_RESTART': '1', 19:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:34 INFO - 'PWD': '/builds/slave/test', 19:28:34 INFO - 'SHELL': '/bin/bash', 19:28:34 INFO - 'SHLVL': '1', 19:28:34 INFO - 'TERM': 'linux', 19:28:34 INFO - 'TMOUT': '86400', 19:28:34 INFO - 'USER': 'cltbld', 19:28:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:34 INFO - '_': '/tools/buildbot/bin/python'} 19:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:35 INFO - Downloading/unpacking psutil>=0.7.1 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:28:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:37 INFO - Installing collected packages: psutil 19:28:37 INFO - Running setup.py install for psutil 19:28:37 INFO - building 'psutil._psutil_linux' extension 19:28:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:28:39 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 19:28:40 INFO - building 'psutil._psutil_posix' extension 19:28:40 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 19:28:40 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 19:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:40 INFO - Successfully installed psutil 19:28:40 INFO - Cleaning up... 19:28:40 INFO - Return code: 0 19:28:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:28:40 INFO - Using env: {'DISPLAY': ':0', 19:28:40 INFO - 'HOME': '/home/cltbld', 19:28:40 INFO - 'LANG': 'en_US.UTF-8', 19:28:40 INFO - 'LANGUAGE': 'en_US:en', 19:28:40 INFO - 'LOGNAME': 'cltbld', 19:28:40 INFO - 'MAIL': '/var/mail/cltbld', 19:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:40 INFO - 'MOZ_NO_REMOTE': '1', 19:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:40 INFO - 'NO_EM_RESTART': '1', 19:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:40 INFO - 'PWD': '/builds/slave/test', 19:28:40 INFO - 'SHELL': '/bin/bash', 19:28:40 INFO - 'SHLVL': '1', 19:28:40 INFO - 'TERM': 'linux', 19:28:40 INFO - 'TMOUT': '86400', 19:28:40 INFO - 'USER': 'cltbld', 19:28:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:40 INFO - '_': '/tools/buildbot/bin/python'} 19:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:28:42 INFO - Installing collected packages: mozsystemmonitor 19:28:42 INFO - Running setup.py install for mozsystemmonitor 19:28:42 INFO - Successfully installed mozsystemmonitor 19:28:42 INFO - Cleaning up... 19:28:43 INFO - Return code: 0 19:28:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:28:43 INFO - Using env: {'DISPLAY': ':0', 19:28:43 INFO - 'HOME': '/home/cltbld', 19:28:43 INFO - 'LANG': 'en_US.UTF-8', 19:28:43 INFO - 'LANGUAGE': 'en_US:en', 19:28:43 INFO - 'LOGNAME': 'cltbld', 19:28:43 INFO - 'MAIL': '/var/mail/cltbld', 19:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:43 INFO - 'MOZ_NO_REMOTE': '1', 19:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:43 INFO - 'NO_EM_RESTART': '1', 19:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:43 INFO - 'PWD': '/builds/slave/test', 19:28:43 INFO - 'SHELL': '/bin/bash', 19:28:43 INFO - 'SHLVL': '1', 19:28:43 INFO - 'TERM': 'linux', 19:28:43 INFO - 'TMOUT': '86400', 19:28:43 INFO - 'USER': 'cltbld', 19:28:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:43 INFO - '_': '/tools/buildbot/bin/python'} 19:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:43 INFO - Downloading/unpacking blobuploader==1.2.4 19:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:45 INFO - Downloading blobuploader-1.2.4.tar.gz 19:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:45 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 19:28:45 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 19:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:45 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 19:28:45 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 19:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:45 INFO - Downloading docopt-0.6.1.tar.gz 19:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:28:45 INFO - Installing collected packages: blobuploader, requests, docopt 19:28:45 INFO - Running setup.py install for blobuploader 19:28:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:28:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:28:46 INFO - Running setup.py install for requests 19:28:46 INFO - Running setup.py install for docopt 19:28:46 INFO - Successfully installed blobuploader requests docopt 19:28:46 INFO - Cleaning up... 19:28:46 INFO - Return code: 0 19:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:46 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 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:46 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 19:28:46 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 19:28:46 INFO - Using env: {'DISPLAY': ':0', 19:28:46 INFO - 'HOME': '/home/cltbld', 19:28:46 INFO - 'LANG': 'en_US.UTF-8', 19:28:46 INFO - 'LANGUAGE': 'en_US:en', 19:28:46 INFO - 'LOGNAME': 'cltbld', 19:28:46 INFO - 'MAIL': '/var/mail/cltbld', 19:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:46 INFO - 'MOZ_NO_REMOTE': '1', 19:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:46 INFO - 'NO_EM_RESTART': '1', 19:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:46 INFO - 'PWD': '/builds/slave/test', 19:28:46 INFO - 'SHELL': '/bin/bash', 19:28:46 INFO - 'SHLVL': '1', 19:28:46 INFO - 'TERM': 'linux', 19:28:46 INFO - 'TMOUT': '86400', 19:28:46 INFO - 'USER': 'cltbld', 19:28:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:46 INFO - '_': '/tools/buildbot/bin/python'} 19:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:46 INFO - Running setup.py (path:/tmp/pip-dlyS8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:46 INFO - Running setup.py (path:/tmp/pip-EMju8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:46 INFO - Running setup.py (path:/tmp/pip-v2rdWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:46 INFO - Running setup.py (path:/tmp/pip-tV1LjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:47 INFO - Running setup.py (path:/tmp/pip-WrqgOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:47 INFO - Running setup.py (path:/tmp/pip-jl8XlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:47 INFO - Running setup.py (path:/tmp/pip-TJmxHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:47 INFO - Running setup.py (path:/tmp/pip-jrwS_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:47 INFO - Running setup.py (path:/tmp/pip-ICEYY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:47 INFO - Running setup.py (path:/tmp/pip-vyv8Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:47 INFO - Running setup.py (path:/tmp/pip-AkUxW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:47 INFO - Running setup.py (path:/tmp/pip-fZxkNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:47 INFO - Running setup.py (path:/tmp/pip-Y8BuKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:47 INFO - Running setup.py (path:/tmp/pip-9ocmwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:47 INFO - Running setup.py (path:/tmp/pip-lfvCoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:47 INFO - Running setup.py (path:/tmp/pip-6rxETh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:47 INFO - Running setup.py (path:/tmp/pip-rp3uju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:28:47 INFO - Running setup.py install for manifestparser 19:28:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Running setup.py install for mozcrash 19:28:48 INFO - Running setup.py install for mozdebug 19:28:48 INFO - Running setup.py install for mozdevice 19:28:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Running setup.py install for mozfile 19:28:48 INFO - Running setup.py install for mozhttpd 19:28:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Running setup.py install for mozinfo 19:28:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Running setup.py install for mozInstall 19:28:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:28:48 INFO - Running setup.py install for mozleak 19:28:48 INFO - Running setup.py install for mozlog 19:28:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Running setup.py install for moznetwork 19:28:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Running setup.py install for mozprocess 19:28:49 INFO - Running setup.py install for mozprofile 19:28:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Running setup.py install for mozrunner 19:28:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Running setup.py install for mozscreenshot 19:28:49 INFO - Running setup.py install for moztest 19:28:49 INFO - Running setup.py install for mozversion 19:28:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:28:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:28:49 INFO - Cleaning up... 19:28:49 INFO - Return code: 0 19:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:49 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 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:49 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 19:28:49 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 19:28:49 INFO - Using env: {'DISPLAY': ':0', 19:28:49 INFO - 'HOME': '/home/cltbld', 19:28:49 INFO - 'LANG': 'en_US.UTF-8', 19:28:49 INFO - 'LANGUAGE': 'en_US:en', 19:28:49 INFO - 'LOGNAME': 'cltbld', 19:28:49 INFO - 'MAIL': '/var/mail/cltbld', 19:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:49 INFO - 'MOZ_NO_REMOTE': '1', 19:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:49 INFO - 'NO_EM_RESTART': '1', 19:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:49 INFO - 'PWD': '/builds/slave/test', 19:28:49 INFO - 'SHELL': '/bin/bash', 19:28:49 INFO - 'SHLVL': '1', 19:28:49 INFO - 'TERM': 'linux', 19:28:49 INFO - 'TMOUT': '86400', 19:28:49 INFO - 'USER': 'cltbld', 19:28:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:49 INFO - '_': '/tools/buildbot/bin/python'} 19:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:50 INFO - Running setup.py (path:/tmp/pip-9xXir3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:50 INFO - Running setup.py (path:/tmp/pip-texzje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:50 INFO - Running setup.py (path:/tmp/pip-QuorAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:50 INFO - Running setup.py (path:/tmp/pip-82lT8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:50 INFO - Running setup.py (path:/tmp/pip-5mdpe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:50 INFO - Running setup.py (path:/tmp/pip-OIjMoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:50 INFO - Running setup.py (path:/tmp/pip-D9N8jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:50 INFO - Running setup.py (path:/tmp/pip-Q6haQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:50 INFO - Running setup.py (path:/tmp/pip-eImNnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:50 INFO - Running setup.py (path:/tmp/pip-MJXubH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:50 INFO - Running setup.py (path:/tmp/pip-xH70Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:50 INFO - Running setup.py (path:/tmp/pip-shEtOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:50 INFO - Running setup.py (path:/tmp/pip-ewVXTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:50 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)) 19:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:50 INFO - Running setup.py (path:/tmp/pip-yFLum9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 19:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:51 INFO - Running setup.py (path:/tmp/pip-p1TuuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:51 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)) 19:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:51 INFO - Running setup.py (path:/tmp/pip-tgE0KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 19:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:51 INFO - Running setup.py (path:/tmp/pip-xq1oDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:51 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)) 19:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:28:51 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)) 19:28:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:28:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:28:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:51 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 19:28:51 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 19:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:53 INFO - Downloading blessings-1.6.tar.gz 19:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:28:53 INFO - Installing collected packages: blessings 19:28:53 INFO - Running setup.py install for blessings 19:28:53 INFO - Successfully installed blessings 19:28:53 INFO - Cleaning up... 19:28:53 INFO - Return code: 0 19:28:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:28:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:53 INFO - Reading from file tmpfile_stdout 19:28:53 INFO - Current package versions: 19:28:53 INFO - argparse == 1.2.1 19:28:53 INFO - blessings == 1.6 19:28:53 INFO - blobuploader == 1.2.4 19:28:53 INFO - docopt == 0.6.1 19:28:53 INFO - manifestparser == 1.1 19:28:53 INFO - mozInstall == 1.12 19:28:53 INFO - mozcrash == 0.17 19:28:53 INFO - mozdebug == 0.1 19:28:53 INFO - mozdevice == 0.48 19:28:53 INFO - mozfile == 1.2 19:28:53 INFO - mozhttpd == 0.7 19:28:53 INFO - mozinfo == 0.9 19:28:53 INFO - mozleak == 0.1 19:28:53 INFO - mozlog == 3.1 19:28:53 INFO - moznetwork == 0.27 19:28:53 INFO - mozprocess == 0.22 19:28:53 INFO - mozprofile == 0.28 19:28:53 INFO - mozrunner == 6.11 19:28:53 INFO - mozscreenshot == 0.1 19:28:53 INFO - mozsystemmonitor == 0.0 19:28:53 INFO - moztest == 0.7 19:28:53 INFO - mozversion == 1.4 19:28:53 INFO - psutil == 3.1.1 19:28:53 INFO - requests == 1.2.3 19:28:53 INFO - wsgiref == 0.1.2 19:28:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:53 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 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:53 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 19:28:53 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 19:28:53 INFO - Using env: {'DISPLAY': ':0', 19:28:53 INFO - 'HOME': '/home/cltbld', 19:28:53 INFO - 'LANG': 'en_US.UTF-8', 19:28:53 INFO - 'LANGUAGE': 'en_US:en', 19:28:53 INFO - 'LOGNAME': 'cltbld', 19:28:53 INFO - 'MAIL': '/var/mail/cltbld', 19:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:53 INFO - 'MOZ_NO_REMOTE': '1', 19:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:53 INFO - 'NO_EM_RESTART': '1', 19:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:53 INFO - 'PWD': '/builds/slave/test', 19:28:53 INFO - 'SHELL': '/bin/bash', 19:28:53 INFO - 'SHLVL': '1', 19:28:53 INFO - 'TERM': 'linux', 19:28:53 INFO - 'TMOUT': '86400', 19:28:53 INFO - 'USER': 'cltbld', 19:28:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:53 INFO - '_': '/tools/buildbot/bin/python'} 19:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 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)) 19:28:53 INFO - Cleaning up... 19:28:53 INFO - Return code: 0 19:28:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:28:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:53 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 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:53 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 19:28:53 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 19:28:53 INFO - Using env: {'DISPLAY': ':0', 19:28:53 INFO - 'HOME': '/home/cltbld', 19:28:53 INFO - 'LANG': 'en_US.UTF-8', 19:28:53 INFO - 'LANGUAGE': 'en_US:en', 19:28:53 INFO - 'LOGNAME': 'cltbld', 19:28:53 INFO - 'MAIL': '/var/mail/cltbld', 19:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:53 INFO - 'MOZ_NO_REMOTE': '1', 19:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:53 INFO - 'NO_EM_RESTART': '1', 19:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:53 INFO - 'PWD': '/builds/slave/test', 19:28:53 INFO - 'SHELL': '/bin/bash', 19:28:53 INFO - 'SHLVL': '1', 19:28:53 INFO - 'TERM': 'linux', 19:28:53 INFO - 'TMOUT': '86400', 19:28:53 INFO - 'USER': 'cltbld', 19:28:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:53 INFO - '_': '/tools/buildbot/bin/python'} 19:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:54 INFO - Downloading/unpacking jsonschema 19:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:54 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 19:28:54 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 19:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:28:55 INFO - Downloading/unpacking functools32 (from jsonschema) 19:28:55 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 19:28:55 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 19:28:55 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 19:28:55 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 19:28:55 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 19:28:55 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 19:28:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:28:56 INFO - warning: no files found matching '*.txt' 19:28:56 INFO - no previously-included directories found matching 'build' 19:28:56 INFO - no previously-included directories found matching 'dist' 19:28:56 INFO - no previously-included directories found matching '.git*' 19:28:56 INFO - Installing collected packages: jsonschema, functools32 19:28:56 INFO - Running setup.py install for functools32 19:28:56 INFO - warning: no files found matching '*.txt' 19:28:56 INFO - no previously-included directories found matching 'build' 19:28:56 INFO - no previously-included directories found matching 'dist' 19:28:56 INFO - no previously-included directories found matching '.git*' 19:28:56 INFO - Successfully installed jsonschema functools32 19:28:56 INFO - Cleaning up... 19:28:56 INFO - Return code: 0 19:28:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:28:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:56 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b7cf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe637d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, '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': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', '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 19:28:56 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', 'flake8'] in /builds/slave/test/build 19:28:56 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 flake8 19:28:56 INFO - Using env: {'DISPLAY': ':0', 19:28:56 INFO - 'HOME': '/home/cltbld', 19:28:56 INFO - 'LANG': 'en_US.UTF-8', 19:28:56 INFO - 'LANGUAGE': 'en_US:en', 19:28:56 INFO - 'LOGNAME': 'cltbld', 19:28:56 INFO - 'MAIL': '/var/mail/cltbld', 19:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:56 INFO - 'MOZ_NO_REMOTE': '1', 19:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:56 INFO - 'NO_EM_RESTART': '1', 19:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:56 INFO - 'PWD': '/builds/slave/test', 19:28:56 INFO - 'SHELL': '/bin/bash', 19:28:56 INFO - 'SHLVL': '1', 19:28:56 INFO - 'TERM': 'linux', 19:28:56 INFO - 'TMOUT': '86400', 19:28:56 INFO - 'USER': 'cltbld', 19:28:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:56 INFO - '_': '/tools/buildbot/bin/python'} 19:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:56 INFO - Downloading/unpacking flake8 19:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:56 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 19:28:56 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 19:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:28:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:28:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:58 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 19:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:28:59 INFO - no previously-included directories found matching 'docs/_build' 19:28:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:28:59 INFO - Running setup.py install for pep8 19:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:28:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:28:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:28:59 INFO - no previously-included directories found matching 'docs/_build' 19:28:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:28:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:28:59 INFO - Cleaning up... 19:28:59 INFO - Return code: 0 19:28:59 INFO - Running post-action listener: _resource_record_post_action 19:28:59 INFO - Running post-action listener: _start_resource_monitoring 19:28:59 INFO - Starting resource monitoring. 19:28:59 INFO - ##### 19:28:59 INFO - ##### Running install step. 19:28:59 INFO - ##### 19:28:59 INFO - Running pre-action listener: _resource_record_pre_action 19:28:59 INFO - Running main action method: install 19:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:59 INFO - Reading from file tmpfile_stdout 19:28:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:28:59 INFO - Reading from file tmpfile_stdout 19:28:59 INFO - Output received: 19:28:59 INFO - Usage: mozinstall [options] installer 19:28:59 INFO - Options: 19:28:59 INFO - -h, --help show this help message and exit 19:28:59 INFO - -d DEST, --destination=DEST 19:28:59 INFO - Directory to install application into. [default: 19:28:59 INFO - "/builds/slave/test"] 19:28:59 INFO - --app=APP Application being installed. [default: firefox] 19:28:59 INFO - mkdir: /builds/slave/test/build/application 19:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:29:15 INFO - Reading from file tmpfile_stdout 19:29:15 INFO - Output received: 19:29:15 INFO - /builds/slave/test/build/application/firefox/firefox 19:29:15 INFO - Running post-action listener: _resource_record_post_action 19:29:15 INFO - ##### 19:29:15 INFO - ##### Running run-tests step. 19:29:15 INFO - ##### 19:29:15 INFO - Running pre-action listener: _resource_record_pre_action 19:29:15 INFO - Running main action method: run_tests 19:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:29:15 INFO - Python 2.7.3 19:29:15 INFO - Return code: 0 19:29:15 INFO - grabbing minidump binary from tooltool 19:29:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:15 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef2640>, '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 0xef3540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef39d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:29:15 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 19:29:15 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 19:29:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:29:15 INFO - Return code: 0 19:29:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:29:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:29:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:29:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:29:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:29:16 INFO - Return code: 0 19:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:29:16 INFO - Using env: {'DISPLAY': ':0', 19:29:16 INFO - 'HOME': '/home/cltbld', 19:29:16 INFO - 'LANG': 'en_US.UTF-8', 19:29:16 INFO - 'LANGUAGE': 'en_US:en', 19:29:16 INFO - 'LOGNAME': 'cltbld', 19:29:16 INFO - 'MAIL': '/var/mail/cltbld', 19:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:16 INFO - 'MOZ_NO_REMOTE': '1', 19:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:29:16 INFO - 'NO_EM_RESTART': '1', 19:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:16 INFO - 'PWD': '/builds/slave/test', 19:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:29:16 INFO - 'SHELL': '/bin/bash', 19:29:16 INFO - 'SHLVL': '1', 19:29:16 INFO - 'TERM': 'linux', 19:29:16 INFO - 'TMOUT': '86400', 19:29:16 INFO - 'USER': 'cltbld', 19:29:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463100988.536791-73939675', 19:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:16 INFO - '_': '/tools/buildbot/bin/python'} 19:29:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:29:17 INFO - mozversion application_buildid: 20160512164135 19:29:17 INFO - mozversion application_changeset: 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 19:29:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:29:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:29:17 INFO - mozversion application_name: Firefox 19:29:17 INFO - mozversion application_remotingname: firefox-dev 19:29:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:29:17 INFO - mozversion application_vendor: Mozilla 19:29:17 INFO - mozversion application_version: 48.0a2 19:29:17 INFO - mozversion platform_buildid: 20160512164135 19:29:17 INFO - mozversion platform_changeset: 20fb337ac107d7a62fd0bff7ad4148c87cd1f9f6 19:29:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:29:17 INFO - mozversion platform_version: 48.0a2 19:29:17 INFO - using testdate: 1463106557 19:29:17 INFO - actual date: 1463106557 19:29:17 INFO - starting webserver on 'localhost:47090' 19:29:17 INFO - SUITE-START | Running 2 tests 19:29:17 INFO - TEST-START | dromaeo_css 19:29:17 INFO - operating with platform_type : linux_ 19:29:17 INFO - Initialising browser for dromaeo_css test... 19:29:17 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2uVoZ/profile http://localhost:47090/getInfo.html) 19:29:22 INFO - PROCESS | 3347 | 19:29:22 INFO - PROCESS | 3347 | (process:3426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:22 INFO - PROCESS | 3347 | __metrics Screen width/height:1600/1200 19:29:22 INFO - PROCESS | 3347 | colorDepth:24 19:29:22 INFO - PROCESS | 3347 | Browser inner width/height: 1024/697 19:29:22 INFO - PROCESS | 3347 | __metrics 19:29:23 ERROR - PROCESS | 3347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:29:24 INFO - TEST-INFO | 3347: exit 0 19:29:24 INFO - Browser initialized. 19:29:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:29:24 INFO - TEST-INFO | started process 3477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2uVoZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:26 INFO - PROCESS | 3477 | 19:29:26 INFO - PROCESS | 3477 | (process:3548): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:29:36 INFO - PROCESS | 3477 | RSS: Main: 151400448 19:29:36 INFO - PROCESS | 3477 | 19:30:25 INFO - PROCESS | 3477 | 1463106625917 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:32:33 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47090/tests/dromaeo/cssquery-ext.html) 19:32:34 INFO - PROCESS | 3477 | RSS: Main: 156450816 19:32:34 INFO - PROCESS | 3477 | 19:35:36 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-ext.html (next: http://localhost:47090/tests/dromaeo/cssquery-jquery.html) 19:35:36 INFO - PROCESS | 3477 | RSS: Main: 153620480 19:35:36 INFO - PROCESS | 3477 | 19:38:38 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47090/tests/dromaeo/cssquery-mootools.html) 19:38:39 INFO - PROCESS | 3477 | RSS: Main: 152932352 19:38:39 INFO - PROCESS | 3477 | 19:41:40 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47090/tests/dromaeo/cssquery-prototype.html) 19:41:41 INFO - PROCESS | 3477 | RSS: Main: 153440256 19:41:41 INFO - PROCESS | 3477 | 19:44:43 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47090/tests/dromaeo/cssquery-yui.html) 19:44:44 INFO - PROCESS | 3477 | RSS: Main: 154165248 19:44:44 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-yui.html (next: http://localhost:47090/tests/dromaeo/cssquery-dojo.html) 19:47:46 INFO - PROCESS | 3477 | RSS: Main: 156295168 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | __start_tp_report 19:47:46 INFO - PROCESS | 3477 | _x_x_mozilla_page_load 19:47:46 INFO - PROCESS | 3477 | _x_x_mozilla_page_load_details 19:47:46 INFO - PROCESS | 3477 | |i|pagename|runs| 19:47:46 INFO - PROCESS | 3477 | |0;dojo.html;3345.53162557242;3397.4054540455413;3408.6420925802804;3426.8862619648603;3452.326796274726;5588.86027849304;5643.746031428585;5648.491635752782;5656.688882111483;5725.398833122519;5658.519025882805;5658.688772117532;5660.660360378381;5668.064769313059;5677.403872593381;4993.825216117428;5073.289739436482;5105.821296254632;5127.589792816584;5185.948140518603;4970.602351811846;5013.523715247045;5067.163917953533;5077.669951453162;5198.8700282493055;5000.149974504325;5071.619628527875;5106.693598384109;5130.56390206831;5154.123798954168;5124.897502049976;5136.126858434057;5142.10013247682;5150.587952963754;5161.122609156452;4922.33548470959;4970.676906001098;5032.874178145539;5039.370078740158;5050.141475949097;5412.188171774265;5421.159720243369;5442.91835622466;5462.044142275086;5465.9180112298345;5963.344032156459;5967.1347654589845;5974.312954010301;5975.40245975399;5983.102534619842;5876.44173803488;6009.06859436788;6057.4245446682935;6073.817785466443;6139.416755408229;5458.263134476834;5496.31296087989;5518.33779946405;5527.060399732055;5532.059549876531;6007.849803754853;6018.548608854353;6022.668753218528;6042.637441753421;6046.153538504613;5843.3864444233595;5966;5975.492083172979;5995.130706047598;6023.186869772525;5945.10823376497;5985.910211346833;5988.401159884064;5990.31111422192;6002.579819412686;5890.9410905891245;5917.7928772493615;5935.436133567304;5941.7623295067715;5982.132590774313;6020.217371741645;6067.696615169224;6070.575059745775;6073.574849760563;6114.694265286718;4552.499225085238;4570.520095390003;4579.977100114478;4582.9541704582525;4601.079784043205;4087.0599762054894;4129.050318426718;4141.544430112685;4145.958540414617;4155.625993660585;5627.831165065055;5786.392428794916;5864.736086876101;5880.382559831241;5923.437273459014;6030.7889223876955;6052.364501727343;6060.636361818217;6063.120847477091;6066.241719785027;5696.060150075274;5787.160861675034;5808.564357673107;5878.088896221007;5911.054231322968;5170.095233334151;5170.844874653766;5180.222966555047;5195.428502864682;5204.141316682781;6254.34329395416;6262;6266.717997690115;6272.686365681698;6279.152314437584;5856.765729370863;5869.178315035983;5870.9412905870395;5986.012307969137;6124.969375153096;6269.96865015672;6278.497720182466;6288.874222515433;6290.370962903673;6306.684665766785;5919.437653422918;5957.255343082114;5961.4038596140035;5963.314218864886;5995.16067750524;5892.94107058924;6057.091436284592;6067.393260673897;6112.5946701277735;6115.938840611537;5969.8806023878415;5991.610545314541;6001.519878409804;6001.699915004145;6002.879942401215;5865.354810970704;5965.761369545343;5967.254093238345;5977.462028417463;5985.760569577343;5606.24315717373;5659.236003139524;5717.42825717425;5723.7424315905055;5744.425557444222;6002.039673652194;6006.699665016819;6008.188894499362;6038.245219347582;6041.305249896318;5569;5894.410558944071;5896.292444906639;5899.528037757055;5902.557308201816 19:47:46 INFO - PROCESS | 3477 | |1;ext.html;607.1378642327894;643.1895811277789;659.9407950239865;671.3454381977573;688.0058315733763;39704;40512.797436012814;40672.38991415131;40731.18537629246;40740;42581.78709106458;43019;43155.78422107885;43197.35203971935;43448;8751.081136480674;8895.421797583169;8949.59726812295;8975.865362019575;8992.23565996891;8632.309415246797;8708.608112634915;8763.474191548528;8764.079771623983;8775.473471591693;9004.459732416077;9006;9062.909370906273;9083.636654533811;9095;8966.327525435585;8992.415492992934;9011.053839346872;9017.909820901772;9026.142516460992;9039.728808135766;9093.45439273639;9120.452772833585;9132.086791320815;9165.083491650848;43245.13509729819;43448;43624;43712.78143609261;43731.34402983958;3752.343339915531;3781.3760729479604;3788.8105594720428;3910.7458015229204;4241.143890245651;33039.6696033039;33621;34052.82973585141;34090.14774630629;34340.48489272638;4276.743395396286;4339.240632889232;4352.608265256111;4361.934570981438;4387.407699960529;309684;310372;310676;311485;311656;58879.41120588825;59291.11063334053;59431.405685942584;59662.70168649129;59744;57267.14099288514;70631.94052089223;71623.64188179026;71772.64113679502;71987.2801271991;18768.155433005548;19068.33260835892;19073.427797166107;19154.52113697141;19297.710534341997;14641.48754793577;14668.339924703414;14744.262786860614;14779.482718104815;14796.112233266038;19974.50063748418;20245.696314555295;20350;20397.184112635627;20459.897700511403;7688.346490548254;7816.49192802466;7882.408819338458;7913.920860791433;8034.758957231175;1175.1362748379934;1239.3385552654481;1241.9565315213924;1249.0694432647736;1288.2141893444991;33529.497057544155;34575.82712086423;34952.82523587366;35002;35271.470927936105;1191.237607930925;1200.951961921531;1280.9039322050696;1290.425760536571;1319.4392383237087;16079.598010049609;16105.838941610435;16280.834914610958;16723.91638041802;17175.57061073483;487102;826101;851708;866477;866497;61130;61603;61648.69175654093;61688.38311616916;62283.065754013725;1447.269129089824;1499.9400023999135;1531.5864716526476;1532.6551525906582;1535.993923979795;33061.83469082735;33246;33632.49551256782;33649;34445.13887152741;52342.21486677627;53061.734691326295;53238.73380633072;53421.46578534165;53421.46578534321;410840;410884;412573;413205;414000;30582.847085764428;30918.536221956238;31232.21919452032;31391.84304078465;31432.37135257328;48587.27119093287;49089.754551227015;49770.80615249287;49808;49873.251901220785;42118.789406052776;42522.129838336885;42649.36025959675;42776.35835462533;42953;40782.59217407788;41281.555145569764;41341;41970.16059678728;42412.15175696407;42766.786166068974;43320.13359732851;43330.350044748724;43952.56047439485;44160.77919610382;34729.305413891074;36254.4561831578;36325.636743632225;36456.81771591125;36963.63036369602;29304.267393314483;29337.266568335963;29659.851700741357;29918.551221732127;30179 19:47:46 INFO - PROCESS | 3477 | |2;jquery.html;419.603474716393;431.79705538396945;432.5976841537369;436.5721592839018;443.0872402850129;18372;19218.519537011583;19282.807171928278;19455.513612159702;20314.89842550785;19310.324138655116;19408.514787130327;19591.41225763226;19621.509462263413;19651.5087122822;5115.155999260127;5282.260483532308;5382.111951527993;5907.409259074101;5910.290765108193;5804.245448091742;5811.360750317462;5817.185594016841;5854;5893.086571581412;5666.801661941833;5804.564657650693;5811.215485909412;5821.767129314822;5836.795712150076;5803.477687008169;5815.82552523425;5818.621789583684;5828.59199856006;5861.238039054895;5137.8201762938115;5162.638615296931;5264.105102132647;5278.392984806758;5314.681119132864;14353.712925741427;14481.78277325841;14544.418223271057;14604.269786510738;20285;2295.414669259345;2433.5011322678984;2497.7502249774875;2600.1549496413554;3016.065019843855;10794.946025269823;11359.375234362107;11916.880831191664;12834.486620535168;15063.54809355721;2033.3493282149718;2044.2504831002427;2069.8758074515576;2071.8964051797348;2102.6425507663735;62058.0691289631;65181.67409162924;80855.59572202101;84745.57627211887;85301;11230.15773816967;11455.713607159722;11733.178677492493;11802.822957655642;11921.34432606215;16355.345786168658;16721.832781672027;16744.330226791037;16845.494635160965;16875.15624218784;8945.19493245611;9054.456732596065;9059.411138275991;9074.637014519478;9113.179813816789;9002.234810041089;9071.27429805614;9125.589348479334;9128.178463938144;9196.540172991323;5023.497650234947;5038.193888977819;5082.2122571001555;5129.333186685707;5151.9484805152215;2038.2560365466497;2041.4692180033;2079.7296351474515;2092.550101728136;2114.6722258050027;1022.6011855376261;1048.9003544663244;1084.4252546150553;1086.000879191146;1174.929504229749;19188.80811191898;19363.322283720285;19535.218591256475;19691.901540492494;20063.59872802565;1060.2525219720078;1105.6019832860163;1116.832475128721;1142.9599964001386;1168.4274705394296;10928.945355273172;11098.889011109786;11201.27191732551;11278.54885804575;11299.435028248554;473638;521625;522686;527676;529121;85948.57025714831;86744.56627716821;95034.52482737681;95239.52380238054;96223;1129.6611016695124;1134.2173900008968;1158.8725240223569;1176.16492290473;1203.2660077352807;16726.33094676248;17146.228419721392;17400.564985875455;17498.91250543739;18072.186751595946;38826.61173388343;39673.2065358697;39934.800325998185;40943;41142.382864257655;54041.729791350794;54992;55129;57645.711771440874;58887.11669325049;8279.420440569102;8366.121557236645;8487.660493580188;8524.190201930807;8590.527520986405;9085;13012.5445609407;13364.198148111145;13970.511032114235;13995.860041399455;11292.943535282271;11655.59205427806;11789.528418863149;12149.724278950584;12305.630831075083;5601.29983752031;9446.622135114518;11058.341248812743;11579.536818527165;11793.233439826385;12137.271763694207;12234;12350.38248087574;12372.876271237532;12604.87395126037;8045.316148127475;8103.392245581723;8130.715424960098;8189.467684600482;8543.487390756574;11615.535378584762;11974.760504790029;12066.276023438622;12145.210561313486;12341.3829308536 19:47:46 INFO - PROCESS | 3477 | |3;mootools.html;1575.1494193135707;1610.4282979542259;1815.2466726308573;1905.17125050603;1910.1881700277395;8229.423940324179;8382.37132215084;8439.620217090238;8446.450980686252;8669.956650216756;8570.142985701426;8667.783305417368;8735.432196907197;8747.387682862201;8751;2409.674693916321;2439.5852705040184;2440.316711320833;2441.1333976438286;2455.0916161020446;2464.987675061622;2470.258922323305;2492.4516606346574;2505.436276837715;2511.1713134665606;2429.842060266086;2445.9755402445926;2454.9631755523683;2480.032787212979;2499.0128899084852;2283.908643654252;2284.823315992265;2309.6420054891437;2385.8449200802065;2437.3662847659557;2452.2152911068465;2455.9263222103364;2459.3605662527693;2465.568525508029;2470.036685692581;8638.870416943751;8681.479111253346;8732.781680457976;8734.781630459225;8734.912650873473;5377.838664840061;5466.125419932831;5480.095784195603;5506.669599824023;5521.5306698930235;3592.2456284180353;3619.2037751694584;3674.8346324415197;3802.8288727007352;3811.5235595550557;1140.9372484513349;1147.5409836065558;1153.1581945180067;1181.4329122021393;1191.8271850581705;12093.213941093802;12158.392080395945;12198.39008049594;12228.082893783001;12253.632391028283;4565.977170114128;4592.67851250416;4630.4443466784205;4645.628349732014;4662.7202367858035;9742.902570974342;9824.90175098254;9826.263030272758;9832.803343933225;9833.065858743408;5435.592330575223;5462.808801692001;5466.070767969455;5468.699221542854;5474.644148130359;4416.050549131888;4860.513948605111;4936.234883593049;4957.132501812169;5015.498450155028;3803.6006219347123;3839.8080095995088;3891.346177874392;3896.5518965318784;3949.822257998397;1097.961571345015;1124.3366413815888;1128.610629332879;1131.5530365505745;1132.2017977325966;1020.4642562654517;1066.4827558634056;1081.2539347849959;1087.9673609791719;1092.4974511724695;5902.468777810018;5910.8817823643285;5956.434138756811;6080.300765412034;6100.023996160593;466.28425367061396;467.4414075180127;469.24217388917333;470.6282037190581;484.04884402149946;4174.624283814472;4301.978490107529;4327.545607711208;4330.350447432847;4333.739975601474;10631.84052239217;10867.29362591429;10969;11037.11703063753;11086.889131108746;10579;10763.3541987481;10823.891761082288;10894;10895.945520272506;8189.795255118551;8308;8372.455790373606;8464.830703385898;8473.830523389497;5946.13781001761;5946.286445626552;5992.610480318765;5999.430054144849;6040.607360521552;9628.229741620513;9700.320977531504;9851.655192068243;9930.25523085757;9954.352967057119;9722.27082968766;9976.20190384753;9978.151857092229;10050.195984321383;10054.798904022025;6184.938150618436;6877.449804015767;7145.356917877416;7290.781276561712;7385.224551422023;8210.137935516685;8309.252167304972;8330.708425205088;8334.416590838584;8346.499210047417;7056.364927156375;7385.630718463948;7398.3341499265325;7419.777406677593;7509.924900751141;7368.226336234832;7589.962050189934;7709;7719.343855772097;7918.089419716806;7000.929990700028;7031.1211098612675;7036.2260151384335;7094.077769889881;7100.183478899992;5109.565686916654;5152.330197074506;5341.41244463101;5345.438728933406;5356.384015838228;5339.172428273624;5360.222767698584;5371.40914499397;5388.757505912165;5613.522850557748 19:47:46 INFO - PROCESS | 3477 | |4;prototype.html;322.48885516456414;332.9950050749238;339.8300849575213;345.61636583392414;349.5857408970369;6597.307282735315;6677.565958212713;6687.398134167924;6717.563358381702;6757.966210168955;6593.769218077368;6644.235912870022;6647.800565983016;6651.900221496681;6687.364700353459;4706.882327941812;4795.640326975474;4931.827386041489;4957.702537847723;4966.652334336598;4892.77982490787;4895.926561101586;4932.876678083058;4934.40787105546;4942.456329803718;4870.853874383774;4899.338589290436;4915.631327650441;4917.483664215241;4918.336024636682;4915.041566894457;4929.901401971976;4936.5063493650705;4938.80244790208;4944.901101977976;4302.139572085595;4302.483701955754;4314.3528470729325;4318.201132790412;4320.891977700551;6175.413335733098;6347.80956571299;6358.7774427895265;6382.808515744535;6396.136521569575;5795.391483894173;5808.796692115756;5830.737616807254;5833.445822646841;5834.941650583482;6946.548474349152;6983;7010.088688470517;7010.929890701079;7015.719371225145;4751.714897106184;4770.189067858472;4787.066522028206;4793.9280910786365;4820.566149046603;7270.563766173994;7336.156342020682;7356.668949897214;7357.3746231570385;7383.926160738378;4642.837500687459;4759.595434388047;4788.090262850047;4796.784144713496;4812.711237325771;4813.374261346073;4840;4841.419029716457;4844.32179494871;4863.829765958175;5687.345955215121;5688.175214593944;5703.914441283384;5707.715763953077;5709.7716091356715;6987.231404545496;7045.295470453017;7045.612491312924;7053.118360204974;7085.751998680022;1683.1079527850259;1696.6776312500585;1698.1933581548665;1700.846923776866;1703.608170120879;1066.9786604267872;1118.3737107219983;1136.1535655936216;1174.2250114924109;1176.2472017908544;6693.832654183684;6704.161979752531;6712.664366781739;6728.764493242713;6731.091302674175;7060.682269297894;7097.716091356391;7167.784966451015;7230.746923857745;7258.129024516986;6919.308069193041;6934;6934;6962.965185174143;7020.403265722369;3939.5863434339553;3975.264576053439;3988.980055099706;3992.940105898414;3993.1614360983936;7599.582022988679;7676.078870535572;7683.1548529661695;7689.615519224017;7690.538567685957;7307.744228952068;7447.702091916371;7469.775906722807;7499.662515186829;7508.511946723445;7503.924960750432;7546.99999999989;7621.733239336597;7625.275598818103;7652.081750190013;7293.301478453006;7294.197638259681;7295.8540829184185;7355.816104597214;7355.852882942419;7188.748393806401;7241.167265764505;7245.7826265212125;7256.96371518139;7262.96368518154;7438.73964411243;7641.88537171954;7654.885176722242;7656.196099409704;7675.194104619158;4717.693349932243;4725.763711814464;4739.90982074118;4771.427428708577;4794.256890182028;7315.817104572428;7336.486445948733;7340.926590734024;7349.77950661481;7356.705731770669;7027.086478757728;7071.222165561681;7106.111736032996;7143.249958754256;7153.105861767279;6876.312368763083;7046.365827075588;7057.0472986146215;7092.148942126978;7110.5022648414115;6966.686499107654;6969.407600353824;6970.442364610718;6977.441804655514;6979.2671769465505;7133.108361454818;7139.964300178466;7141.750038748619;7143.107111611049;7157.212706602166;6907.89638155418;6969.756058537927;6970.825729356807;6975.162980442379;6979.616121113185 19:47:46 INFO - PROCESS | 3477 | |5;yui.html;855.2003876375587;936.8407370746972;944.3767113704956;947.2753343692073;966.4346357380932;13585.66035849103;13821.723565528697;15460.613484662888;15569;15570.14364209968;13579.796303055462;13592.25242611656;13680.52118175864;13682.794758078637;13714.0400171988;891.777055736066;908.9000209976914;914.3371055984425;921.216965579259;929.3540989012639;918.2883265469281;923.6997975657938;925.2829057480473;925.319889880937;925.5141050948272;947.0387556630026;947.853082772168;955.7849483866144;956.9090936361034;959.596969272907;946.9053094690511;948.7390967483963;948.8719022931884;949.0888746803008;949.2121539122512;697.093778088488;700.8212905709063;700.8808502554577;703.1772825793834;704.2148004974467;15914.52256432309;15949.840501595068;15951.042937423792;16051;16053.438129665406;14596.562103136923;14597.12417254968;14641.853581464156;14697.632559185999;14843.406263749437;12162.209456385395;12175.45210465531;12307.4461649226;12420.875791242062;12470.376481175996;4065.2479291331197;4071.043304823364;4087.4890638670167;4153;4175.144095460423;57557;57957.42042579562;58145.41854581442;58176.70911645457;58248.70875645637;10711.571537138427;10846.566137354575;11217.270877392943;11313.264637798517;11361.488733007034;20252.392428227176;20409.591808163754;20478.488037798877;20513.17947282122;20567.280145194847;8654.177853103945;8755.255803256667;8824.426412283181;8861.867071993925;9016.23362014223;4980.800767969313;4991.800327986913;5048.318477005557;5060.924086138711;5151.948480515147;3658.0854786303425;3715.405535114369;3722.925541489209;3737.0657335666083;3739.1773809762353;638.696619105921;663.045214890556;667.8196886840526;677.7898851356096;684.5789839248926;684.2746688510096;703.0438603499236;705.7953193573909;737.2480070328343;771.155584634824;9015.729528114167;9726.756831079138;9777.120059194707;9847.415573417224;9922.553485093189;761.3186198352444;798.7044793426469;800.803803068252;818.29217726666;831.6548632317521;4306.41863348444;4328.264195086843;4474.351219073216;4524.683272170916;4579.107074120515;59852.70073649691;60354.396456035756;60571.09143362853;62729;62775.37224627695;51053.74473127611;51658.74170629198;52210;52338.73830630899;52749;46594.534054659016;47054.76472617615;47497.762511187226;47561.38412387283;48220.758896205996;9418.670346537838;9469.810603787748;9519.666811661558;9584.329096963425;9669.661561845302;36863;37325.25349493049;37408.251834963696;38044.42933355946;38304.80847595744;43776.56223437725;45581.77209113933;47126;47138.29292560683;49720.751396242784;11968.46141923598;12325.691857703629;12435.191712538655;12476.563320283747;12605.243685378906;13668.248246346546;13894.930525347712;14028.08817426864;14098.295085245902;14237.35931883047;13187.340632968506;13544.255065971467;13749.587512374645;13813.309334533435;13819.378127984064;12921.483140674267;13092.738145237232;13119;13141.737165256833;13220.140690855063;11377.203595748219;11415.040255240592;11565.942170289094;11578;11743.236689615147;10411.271211015157;10431.269811113149;10453.84319235197;10769.676909692722;10930.344179349264;10667.57329706834;11018.944905275423;11078.501467433824;11179.329240245612;11221.270617409842 19:47:46 INFO - PROCESS | 3477 | __end_tp_report 19:47:46 INFO - PROCESS | 3477 | __start_cc_report 19:47:46 INFO - PROCESS | 3477 | _x_x_mozilla_cycle_collect,333 19:47:46 INFO - PROCESS | 3477 | __end_cc_report 19:47:46 INFO - PROCESS | 3477 | __startTimestamp1463107666955__endTimestamp 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | ------- Summary: start ------- 19:47:46 INFO - PROCESS | 3477 | Number of tests: 6 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#0] dojo.html Cycles:165 Average:5594.61 Median:5876.44 stddev:629.00 (10.7%) stddev-sans-first:605.68 19:47:46 INFO - PROCESS | 3477 | Values: 3345.5 3397.4 3408.6 3426.9 3452.3 5588.9 5643.7 5648.5 5656.7 5725.4 5658.5 5658.7 5660.7 5668.1 5677.4 4993.8 5073.3 5105.8 5127.6 5185.9 4970.6 5013.5 5067.2 5077.7 5198.9 5000.1 5071.6 5106.7 5130.6 5154.1 5124.9 5136.1 5142.1 5150.6 5161.1 4922.3 4970.7 5032.9 5039.4 5050.1 5412.2 5421.2 5442.9 5462.0 5465.9 5963.3 5967.1 5974.3 5975.4 5983.1 5876.4 6009.1 6057.4 6073.8 6139.4 5458.3 5496.3 5518.3 5527.1 5532.1 6007.8 6018.5 6022.7 6042.6 6046.2 5843.4 5966.0 5975.5 5995.1 6023.2 5945.1 5985.9 5988.4 5990.3 6002.6 5890.9 5917.8 5935.4 5941.8 5982.1 6020.2 6067.7 6070.6 6073.6 6114.7 4552.5 4570.5 4580.0 4583.0 4601.1 4087.1 4129.1 4141.5 4146.0 4155.6 5627.8 5786.4 5864.7 5880.4 5923.4 6030.8 6052.4 6060.6 6063.1 6066.2 5696.1 5787.2 5808.6 5878.1 5911.1 5170.1 5170.8 5180.2 5195.4 5204.1 6254.3 6262.0 6266.7 6272.7 6279.2 5856.8 5869.2 5870.9 5986.0 6125.0 6270.0 6278.5 6288.9 6290.4 6306.7 5919.4 5957.3 5961.4 5963.3 5995.2 5892.9 6057.1 6067.4 6112.6 6115.9 5969.9 5991.6 6001.5 6001.7 6002.9 5865.4 5965.8 5967.3 5977.5 5985.8 5606.2 5659.2 5717.4 5723.7 5744.4 6002.0 6006.7 6008.2 6038.2 6041.3 5569.0 5894.4 5896.3 5899.5 5902.6 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#1] ext.html Cycles:180 Average:66245.60 Median:42467.14 stddev:147085.27 (346.4%) stddev-sans-first:147415.32 19:47:46 INFO - PROCESS | 3477 | Values: 607.1 643.2 659.9 671.3 688.0 39704.0 40512.8 40672.4 40731.2 40740.0 42581.8 43019.0 43155.8 43197.4 43448.0 8751.1 8895.4 8949.6 8975.9 8992.2 8632.3 8708.6 8763.5 8764.1 8775.5 9004.5 9006.0 9062.9 9083.6 9095.0 8966.3 8992.4 9011.1 9017.9 9026.1 9039.7 9093.5 9120.5 9132.1 9165.1 43245.1 43448.0 43624.0 43712.8 43731.3 3752.3 3781.4 3788.8 3910.7 4241.1 33039.7 33621.0 34052.8 34090.1 34340.5 4276.7 4339.2 4352.6 4361.9 4387.4 309684.0 310372.0 310676.0 311485.0 311656.0 58879.4 59291.1 59431.4 59662.7 59744.0 57267.1 70631.9 71623.6 71772.6 71987.3 18768.2 19068.3 19073.4 19154.5 19297.7 14641.5 14668.3 14744.3 14779.5 14796.1 19974.5 20245.7 20350.0 20397.2 20459.9 7688.3 7816.5 7882.4 7913.9 8034.8 1175.1 1239.3 1242.0 1249.1 1288.2 33529.5 34575.8 34952.8 35002.0 35271.5 1191.2 1201.0 1280.9 1290.4 1319.4 16079.6 16105.8 16280.8 16723.9 17175.6 487102.0 826101.0 851708.0 866477.0 866497.0 61130.0 61603.0 61648.7 61688.4 62283.1 1447.3 1499.9 1531.6 1532.7 1536.0 33061.8 33246.0 33632.5 33649.0 34445.1 52342.2 53061.7 53238.7 53421.5 53421.5 410840.0 410884.0 412573.0 413205.0 414000.0 30582.8 30918.5 31232.2 31391.8 31432.4 48587.3 49089.8 49770.8 49808.0 49873.3 42118.8 42522.1 42649.4 42776.4 42953.0 40782.6 41281.6 41341.0 41970.2 42412.2 42766.8 43320.1 43330.4 43952.6 44160.8 34729.3 36254.5 36325.6 36456.8 36963.6 29304.3 29337.3 29659.9 29918.6 30179.0 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#2] jquery.html Cycles:180 Average:29426.94 Median:2108.66 stddev:84739.01 (4018.6%) stddev-sans-first:84948.73 19:47:46 INFO - PROCESS | 3477 | Values: 419.6 431.8 432.6 436.6 443.1 18372.0 19218.5 19282.8 19455.5 20314.9 19310.3 19408.5 19591.4 19621.5 19651.5 5115.2 5282.3 5382.1 5907.4 5910.3 5804.2 5811.4 5817.2 5854.0 5893.1 5666.8 5804.6 5811.2 5821.8 5836.8 5803.5 5815.8 5818.6 5828.6 5861.2 5137.8 5162.6 5264.1 5278.4 5314.7 14353.7 14481.8 14544.4 14604.3 20285.0 2295.4 2433.5 2497.8 2600.2 3016.1 10794.9 11359.4 11916.9 12834.5 15063.5 2033.3 2044.3 2069.9 2071.9 2102.6 62058.1 65181.7 80855.6 84745.6 85301.0 11230.2 11455.7 11733.2 11802.8 11921.3 16355.3 16721.8 16744.3 16845.5 16875.2 8945.2 9054.5 9059.4 9074.6 9113.2 9002.2 9071.3 9125.6 9128.2 9196.5 5023.5 5038.2 5082.2 5129.3 5151.9 2038.3 2041.5 2079.7 2092.6 2114.7 1022.6 1048.9 1084.4 1086.0 1174.9 19188.8 19363.3 19535.2 19691.9 20063.6 1060.3 1105.6 1116.8 1143.0 1168.4 10928.9 11098.9 11201.3 11278.5 11299.4 473638.0 521625.0 522686.0 527676.0 529121.0 85948.6 86744.6 95034.5 95239.5 96223.0 1129.7 1134.2 1158.9 1176.2 1203.3 16726.3 17146.2 17400.6 17498.9 18072.2 38826.6 39673.2 39934.8 40943.0 41142.4 54041.7 54992.0 55129.0 57645.7 58887.1 8279.4 8366.1 8487.7 8524.2 8590.5 9085.0 13012.5 13364.2 13970.5 13995.9 11292.9 11655.6 11789.5 12149.7 12305.6 5601.3 9446.6 11058.3 11579.5 11793.2 12137.3 12234.0 12350.4 12372.9 12604.9 8045.3 8103.4 8130.7 8189.5 8543.5 11615.5 11974.8 12066.3 12145.2 12341.4 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#3] mootools.html Cycles:180 Average:5769.74 Median:4986.32 stddev:3204.63 (64.3%) stddev-sans-first:3198.11 19:47:46 INFO - PROCESS | 3477 | Values: 1575.1 1610.4 1815.2 1905.2 1910.2 8229.4 8382.4 8439.6 8446.5 8670.0 8570.1 8667.8 8735.4 8747.4 8751.0 2409.7 2439.6 2440.3 2441.1 2455.1 2465.0 2470.3 2492.5 2505.4 2511.2 2429.8 2446.0 2455.0 2480.0 2499.0 2283.9 2284.8 2309.6 2385.8 2437.4 2452.2 2455.9 2459.4 2465.6 2470.0 8638.9 8681.5 8732.8 8734.8 8734.9 5377.8 5466.1 5480.1 5506.7 5521.5 3592.2 3619.2 3674.8 3802.8 3811.5 1140.9 1147.5 1153.2 1181.4 1191.8 12093.2 12158.4 12198.4 12228.1 12253.6 4566.0 4592.7 4630.4 4645.6 4662.7 9742.9 9824.9 9826.3 9832.8 9833.1 5435.6 5462.8 5466.1 5468.7 5474.6 4416.1 4860.5 4936.2 4957.1 5015.5 3803.6 3839.8 3891.3 3896.6 3949.8 1098.0 1124.3 1128.6 1131.6 1132.2 1020.5 1066.5 1081.3 1088.0 1092.5 5902.5 5910.9 5956.4 6080.3 6100.0 466.3 467.4 469.2 470.6 484.0 4174.6 4302.0 4327.5 4330.4 4333.7 10631.8 10867.3 10969.0 11037.1 11086.9 10579.0 10763.4 10823.9 10894.0 10895.9 8189.8 8308.0 8372.5 8464.8 8473.8 5946.1 5946.3 5992.6 5999.4 6040.6 9628.2 9700.3 9851.7 9930.3 9954.4 9722.3 9976.2 9978.2 10050.2 10054.8 6184.9 6877.4 7145.4 7290.8 7385.2 8210.1 8309.3 8330.7 8334.4 8346.5 7056.4 7385.6 7398.3 7419.8 7509.9 7368.2 7590.0 7709.0 7719.3 7918.1 7000.9 7031.1 7036.2 7094.1 7100.2 5109.6 5152.3 5341.4 5345.4 5356.4 5339.2 5360.2 5371.4 5388.8 5613.5 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#4] prototype.html Cycles:180 Average:5862.36 Median:6715.11 stddev:1827.65 (27.2%) stddev-sans-first:1784.85 19:47:46 INFO - PROCESS | 3477 | Values: 322.5 333.0 339.8 345.6 349.6 6597.3 6677.6 6687.4 6717.6 6758.0 6593.8 6644.2 6647.8 6651.9 6687.4 4706.9 4795.6 4931.8 4957.7 4966.7 4892.8 4895.9 4932.9 4934.4 4942.5 4870.9 4899.3 4915.6 4917.5 4918.3 4915.0 4929.9 4936.5 4938.8 4944.9 4302.1 4302.5 4314.4 4318.2 4320.9 6175.4 6347.8 6358.8 6382.8 6396.1 5795.4 5808.8 5830.7 5833.4 5834.9 6946.5 6983.0 7010.1 7010.9 7015.7 4751.7 4770.2 4787.1 4793.9 4820.6 7270.6 7336.2 7356.7 7357.4 7383.9 4642.8 4759.6 4788.1 4796.8 4812.7 4813.4 4840.0 4841.4 4844.3 4863.8 5687.3 5688.2 5703.9 5707.7 5709.8 6987.2 7045.3 7045.6 7053.1 7085.8 1683.1 1696.7 1698.2 1700.8 1703.6 1067.0 1118.4 1136.2 1174.2 1176.2 6693.8 6704.2 6712.7 6728.8 6731.1 7060.7 7097.7 7167.8 7230.7 7258.1 6919.3 6934.0 6934.0 6963.0 7020.4 3939.6 3975.3 3989.0 3992.9 3993.2 7599.6 7676.1 7683.2 7689.6 7690.5 7307.7 7447.7 7469.8 7499.7 7508.5 7503.9 7547.0 7621.7 7625.3 7652.1 7293.3 7294.2 7295.9 7355.8 7355.9 7188.7 7241.2 7245.8 7257.0 7263.0 7438.7 7641.9 7654.9 7656.2 7675.2 4717.7 4725.8 4739.9 4771.4 4794.3 7315.8 7336.5 7340.9 7349.8 7356.7 7027.1 7071.2 7106.1 7143.2 7153.1 6876.3 7046.4 7057.0 7092.1 7110.5 6966.7 6969.4 6970.4 6977.4 6979.3 7133.1 7140.0 7141.8 7143.1 7157.2 6907.9 6969.8 6970.8 6975.2 6979.6 19:47:46 INFO - PROCESS | 3477 | 19:47:46 INFO - PROCESS | 3477 | [#5] yui.html Cycles:180 Average:15138.75 Median:25080.44 stddev:17045.60 (68.0%) stddev-sans-first:17059.67 19:47:46 INFO - PROCESS | 3477 | Values: 855.2 936.8 944.4 947.3 966.4 13585.7 13821.7 15460.6 15569.0 15570.1 13579.8 13592.3 13680.5 13682.8 13714.0 891.8 908.9 914.3 921.2 929.4 918.3 923.7 925.3 925.3 925.5 947.0 947.9 955.8 956.9 959.6 946.9 948.7 948.9 949.1 949.2 697.1 700.8 700.9 703.2 704.2 15914.5 15949.8 15951.0 16051.0 16053.4 14596.6 14597.1 14641.9 14697.6 14843.4 12162.2 12175.5 12307.4 12420.9 12470.4 4065.2 4071.0 4087.5 4153.0 4175.1 57557.0 57957.4 58145.4 58176.7 58248.7 10711.6 10846.6 11217.3 11313.3 11361.5 20252.4 20409.6 20478.5 20513.2 20567.3 8654.2 8755.3 8824.4 8861.9 9016.2 4980.8 4991.8 5048.3 5060.9 5151.9 3658.1 3715.4 3722.9 3737.1 3739.2 638.7 663.0 667.8 677.8 684.6 684.3 703.0 705.8 737.2 771.2 9015.7 9726.8 9777.1 9847.4 9922.6 761.3 798.7 800.8 818.3 831.7 4306.4 4328.3 4474.4 4524.7 4579.1 59852.7 60354.4 60571.1 62729.0 62775.4 51053.7 51658.7 52210.0 52338.7 52749.0 46594.5 47054.8 47497.8 47561.4 48220.8 9418.7 9469.8 9519.7 9584.3 9669.7 36863.0 37325.3 37408.3 38044.4 38304.8 43776.6 45581.8 47126.0 47138.3 49720.8 11968.5 12325.7 12435.2 12476.6 12605.2 13668.2 13894.9 14028.1 14098.3 14237.4 13187.3 13544.3 13749.6 13813.3 13819.4 12921.5 13092.7 13119.0 13141.7 13220.1 11377.2 11415.0 11565.9 11578.0 11743.2 10411.3 10431.3 10453.8 10769.7 10930.3 10667.6 11018.9 11078.5 11179.3 11221.3 19:47:46 INFO - PROCESS | 3477 | -------- Summary: end -------- 19:47:46 INFO - PROCESS | 3477 | 19:47:47 INFO - TEST-INFO | 3477: exit 0 19:47:47 INFO - TEST-OK | dromaeo_css | took 1110394ms 19:47:47 INFO - TEST-START | kraken 19:47:47 INFO - operating with platform_type : linux_ 19:47:47 INFO - Initialising browser for kraken test... 19:47:47 INFO - TEST-INFO | started process 3722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvmqSm/profile http://localhost:47090/getInfo.html) 19:47:51 INFO - PROCESS | 3722 | 19:47:51 INFO - PROCESS | 3722 | (process:3803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:47:52 INFO - PROCESS | 3722 | __metrics Screen width/height:1600/1200 19:47:52 INFO - PROCESS | 3722 | colorDepth:24 19:47:52 INFO - PROCESS | 3722 | Browser inner width/height: 1024/697 19:47:52 INFO - PROCESS | 3722 | __metrics 19:47:53 ERROR - PROCESS | 3722 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:47:54 INFO - TEST-INFO | 3722: exit 0 19:47:54 INFO - Browser initialized. 19:47:54 INFO - Running cycle 1/1 for kraken test... 19:47:54 INFO - TEST-INFO | started process 3855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvmqSm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:56 INFO - PROCESS | 3855 | 19:47:56 INFO - PROCESS | 3855 | (process:3929): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:48:06 INFO - PROCESS | 3855 | RSS: Main: 151597056 19:48:06 INFO - PROCESS | 3855 | 19:48:08 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-beat-detection) 19:48:09 INFO - PROCESS | 3855 | RSS: Main: 156880896 19:48:09 INFO - PROCESS | 3855 | 19:48:12 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-dft) 19:48:12 INFO - PROCESS | 3855 | RSS: Main: 156495872 19:48:12 INFO - PROCESS | 3855 | 19:48:15 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-fft) 19:48:16 INFO - PROCESS | 3855 | RSS: Main: 157036544 19:48:16 INFO - PROCESS | 3855 | 19:48:18 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-oscillator) 19:48:18 INFO - PROCESS | 3855 | RSS: Main: 156577792 19:48:18 INFO - PROCESS | 3855 | 19:48:21 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:48:21 INFO - PROCESS | 3855 | RSS: Main: 156934144 19:48:21 INFO - PROCESS | 3855 | 19:48:24 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-darkroom) 19:48:25 INFO - PROCESS | 3855 | RSS: Main: 156971008 19:48:25 INFO - PROCESS | 3855 | 19:48:28 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-desaturate) 19:48:29 INFO - PROCESS | 3855 | RSS: Main: 157679616 19:48:29 INFO - PROCESS | 3855 | 19:48:32 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47090/tests/kraken/driver.html?testName=json-parse-financial) 19:48:32 INFO - PROCESS | 3855 | RSS: Main: 156786688 19:48:32 INFO - PROCESS | 3855 | 19:48:34 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:48:34 INFO - PROCESS | 3855 | RSS: Main: 156798976 19:48:34 INFO - PROCESS | 3855 | 19:48:36 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:48:37 INFO - PROCESS | 3855 | RSS: Main: 156532736 19:48:37 INFO - PROCESS | 3855 | 19:48:39 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:48:40 INFO - PROCESS | 3855 | RSS: Main: 156282880 19:48:40 INFO - PROCESS | 3855 | 19:48:43 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:48:43 INFO - PROCESS | 3855 | RSS: Main: 157102080 19:48:43 INFO - PROCESS | 3855 | 19:48:45 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:48:46 INFO - PROCESS | 3855 | RSS: Main: 157138944 19:48:46 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47090/tests/kraken/driver.html?testName=ai-astar) 19:48:48 INFO - PROCESS | 3855 | RSS: Main: 158973952 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | __start_tp_report 19:48:48 INFO - PROCESS | 3855 | _x_x_mozilla_page_load 19:48:48 INFO - PROCESS | 3855 | _x_x_mozilla_page_load_details 19:48:48 INFO - PROCESS | 3855 | |i|pagename|runs| 19:48:48 INFO - PROCESS | 3855 | |0;ai-astar;108;111;105;110;111;111;100;110;112;112 19:48:48 INFO - PROCESS | 3855 | |1;audio-beat-detection;159;129;159;184;135;158;155;140;174;136 19:48:48 INFO - PROCESS | 3855 | |2;audio-dft;162;165;161;163;162;163;162;164;161;162 19:48:48 INFO - PROCESS | 3855 | |3;audio-fft;76;74;75;168;78;77;80;77;158;75 19:48:48 INFO - PROCESS | 3855 | |4;audio-oscillator;93;97;154;92;101;93;152;91;92;145 19:48:48 INFO - PROCESS | 3855 | |5;imaging-gaussian-blur;120;120;118;117;118;117;118;118;117;118 19:48:48 INFO - PROCESS | 3855 | |6;imaging-darkroom;146;147;146;147;147;148;147;147;147;147 19:48:48 INFO - PROCESS | 3855 | |7;imaging-desaturate;96;96;97;95;95;96;97;95;95;96 19:48:48 INFO - PROCESS | 3855 | |8;json-parse-financial;56;56;60;55;57;60;55;72;53;53 19:48:48 INFO - PROCESS | 3855 | |9;json-stringify-tinderbox;57;58;57;58;57;57;56;58;57;56 19:48:48 INFO - PROCESS | 3855 | |10;stanford-crypto-aes;74;77;75;73;83;75;77;76;75;76 19:48:48 INFO - PROCESS | 3855 | |11;stanford-crypto-ccm;118;124;119;115;114;122;120;119;128;137 19:48:48 INFO - PROCESS | 3855 | |12;stanford-crypto-pbkdf2;165;161;157;162;163;158;159;169;160;169 19:48:48 INFO - PROCESS | 3855 | |13;stanford-crypto-sha256-iterative;69;67;67;67;67;65;73;66;65;72 19:48:48 INFO - PROCESS | 3855 | __end_tp_report 19:48:48 INFO - PROCESS | 3855 | __start_cc_report 19:48:48 INFO - PROCESS | 3855 | _x_x_mozilla_cycle_collect,815 19:48:48 INFO - PROCESS | 3855 | __end_cc_report 19:48:48 INFO - PROCESS | 3855 | __startTimestamp1463107728430__endTimestamp 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | ------- Summary: start ------- 19:48:48 INFO - PROCESS | 3855 | Number of tests: 14 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:4.01 19:48:48 INFO - PROCESS | 3855 | Values: 108.0 111.0 105.0 110.0 111.0 111.0 100.0 110.0 112.0 112.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:158.50 stddev:17.83 (11.2%) stddev-sans-first:18.77 19:48:48 INFO - PROCESS | 3855 | Values: 159.0 129.0 159.0 184.0 135.0 158.0 155.0 140.0 174.0 136.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 19:48:48 INFO - PROCESS | 3855 | Values: 162.0 165.0 161.0 163.0 162.0 163.0 162.0 164.0 161.0 162.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.50 stddev:36.59 (47.8%) stddev-sans-first:38.24 19:48:48 INFO - PROCESS | 3855 | Values: 76.0 74.0 75.0 168.0 78.0 77.0 80.0 77.0 158.0 75.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:27.39 (29.8%) stddev-sans-first:28.27 19:48:48 INFO - PROCESS | 3855 | Values: 93.0 97.0 154.0 92.0 101.0 93.0 152.0 91.0 92.0 145.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:0.93 19:48:48 INFO - PROCESS | 3855 | Values: 120.0 120.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 19:48:48 INFO - PROCESS | 3855 | Values: 146.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 19:48:48 INFO - PROCESS | 3855 | Values: 96.0 96.0 97.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.50 stddev:5.58 (9.9%) stddev-sans-first:5.88 19:48:48 INFO - PROCESS | 3855 | Values: 56.0 56.0 60.0 55.0 57.0 60.0 55.0 72.0 53.0 53.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 19:48:48 INFO - PROCESS | 3855 | Values: 57.0 58.0 57.0 58.0 57.0 57.0 56.0 58.0 57.0 56.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:2.73 (3.6%) stddev-sans-first:2.78 19:48:48 INFO - PROCESS | 3855 | Values: 74.0 77.0 75.0 73.0 83.0 75.0 77.0 76.0 75.0 76.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.00 stddev:6.79 (5.6%) stddev-sans-first:7.07 19:48:48 INFO - PROCESS | 3855 | Values: 118.0 124.0 119.0 115.0 114.0 122.0 120.0 119.0 128.0 137.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:4.24 (2.6%) stddev-sans-first:4.39 19:48:48 INFO - PROCESS | 3855 | Values: 165.0 161.0 157.0 162.0 163.0 158.0 159.0 169.0 160.0 169.0 19:48:48 INFO - PROCESS | 3855 | 19:48:48 INFO - PROCESS | 3855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.74 (4.1%) stddev-sans-first:2.87 19:48:48 INFO - PROCESS | 3855 | Values: 69.0 67.0 67.0 67.0 67.0 65.0 73.0 66.0 65.0 72.0 19:48:48 INFO - PROCESS | 3855 | -------- Summary: end -------- 19:48:48 INFO - PROCESS | 3855 | 19:48:49 INFO - TEST-INFO | 3855: exit 0 19:48:49 INFO - TEST-OK | kraken | took 61766ms 19:48:49 INFO - SUITE-END | took 1172s 19:48:49 INFO - Completed test suite (00:19:32) 19:48:49 INFO - javascript benchmark 19:48:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.53162557242, 3397.4054540455413, 3408.6420925802804, 3426.8862619648603, 3452.326796274726, 5588.86027849304, 5643.746031428585, 5648.491635752782, 5656.688882111483, 5725.398833122519, 5658.519025882805, 5658.688772117532, 5660.660360378381, 5668.064769313059, 5677.403872593381, 4993.825216117428, 5073.289739436482, 5105.821296254632, 5127.589792816584, 5185.948140518603, 4970.602351811846, 5013.523715247045, 5067.163917953533, 5077.669951453162, 5198.8700282493055, 5000.149974504325, 5071.619628527875, 5106.693598384109, 5130.56390206831, 5154.123798954168, 5124.897502049976, 5136.126858434057, 5142.10013247682, 5150.587952963754, 5161.122609156452, 4922.33548470959, 4970.676906001098, 5032.874178145539, 5039.370078740158, 5050.141475949097, 5412.188171774265, 5421.159720243369, 5442.91835622466, 5462.044142275086, 5465.9180112298345, 5963.344032156459, 5967.1347654589845, 5974.312954010301, 5975.40245975399, 5983.102534619842, 5876.44173803488, 6009.06859436788, 6057.4245446682935, 6073.817785466443, 6139.416755408229, 5458.263134476834, 5496.31296087989, 5518.33779946405, 5527.060399732055, 5532.059549876531, 6007.849803754853, 6018.548608854353, 6022.668753218528, 6042.637441753421, 6046.153538504613, 5843.3864444233595, 5966.0, 5975.492083172979, 5995.130706047598, 6023.186869772525, 5945.10823376497, 5985.910211346833, 5988.401159884064, 5990.31111422192, 6002.579819412686, 5890.9410905891245, 5917.7928772493615, 5935.436133567304, 5941.7623295067715, 5982.132590774313, 6020.217371741645, 6067.696615169224, 6070.575059745775, 6073.574849760563, 6114.694265286718, 4552.499225085238, 4570.520095390003, 4579.977100114478, 4582.9541704582525, 4601.079784043205, 4087.0599762054894, 4129.050318426718, 4141.544430112685, 4145.958540414617, 4155.625993660585, 5627.831165065055, 5786.392428794916, 5864.736086876101, 5880.382559831241, 5923.437273459014, 6030.7889223876955, 6052.364501727343, 6060.636361818217, 6063.120847477091, 6066.241719785027, 5696.060150075274, 5787.160861675034, 5808.564357673107, 5878.088896221007, 5911.054231322968, 5170.095233334151, 5170.844874653766, 5180.222966555047, 5195.428502864682, 5204.141316682781, 6254.34329395416, 6262.0, 6266.717997690115, 6272.686365681698, 6279.152314437584, 5856.765729370863, 5869.178315035983, 5870.9412905870395, 5986.012307969137, 6124.969375153096, 6269.96865015672, 6278.497720182466, 6288.874222515433, 6290.370962903673, 6306.684665766785, 5919.437653422918, 5957.255343082114, 5961.4038596140035, 5963.314218864886, 5995.16067750524, 5892.94107058924, 6057.091436284592, 6067.393260673897, 6112.5946701277735, 6115.938840611537, 5969.8806023878415, 5991.610545314541, 6001.519878409804, 6001.699915004145, 6002.879942401215, 5865.354810970704, 5965.761369545343, 5967.254093238345, 5977.462028417463, 5985.760569577343, 5606.24315717373, 5659.236003139524, 5717.42825717425, 5723.7424315905055, 5744.425557444222, 6002.039673652194, 6006.699665016819, 6008.188894499362, 6038.245219347582, 6041.305249896318, 5569.0, 5894.410558944071, 5896.292444906639, 5899.528037757055, 5902.557308201816], "value": 5553.6022290089995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.1378642327894, 643.1895811277789, 659.9407950239865, 671.3454381977573, 688.0058315733763, 39704.0, 40512.797436012814, 40672.38991415131, 40731.18537629246, 40740.0, 42581.78709106458, 43019.0, 43155.78422107885, 43197.35203971935, 43448.0, 8751.081136480674, 8895.421797583169, 8949.59726812295, 8975.865362019575, 8992.23565996891, 8632.309415246797, 8708.608112634915, 8763.474191548528, 8764.079771623983, 8775.473471591693, 9004.459732416077, 9006.0, 9062.909370906273, 9083.636654533811, 9095.0, 8966.327525435585, 8992.415492992934, 9011.053839346872, 9017.909820901772, 9026.142516460992, 9039.728808135766, 9093.45439273639, 9120.452772833585, 9132.086791320815, 9165.083491650848, 43245.13509729819, 43448.0, 43624.0, 43712.78143609261, 43731.34402983958, 3752.343339915531, 3781.3760729479604, 3788.8105594720428, 3910.7458015229204, 4241.143890245651, 33039.6696033039, 33621.0, 34052.82973585141, 34090.14774630629, 34340.48489272638, 4276.743395396286, 4339.240632889232, 4352.608265256111, 4361.934570981438, 4387.407699960529, 309684.0, 310372.0, 310676.0, 311485.0, 311656.0, 58879.41120588825, 59291.11063334053, 59431.405685942584, 59662.70168649129, 59744.0, 57267.14099288514, 70631.94052089223, 71623.64188179026, 71772.64113679502, 71987.2801271991, 18768.155433005548, 19068.33260835892, 19073.427797166107, 19154.52113697141, 19297.710534341997, 14641.48754793577, 14668.339924703414, 14744.262786860614, 14779.482718104815, 14796.112233266038, 19974.50063748418, 20245.696314555295, 20350.0, 20397.184112635627, 20459.897700511403, 7688.346490548254, 7816.49192802466, 7882.408819338458, 7913.920860791433, 8034.758957231175, 1175.1362748379934, 1239.3385552654481, 1241.9565315213924, 1249.0694432647736, 1288.2141893444991, 33529.497057544155, 34575.82712086423, 34952.82523587366, 35002.0, 35271.470927936105, 1191.237607930925, 1200.951961921531, 1280.9039322050696, 1290.425760536571, 1319.4392383237087, 16079.598010049609, 16105.838941610435, 16280.834914610958, 16723.91638041802, 17175.57061073483, 487102.0, 826101.0, 851708.0, 866477.0, 866497.0, 61130.0, 61603.0, 61648.69175654093, 61688.38311616916, 62283.065754013725, 1447.269129089824, 1499.9400023999135, 1531.5864716526476, 1532.6551525906582, 1535.993923979795, 33061.83469082735, 33246.0, 33632.49551256782, 33649.0, 34445.13887152741, 52342.21486677627, 53061.734691326295, 53238.73380633072, 53421.46578534165, 53421.46578534321, 410840.0, 410884.0, 412573.0, 413205.0, 414000.0, 30582.847085764428, 30918.536221956238, 31232.21919452032, 31391.84304078465, 31432.37135257328, 48587.27119093287, 49089.754551227015, 49770.80615249287, 49808.0, 49873.251901220785, 42118.789406052776, 42522.129838336885, 42649.36025959675, 42776.35835462533, 42953.0, 40782.59217407788, 41281.555145569764, 41341.0, 41970.16059678728, 42412.15175696407, 42766.786166068974, 43320.13359732851, 43330.350044748724, 43952.56047439485, 44160.77919610382, 34729.305413891074, 36254.4561831578, 36325.636743632225, 36456.81771591125, 36963.63036369602, 29304.267393314483, 29337.266568335963, 29659.851700741357, 29918.551221732127, 30179.0], "value": 21204.82433578339, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.603474716393, 431.79705538396945, 432.5976841537369, 436.5721592839018, 443.0872402850129, 18372.0, 19218.519537011583, 19282.807171928278, 19455.513612159702, 20314.89842550785, 19310.324138655116, 19408.514787130327, 19591.41225763226, 19621.509462263413, 19651.5087122822, 5115.155999260127, 5282.260483532308, 5382.111951527993, 5907.409259074101, 5910.290765108193, 5804.245448091742, 5811.360750317462, 5817.185594016841, 5854.0, 5893.086571581412, 5666.801661941833, 5804.564657650693, 5811.215485909412, 5821.767129314822, 5836.795712150076, 5803.477687008169, 5815.82552523425, 5818.621789583684, 5828.59199856006, 5861.238039054895, 5137.8201762938115, 5162.638615296931, 5264.105102132647, 5278.392984806758, 5314.681119132864, 14353.712925741427, 14481.78277325841, 14544.418223271057, 14604.269786510738, 20285.0, 2295.414669259345, 2433.5011322678984, 2497.7502249774875, 2600.1549496413554, 3016.065019843855, 10794.946025269823, 11359.375234362107, 11916.880831191664, 12834.486620535168, 15063.54809355721, 2033.3493282149718, 2044.2504831002427, 2069.8758074515576, 2071.8964051797348, 2102.6425507663735, 62058.0691289631, 65181.67409162924, 80855.59572202101, 84745.57627211887, 85301.0, 11230.15773816967, 11455.713607159722, 11733.178677492493, 11802.822957655642, 11921.34432606215, 16355.345786168658, 16721.832781672027, 16744.330226791037, 16845.494635160965, 16875.15624218784, 8945.19493245611, 9054.456732596065, 9059.411138275991, 9074.637014519478, 9113.179813816789, 9002.234810041089, 9071.27429805614, 9125.589348479334, 9128.178463938144, 9196.540172991323, 5023.497650234947, 5038.193888977819, 5082.2122571001555, 5129.333186685707, 5151.9484805152215, 2038.2560365466497, 2041.4692180033, 2079.7296351474515, 2092.550101728136, 2114.6722258050027, 1022.6011855376261, 1048.9003544663244, 1084.4252546150553, 1086.000879191146, 1174.929504229749, 19188.80811191898, 19363.322283720285, 19535.218591256475, 19691.901540492494, 20063.59872802565, 1060.2525219720078, 1105.6019832860163, 1116.832475128721, 1142.9599964001386, 1168.4274705394296, 10928.945355273172, 11098.889011109786, 11201.27191732551, 11278.54885804575, 11299.435028248554, 473638.0, 521625.0, 522686.0, 527676.0, 529121.0, 85948.57025714831, 86744.56627716821, 95034.52482737681, 95239.52380238054, 96223.0, 1129.6611016695124, 1134.2173900008968, 1158.8725240223569, 1176.16492290473, 1203.2660077352807, 16726.33094676248, 17146.228419721392, 17400.564985875455, 17498.91250543739, 18072.186751595946, 38826.61173388343, 39673.2065358697, 39934.800325998185, 40943.0, 41142.382864257655, 54041.729791350794, 54992.0, 55129.0, 57645.711771440874, 58887.11669325049, 8279.420440569102, 8366.121557236645, 8487.660493580188, 8524.190201930807, 8590.527520986405, 9085.0, 13012.5445609407, 13364.198148111145, 13970.511032114235, 13995.860041399455, 11292.943535282271, 11655.59205427806, 11789.528418863149, 12149.724278950584, 12305.630831075083, 5601.29983752031, 9446.622135114518, 11058.341248812743, 11579.536818527165, 11793.233439826385, 12137.271763694207, 12234.0, 12350.38248087574, 12372.876271237532, 12604.87395126037, 8045.316148127475, 8103.392245581723, 8130.715424960098, 8189.467684600482, 8543.487390756574, 11615.535378584762, 11974.760504790029, 12066.276023438622, 12145.210561313486, 12341.3829308536], "value": 9396.462050187953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.1494193135707, 1610.4282979542259, 1815.2466726308573, 1905.17125050603, 1910.1881700277395, 8229.423940324179, 8382.37132215084, 8439.620217090238, 8446.450980686252, 8669.956650216756, 8570.142985701426, 8667.783305417368, 8735.432196907197, 8747.387682862201, 8751.0, 2409.674693916321, 2439.5852705040184, 2440.316711320833, 2441.1333976438286, 2455.0916161020446, 2464.987675061622, 2470.258922323305, 2492.4516606346574, 2505.436276837715, 2511.1713134665606, 2429.842060266086, 2445.9755402445926, 2454.9631755523683, 2480.032787212979, 2499.0128899084852, 2283.908643654252, 2284.823315992265, 2309.6420054891437, 2385.8449200802065, 2437.3662847659557, 2452.2152911068465, 2455.9263222103364, 2459.3605662527693, 2465.568525508029, 2470.036685692581, 8638.870416943751, 8681.479111253346, 8732.781680457976, 8734.781630459225, 8734.912650873473, 5377.838664840061, 5466.125419932831, 5480.095784195603, 5506.669599824023, 5521.5306698930235, 3592.2456284180353, 3619.2037751694584, 3674.8346324415197, 3802.8288727007352, 3811.5235595550557, 1140.9372484513349, 1147.5409836065558, 1153.1581945180067, 1181.4329122021393, 1191.8271850581705, 12093.213941093802, 12158.392080395945, 12198.39008049594, 12228.082893783001, 12253.632391028283, 4565.977170114128, 4592.67851250416, 4630.4443466784205, 4645.628349732014, 4662.7202367858035, 9742.902570974342, 9824.90175098254, 9826.263030272758, 9832.803343933225, 9833.065858743408, 5435.592330575223, 5462.808801692001, 5466.070767969455, 5468.699221542854, 5474.644148130359, 4416.050549131888, 4860.513948605111, 4936.234883593049, 4957.132501812169, 5015.498450155028, 3803.6006219347123, 3839.8080095995088, 3891.346177874392, 3896.5518965318784, 3949.822257998397, 1097.961571345015, 1124.3366413815888, 1128.610629332879, 1131.5530365505745, 1132.2017977325966, 1020.4642562654517, 1066.4827558634056, 1081.2539347849959, 1087.9673609791719, 1092.4974511724695, 5902.468777810018, 5910.8817823643285, 5956.434138756811, 6080.300765412034, 6100.023996160593, 466.28425367061396, 467.4414075180127, 469.24217388917333, 470.6282037190581, 484.04884402149946, 4174.624283814472, 4301.978490107529, 4327.545607711208, 4330.350447432847, 4333.739975601474, 10631.84052239217, 10867.29362591429, 10969.0, 11037.11703063753, 11086.889131108746, 10579.0, 10763.3541987481, 10823.891761082288, 10894.0, 10895.945520272506, 8189.795255118551, 8308.0, 8372.455790373606, 8464.830703385898, 8473.830523389497, 5946.13781001761, 5946.286445626552, 5992.610480318765, 5999.430054144849, 6040.607360521552, 9628.229741620513, 9700.320977531504, 9851.655192068243, 9930.25523085757, 9954.352967057119, 9722.27082968766, 9976.20190384753, 9978.151857092229, 10050.195984321383, 10054.798904022025, 6184.938150618436, 6877.449804015767, 7145.356917877416, 7290.781276561712, 7385.224551422023, 8210.137935516685, 8309.252167304972, 8330.708425205088, 8334.416590838584, 8346.499210047417, 7056.364927156375, 7385.630718463948, 7398.3341499265325, 7419.777406677593, 7509.924900751141, 7368.226336234832, 7589.962050189934, 7709.0, 7719.343855772097, 7918.089419716806, 7000.929990700028, 7031.1211098612675, 7036.2260151384335, 7094.077769889881, 7100.183478899992, 5109.565686916654, 5152.330197074506, 5341.41244463101, 5345.438728933406, 5356.384015838228, 5339.172428273624, 5360.222767698584, 5371.40914499397, 5388.757505912165, 5613.522850557748], "value": 4597.979989979493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.48885516456414, 332.9950050749238, 339.8300849575213, 345.61636583392414, 349.5857408970369, 6597.307282735315, 6677.565958212713, 6687.398134167924, 6717.563358381702, 6757.966210168955, 6593.769218077368, 6644.235912870022, 6647.800565983016, 6651.900221496681, 6687.364700353459, 4706.882327941812, 4795.640326975474, 4931.827386041489, 4957.702537847723, 4966.652334336598, 4892.77982490787, 4895.926561101586, 4932.876678083058, 4934.40787105546, 4942.456329803718, 4870.853874383774, 4899.338589290436, 4915.631327650441, 4917.483664215241, 4918.336024636682, 4915.041566894457, 4929.901401971976, 4936.5063493650705, 4938.80244790208, 4944.901101977976, 4302.139572085595, 4302.483701955754, 4314.3528470729325, 4318.201132790412, 4320.891977700551, 6175.413335733098, 6347.80956571299, 6358.7774427895265, 6382.808515744535, 6396.136521569575, 5795.391483894173, 5808.796692115756, 5830.737616807254, 5833.445822646841, 5834.941650583482, 6946.548474349152, 6983.0, 7010.088688470517, 7010.929890701079, 7015.719371225145, 4751.714897106184, 4770.189067858472, 4787.066522028206, 4793.9280910786365, 4820.566149046603, 7270.563766173994, 7336.156342020682, 7356.668949897214, 7357.3746231570385, 7383.926160738378, 4642.837500687459, 4759.595434388047, 4788.090262850047, 4796.784144713496, 4812.711237325771, 4813.374261346073, 4840.0, 4841.419029716457, 4844.32179494871, 4863.829765958175, 5687.345955215121, 5688.175214593944, 5703.914441283384, 5707.715763953077, 5709.7716091356715, 6987.231404545496, 7045.295470453017, 7045.612491312924, 7053.118360204974, 7085.751998680022, 1683.1079527850259, 1696.6776312500585, 1698.1933581548665, 1700.846923776866, 1703.608170120879, 1066.9786604267872, 1118.3737107219983, 1136.1535655936216, 1174.2250114924109, 1176.2472017908544, 6693.832654183684, 6704.161979752531, 6712.664366781739, 6728.764493242713, 6731.091302674175, 7060.682269297894, 7097.716091356391, 7167.784966451015, 7230.746923857745, 7258.129024516986, 6919.308069193041, 6934.0, 6934.0, 6962.965185174143, 7020.403265722369, 3939.5863434339553, 3975.264576053439, 3988.980055099706, 3992.940105898414, 3993.1614360983936, 7599.582022988679, 7676.078870535572, 7683.1548529661695, 7689.615519224017, 7690.538567685957, 7307.744228952068, 7447.702091916371, 7469.775906722807, 7499.662515186829, 7508.511946723445, 7503.924960750432, 7546.99999999989, 7621.733239336597, 7625.275598818103, 7652.081750190013, 7293.301478453006, 7294.197638259681, 7295.8540829184185, 7355.816104597214, 7355.852882942419, 7188.748393806401, 7241.167265764505, 7245.7826265212125, 7256.96371518139, 7262.96368518154, 7438.73964411243, 7641.88537171954, 7654.885176722242, 7656.196099409704, 7675.194104619158, 4717.693349932243, 4725.763711814464, 4739.90982074118, 4771.427428708577, 4794.256890182028, 7315.817104572428, 7336.486445948733, 7340.926590734024, 7349.77950661481, 7356.705731770669, 7027.086478757728, 7071.222165561681, 7106.111736032996, 7143.249958754256, 7153.105861767279, 6876.312368763083, 7046.365827075588, 7057.0472986146215, 7092.148942126978, 7110.5022648414115, 6966.686499107654, 6969.407600353824, 6970.442364610718, 6977.441804655514, 6979.2671769465505, 7133.108361454818, 7139.964300178466, 7141.750038748619, 7143.107111611049, 7157.212706602166, 6907.89638155418, 6969.756058537927, 6970.825729356807, 6975.162980442379, 6979.616121113185], "value": 5251.708150719022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.2003876375587, 936.8407370746972, 944.3767113704956, 947.2753343692073, 966.4346357380932, 13585.66035849103, 13821.723565528697, 15460.613484662888, 15569.0, 15570.14364209968, 13579.796303055462, 13592.25242611656, 13680.52118175864, 13682.794758078637, 13714.0400171988, 891.777055736066, 908.9000209976914, 914.3371055984425, 921.216965579259, 929.3540989012639, 918.2883265469281, 923.6997975657938, 925.2829057480473, 925.319889880937, 925.5141050948272, 947.0387556630026, 947.853082772168, 955.7849483866144, 956.9090936361034, 959.596969272907, 946.9053094690511, 948.7390967483963, 948.8719022931884, 949.0888746803008, 949.2121539122512, 697.093778088488, 700.8212905709063, 700.8808502554577, 703.1772825793834, 704.2148004974467, 15914.52256432309, 15949.840501595068, 15951.042937423792, 16051.0, 16053.438129665406, 14596.562103136923, 14597.12417254968, 14641.853581464156, 14697.632559185999, 14843.406263749437, 12162.209456385395, 12175.45210465531, 12307.4461649226, 12420.875791242062, 12470.376481175996, 4065.2479291331197, 4071.043304823364, 4087.4890638670167, 4153.0, 4175.144095460423, 57557.0, 57957.42042579562, 58145.41854581442, 58176.70911645457, 58248.70875645637, 10711.571537138427, 10846.566137354575, 11217.270877392943, 11313.264637798517, 11361.488733007034, 20252.392428227176, 20409.591808163754, 20478.488037798877, 20513.17947282122, 20567.280145194847, 8654.177853103945, 8755.255803256667, 8824.426412283181, 8861.867071993925, 9016.23362014223, 4980.800767969313, 4991.800327986913, 5048.318477005557, 5060.924086138711, 5151.948480515147, 3658.0854786303425, 3715.405535114369, 3722.925541489209, 3737.0657335666083, 3739.1773809762353, 638.696619105921, 663.045214890556, 667.8196886840526, 677.7898851356096, 684.5789839248926, 684.2746688510096, 703.0438603499236, 705.7953193573909, 737.2480070328343, 771.155584634824, 9015.729528114167, 9726.756831079138, 9777.120059194707, 9847.415573417224, 9922.553485093189, 761.3186198352444, 798.7044793426469, 800.803803068252, 818.29217726666, 831.6548632317521, 4306.41863348444, 4328.264195086843, 4474.351219073216, 4524.683272170916, 4579.107074120515, 59852.70073649691, 60354.396456035756, 60571.09143362853, 62729.0, 62775.37224627695, 51053.74473127611, 51658.74170629198, 52210.0, 52338.73830630899, 52749.0, 46594.534054659016, 47054.76472617615, 47497.762511187226, 47561.38412387283, 48220.758896205996, 9418.670346537838, 9469.810603787748, 9519.666811661558, 9584.329096963425, 9669.661561845302, 36863.0, 37325.25349493049, 37408.251834963696, 38044.42933355946, 38304.80847595744, 43776.56223437725, 45581.77209113933, 47126.0, 47138.29292560683, 49720.751396242784, 11968.46141923598, 12325.691857703629, 12435.191712538655, 12476.563320283747, 12605.243685378906, 13668.248246346546, 13894.930525347712, 14028.08817426864, 14098.295085245902, 14237.35931883047, 13187.340632968506, 13544.255065971467, 13749.587512374645, 13813.309334533435, 13819.378127984064, 12921.483140674267, 13092.738145237232, 13119.0, 13141.737165256833, 13220.140690855063, 11377.203595748219, 11415.040255240592, 11565.942170289094, 11578.0, 11743.236689615147, 10411.271211015157, 10431.269811113149, 10453.84319235197, 10769.676909692722, 10930.344179349264, 10667.57329706834, 11018.944905275423, 11078.501467433824, 11179.329240245612, 11221.270617409842], "value": 7105.3512110009115, "unit": "score"}], "name": "dromaeo_css", "value": 7581.312747943216, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 105.0, 110.0, 111.0, 111.0, 100.0, 110.0, 112.0, 112.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 159.0, 184.0, 135.0, 158.0, 155.0, 140.0, 174.0, 136.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 163.0, 162.0, 163.0, 162.0, 164.0, 161.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 168.0, 78.0, 77.0, 80.0, 77.0, 158.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 154.0, 92.0, 101.0, 93.0, 152.0, 91.0, 92.0, 145.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 60.0, 55.0, 57.0, 60.0, 55.0, 72.0, 53.0, 53.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 56.0, 58.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 73.0, 83.0, 75.0, 77.0, 76.0, 75.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 119.0, 115.0, 114.0, 122.0, 120.0, 119.0, 128.0, 137.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 157.0, 162.0, 163.0, 158.0, 159.0, 169.0, 160.0, 169.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 67.0, 65.0, 73.0, 66.0, 65.0, 72.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1532.5999999999995, "alertThreshold": 2.0}]} 19:48:49 INFO - Return code: 0 19:48:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:48:49 ERROR - # TBPL SUCCESS # 19:48:49 INFO - Running post-action listener: _resource_record_post_action 19:48:49 INFO - Running post-run listener: _resource_record_post_run 19:48:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7946240; Write bytes: 389713920; Read time: 2304; Write time: 493524 19:48:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4624384; Read time: 0; Write time: 408 19:48:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 7946240; Write bytes: 366829568; Read time: 2304; Write time: 480112 19:48:50 INFO - Running post-run listener: _upload_blobber_files 19:48:50 INFO - Blob upload gear active. 19:48:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:50 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 19:48:50 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:48:50 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:48:51 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:52 INFO - (blobuploader) - INFO - Done attempting. 19:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:52 INFO - (blobuploader) - INFO - Done attempting. 19:48:52 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:52 INFO - Return code: 0 19:48:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6ea7cbe426e9872fe78d7e68d0ccbdddadb208581d56e93c9f7c4bd859001f317b65b42dc92f34820c402369bfef14bae09f693c475d62fe04d4df98f0fe574", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650c92a84d20df94542a0b6973d400d030ed1e620d2ae9a9c0ccd3e4d5bdee0c2bcf42a991915a9e2c3c2931e2b8b36e34932906cc338629b40794d0b7cc1ccc"} 19:48:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:52 INFO - Contents: 19:48:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6ea7cbe426e9872fe78d7e68d0ccbdddadb208581d56e93c9f7c4bd859001f317b65b42dc92f34820c402369bfef14bae09f693c475d62fe04d4df98f0fe574", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650c92a84d20df94542a0b6973d400d030ed1e620d2ae9a9c0ccd3e4d5bdee0c2bcf42a991915a9e2c3c2931e2b8b36e34932906cc338629b40794d0b7cc1ccc"} 19:48:52 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:52 INFO - Copying logs to upload dir... 19:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.621602 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-12 19:48:52.848083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 19:48:52.851998) ========= 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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6ea7cbe426e9872fe78d7e68d0ccbdddadb208581d56e93c9f7c4bd859001f317b65b42dc92f34820c402369bfef14bae09f693c475d62fe04d4df98f0fe574", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650c92a84d20df94542a0b6973d400d030ed1e620d2ae9a9c0ccd3e4d5bdee0c2bcf42a991915a9e2c3c2931e2b8b36e34932906cc338629b40794d0b7cc1ccc"} build_url:https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/PfEhO9qWRgS3j32gco48QQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6ea7cbe426e9872fe78d7e68d0ccbdddadb208581d56e93c9f7c4bd859001f317b65b42dc92f34820c402369bfef14bae09f693c475d62fe04d4df98f0fe574", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/650c92a84d20df94542a0b6973d400d030ed1e620d2ae9a9c0ccd3e4d5bdee0c2bcf42a991915a9e2c3c2931e2b8b36e34932906cc338629b40794d0b7cc1ccc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 19:48:52.895681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:48:52.896009) ========= 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=52faae308a556c440401f8e5000001e8-1463100988.536791-73939675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:48:52.976405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 19:48:52.977163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 19:48:52.977699) ========= ========= Total master_lag: 0.18 =========