builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1465501814.53 results: success (0) buildid: 20160609095529 builduid: 50260888102748178194f2d93b146567 revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.528687) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.529379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.529852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.547979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.548328) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 12:50:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-06-09 12:50:14 (18.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.664903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.665222) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020902 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:14.714072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 12:50:14.714659) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --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-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 12:50:14,994 truncating revision to first 12 chars 2016-06-09 12:50:14,994 Setting DEBUG logging. 2016-06-09 12:50:14,994 attempt 1/10 2016-06-09 12:50:14,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a23a6103b9be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 12:50:15,979 unpacking tar archive at: mozilla-beta-a23a6103b9be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 12:50:16.053489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:16.053802) ========= script_repo_revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:16.054203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:16.054513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:50:16.064888) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-09 12:50:16.065332) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:16 INFO - MultiFileLogger online at 20160609 12:50:16 in /builds/slave/test 12:50:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:16 INFO - {'append_to_log': False, 12:50:16 INFO - 'base_work_dir': '/builds/slave/test', 12:50:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:16 INFO - 'branch': 'Mozilla-Beta', 12:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:16 INFO - 'config_files': ('talos/linux_config.py',), 12:50:16 INFO - 'default_actions': ('clobber', 12:50:16 INFO - 'read-buildbot-config', 12:50:16 INFO - 'download-and-extract', 12:50:16 INFO - 'populate-webroot', 12:50:16 INFO - 'create-virtualenv', 12:50:16 INFO - 'install', 12:50:16 INFO - 'run-tests'), 12:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:16 INFO - 'download_minidump_stackwalk': True, 12:50:16 INFO - 'download_symbols': 'ondemand', 12:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:16 INFO - 'installer_path': 'installer.exe', 12:50:16 INFO - 'log_level': 'info', 12:50:16 INFO - 'log_name': 'talos', 12:50:16 INFO - 'log_to_console': True, 12:50:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:16 INFO - 'opt_config_files': (), 12:50:16 INFO - 'pip_index': False, 12:50:16 INFO - 'sps_profile': False, 12:50:16 INFO - 'sps_profile_interval': 0, 12:50:16 INFO - 'suite': 'dromaeojs-e10s', 12:50:16 INFO - 'system_bits': '32', 12:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:16 INFO - 'title': 'talos-linux64-ix-062', 12:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:16 INFO - 'use_talos_json': True, 12:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:16 INFO - 'work_dir': 'build'} 12:50:16 INFO - ##### 12:50:16 INFO - ##### Running clobber step. 12:50:16 INFO - ##### 12:50:16 INFO - Running pre-action listener: _resource_record_pre_action 12:50:16 INFO - Running main action method: clobber 12:50:16 INFO - rmtree: /builds/slave/test/build 12:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:17 INFO - Running post-action listener: _resource_record_post_action 12:50:17 INFO - ##### 12:50:17 INFO - ##### Running read-buildbot-config step. 12:50:17 INFO - ##### 12:50:17 INFO - Running pre-action listener: _resource_record_pre_action 12:50:17 INFO - Running main action method: read_buildbot_config 12:50:17 INFO - Using buildbot properties: 12:50:17 INFO - { 12:50:17 INFO - "project": "", 12:50:17 INFO - "product": "firefox", 12:50:17 INFO - "script_repo_revision": "production", 12:50:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:50:17 INFO - "repository": "", 12:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:50:17 INFO - "buildid": "20160609095529", 12:50:17 INFO - "pgo_build": "True", 12:50:17 INFO - "basedir": "/builds/slave/test", 12:50:17 INFO - "buildnumber": 8, 12:50:17 INFO - "slavename": "talos-linux64-ix-062", 12:50:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:50:17 INFO - "platform": "ubuntu64_hw", 12:50:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:50:17 INFO - "branch": "mozilla-beta", 12:50:17 INFO - "repo_path": "releases/mozilla-beta", 12:50:17 INFO - "revision": "a23a6103b9bef3d80874d74e2278ee47b458ed87", 12:50:17 INFO - "stage_platform": "linux64-pgo", 12:50:17 INFO - "builduid": "50260888102748178194f2d93b146567", 12:50:17 INFO - "slavebuilddir": "test" 12:50:17 INFO - } 12:50:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:50:17 INFO - Running post-action listener: _resource_record_post_action 12:50:17 INFO - ##### 12:50:17 INFO - ##### Running download-and-extract step. 12:50:17 INFO - ##### 12:50:17 INFO - Running pre-action listener: _resource_record_pre_action 12:50:17 INFO - Running main action method: download_and_extract 12:50:17 INFO - mkdir: /builds/slave/test/build/tests 12:50: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')]} 12:50:17 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:50:18 INFO - Downloaded 1327 bytes. 12:50:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:50:18 INFO - Using the following test package requirements: 12:50:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:50:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:50:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:50:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'jsshell-linux-x86_64.zip'], 12:50:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:50:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:50:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:50:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:50:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:50:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:50:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:50:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:50:18 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')]} 12:50:18 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:19 INFO - Downloaded 24178211 bytes. 12:50:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:50:21 INFO - Return code: 0 12:50:21 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:50:21 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')]} 12:50:21 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:50:22 INFO - Downloaded 24178211 bytes. 12:50:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:50:23 INFO - Return code: 0 12:50:23 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')]} 12:50:23 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:50:24 INFO - Downloaded 10840145 bytes. 12:50:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:50:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:50:25 INFO - Return code: 0 12:50:25 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')]} 12:50:25 INFO - https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:50:26 INFO - Downloaded 56011965 bytes. 12:50:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:26 INFO - mkdir: /builds/slave/test/properties 12:50:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:26 INFO - Contents: 12:50:26 INFO - build_url:https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:50:27 INFO - Running post-action listener: _resource_record_post_action 12:50:27 INFO - Running post-action listener: set_extra_try_arguments 12:50:27 INFO - ##### 12:50:27 INFO - ##### Running populate-webroot step. 12:50:27 INFO - ##### 12:50:27 INFO - Running pre-action listener: _resource_record_pre_action 12:50:27 INFO - Running main action method: populate_webroot 12:50:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:27 INFO - '--tppagecycles', 12:50:27 INFO - '7'], 12:50:27 INFO - 'tests': ['tsvgm']}}, 12:50:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['damp', 'tps']}, 12:50:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'tests': ['damp', 'tps']}, 12:50:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['dromaeo_dom']}, 12:50:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['a11yr', 12:50:27 INFO - 'ts_paint', 12:50:27 INFO - 'tpaint', 12:50:27 INFO - 'sessionrestore', 12:50:27 INFO - 'sessionrestore_no_auto_restore', 12:50:27 INFO - 'tabpaint']}, 12:50:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['tsvgx', 12:50:27 INFO - 'tsvgr_opacity', 12:50:27 INFO - 'tart', 12:50:27 INFO - 'tscrollx', 12:50:27 INFO - 'cart']}, 12:50:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:27 INFO - 'tsvgr_opacity', 12:50:27 INFO - 'tart', 12:50:27 INFO - 'tscrollx', 12:50:27 INFO - 'cart']}, 12:50:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'talos_options': ['--disable-e10s'], 12:50:27 INFO - 'tests': ['tp5o']}, 12:50:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'tests': ['tp5o']}, 12:50:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'talos_options': ['--disable-e10s', 12:50:27 INFO - '--xperf_path', 12:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:27 INFO - 'tests': ['tp5n']}, 12:50:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:27 INFO - 'talos_options': ['--xperf_path', 12:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:27 INFO - 'tests': ['tp5n']}}, 12:50:27 INFO - 'talos.zip': {'path': '', 12:50:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:27 INFO - Running post-action listener: _resource_record_post_action 12:50:27 INFO - ##### 12:50:27 INFO - ##### Running create-virtualenv step. 12:50:27 INFO - ##### 12:50:27 INFO - Running pre-action listener: _resource_record_pre_action 12:50:27 INFO - Running main action method: create_virtualenv 12:50:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:27 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 12:50:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:27 INFO - Using real prefix '/usr' 12:50:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:30 INFO - Installing pip.................done. 12:50:30 INFO - Return code: 0 12:50:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:30 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')]} 12:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:30 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')]} 12:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:30 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:30 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 12:50:30 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 12:50:30 INFO - Using env: {'DISPLAY': ':0', 12:50:30 INFO - 'HOME': '/home/cltbld', 12:50:30 INFO - 'LANG': 'en_US.UTF-8', 12:50:30 INFO - 'LANGUAGE': 'en_US:en', 12:50:30 INFO - 'LOGNAME': 'cltbld', 12:50:30 INFO - 'MAIL': '/var/mail/cltbld', 12:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:30 INFO - 'MOZ_NO_REMOTE': '1', 12:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:30 INFO - 'NO_EM_RESTART': '1', 12:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:30 INFO - 'PWD': '/builds/slave/test', 12:50:30 INFO - 'SHELL': '/bin/bash', 12:50:30 INFO - 'SHLVL': '1', 12:50:30 INFO - 'TERM': 'linux', 12:50:30 INFO - 'TMOUT': '86400', 12:50:30 INFO - 'USER': 'cltbld', 12:50:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:30 INFO - '_': '/tools/buildbot/bin/python'} 12:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:30 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 12:50:30 INFO - Cleaning up... 12:50:30 INFO - Return code: 0 12:50:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50:30 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')]} 12:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:30 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')]} 12:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:30 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:30 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 12:50:30 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 12:50:30 INFO - Using env: {'DISPLAY': ':0', 12:50:30 INFO - 'HOME': '/home/cltbld', 12:50:30 INFO - 'LANG': 'en_US.UTF-8', 12:50:30 INFO - 'LANGUAGE': 'en_US:en', 12:50:30 INFO - 'LOGNAME': 'cltbld', 12:50:30 INFO - 'MAIL': '/var/mail/cltbld', 12:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:30 INFO - 'MOZ_NO_REMOTE': '1', 12:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:30 INFO - 'NO_EM_RESTART': '1', 12:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:30 INFO - 'PWD': '/builds/slave/test', 12:50:30 INFO - 'SHELL': '/bin/bash', 12:50:30 INFO - 'SHLVL': '1', 12:50:30 INFO - 'TERM': 'linux', 12:50:30 INFO - 'TMOUT': '86400', 12:50:30 INFO - 'USER': 'cltbld', 12:50:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:30 INFO - '_': '/tools/buildbot/bin/python'} 12:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:30 INFO - Downloading/unpacking psutil>=0.7.1 12:50:30 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 12:50:30 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 12:50:30 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 12:50:30 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 12:50:30 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 12:50:30 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 12:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:32 INFO - Installing collected packages: psutil 12:50:32 INFO - Running setup.py install for psutil 12:50:32 INFO - building 'psutil._psutil_linux' extension 12:50:32 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 12:50:33 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 12:50:33 INFO - building 'psutil._psutil_posix' extension 12:50:33 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 12:50:33 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 12:50:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:33 INFO - Successfully installed psutil 12:50:33 INFO - Cleaning up... 12:50:33 INFO - Return code: 0 12:50:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50:33 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')]} 12:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:33 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')]} 12:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:33 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:33 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 12:50:33 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 12:50:33 INFO - Using env: {'DISPLAY': ':0', 12:50:33 INFO - 'HOME': '/home/cltbld', 12:50:33 INFO - 'LANG': 'en_US.UTF-8', 12:50:33 INFO - 'LANGUAGE': 'en_US:en', 12:50:33 INFO - 'LOGNAME': 'cltbld', 12:50:33 INFO - 'MAIL': '/var/mail/cltbld', 12:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:33 INFO - 'MOZ_NO_REMOTE': '1', 12:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:33 INFO - 'NO_EM_RESTART': '1', 12:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:33 INFO - 'PWD': '/builds/slave/test', 12:50:33 INFO - 'SHELL': '/bin/bash', 12:50:33 INFO - 'SHLVL': '1', 12:50:33 INFO - 'TERM': 'linux', 12:50:33 INFO - 'TMOUT': '86400', 12:50:33 INFO - 'USER': 'cltbld', 12:50:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:33 INFO - '_': '/tools/buildbot/bin/python'} 12:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:33 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 12:50:33 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 12:50:33 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 12:50:33 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 12:50:33 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 12:50:33 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 12:50:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:50:35 INFO - Installing collected packages: mozsystemmonitor 12:50:35 INFO - Running setup.py install for mozsystemmonitor 12:50:35 INFO - Successfully installed mozsystemmonitor 12:50:35 INFO - Cleaning up... 12:50:35 INFO - Return code: 0 12:50:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:50:35 INFO - Using env: {'DISPLAY': ':0', 12:50:35 INFO - 'HOME': '/home/cltbld', 12:50:35 INFO - 'LANG': 'en_US.UTF-8', 12:50:35 INFO - 'LANGUAGE': 'en_US:en', 12:50:35 INFO - 'LOGNAME': 'cltbld', 12:50:35 INFO - 'MAIL': '/var/mail/cltbld', 12:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:35 INFO - 'MOZ_NO_REMOTE': '1', 12:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:35 INFO - 'NO_EM_RESTART': '1', 12:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:35 INFO - 'PWD': '/builds/slave/test', 12:50:35 INFO - 'SHELL': '/bin/bash', 12:50:35 INFO - 'SHLVL': '1', 12:50:35 INFO - 'TERM': 'linux', 12:50:35 INFO - 'TMOUT': '86400', 12:50:35 INFO - 'USER': 'cltbld', 12:50:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:35 INFO - '_': '/tools/buildbot/bin/python'} 12:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:39 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 12:50:39 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 12:50:39 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 12:50:39 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 12:50:39 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 12:50:39 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 12:50:39 INFO - Downloading docopt-0.6.1.tar.gz 12:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:39 INFO - Running setup.py install for blobuploader 12:50:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:39 INFO - Running setup.py install for requests 12:50:39 INFO - Running setup.py install for docopt 12:50:40 INFO - Successfully installed blobuploader requests docopt 12:50:40 INFO - Cleaning up... 12:50:40 INFO - Return code: 0 12:50:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:40 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:40 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 12:50:40 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 12:50:40 INFO - Using env: {'DISPLAY': ':0', 12:50:40 INFO - 'HOME': '/home/cltbld', 12:50:40 INFO - 'LANG': 'en_US.UTF-8', 12:50:40 INFO - 'LANGUAGE': 'en_US:en', 12:50:40 INFO - 'LOGNAME': 'cltbld', 12:50:40 INFO - 'MAIL': '/var/mail/cltbld', 12:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:40 INFO - 'MOZ_NO_REMOTE': '1', 12:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:40 INFO - 'NO_EM_RESTART': '1', 12:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:40 INFO - 'PWD': '/builds/slave/test', 12:50:40 INFO - 'SHELL': '/bin/bash', 12:50:40 INFO - 'SHLVL': '1', 12:50:40 INFO - 'TERM': 'linux', 12:50:40 INFO - 'TMOUT': '86400', 12:50:40 INFO - 'USER': 'cltbld', 12:50:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:40 INFO - '_': '/tools/buildbot/bin/python'} 12:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:40 INFO - Running setup.py (path:/tmp/pip-RKXyJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:40 INFO - Running setup.py (path:/tmp/pip-_awb0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:40 INFO - Running setup.py (path:/tmp/pip-AsUTl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:40 INFO - Running setup.py (path:/tmp/pip-fl6BN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:40 INFO - Running setup.py (path:/tmp/pip-vFImuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:40 INFO - Running setup.py (path:/tmp/pip-vedGbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:40 INFO - Running setup.py (path:/tmp/pip-1S2Gku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:40 INFO - Running setup.py (path:/tmp/pip-4iPJ1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:40 INFO - Running setup.py (path:/tmp/pip-VBUuJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:40 INFO - Running setup.py (path:/tmp/pip-saqWms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:41 INFO - Running setup.py (path:/tmp/pip-MQnPk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:41 INFO - Running setup.py (path:/tmp/pip-ONgwjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:41 INFO - Running setup.py (path:/tmp/pip-RhvmbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:41 INFO - Running setup.py (path:/tmp/pip-3NMEdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:41 INFO - Running setup.py (path:/tmp/pip-D7urFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:41 INFO - Running setup.py (path:/tmp/pip-0H91JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:41 INFO - Running setup.py (path:/tmp/pip-ueB8Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:41 INFO - Running setup.py install for manifestparser 12:50:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Running setup.py install for mozcrash 12:50:41 INFO - Running setup.py install for mozdebug 12:50:41 INFO - Running setup.py install for mozdevice 12:50:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:41 INFO - Running setup.py install for mozfile 12:50:42 INFO - Running setup.py install for mozhttpd 12:50:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozinfo 12:50:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozInstall 12:50:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozleak 12:50:42 INFO - Running setup.py install for mozlog 12:50:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for moznetwork 12:50:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozprocess 12:50:42 INFO - Running setup.py install for mozprofile 12:50:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:50:42 INFO - Running setup.py install for mozrunner 12:50:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:50:43 INFO - Running setup.py install for mozscreenshot 12:50:43 INFO - Running setup.py install for moztest 12:50:43 INFO - Running setup.py install for mozversion 12:50:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:50:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:50:43 INFO - Cleaning up... 12:50:43 INFO - Return code: 0 12:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:43 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:43 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 12:50:43 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 12:50:43 INFO - Using env: {'DISPLAY': ':0', 12:50:43 INFO - 'HOME': '/home/cltbld', 12:50:43 INFO - 'LANG': 'en_US.UTF-8', 12:50:43 INFO - 'LANGUAGE': 'en_US:en', 12:50:43 INFO - 'LOGNAME': 'cltbld', 12:50:43 INFO - 'MAIL': '/var/mail/cltbld', 12:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:43 INFO - 'MOZ_NO_REMOTE': '1', 12:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:43 INFO - 'NO_EM_RESTART': '1', 12:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:43 INFO - 'PWD': '/builds/slave/test', 12:50:43 INFO - 'SHELL': '/bin/bash', 12:50:43 INFO - 'SHLVL': '1', 12:50:43 INFO - 'TERM': 'linux', 12:50:43 INFO - 'TMOUT': '86400', 12:50:43 INFO - 'USER': 'cltbld', 12:50:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:43 INFO - '_': '/tools/buildbot/bin/python'} 12:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:43 INFO - Running setup.py (path:/tmp/pip-qejKj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:43 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)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:43 INFO - Running setup.py (path:/tmp/pip-lGn0Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:43 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)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:43 INFO - Running setup.py (path:/tmp/pip-7YC6J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:43 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)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:43 INFO - Running setup.py (path:/tmp/pip-m5oeyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:43 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)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:43 INFO - Running setup.py (path:/tmp/pip-H4rxmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:43 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)) 12:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:43 INFO - Running setup.py (path:/tmp/pip-nHnEYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:44 INFO - Running setup.py (path:/tmp/pip-UYF9Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:44 INFO - Running setup.py (path:/tmp/pip-mGH9Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:44 INFO - Running setup.py (path:/tmp/pip-VAXEIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:44 INFO - Running setup.py (path:/tmp/pip-B9_89x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:44 INFO - Running setup.py (path:/tmp/pip-dAwCVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:44 INFO - Running setup.py (path:/tmp/pip-JKvFol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:44 INFO - Running setup.py (path:/tmp/pip-oBfxI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:44 INFO - Running setup.py (path:/tmp/pip-7pGdyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:44 INFO - Running setup.py (path:/tmp/pip-vmYJjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:44 INFO - Running setup.py (path:/tmp/pip-AS7BN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:44 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)) 12:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:44 INFO - Running setup.py (path:/tmp/pip-EjCRI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:44 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)) 12:50:44 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)) 12:50:44 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)) 12:50:44 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)) 12:50:44 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)) 12:50:44 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)) 12:50:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:44 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 12:50:44 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 12:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:46 INFO - Downloading blessings-1.6.tar.gz 12:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:50:46 INFO - Installing collected packages: blessings 12:50:46 INFO - Running setup.py install for blessings 12:50:46 INFO - Successfully installed blessings 12:50:46 INFO - Cleaning up... 12:50:46 INFO - Return code: 0 12:50:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:47 INFO - Reading from file tmpfile_stdout 12:50:47 INFO - Current package versions: 12:50:47 INFO - argparse == 1.2.1 12:50:47 INFO - blessings == 1.6 12:50:47 INFO - blobuploader == 1.2.4 12:50:47 INFO - docopt == 0.6.1 12:50:47 INFO - manifestparser == 1.1 12:50:47 INFO - mozInstall == 1.12 12:50:47 INFO - mozcrash == 0.17 12:50:47 INFO - mozdebug == 0.1 12:50:47 INFO - mozdevice == 0.48 12:50:47 INFO - mozfile == 1.2 12:50:47 INFO - mozhttpd == 0.7 12:50:47 INFO - mozinfo == 0.9 12:50:47 INFO - mozleak == 0.1 12:50:47 INFO - mozlog == 3.1 12:50:47 INFO - moznetwork == 0.27 12:50:47 INFO - mozprocess == 0.22 12:50:47 INFO - mozprofile == 0.28 12:50:47 INFO - mozrunner == 6.11 12:50:47 INFO - mozscreenshot == 0.1 12:50:47 INFO - mozsystemmonitor == 0.0 12:50:47 INFO - moztest == 0.7 12:50:47 INFO - mozversion == 1.4 12:50:47 INFO - psutil == 3.1.1 12:50:47 INFO - requests == 1.2.3 12:50:47 INFO - wsgiref == 0.1.2 12:50:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:47 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 12:50:47 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 12:50:47 INFO - Using env: {'DISPLAY': ':0', 12:50:47 INFO - 'HOME': '/home/cltbld', 12:50:47 INFO - 'LANG': 'en_US.UTF-8', 12:50:47 INFO - 'LANGUAGE': 'en_US:en', 12:50:47 INFO - 'LOGNAME': 'cltbld', 12:50:47 INFO - 'MAIL': '/var/mail/cltbld', 12:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:47 INFO - 'MOZ_NO_REMOTE': '1', 12:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:47 INFO - 'NO_EM_RESTART': '1', 12:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:47 INFO - 'PWD': '/builds/slave/test', 12:50:47 INFO - 'SHELL': '/bin/bash', 12:50:47 INFO - 'SHLVL': '1', 12:50:47 INFO - 'TERM': 'linux', 12:50:47 INFO - 'TMOUT': '86400', 12:50:47 INFO - 'USER': 'cltbld', 12:50:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:47 INFO - '_': '/tools/buildbot/bin/python'} 12:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 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)) 12:50:47 INFO - Cleaning up... 12:50:47 INFO - Return code: 0 12:50:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:47 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 12:50:47 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 12:50:47 INFO - Using env: {'DISPLAY': ':0', 12:50:47 INFO - 'HOME': '/home/cltbld', 12:50:47 INFO - 'LANG': 'en_US.UTF-8', 12:50:47 INFO - 'LANGUAGE': 'en_US:en', 12:50:47 INFO - 'LOGNAME': 'cltbld', 12:50:47 INFO - 'MAIL': '/var/mail/cltbld', 12:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:47 INFO - 'MOZ_NO_REMOTE': '1', 12:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:47 INFO - 'NO_EM_RESTART': '1', 12:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:47 INFO - 'PWD': '/builds/slave/test', 12:50:47 INFO - 'SHELL': '/bin/bash', 12:50:47 INFO - 'SHLVL': '1', 12:50:47 INFO - 'TERM': 'linux', 12:50:47 INFO - 'TMOUT': '86400', 12:50:47 INFO - 'USER': 'cltbld', 12:50:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:47 INFO - '_': '/tools/buildbot/bin/python'} 12:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:47 INFO - Downloading/unpacking jsonschema 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:47 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 12:50:47 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 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:49 INFO - Downloading/unpacking functools32 (from jsonschema) 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:49 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 12:50:49 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 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:49 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:49 INFO - warning: no files found matching '*.txt' 12:50:49 INFO - no previously-included directories found matching 'build' 12:50:49 INFO - no previously-included directories found matching 'dist' 12:50:49 INFO - no previously-included directories found matching '.git*' 12:50:49 INFO - Installing collected packages: jsonschema, functools32 12:50:49 INFO - Running setup.py install for functools32 12:50:49 INFO - warning: no files found matching '*.txt' 12:50:49 INFO - no previously-included directories found matching 'build' 12:50:49 INFO - no previously-included directories found matching 'dist' 12:50:49 INFO - no previously-included directories found matching '.git*' 12:50:49 INFO - Successfully installed jsonschema functools32 12:50:49 INFO - Cleaning up... 12:50:50 INFO - Return code: 0 12:50:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fc572e60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', '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 12:50:50 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 12:50:50 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 12:50:50 INFO - Using env: {'DISPLAY': ':0', 12:50:50 INFO - 'HOME': '/home/cltbld', 12:50:50 INFO - 'LANG': 'en_US.UTF-8', 12:50:50 INFO - 'LANGUAGE': 'en_US:en', 12:50:50 INFO - 'LOGNAME': 'cltbld', 12:50:50 INFO - 'MAIL': '/var/mail/cltbld', 12:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:50 INFO - 'MOZ_NO_REMOTE': '1', 12:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:50 INFO - 'NO_EM_RESTART': '1', 12:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:50 INFO - 'PWD': '/builds/slave/test', 12:50:50 INFO - 'SHELL': '/bin/bash', 12:50:50 INFO - 'SHLVL': '1', 12:50:50 INFO - 'TERM': 'linux', 12:50:50 INFO - 'TMOUT': '86400', 12:50:50 INFO - 'USER': 'cltbld', 12:50:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:50 INFO - '_': '/tools/buildbot/bin/python'} 12:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:50 INFO - Downloading/unpacking flake8 12:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:50 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 12:50:50 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 12:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:50:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:50:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:50:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:50:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:50:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:50:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:50:52 INFO - no previously-included directories found matching 'docs/_build' 12:50:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:50:52 INFO - Running setup.py install for pep8 12:50:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:50:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:50:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:50:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:50:52 INFO - no previously-included directories found matching 'docs/_build' 12:50:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:50:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:50:52 INFO - Cleaning up... 12:50:53 INFO - Return code: 0 12:50:53 INFO - Running post-action listener: _resource_record_post_action 12:50:53 INFO - Running post-action listener: _start_resource_monitoring 12:50:53 INFO - Starting resource monitoring. 12:50:53 INFO - ##### 12:50:53 INFO - ##### Running install step. 12:50:53 INFO - ##### 12:50:53 INFO - Running pre-action listener: _resource_record_pre_action 12:50:53 INFO - Running main action method: install 12:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:50:53 INFO - Reading from file tmpfile_stdout 12:50:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:50:53 INFO - Reading from file tmpfile_stdout 12:50:53 INFO - Output received: 12:50:53 INFO - Usage: mozinstall [options] installer 12:50:53 INFO - Options: 12:50:53 INFO - -h, --help show this help message and exit 12:50:53 INFO - -d DEST, --destination=DEST 12:50:53 INFO - Directory to install application into. [default: 12:50:53 INFO - "/builds/slave/test"] 12:50:53 INFO - --app=APP Application being installed. [default: firefox] 12:50:53 INFO - mkdir: /builds/slave/test/build/application 12:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:51:06 INFO - Reading from file tmpfile_stdout 12:51:06 INFO - Output received: 12:51:06 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:06 INFO - Running post-action listener: _resource_record_post_action 12:51:06 INFO - ##### 12:51:06 INFO - ##### Running run-tests step. 12:51:06 INFO - ##### 12:51:06 INFO - Running pre-action listener: _resource_record_pre_action 12:51:06 INFO - Running main action method: run_tests 12:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:06 INFO - Python 2.7.3 12:51:06 INFO - Return code: 0 12:51:06 INFO - grabbing minidump binary from tooltool 12:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:51:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b6410>, '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 0x18b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:51:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:51:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:06 INFO - Return code: 0 12:51:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:07 INFO - Return code: 0 12:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 12:51:07 INFO - Using env: {'DISPLAY': ':0', 12:51:07 INFO - 'HOME': '/home/cltbld', 12:51:07 INFO - 'LANG': 'en_US.UTF-8', 12:51:07 INFO - 'LANGUAGE': 'en_US:en', 12:51:07 INFO - 'LOGNAME': 'cltbld', 12:51:07 INFO - 'MAIL': '/var/mail/cltbld', 12:51:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:07 INFO - 'MOZ_NO_REMOTE': '1', 12:51:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:07 INFO - 'NO_EM_RESTART': '1', 12:51:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:07 INFO - 'PWD': '/builds/slave/test', 12:51:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:07 INFO - 'SHELL': '/bin/bash', 12:51:07 INFO - 'SHLVL': '1', 12:51:07 INFO - 'TERM': 'linux', 12:51:07 INFO - 'TMOUT': '86400', 12:51:07 INFO - 'USER': 'cltbld', 12:51:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038', 12:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:07 INFO - '_': '/tools/buildbot/bin/python'} 12:51:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:51:07 INFO - mozversion application_buildid: 20160609095529 12:51:07 INFO - mozversion application_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:51:07 INFO - mozversion application_display_name: Firefox 12:51:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:07 INFO - mozversion application_name: Firefox 12:51:07 INFO - mozversion application_remotingname: firefox 12:51:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:07 INFO - mozversion application_vendor: Mozilla 12:51:07 INFO - mozversion application_version: 48.0 12:51:07 INFO - mozversion platform_buildid: 20160609095529 12:51:07 INFO - mozversion platform_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:51:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:07 INFO - mozversion platform_version: 48.0 12:51:07 INFO - using testdate: 1465501867 12:51:07 INFO - actual date: 1465501867 12:51:07 INFO - starting webserver on 'localhost:35844' 12:51:07 INFO - SUITE-START | Running 2 tests 12:51:07 INFO - TEST-START | dromaeo_css 12:51:07 INFO - operating with platform_type : linux_ 12:51:07 INFO - Initialising browser for dromaeo_css test... 12:51:07 INFO - TEST-INFO | started process 16713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9W5Buj/profile http://localhost:35844/getInfo.html) 12:51:11 INFO - PROCESS | 16713 | 12:51:11 INFO - PROCESS | 16713 | (process:16791): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:11 INFO - PROCESS | 16713 | __metrics Screen width/height:1600/1200 12:51:11 INFO - PROCESS | 16713 | colorDepth:24 12:51:11 INFO - PROCESS | 16713 | Browser inner width/height: 1024/697 12:51:11 INFO - PROCESS | 16713 | __metrics 12:51:12 ERROR - PROCESS | 16713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 12:51:13 INFO - TEST-INFO | 16713: exit 0 12:51:13 INFO - Browser initialized. 12:51:13 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:13 INFO - TEST-INFO | started process 16841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9W5Buj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:14 INFO - PROCESS | 16841 | 12:51:14 INFO - PROCESS | 16841 | (process:16909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:24 INFO - PROCESS | 16841 | RSS: Main: 151638016 12:51:24 INFO - PROCESS | 16841 | 12:52:14 INFO - PROCESS | 16841 | 1465501934443 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] 12:54:21 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35844/tests/dromaeo/cssquery-ext.html) 12:54:22 INFO - PROCESS | 16841 | RSS: Main: 155418624 12:54:22 INFO - PROCESS | 16841 | 12:57:24 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-ext.html (next: http://localhost:35844/tests/dromaeo/cssquery-jquery.html) 12:57:25 INFO - PROCESS | 16841 | RSS: Main: 153145344 12:57:25 INFO - PROCESS | 16841 | 13:00:26 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35844/tests/dromaeo/cssquery-mootools.html) 13:00:27 INFO - PROCESS | 16841 | RSS: Main: 152973312 13:00:27 INFO - PROCESS | 16841 | 13:03:29 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35844/tests/dromaeo/cssquery-prototype.html) 13:03:29 INFO - PROCESS | 16841 | RSS: Main: 153772032 13:03:29 INFO - PROCESS | 16841 | 13:06:31 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35844/tests/dromaeo/cssquery-yui.html) 13:06:32 INFO - PROCESS | 16841 | RSS: Main: 152813568 13:06:32 INFO - PROCESS | 16841 | 13:09:34 INFO - PROCESS | 16841 | Cycle 1(1): loaded http://localhost:35844/tests/dromaeo/cssquery-yui.html (next: http://localhost:35844/tests/dromaeo/cssquery-dojo.html) 13:09:35 INFO - PROCESS | 16841 | RSS: Main: 156532736 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | __start_tp_report 13:09:35 INFO - PROCESS | 16841 | _x_x_mozilla_page_load 13:09:35 INFO - PROCESS | 16841 | _x_x_mozilla_page_load_details 13:09:35 INFO - PROCESS | 16841 | |i|pagename|runs| 13:09:35 INFO - PROCESS | 16841 | |0;dojo.html;3329.1510664780485;3347.615024272209;3412.3345947540233;3425.965740342596;3436.24402631421;5574.665520068798;5592.916106258409;5658.377578466366;5664.915026274599;5712.971435142818;5601.327840659116;5686.175504551848;5687.118496633018;5704.030314846475;5715.3141623005295;5082.872928176806;5202.479752024805;5202.713850738208;5203.8178663746585;5208.791648334081;5055.418626857903;5142.820001299955;5215.113430716788;5251.921221181686;5287.841364759063;5157.045946499891;5209.583233341343;5214.165733482643;5216.660917040399;5217.660852044605;5132.204508301219;5159.871003224912;5237.528622424;5241.42344342122;5290.735463226823;4999.575036121934;5110.9744451277875;5112.821051263225;5135.460776618439;5162.3030890830005;5578.86052848682;5598.1322894951345;5598.24423702799;5613.989481893258;5652.5195358394585;6074.2103526541705;6097;6110.297315808694;6135.233095863017;6149.969250153766;5913.2608423947;5949.315828679714;5990.490808281302;6094.664793436359;6164.630122192638;5691.51622112121;5692.089265717506;5698.601097923189;5700.714964251771;5741.885162296772;6130.887362651087;6181.320054793969;6199.318075011745;6206.162168107247;6211.409916057967;5824.359320474744;5852.063669812809;5867.295924489089;5875.030619947661;5900.940990590125;5859.2090067841145;5888.352281249059;5903.0260007099205;5934.762609495572;5944.762209511658;5739.8565035874435;5853.385394533598;5892.852678683067;5950.9702451487465;6010.308814486302;6064.818055458255;6072.846159229733;6089.056196289582;6089.269287685417;6113.602615829956;4616.169089563844;4650.255959046604;4655.534446555317;4657.347971284023;4676.08816280822;4029.0531725044593;4110.136871257069;4139.91720165595;4173.853915112956;4204.831806727758;5588.050031494656;5722;5826.300843898759;5828.329742079715;5890.352061273256;6013.248343957005;6044.093385992049;6059.0608455689435;6063.8484037898525;6065.150878876961;5707.343655479673;5731.971340143356;5745.080787074048;5790.942090579125;5801.50687191585;4974.751262436864;5063.670861393997;5092.083424983539;5105.566026887682;5107.540321371094;6272.498200143978;6290.968545157245;6297.27581328144;6310.0534919761485;6313.116163737081;5847.795327163529;6039;6070.1501789750355;6082.847928801815;6087.147799308012;6147.477464415575;6200.3799620037635;6213.409726076015;6215.502759779297;6249.281332646804;5918.319393269829;5919.85200369977;5926.525877929669;5936.436038576328;5952.434518720715;5846.912296315644;6021.157038014594;6033.18551995475;6075.756969721162;6120.204373431426;5931.6441013539325;5954.612950158225;5955.583109182316;5997.460228579449;5998.190244316961;5913.5564832636865;5937.762489500372;5958.225430693982;5982.760689572368;5982.760689572542;5577.860553486033;5764.394738552559;5829.94170058294;5835.591508594358;5884.9705751470965;5964.194833697569;5972.522198224045;5982.820515384546;5999.1901093351835;6024.668643224665;5832.387599302012;5871.6183448075735;5874;5875.882482350244;5883.117532370179 13:09:35 INFO - PROCESS | 16841 | |1;ext.html;674.9527533072685;677.6848765324123;680.5474359550899;731.3198725185575;750.3397010630646;39660.60339396605;40085.59914400855;40290.7985460073;40328.59671403285;40351;43488.347674784905;43867.56132438675;43948;43950.560494395046;44054.779726101406;8838.734837954871;8976.326775491832;8987.865182022275;8993.640254389817;9007.1443212895;8785.42894711845;8861.645534178626;8927.77680557988;9161.17549420552;9215;9148.908510914873;9156.267498600097;9219.492927888963;9248.491332976684;9277.86083208749;9129.543522823833;9134.497602631853;9136.908630913673;9149.862752058725;9190.264778817713;9001;9018.323625728031;9106.544672766335;9107.316951228684;9116.680916167968;43821.78089109566;44123.338149927775;44164.77917610423;44241.77879110584;44341;3718.3864662330952;3951.111000025;3991.5210174779213;4297.355396690521;4689.812407503696;32978;33345.16637084068;33383.332333353195;33446.66553334484;34653.13367165816;4402.185595664812;4420.734755914656;4470.9105817883465;4476.350929115292;4507.887302817423;310318.99999999773;311583;311702;312189;313336;61613;63115.36884631095;63189.68405157945;63301.36698633047;63543.36456635467;77641;78709;79408;79436.60281698554;79829.60085199536;19805.20779168846;20071;20123.39629811108;20137;20175.39473815788;15419.61450963735;15470.84529154694;15627.296771645304;15634;15635.843641563666;20895.164193432094;21271.149154033974;21314.893425532773;21351.46621334479;21369.717816931035;7871.819227115979;7892;8035.758927232192;8116.8782468263025;8246.752597422086;1112.5994641928899;1116.391566596207;1151.1078913841673;1185.3125187391292;1287;33145.83427082849;33161;33222.50166247508;33299;33420.49869251963;1219.1283232488813;1256.447163248168;1260.464302671361;1281.8077288406814;1293.2176033499597;16963.321467141177;17224.483265501804;17476.300947962194;17510.562235943948;17557.82442175562;474313;485998;552679;557145;561959;63180.684096580146;64513.67743161348;64570.67714661491;64772.67613661902;64849.675751621886;1567.8197007344074;1573.6695293988162;1576.18038619917;1595.361855257883;1654.0075954427489;32531.674683253812;33667.663323366454;33941.151471213416;34282.828585856914;34321.82839085789;54676.17985730138;55360.72319638376;55647.16529252145;55654.44345556493;55670.16494752663;428033;428321;428849;429233;430168;30893.536596950613;47208.29187562258;47392;47614;48322.5167748318;45121.54878451173;45171.32243016423;46330.76834615805;47422.525774741815;49821.25268120909;41084.383734244606;41630.167396652505;41799.37300940549;42228.36657450202;43510.34734479048;40657.79671101626;42548.36177457279;42553.5744642562;42753.35869961891;43189;42679.35980960226;42929.35605965851;43231.78384108059;43472.78263608662;43553.78223108864;35562.28875422425;36398.636013640586;36441.60547629006;36925.446118308784;37292.44061339028;28397.23857625249;28762.856185718938;29099.7090029097;29193.7080629191;29252.414951700423 13:09:35 INFO - PROCESS | 16841 | |2;jquery.html;428.65525575104186;439.41118900673104;440.9845655402062;441.25428026634967;453.2295098332835;18431;18572.164252608633;19263.133159007844;19812.900935495338;19828.306009289678;19312.420627381165;19402;19408.708869366972;19850.503737406572;19861.801381986177;5737.082066869301;5796.971015144918;5896.056630939051;5903.822885313426;5908.645481271137;5459.099248623992;5720.856978575548;5761.654300741948;5762.4525670061485;5832.533397328225;5708.058170401879;5726.198332233491;5751.166080918264;5754.482096611304;5950.166976623276;6379.904301435482;6396.6801659917055;6407.775727849503;6414.166158399425;6419.325970773095;5646.068398714207;5728.97135514324;5733.054046082391;5761.308642962829;5776.249087618625;13304.800427993589;14041.087329323562;14073.64815879601;14074.22591757453;15547;2458.778709916116;2508.5610018246916;2564.4999225151105;2627.9868600656873;2926.136789647038;10603;10678.305910115818;10715.410652414113;10889.782204355868;13037.54368597104;2118.555103428282;2125.798049185325;2226.610343189935;2263.2305016294376;2277.3226554853973;78724;80152.59923700402;80485.19514804777;80665.19334806636;84025.57987210025;11541;11661.941690291495;11742.88257117435;11765.11761617882;11986.700332491757;16338.75491867623;16618.83381166197;16714.749278760828;16726.16369181536;16781.412650557173;8645.481271123752;8676;8679.956600216958;8733.912660873437;8745.47527148373;8120.431569790058;8325.542095184823;8336.124706905808;8384.664613415394;8434.704785332484;4923.286123512143;4924.285978533093;4933.975330123399;4962.478939711351;5045.672031317952;2056.4344805178694;2078.449210959097;2084.9270275540284;2148.280326090777;2212.4911270407897;1000.7348052766023;1056.2553399853084;1097.7310558912957;1170.3153655111855;1206.4329765010432;18013.909930450263;18388.356407525673;18573.34993275256;19412.029398530016;19603.117859696347;1079.9956040882055;1085.1698450685233;1103.2663278919429;1144.3591588710349;1180.1208099965581;10349.689509314732;11107.111431085494;11141.72145696364;11367.715807104889;11577.536898524133;482138;492556;495760;499032;540893;95197.0480295202;95550;95571.52214238884;96896.51551742337;97112.51443742737;1095.5343978808814;1095.7151140703475;1175.670812172593;1223.1315765806198;1234.7098431868503;15715.528534143994;16905.577360566083;17230.655386892442;17581.82418175802;17681.469555913343;35471.46792798162;36196.914092577266;36733;38007.619923800405;39673.40489892596;51883;52037;52090.73954630203;53028;53894.73052634712;9162.267018638626;9203.723888283363;9211.355205135576;9296.628134874529;9452.669156579486;9931.851022234816;13358.332083395986;13678.452861885413;13760.518381856587;13773.104748191336;5798.652080875161;6489.251178774022;7751.573663448565;10936.781264374828;11831.17181797266;11683.707907302385;11705.122115841175;11748.882511175121;12001.879981200076;12057.758844823229;11894.821577676168;11952.223105498115;12237.605182516152;12327.198732082386;12406.937965310115;8820.5589720515;8991.28069754431;9016.549172541478;9217.861732074158;9246.768830779285;12012.819807703067;12374.13381063317;12407.813882791585;12497.25016499013;12555.497780088694 13:09:35 INFO - PROCESS | 16841 | |3;mootools.html;1585.627377566272;1595.5691963169945;1823.9179236934337;1935.7677078750553;1968.557074658202;7452.7391541296065;8438.113998030196;8607.096254893233;8780.868286975692;8796.736097917057;8430.452020618655;8516.31869450444;8528.70149544766;8537.359698022643;8544.18830211129;2457.508498300347;2463.0763463701114;2473.084958565333;2484.7391023942496;2490.0164435048146;2397.280815755275;2422.9636555451684;2452.3378687754293;2468.2471846086937;2473.369290830836;2442.670239517669;2447.4248551590363;2457.373369790701;2471.0733474946896;2471.765182307678;2378.405398650346;2385.522895420914;2393.8204634652384;2411.794997425221;2457.0540341968294;2407.5666380051584;2419.189571493534;2431.513697260555;2437.9634305485433;2438.6585877977095;8784.429012114257;8821.2060914518;8826.42628229163;8836.955815220947;8883.600237989242;5596.104623260299;5685.630434021776;5717.056685646863;5739.282589676291;5742.569307301927;3436.6735160159747;3451.861925522976;3522.982385088058;3630.49173115764;3666.4683620874825;1168.526746667601;1209.214010892918;1213.9635810925686;1239.8946089582307;1254.9372531373394;12395.380230988414;12441.191322564004;12503.374831258401;12523.56167534141;12565.874341256562;4892.779824907888;4898.2652602109965;4965.205567109245;4994.600431965434;5073.873153171126;10526.73683157912;10539.367637941748;10569.894301057046;10620.946895265628;10628.681139565826;5660.716964151776;5675.921574900755;5683.2895888014;5705.942940570624;5728.856778580485;4935.531124543163;5131.589472842164;5160.561352285023;5176.741162941913;5186.377634683862;4231.238377092153;4244.278472659656;4258.467691538558;4263.509696384894;4389.836693276285;1389.4581113365796;1390.0894913831457;1404.8735613794809;1412.95054673088;1418.7020725647524;1058.3544038136731;1058.7194393485731;1069.6844430892904;1072.8658917635296;1111.2665640677114;6032.547558933097;6064.090386442069;6113.786017489367;6141.355157708465;6226.221722284715;504.99495005049477;506.7542242012621;507.3227241632462;517.2138349708497;521.1973560716455;4283.635890949242;4372;4377.627901628397;4414.1171765647;4416.6908316418185;10655.627053053106;11015.284006539548;11035.503402346752;11058.447077646246;11103.83344249837;10862.131029517619;10866.130709543218;10868.782624347627;10879.510422031028;10889.673309800719;7938.682452701943;8189.344852411793;8212.548309843016;8226.876596851052;8397.958010210032;6058.606190597597;6130.50955923534;6135.969320153549;6157;6236.594621349598;9300.023497532662;9458.668946586837;9576.329656923948;9620.567074481805;9633.518324083627;9664.56509457062;9737.782777152855;9742.269329800434;10003.399796012263;10253.436061016715;7597.6201189941385;7872.881906771288;7916.406269529693;7960.761177164694;8065.1934806518875;8394.706185283485;8447.324214062983;8502.574871256536;8563.229309362187;8577.528235946833;7536.585487798224;7737.92262077372;7821.1396746359;7864.567448790372;7865.410094243069;7597.126330471845;7615.162332143571;7688.231176882267;7731.188225236269;7785.571793551409;7181.605011724405;7212.567245965259;7224.927750722425;7243.45674074436;7247.456440767069;4973.104841128632;5053.065182941167;5155.458676838878;5182.663126896739;5215.217717342429;5108.540231379194;5210.583153347648;5270.578353731769;5284.101702710472;5389.676619402849 13:09:35 INFO - PROCESS | 16841 | |4;prototype.html;347.04562453253556;348.3694512931594;353.78949525032607;359.3872447477052;360.47010893985833;6476.255230648477;6676.365745254199;6685.966570167148;6743.662816859162;6784.4572434205265;6520.21757389114;6528.37980391862;6560.835979100525;6562.146920900276;6583.3087525809815;4779.498152693969;4960.6527543072;4967.577755890736;4973.5523802857915;4984.4517103118715;4919.532644398794;4982.377202849644;4986.626003049786;4990.3762029746285;5002.549770520653;4913.140200464904;4916.729579873106;4928.310036594879;4930.186519224324;4946.901061978759;4889.731064791453;4920.630952678545;4925.31045653607;4934.136526107953;4948.901021979576;4266.402703621496;4279.844442000674;4295;4296.162248361571;4302.870913872589;6283.371662833726;6319.57809492865;6338.492920566389;6353.205849268841;6354.205724284465;5664.2636457260705;5729.512991395736;5747.885042299173;5771.076627739583;5781;6913.308669133096;6915.343042410963;6916.723331066752;6935.965320173417;6952.478564107712;4724.126036683225;4724.692894961817;4731.645126615484;4746.620270378396;4755.976220118877;7184.676689548983;7235.204127545966;7252.383547398477;7256.818579535501;7265;4829.251466022772;4830.6135509159185;4836.129496690559;4847.684900481528;4860.927086093711;4798.808047678054;4901.58336541398;4908.705477671351;4909.754512274372;4909.852704418873;5713.885722285531;5722.0272553665145;5723.513501352431;5730.7421166047625;5734.569907256972;6899.068625735562;6931.480138989495;6972.546784458994;7002.649867506604;7017.508774385744;1687.8480936715755;1696.991515042417;1708.7269983862102;1714.3485475519224;1721.6470623522148;1091.3833683968533;1099.8012166738295;1111.4109521953378;1113.281933153128;1130;6786.966065169642;6790.932090679129;6801.7619383322335;6866.107406037183;6871.209810871814;7168.283171682894;7211.819704507429;7218.963905180441;7221.350078492961;7229.927700722926;6656.800295991128;6657.101291325609;6671;6693.698783554752;6839.110915580943;3904.668103211202;3929.9214015719526;3937.0551067743536;3949.822257998397;3954.8418063277722;7627.351675107678;7649.464537482434;7654.813503906903;7662.425318101054;7686.192949740309;7361.153467351216;7375.520591161558;7418.925810741932;7427.554346739213;7434.7769566913075;7365.373943214887;7524.17234104259;7538.660760265801;7626.923730762733;7666.080070391588;7191.604461754654;7195.38839198653;7271.381932535794;7308.524945878501;7336.119665640157;7145.3926416253125;7177.677004534913;7178.353948144692;7204.24355442671;7222.566646001046;7605.315521603082;7652.732154374793;7653.311201991624;7658.502197357154;7671.53970761756;4804.711717296974;4874.439439464507;4913.950860491349;4917.532834380728;4917.557419832232;7273.9636301818155;7284.271572842674;7285.562866228043;7288.526245794006;7293.343599076109;7028.50800443964;7033.542819716702;7034;7036.155661320469;7042.22535521082;6979.162500499972;6993.370596646327;7002.334778196063;7009.579425234502;7045.718171273092;6735;6786.3892249697765;6907.240203577502;6945.895811562729;6952.096227490394;7070.858582828418;7097.396721278749;7106;7107.680154392961;7130.572165670076;6934.410575101173;6936.79189624312;6945.861082778417;6948.062011628365;6952.270011648907 13:09:35 INFO - PROCESS | 16841 | |5;yui.html;827.9710210142642;858.0261403307244;867.20217399992;869.639099773594;938.8085575628728;15027.098374097563;15059;15092.698146037073;15169;15255.313510892009;14594;14608.123512589253;14639.634009149777;14662.63343416415;14693.33879975401;892.638481415028;908.8227795579865;934.243262957007;935.0415823780645;935.0555938502093;932.3520153493325;934.3086116273943;935.6444551070583;936.1995493852726;939.3330735178032;957.1146689312393;959.0888655777039;959.9616015359377;960.7646126698934;964.5322018820866;949.4635530925005;952.0384411744188;953.1374106433689;954.5561313988994;954.8185844689522;706.7455715942257;707.7416742888809;708.1749761527814;710.4919982212691;712.4229374206857;16258.918705406515;16305.91847040769;16339.591510212222;16401.343946242137;16401.83598164015;14359.066660667128;14446.422143114263;14460.927695361455;14510.637234069127;14546.127232365987;12198.310788977895;12415.379231038412;12533.373331333396;12548.81176782349;12732.108752387336;3995.4805875236325;3996.540397854255;4081.8163182656554;4176.812043458051;4200.726952748061;57766.7111664439;58213.41786582165;58371.416285837025;59117.704411478524;59360.40639593592;11604.466090975082;11740;11756.647300580997;11817.172797904064;12118.091143164122;20362;20537.58924821495;20630;20636.896815515825;20696.48258793542;8505.702300419456;8545.914540854512;8596.312295016383;8632.611532481053;8701.26039286655;4738.123447162286;4851.417829860439;5020.297158397827;5106.693598384109;5109.948900511022;3621.420572708354;3676.5220521332058;3678.301122786662;3697.1126929536717;3707.573629032696;673.4545018535002;689.6069240532948;689.8206466318793;689.8275431142215;691.4261163234604;766.5975362934504;782.4366456151675;786.2648423723722;802.6749166587541;833.6623667414585;9571.33000689945;9646.42121472714;9683.854742178873;9756.170725488271;9848.409095454295;794.7893808140848;817.37062461904;831.1978940322617;840.9537475438909;856.4176360075209;4294.57054294568;4561.749103799323;4582.495925448198;4603.769811509411;4790.233562629963;60441.395586044455;62184.68907655523;62562.374376256565;62586.68706656437;64734.676326618064;52130.95738085293;52479.73760131175;52829.47170528323;53160.468395316326;56724;50707.23939140916;50988.49011509911;51061.744691276304;51573.98343279939;52192.739036303814;9862.802743944938;9874.012598740068;9911.950440248042;9926;9935.453550054817;36306.58539022642;37590.248195036496;38150.80924595359;38894;39154.6084539151;44042.779786100866;44150.11699765922;49306.260406094654;49695.75152124361;51656;12783.744325113632;12868.356582171042;13010.869891301345;13065.934670326587;13261.270630115436;13610.251436171106;13682.931585342409;13713.314334283445;14214.21821799811;14536.41854325815;12973.481060757464;13033.674158146123;13144.737105258033;13298.869596084442;13727.45090196381;12517.436715347649;12956.222626642431;13189.670258243621;13351.132176408502;13572.728545429234;11851.762964740485;11983;12152.331621760888;12331.815022774845;12461.314627695201;11198.328100314007;11241.156913231376;11361.4887330072;11429.714257143305;11814.877586629256;11041.723956901142;11315.377654229096;11402.771944561227;11473.254238474472;11576 13:09:35 INFO - PROCESS | 16841 | __end_tp_report 13:09:35 INFO - PROCESS | 16841 | __start_cc_report 13:09:35 INFO - PROCESS | 16841 | _x_x_mozilla_cycle_collect,321 13:09:35 INFO - PROCESS | 16841 | __end_cc_report 13:09:35 INFO - PROCESS | 16841 | __startTimestamp1465502975001__endTimestamp 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | ------- Summary: start ------- 13:09:35 INFO - PROCESS | 16841 | Number of tests: 6 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#0] dojo.html Cycles:165 Average:5619.45 Median:5847.80 stddev:619.26 (10.6%) stddev-sans-first:594.53 13:09:35 INFO - PROCESS | 16841 | Values: 3329.2 3347.6 3412.3 3426.0 3436.2 5574.7 5592.9 5658.4 5664.9 5713.0 5601.3 5686.2 5687.1 5704.0 5715.3 5082.9 5202.5 5202.7 5203.8 5208.8 5055.4 5142.8 5215.1 5251.9 5287.8 5157.0 5209.6 5214.2 5216.7 5217.7 5132.2 5159.9 5237.5 5241.4 5290.7 4999.6 5111.0 5112.8 5135.5 5162.3 5578.9 5598.1 5598.2 5614.0 5652.5 6074.2 6097.0 6110.3 6135.2 6150.0 5913.3 5949.3 5990.5 6094.7 6164.6 5691.5 5692.1 5698.6 5700.7 5741.9 6130.9 6181.3 6199.3 6206.2 6211.4 5824.4 5852.1 5867.3 5875.0 5900.9 5859.2 5888.4 5903.0 5934.8 5944.8 5739.9 5853.4 5892.9 5951.0 6010.3 6064.8 6072.8 6089.1 6089.3 6113.6 4616.2 4650.3 4655.5 4657.3 4676.1 4029.1 4110.1 4139.9 4173.9 4204.8 5588.1 5722.0 5826.3 5828.3 5890.4 6013.2 6044.1 6059.1 6063.8 6065.2 5707.3 5732.0 5745.1 5790.9 5801.5 4974.8 5063.7 5092.1 5105.6 5107.5 6272.5 6291.0 6297.3 6310.1 6313.1 5847.8 6039.0 6070.2 6082.8 6087.1 6147.5 6200.4 6213.4 6215.5 6249.3 5918.3 5919.9 5926.5 5936.4 5952.4 5846.9 6021.2 6033.2 6075.8 6120.2 5931.6 5954.6 5955.6 5997.5 5998.2 5913.6 5937.8 5958.2 5982.8 5982.8 5577.9 5764.4 5829.9 5835.6 5885.0 5964.2 5972.5 5982.8 5999.2 6024.7 5832.4 5871.6 5874.0 5875.9 5883.1 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#1] ext.html Cycles:180 Average:60628.56 Median:43210.39 stddev:114266.36 (264.4%) stddev-sans-first:114498.24 13:09:35 INFO - PROCESS | 16841 | Values: 675.0 677.7 680.5 731.3 750.3 39660.6 40085.6 40290.8 40328.6 40351.0 43488.3 43867.6 43948.0 43950.6 44054.8 8838.7 8976.3 8987.9 8993.6 9007.1 8785.4 8861.6 8927.8 9161.2 9215.0 9148.9 9156.3 9219.5 9248.5 9277.9 9129.5 9134.5 9136.9 9149.9 9190.3 9001.0 9018.3 9106.5 9107.3 9116.7 43821.8 44123.3 44164.8 44241.8 44341.0 3718.4 3951.1 3991.5 4297.4 4689.8 32978.0 33345.2 33383.3 33446.7 34653.1 4402.2 4420.7 4470.9 4476.4 4507.9 310319.0 311583.0 311702.0 312189.0 313336.0 61613.0 63115.4 63189.7 63301.4 63543.4 77641.0 78709.0 79408.0 79436.6 79829.6 19805.2 20071.0 20123.4 20137.0 20175.4 15419.6 15470.8 15627.3 15634.0 15635.8 20895.2 21271.1 21314.9 21351.5 21369.7 7871.8 7892.0 8035.8 8116.9 8246.8 1112.6 1116.4 1151.1 1185.3 1287.0 33145.8 33161.0 33222.5 33299.0 33420.5 1219.1 1256.4 1260.5 1281.8 1293.2 16963.3 17224.5 17476.3 17510.6 17557.8 474313.0 485998.0 552679.0 557145.0 561959.0 63180.7 64513.7 64570.7 64772.7 64849.7 1567.8 1573.7 1576.2 1595.4 1654.0 32531.7 33667.7 33941.2 34282.8 34321.8 54676.2 55360.7 55647.2 55654.4 55670.2 428033.0 428321.0 428849.0 429233.0 430168.0 30893.5 47208.3 47392.0 47614.0 48322.5 45121.5 45171.3 46330.8 47422.5 49821.3 41084.4 41630.2 41799.4 42228.4 43510.3 40657.8 42548.4 42553.6 42753.4 43189.0 42679.4 42929.4 43231.8 43472.8 43553.8 35562.3 36398.6 36441.6 36925.4 37292.4 28397.2 28762.9 29099.7 29193.7 29252.4 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#2] jquery.html Cycles:180 Average:29071.32 Median:2368.05 stddev:82803.87 (3496.7%) stddev-sans-first:83008.23 13:09:35 INFO - PROCESS | 16841 | Values: 428.7 439.4 441.0 441.3 453.2 18431.0 18572.2 19263.1 19812.9 19828.3 19312.4 19402.0 19408.7 19850.5 19861.8 5737.1 5797.0 5896.1 5903.8 5908.6 5459.1 5720.9 5761.7 5762.5 5832.5 5708.1 5726.2 5751.2 5754.5 5950.2 6379.9 6396.7 6407.8 6414.2 6419.3 5646.1 5729.0 5733.1 5761.3 5776.2 13304.8 14041.1 14073.6 14074.2 15547.0 2458.8 2508.6 2564.5 2628.0 2926.1 10603.0 10678.3 10715.4 10889.8 13037.5 2118.6 2125.8 2226.6 2263.2 2277.3 78724.0 80152.6 80485.2 80665.2 84025.6 11541.0 11661.9 11742.9 11765.1 11986.7 16338.8 16618.8 16714.7 16726.2 16781.4 8645.5 8676.0 8680.0 8733.9 8745.5 8120.4 8325.5 8336.1 8384.7 8434.7 4923.3 4924.3 4934.0 4962.5 5045.7 2056.4 2078.4 2084.9 2148.3 2212.5 1000.7 1056.3 1097.7 1170.3 1206.4 18013.9 18388.4 18573.3 19412.0 19603.1 1080.0 1085.2 1103.3 1144.4 1180.1 10349.7 11107.1 11141.7 11367.7 11577.5 482138.0 492556.0 495760.0 499032.0 540893.0 95197.0 95550.0 95571.5 96896.5 97112.5 1095.5 1095.7 1175.7 1223.1 1234.7 15715.5 16905.6 17230.7 17581.8 17681.5 35471.5 36196.9 36733.0 38007.6 39673.4 51883.0 52037.0 52090.7 53028.0 53894.7 9162.3 9203.7 9211.4 9296.6 9452.7 9931.9 13358.3 13678.5 13760.5 13773.1 5798.7 6489.3 7751.6 10936.8 11831.2 11683.7 11705.1 11748.9 12001.9 12057.8 11894.8 11952.2 12237.6 12327.2 12406.9 8820.6 8991.3 9016.5 9217.9 9246.8 12012.8 12374.1 12407.8 12497.3 12555.5 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#3] mootools.html Cycles:180 Average:5883.15 Median:507.04 stddev:3239.54 (638.9%) stddev-sans-first:3232.52 13:09:35 INFO - PROCESS | 16841 | Values: 1585.6 1595.6 1823.9 1935.8 1968.6 7452.7 8438.1 8607.1 8780.9 8796.7 8430.5 8516.3 8528.7 8537.4 8544.2 2457.5 2463.1 2473.1 2484.7 2490.0 2397.3 2423.0 2452.3 2468.2 2473.4 2442.7 2447.4 2457.4 2471.1 2471.8 2378.4 2385.5 2393.8 2411.8 2457.1 2407.6 2419.2 2431.5 2438.0 2438.7 8784.4 8821.2 8826.4 8837.0 8883.6 5596.1 5685.6 5717.1 5739.3 5742.6 3436.7 3451.9 3523.0 3630.5 3666.5 1168.5 1209.2 1214.0 1239.9 1254.9 12395.4 12441.2 12503.4 12523.6 12565.9 4892.8 4898.3 4965.2 4994.6 5073.9 10526.7 10539.4 10569.9 10620.9 10628.7 5660.7 5675.9 5683.3 5705.9 5728.9 4935.5 5131.6 5160.6 5176.7 5186.4 4231.2 4244.3 4258.5 4263.5 4389.8 1389.5 1390.1 1404.9 1413.0 1418.7 1058.4 1058.7 1069.7 1072.9 1111.3 6032.5 6064.1 6113.8 6141.4 6226.2 505.0 506.8 507.3 517.2 521.2 4283.6 4372.0 4377.6 4414.1 4416.7 10655.6 11015.3 11035.5 11058.4 11103.8 10862.1 10866.1 10868.8 10879.5 10889.7 7938.7 8189.3 8212.5 8226.9 8398.0 6058.6 6130.5 6136.0 6157.0 6236.6 9300.0 9458.7 9576.3 9620.6 9633.5 9664.6 9737.8 9742.3 10003.4 10253.4 7597.6 7872.9 7916.4 7960.8 8065.2 8394.7 8447.3 8502.6 8563.2 8577.5 7536.6 7737.9 7821.1 7864.6 7865.4 7597.1 7615.2 7688.2 7731.2 7785.6 7181.6 7212.6 7224.9 7243.5 7247.5 4973.1 5053.1 5155.5 5182.7 5215.2 5108.5 5210.6 5270.6 5284.1 5389.7 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#4] prototype.html Cycles:180 Average:5842.28 Median:6689.83 stddev:1806.93 (27.0%) stddev-sans-first:1764.29 13:09:35 INFO - PROCESS | 16841 | Values: 347.0 348.4 353.8 359.4 360.5 6476.3 6676.4 6686.0 6743.7 6784.5 6520.2 6528.4 6560.8 6562.1 6583.3 4779.5 4960.7 4967.6 4973.6 4984.5 4919.5 4982.4 4986.6 4990.4 5002.5 4913.1 4916.7 4928.3 4930.2 4946.9 4889.7 4920.6 4925.3 4934.1 4948.9 4266.4 4279.8 4295.0 4296.2 4302.9 6283.4 6319.6 6338.5 6353.2 6354.2 5664.3 5729.5 5747.9 5771.1 5781.0 6913.3 6915.3 6916.7 6936.0 6952.5 4724.1 4724.7 4731.6 4746.6 4756.0 7184.7 7235.2 7252.4 7256.8 7265.0 4829.3 4830.6 4836.1 4847.7 4860.9 4798.8 4901.6 4908.7 4909.8 4909.9 5713.9 5722.0 5723.5 5730.7 5734.6 6899.1 6931.5 6972.5 7002.6 7017.5 1687.8 1697.0 1708.7 1714.3 1721.6 1091.4 1099.8 1111.4 1113.3 1130.0 6787.0 6790.9 6801.8 6866.1 6871.2 7168.3 7211.8 7219.0 7221.4 7229.9 6656.8 6657.1 6671.0 6693.7 6839.1 3904.7 3929.9 3937.1 3949.8 3954.8 7627.4 7649.5 7654.8 7662.4 7686.2 7361.2 7375.5 7418.9 7427.6 7434.8 7365.4 7524.2 7538.7 7626.9 7666.1 7191.6 7195.4 7271.4 7308.5 7336.1 7145.4 7177.7 7178.4 7204.2 7222.6 7605.3 7652.7 7653.3 7658.5 7671.5 4804.7 4874.4 4914.0 4917.5 4917.6 7274.0 7284.3 7285.6 7288.5 7293.3 7028.5 7033.5 7034.0 7036.2 7042.2 6979.2 6993.4 7002.3 7009.6 7045.7 6735.0 6786.4 6907.2 6945.9 6952.1 7070.9 7097.4 7106.0 7107.7 7130.6 6934.4 6936.8 6945.9 6948.1 6952.3 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - PROCESS | 16841 | [#5] yui.html Cycles:180 Average:15512.42 Median:4670.95 stddev:17538.76 (375.5%) stddev-sans-first:17553.29 13:09:35 INFO - PROCESS | 16841 | Values: 828.0 858.0 867.2 869.6 938.8 15027.1 15059.0 15092.7 15169.0 15255.3 14594.0 14608.1 14639.6 14662.6 14693.3 892.6 908.8 934.2 935.0 935.1 932.4 934.3 935.6 936.2 939.3 957.1 959.1 960.0 960.8 964.5 949.5 952.0 953.1 954.6 954.8 706.7 707.7 708.2 710.5 712.4 16258.9 16305.9 16339.6 16401.3 16401.8 14359.1 14446.4 14460.9 14510.6 14546.1 12198.3 12415.4 12533.4 12548.8 12732.1 3995.5 3996.5 4081.8 4176.8 4200.7 57766.7 58213.4 58371.4 59117.7 59360.4 11604.5 11740.0 11756.6 11817.2 12118.1 20362.0 20537.6 20630.0 20636.9 20696.5 8505.7 8545.9 8596.3 8632.6 8701.3 4738.1 4851.4 5020.3 5106.7 5109.9 3621.4 3676.5 3678.3 3697.1 3707.6 673.5 689.6 689.8 689.8 691.4 766.6 782.4 786.3 802.7 833.7 9571.3 9646.4 9683.9 9756.2 9848.4 794.8 817.4 831.2 841.0 856.4 4294.6 4561.7 4582.5 4603.8 4790.2 60441.4 62184.7 62562.4 62586.7 64734.7 52131.0 52479.7 52829.5 53160.5 56724.0 50707.2 50988.5 51061.7 51574.0 52192.7 9862.8 9874.0 9912.0 9926.0 9935.5 36306.6 37590.2 38150.8 38894.0 39154.6 44042.8 44150.1 49306.3 49695.8 51656.0 12783.7 12868.4 13010.9 13065.9 13261.3 13610.3 13682.9 13713.3 14214.2 14536.4 12973.5 13033.7 13144.7 13298.9 13727.5 12517.4 12956.2 13189.7 13351.1 13572.7 11851.8 11983.0 12152.3 12331.8 12461.3 11198.3 11241.2 11361.5 11429.7 11814.9 11041.7 11315.4 11402.8 11473.3 11576.0 13:09:35 INFO - PROCESS | 16841 | -------- Summary: end -------- 13:09:35 INFO - PROCESS | 16841 | 13:09:35 INFO - TEST-INFO | 16841: exit 0 13:09:35 INFO - TEST-OK | dromaeo_css | took 1107795ms 13:09:35 INFO - TEST-START | kraken 13:09:35 INFO - operating with platform_type : linux_ 13:09:35 INFO - Initialising browser for kraken test... 13:09:35 INFO - TEST-INFO | started process 17083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4rtr9/profile http://localhost:35844/getInfo.html) 13:09:38 INFO - PROCESS | 17083 | 13:09:38 INFO - PROCESS | 17083 | (process:17164): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:09:39 INFO - PROCESS | 17083 | __metrics Screen width/height:1600/1200 13:09:39 INFO - PROCESS | 17083 | colorDepth:24 13:09:39 INFO - PROCESS | 17083 | Browser inner width/height: 1024/697 13:09:39 INFO - PROCESS | 17083 | __metrics 13:09:39 ERROR - PROCESS | 17083 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 13:09:40 INFO - TEST-INFO | 17083: exit 0 13:09:40 INFO - Browser initialized. 13:09:40 INFO - Running cycle 1/1 for kraken test... 13:09:40 INFO - TEST-INFO | started process 17214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4rtr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:42 INFO - PROCESS | 17214 | 13:09:42 INFO - PROCESS | 17214 | (process:17284): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:09:52 INFO - PROCESS | 17214 | RSS: Main: 151183360 13:09:52 INFO - PROCESS | 17214 | 13:09:54 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35844/tests/kraken/driver.html?testName=audio-beat-detection) 13:09:55 INFO - PROCESS | 17214 | RSS: Main: 156114944 13:09:55 INFO - PROCESS | 17214 | 13:09:58 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35844/tests/kraken/driver.html?testName=audio-dft) 13:09:58 INFO - PROCESS | 17214 | RSS: Main: 156053504 13:09:58 INFO - PROCESS | 17214 | 13:10:01 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35844/tests/kraken/driver.html?testName=audio-fft) 13:10:02 INFO - PROCESS | 17214 | RSS: Main: 156737536 13:10:02 INFO - PROCESS | 17214 | 13:10:04 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35844/tests/kraken/driver.html?testName=audio-oscillator) 13:10:05 INFO - PROCESS | 17214 | RSS: Main: 156733440 13:10:05 INFO - PROCESS | 17214 | 13:10:07 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:07 INFO - PROCESS | 17214 | RSS: Main: 156454912 13:10:07 INFO - PROCESS | 17214 | 13:10:10 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35844/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:11 INFO - PROCESS | 17214 | RSS: Main: 157274112 13:10:11 INFO - PROCESS | 17214 | 13:10:14 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35844/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:15 INFO - PROCESS | 17214 | RSS: Main: 156913664 13:10:15 INFO - PROCESS | 17214 | 13:10:18 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35844/tests/kraken/driver.html?testName=json-parse-financial) 13:10:18 INFO - PROCESS | 17214 | RSS: Main: 156868608 13:10:18 INFO - PROCESS | 17214 | 13:10:20 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:21 INFO - PROCESS | 17214 | RSS: Main: 156717056 13:10:21 INFO - PROCESS | 17214 | 13:10:22 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:23 INFO - PROCESS | 17214 | RSS: Main: 156602368 13:10:23 INFO - PROCESS | 17214 | 13:10:25 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:26 INFO - PROCESS | 17214 | RSS: Main: 157093888 13:10:26 INFO - PROCESS | 17214 | 13:10:28 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:29 INFO - PROCESS | 17214 | RSS: Main: 157200384 13:10:29 INFO - PROCESS | 17214 | 13:10:31 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:32 INFO - PROCESS | 17214 | RSS: Main: 157155328 13:10:32 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | Cycle 1(1): loaded http://localhost:35844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35844/tests/kraken/driver.html?testName=ai-astar) 13:10:34 INFO - PROCESS | 17214 | RSS: Main: 158052352 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | __start_tp_report 13:10:34 INFO - PROCESS | 17214 | _x_x_mozilla_page_load 13:10:34 INFO - PROCESS | 17214 | _x_x_mozilla_page_load_details 13:10:34 INFO - PROCESS | 17214 | |i|pagename|runs| 13:10:34 INFO - PROCESS | 17214 | |0;ai-astar;109;113;105;111;113;113;103;112;111;115 13:10:34 INFO - PROCESS | 17214 | |1;audio-beat-detection;154;129;152;184;134;158;154;127;199;128 13:10:34 INFO - PROCESS | 17214 | |2;audio-dft;164;163;162;167;160;162;164;163;163;163 13:10:34 INFO - PROCESS | 17214 | |3;audio-fft;77;76;78;165;77;77;75;77;168;74 13:10:34 INFO - PROCESS | 17214 | |4;audio-oscillator;92;93;165;93;94;95;153;92;93;151 13:10:34 INFO - PROCESS | 17214 | |5;imaging-gaussian-blur;119;119;117;118;117;118;117;118;118;118 13:10:34 INFO - PROCESS | 17214 | |6;imaging-darkroom;147;147;148;146;148;147;150;147;150;149 13:10:34 INFO - PROCESS | 17214 | |7;imaging-desaturate;95;95;99;96;97;95;95;96;95;96 13:10:34 INFO - PROCESS | 17214 | |8;json-parse-financial;57;53;60;56;56;56;55;74;57;54 13:10:34 INFO - PROCESS | 17214 | |9;json-stringify-tinderbox;59;59;59;60;59;59;61;58;60;60 13:10:34 INFO - PROCESS | 17214 | |10;stanford-crypto-aes;74;79;71;72;73;74;76;72;74;74 13:10:34 INFO - PROCESS | 17214 | |11;stanford-crypto-ccm;114;121;118;114;116;116;114;117;127;130 13:10:34 INFO - PROCESS | 17214 | |12;stanford-crypto-pbkdf2;161;156;155;162;158;167;159;159;156;156 13:10:34 INFO - PROCESS | 17214 | |13;stanford-crypto-sha256-iterative;68;68;66;67;67;63;66;67;74;65 13:10:34 INFO - PROCESS | 17214 | __end_tp_report 13:10:34 INFO - PROCESS | 17214 | __start_cc_report 13:10:34 INFO - PROCESS | 17214 | _x_x_mozilla_cycle_collect,863 13:10:34 INFO - PROCESS | 17214 | __end_cc_report 13:10:34 INFO - PROCESS | 17214 | __startTimestamp1465503034395__endTimestamp 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | ------- Summary: start ------- 13:10:34 INFO - PROCESS | 17214 | Number of tests: 14 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:4.00 13:10:34 INFO - PROCESS | 17214 | Values: 109.0 113.0 105.0 111.0 113.0 113.0 103.0 112.0 111.0 115.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:154.00 stddev:24.34 (15.8%) stddev-sans-first:25.80 13:10:34 INFO - PROCESS | 17214 | Values: 154.0 129.0 152.0 184.0 134.0 158.0 154.0 127.0 199.0 128.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.79 (1.1%) stddev-sans-first:1.87 13:10:34 INFO - PROCESS | 17214 | Values: 164.0 163.0 162.0 167.0 160.0 162.0 164.0 163.0 163.0 163.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.00 stddev:38.02 (49.4%) stddev-sans-first:39.81 13:10:34 INFO - PROCESS | 17214 | Values: 77.0 76.0 78.0 165.0 77.0 77.0 75.0 77.0 168.0 74.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:93.00 stddev:30.74 (33.1%) stddev-sans-first:31.74 13:10:34 INFO - PROCESS | 17214 | Values: 92.0 93.0 165.0 93.0 94.0 95.0 153.0 92.0 93.0 151.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 13:10:34 INFO - PROCESS | 17214 | Values: 119.0 119.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 13:10:34 INFO - PROCESS | 17214 | Values: 147.0 147.0 148.0 146.0 148.0 147.0 150.0 147.0 150.0 149.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.29 (1.3%) stddev-sans-first:1.32 13:10:34 INFO - PROCESS | 17214 | Values: 95.0 95.0 99.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.50 stddev:6.00 (10.6%) stddev-sans-first:6.35 13:10:34 INFO - PROCESS | 17214 | Values: 57.0 53.0 60.0 56.0 56.0 56.0 55.0 74.0 57.0 54.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 13:10:34 INFO - PROCESS | 17214 | Values: 59.0 59.0 59.0 60.0 59.0 59.0 61.0 58.0 60.0 60.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:2.28 (3.1%) stddev-sans-first:2.42 13:10:34 INFO - PROCESS | 17214 | Values: 74.0 79.0 71.0 72.0 73.0 74.0 76.0 72.0 74.0 74.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:117.50 stddev:5.64 (4.8%) stddev-sans-first:5.72 13:10:34 INFO - PROCESS | 17214 | Values: 114.0 121.0 118.0 114.0 116.0 116.0 114.0 117.0 127.0 130.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:3.67 (2.3%) stddev-sans-first:3.81 13:10:34 INFO - PROCESS | 17214 | Values: 161.0 156.0 155.0 162.0 158.0 167.0 159.0 159.0 156.0 156.0 13:10:34 INFO - PROCESS | 17214 | 13:10:34 INFO - PROCESS | 17214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.85 (4.2%) stddev-sans-first:3.00 13:10:34 INFO - PROCESS | 17214 | Values: 68.0 68.0 66.0 67.0 67.0 63.0 66.0 67.0 74.0 65.0 13:10:34 INFO - PROCESS | 17214 | -------- Summary: end -------- 13:10:34 INFO - PROCESS | 17214 | 13:10:35 INFO - TEST-INFO | 17214: exit 0 13:10:35 INFO - TEST-OK | kraken | took 59598ms 13:10:35 INFO - SUITE-END | took 1167s 13:10:35 INFO - Completed test suite (00:19:27) 13:10:35 INFO - javascript benchmark 13:10:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.1510664780485, 3347.615024272209, 3412.3345947540233, 3425.965740342596, 3436.24402631421, 5574.665520068798, 5592.916106258409, 5658.377578466366, 5664.915026274599, 5712.971435142818, 5601.327840659116, 5686.175504551848, 5687.118496633018, 5704.030314846475, 5715.3141623005295, 5082.872928176806, 5202.479752024805, 5202.713850738208, 5203.8178663746585, 5208.791648334081, 5055.418626857903, 5142.820001299955, 5215.113430716788, 5251.921221181686, 5287.841364759063, 5157.045946499891, 5209.583233341343, 5214.165733482643, 5216.660917040399, 5217.660852044605, 5132.204508301219, 5159.871003224912, 5237.528622424, 5241.42344342122, 5290.735463226823, 4999.575036121934, 5110.9744451277875, 5112.821051263225, 5135.460776618439, 5162.3030890830005, 5578.86052848682, 5598.1322894951345, 5598.24423702799, 5613.989481893258, 5652.5195358394585, 6074.2103526541705, 6097.0, 6110.297315808694, 6135.233095863017, 6149.969250153766, 5913.2608423947, 5949.315828679714, 5990.490808281302, 6094.664793436359, 6164.630122192638, 5691.51622112121, 5692.089265717506, 5698.601097923189, 5700.714964251771, 5741.885162296772, 6130.887362651087, 6181.320054793969, 6199.318075011745, 6206.162168107247, 6211.409916057967, 5824.359320474744, 5852.063669812809, 5867.295924489089, 5875.030619947661, 5900.940990590125, 5859.2090067841145, 5888.352281249059, 5903.0260007099205, 5934.762609495572, 5944.762209511658, 5739.8565035874435, 5853.385394533598, 5892.852678683067, 5950.9702451487465, 6010.308814486302, 6064.818055458255, 6072.846159229733, 6089.056196289582, 6089.269287685417, 6113.602615829956, 4616.169089563844, 4650.255959046604, 4655.534446555317, 4657.347971284023, 4676.08816280822, 4029.0531725044593, 4110.136871257069, 4139.91720165595, 4173.853915112956, 4204.831806727758, 5588.050031494656, 5722.0, 5826.300843898759, 5828.329742079715, 5890.352061273256, 6013.248343957005, 6044.093385992049, 6059.0608455689435, 6063.8484037898525, 6065.150878876961, 5707.343655479673, 5731.971340143356, 5745.080787074048, 5790.942090579125, 5801.50687191585, 4974.751262436864, 5063.670861393997, 5092.083424983539, 5105.566026887682, 5107.540321371094, 6272.498200143978, 6290.968545157245, 6297.27581328144, 6310.0534919761485, 6313.116163737081, 5847.795327163529, 6039.0, 6070.1501789750355, 6082.847928801815, 6087.147799308012, 6147.477464415575, 6200.3799620037635, 6213.409726076015, 6215.502759779297, 6249.281332646804, 5918.319393269829, 5919.85200369977, 5926.525877929669, 5936.436038576328, 5952.434518720715, 5846.912296315644, 6021.157038014594, 6033.18551995475, 6075.756969721162, 6120.204373431426, 5931.6441013539325, 5954.612950158225, 5955.583109182316, 5997.460228579449, 5998.190244316961, 5913.5564832636865, 5937.762489500372, 5958.225430693982, 5982.760689572368, 5982.760689572542, 5577.860553486033, 5764.394738552559, 5829.94170058294, 5835.591508594358, 5884.9705751470965, 5964.194833697569, 5972.522198224045, 5982.820515384546, 5999.1901093351835, 6024.668643224665, 5832.387599302012, 5871.6183448075735, 5874.0, 5875.882482350244, 5883.117532370179], "value": 5579.416736591609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.9527533072685, 677.6848765324123, 680.5474359550899, 731.3198725185575, 750.3397010630646, 39660.60339396605, 40085.59914400855, 40290.7985460073, 40328.59671403285, 40351.0, 43488.347674784905, 43867.56132438675, 43948.0, 43950.560494395046, 44054.779726101406, 8838.734837954871, 8976.326775491832, 8987.865182022275, 8993.640254389817, 9007.1443212895, 8785.42894711845, 8861.645534178626, 8927.77680557988, 9161.17549420552, 9215.0, 9148.908510914873, 9156.267498600097, 9219.492927888963, 9248.491332976684, 9277.86083208749, 9129.543522823833, 9134.497602631853, 9136.908630913673, 9149.862752058725, 9190.264778817713, 9001.0, 9018.323625728031, 9106.544672766335, 9107.316951228684, 9116.680916167968, 43821.78089109566, 44123.338149927775, 44164.77917610423, 44241.77879110584, 44341.0, 3718.3864662330952, 3951.111000025, 3991.5210174779213, 4297.355396690521, 4689.812407503696, 32978.0, 33345.16637084068, 33383.332333353195, 33446.66553334484, 34653.13367165816, 4402.185595664812, 4420.734755914656, 4470.9105817883465, 4476.350929115292, 4507.887302817423, 310318.99999999773, 311583.0, 311702.0, 312189.0, 313336.0, 61613.0, 63115.36884631095, 63189.68405157945, 63301.36698633047, 63543.36456635467, 77641.0, 78709.0, 79408.0, 79436.60281698554, 79829.60085199536, 19805.20779168846, 20071.0, 20123.39629811108, 20137.0, 20175.39473815788, 15419.61450963735, 15470.84529154694, 15627.296771645304, 15634.0, 15635.843641563666, 20895.164193432094, 21271.149154033974, 21314.893425532773, 21351.46621334479, 21369.717816931035, 7871.819227115979, 7892.0, 8035.758927232192, 8116.8782468263025, 8246.752597422086, 1112.5994641928899, 1116.391566596207, 1151.1078913841673, 1185.3125187391292, 1287.0, 33145.83427082849, 33161.0, 33222.50166247508, 33299.0, 33420.49869251963, 1219.1283232488813, 1256.447163248168, 1260.464302671361, 1281.8077288406814, 1293.2176033499597, 16963.321467141177, 17224.483265501804, 17476.300947962194, 17510.562235943948, 17557.82442175562, 474313.0, 485998.0, 552679.0, 557145.0, 561959.0, 63180.684096580146, 64513.67743161348, 64570.67714661491, 64772.67613661902, 64849.675751621886, 1567.8197007344074, 1573.6695293988162, 1576.18038619917, 1595.361855257883, 1654.0075954427489, 32531.674683253812, 33667.663323366454, 33941.151471213416, 34282.828585856914, 34321.82839085789, 54676.17985730138, 55360.72319638376, 55647.16529252145, 55654.44345556493, 55670.16494752663, 428033.0, 428321.0, 428849.0, 429233.0, 430168.0, 30893.536596950613, 47208.29187562258, 47392.0, 47614.0, 48322.5167748318, 45121.54878451173, 45171.32243016423, 46330.76834615805, 47422.525774741815, 49821.25268120909, 41084.383734244606, 41630.167396652505, 41799.37300940549, 42228.36657450202, 43510.34734479048, 40657.79671101626, 42548.36177457279, 42553.5744642562, 42753.35869961891, 43189.0, 42679.35980960226, 42929.35605965851, 43231.78384108059, 43472.78263608662, 43553.78223108864, 35562.28875422425, 36398.636013640586, 36441.60547629006, 36925.446118308784, 37292.44061339028, 28397.23857625249, 28762.856185718938, 29099.7090029097, 29193.7080629191, 29252.414951700423], "value": 21584.576733883805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.65525575104186, 439.41118900673104, 440.9845655402062, 441.25428026634967, 453.2295098332835, 18431.0, 18572.164252608633, 19263.133159007844, 19812.900935495338, 19828.306009289678, 19312.420627381165, 19402.0, 19408.708869366972, 19850.503737406572, 19861.801381986177, 5737.082066869301, 5796.971015144918, 5896.056630939051, 5903.822885313426, 5908.645481271137, 5459.099248623992, 5720.856978575548, 5761.654300741948, 5762.4525670061485, 5832.533397328225, 5708.058170401879, 5726.198332233491, 5751.166080918264, 5754.482096611304, 5950.166976623276, 6379.904301435482, 6396.6801659917055, 6407.775727849503, 6414.166158399425, 6419.325970773095, 5646.068398714207, 5728.97135514324, 5733.054046082391, 5761.308642962829, 5776.249087618625, 13304.800427993589, 14041.087329323562, 14073.64815879601, 14074.22591757453, 15547.0, 2458.778709916116, 2508.5610018246916, 2564.4999225151105, 2627.9868600656873, 2926.136789647038, 10603.0, 10678.305910115818, 10715.410652414113, 10889.782204355868, 13037.54368597104, 2118.555103428282, 2125.798049185325, 2226.610343189935, 2263.2305016294376, 2277.3226554853973, 78724.0, 80152.59923700402, 80485.19514804777, 80665.19334806636, 84025.57987210025, 11541.0, 11661.941690291495, 11742.88257117435, 11765.11761617882, 11986.700332491757, 16338.75491867623, 16618.83381166197, 16714.749278760828, 16726.16369181536, 16781.412650557173, 8645.481271123752, 8676.0, 8679.956600216958, 8733.912660873437, 8745.47527148373, 8120.431569790058, 8325.542095184823, 8336.124706905808, 8384.664613415394, 8434.704785332484, 4923.286123512143, 4924.285978533093, 4933.975330123399, 4962.478939711351, 5045.672031317952, 2056.4344805178694, 2078.449210959097, 2084.9270275540284, 2148.280326090777, 2212.4911270407897, 1000.7348052766023, 1056.2553399853084, 1097.7310558912957, 1170.3153655111855, 1206.4329765010432, 18013.909930450263, 18388.356407525673, 18573.34993275256, 19412.029398530016, 19603.117859696347, 1079.9956040882055, 1085.1698450685233, 1103.2663278919429, 1144.3591588710349, 1180.1208099965581, 10349.689509314732, 11107.111431085494, 11141.72145696364, 11367.715807104889, 11577.536898524133, 482138.0, 492556.0, 495760.0, 499032.0, 540893.0, 95197.0480295202, 95550.0, 95571.52214238884, 96896.51551742337, 97112.51443742737, 1095.5343978808814, 1095.7151140703475, 1175.670812172593, 1223.1315765806198, 1234.7098431868503, 15715.528534143994, 16905.577360566083, 17230.655386892442, 17581.82418175802, 17681.469555913343, 35471.46792798162, 36196.914092577266, 36733.0, 38007.619923800405, 39673.40489892596, 51883.0, 52037.0, 52090.73954630203, 53028.0, 53894.73052634712, 9162.267018638626, 9203.723888283363, 9211.355205135576, 9296.628134874529, 9452.669156579486, 9931.851022234816, 13358.332083395986, 13678.452861885413, 13760.518381856587, 13773.104748191336, 5798.652080875161, 6489.251178774022, 7751.573663448565, 10936.781264374828, 11831.17181797266, 11683.707907302385, 11705.122115841175, 11748.882511175121, 12001.879981200076, 12057.758844823229, 11894.821577676168, 11952.223105498115, 12237.605182516152, 12327.198732082386, 12406.937965310115, 8820.5589720515, 8991.28069754431, 9016.549172541478, 9217.861732074158, 9246.768830779285, 12012.819807703067, 12374.13381063317, 12407.813882791585, 12497.25016499013, 12555.497780088694], "value": 9388.40233535338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1585.627377566272, 1595.5691963169945, 1823.9179236934337, 1935.7677078750553, 1968.557074658202, 7452.7391541296065, 8438.113998030196, 8607.096254893233, 8780.868286975692, 8796.736097917057, 8430.452020618655, 8516.31869450444, 8528.70149544766, 8537.359698022643, 8544.18830211129, 2457.508498300347, 2463.0763463701114, 2473.084958565333, 2484.7391023942496, 2490.0164435048146, 2397.280815755275, 2422.9636555451684, 2452.3378687754293, 2468.2471846086937, 2473.369290830836, 2442.670239517669, 2447.4248551590363, 2457.373369790701, 2471.0733474946896, 2471.765182307678, 2378.405398650346, 2385.522895420914, 2393.8204634652384, 2411.794997425221, 2457.0540341968294, 2407.5666380051584, 2419.189571493534, 2431.513697260555, 2437.9634305485433, 2438.6585877977095, 8784.429012114257, 8821.2060914518, 8826.42628229163, 8836.955815220947, 8883.600237989242, 5596.104623260299, 5685.630434021776, 5717.056685646863, 5739.282589676291, 5742.569307301927, 3436.6735160159747, 3451.861925522976, 3522.982385088058, 3630.49173115764, 3666.4683620874825, 1168.526746667601, 1209.214010892918, 1213.9635810925686, 1239.8946089582307, 1254.9372531373394, 12395.380230988414, 12441.191322564004, 12503.374831258401, 12523.56167534141, 12565.874341256562, 4892.779824907888, 4898.2652602109965, 4965.205567109245, 4994.600431965434, 5073.873153171126, 10526.73683157912, 10539.367637941748, 10569.894301057046, 10620.946895265628, 10628.681139565826, 5660.716964151776, 5675.921574900755, 5683.2895888014, 5705.942940570624, 5728.856778580485, 4935.531124543163, 5131.589472842164, 5160.561352285023, 5176.741162941913, 5186.377634683862, 4231.238377092153, 4244.278472659656, 4258.467691538558, 4263.509696384894, 4389.836693276285, 1389.4581113365796, 1390.0894913831457, 1404.8735613794809, 1412.95054673088, 1418.7020725647524, 1058.3544038136731, 1058.7194393485731, 1069.6844430892904, 1072.8658917635296, 1111.2665640677114, 6032.547558933097, 6064.090386442069, 6113.786017489367, 6141.355157708465, 6226.221722284715, 504.99495005049477, 506.7542242012621, 507.3227241632462, 517.2138349708497, 521.1973560716455, 4283.635890949242, 4372.0, 4377.627901628397, 4414.1171765647, 4416.6908316418185, 10655.627053053106, 11015.284006539548, 11035.503402346752, 11058.447077646246, 11103.83344249837, 10862.131029517619, 10866.130709543218, 10868.782624347627, 10879.510422031028, 10889.673309800719, 7938.682452701943, 8189.344852411793, 8212.548309843016, 8226.876596851052, 8397.958010210032, 6058.606190597597, 6130.50955923534, 6135.969320153549, 6157.0, 6236.594621349598, 9300.023497532662, 9458.668946586837, 9576.329656923948, 9620.567074481805, 9633.518324083627, 9664.56509457062, 9737.782777152855, 9742.269329800434, 10003.399796012263, 10253.436061016715, 7597.6201189941385, 7872.881906771288, 7916.406269529693, 7960.761177164694, 8065.1934806518875, 8394.706185283485, 8447.324214062983, 8502.574871256536, 8563.229309362187, 8577.528235946833, 7536.585487798224, 7737.92262077372, 7821.1396746359, 7864.567448790372, 7865.410094243069, 7597.126330471845, 7615.162332143571, 7688.231176882267, 7731.188225236269, 7785.571793551409, 7181.605011724405, 7212.567245965259, 7224.927750722425, 7243.45674074436, 7247.456440767069, 4973.104841128632, 5053.065182941167, 5155.458676838878, 5182.663126896739, 5215.217717342429, 5108.540231379194, 5210.583153347648, 5270.578353731769, 5284.101702710472, 5389.676619402849], "value": 4716.268690273013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.04562453253556, 348.3694512931594, 353.78949525032607, 359.3872447477052, 360.47010893985833, 6476.255230648477, 6676.365745254199, 6685.966570167148, 6743.662816859162, 6784.4572434205265, 6520.21757389114, 6528.37980391862, 6560.835979100525, 6562.146920900276, 6583.3087525809815, 4779.498152693969, 4960.6527543072, 4967.577755890736, 4973.5523802857915, 4984.4517103118715, 4919.532644398794, 4982.377202849644, 4986.626003049786, 4990.3762029746285, 5002.549770520653, 4913.140200464904, 4916.729579873106, 4928.310036594879, 4930.186519224324, 4946.901061978759, 4889.731064791453, 4920.630952678545, 4925.31045653607, 4934.136526107953, 4948.901021979576, 4266.402703621496, 4279.844442000674, 4295.0, 4296.162248361571, 4302.870913872589, 6283.371662833726, 6319.57809492865, 6338.492920566389, 6353.205849268841, 6354.205724284465, 5664.2636457260705, 5729.512991395736, 5747.885042299173, 5771.076627739583, 5781.0, 6913.308669133096, 6915.343042410963, 6916.723331066752, 6935.965320173417, 6952.478564107712, 4724.126036683225, 4724.692894961817, 4731.645126615484, 4746.620270378396, 4755.976220118877, 7184.676689548983, 7235.204127545966, 7252.383547398477, 7256.818579535501, 7265.0, 4829.251466022772, 4830.6135509159185, 4836.129496690559, 4847.684900481528, 4860.927086093711, 4798.808047678054, 4901.58336541398, 4908.705477671351, 4909.754512274372, 4909.852704418873, 5713.885722285531, 5722.0272553665145, 5723.513501352431, 5730.7421166047625, 5734.569907256972, 6899.068625735562, 6931.480138989495, 6972.546784458994, 7002.649867506604, 7017.508774385744, 1687.8480936715755, 1696.991515042417, 1708.7269983862102, 1714.3485475519224, 1721.6470623522148, 1091.3833683968533, 1099.8012166738295, 1111.4109521953378, 1113.281933153128, 1130.0, 6786.966065169642, 6790.932090679129, 6801.7619383322335, 6866.107406037183, 6871.209810871814, 7168.283171682894, 7211.819704507429, 7218.963905180441, 7221.350078492961, 7229.927700722926, 6656.800295991128, 6657.101291325609, 6671.0, 6693.698783554752, 6839.110915580943, 3904.668103211202, 3929.9214015719526, 3937.0551067743536, 3949.822257998397, 3954.8418063277722, 7627.351675107678, 7649.464537482434, 7654.813503906903, 7662.425318101054, 7686.192949740309, 7361.153467351216, 7375.520591161558, 7418.925810741932, 7427.554346739213, 7434.7769566913075, 7365.373943214887, 7524.17234104259, 7538.660760265801, 7626.923730762733, 7666.080070391588, 7191.604461754654, 7195.38839198653, 7271.381932535794, 7308.524945878501, 7336.119665640157, 7145.3926416253125, 7177.677004534913, 7178.353948144692, 7204.24355442671, 7222.566646001046, 7605.315521603082, 7652.732154374793, 7653.311201991624, 7658.502197357154, 7671.53970761756, 4804.711717296974, 4874.439439464507, 4913.950860491349, 4917.532834380728, 4917.557419832232, 7273.9636301818155, 7284.271572842674, 7285.562866228043, 7288.526245794006, 7293.343599076109, 7028.50800443964, 7033.542819716702, 7034.0, 7036.155661320469, 7042.22535521082, 6979.162500499972, 6993.370596646327, 7002.334778196063, 7009.579425234502, 7045.718171273092, 6735.0, 6786.3892249697765, 6907.240203577502, 6945.895811562729, 6952.096227490394, 7070.858582828418, 7097.396721278749, 7106.0, 7107.680154392961, 7130.572165670076, 6934.410575101173, 6936.79189624312, 6945.861082778417, 6948.062011628365, 6952.270011648907], "value": 5242.783980520471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.9710210142642, 858.0261403307244, 867.20217399992, 869.639099773594, 938.8085575628728, 15027.098374097563, 15059.0, 15092.698146037073, 15169.0, 15255.313510892009, 14594.0, 14608.123512589253, 14639.634009149777, 14662.63343416415, 14693.33879975401, 892.638481415028, 908.8227795579865, 934.243262957007, 935.0415823780645, 935.0555938502093, 932.3520153493325, 934.3086116273943, 935.6444551070583, 936.1995493852726, 939.3330735178032, 957.1146689312393, 959.0888655777039, 959.9616015359377, 960.7646126698934, 964.5322018820866, 949.4635530925005, 952.0384411744188, 953.1374106433689, 954.5561313988994, 954.8185844689522, 706.7455715942257, 707.7416742888809, 708.1749761527814, 710.4919982212691, 712.4229374206857, 16258.918705406515, 16305.91847040769, 16339.591510212222, 16401.343946242137, 16401.83598164015, 14359.066660667128, 14446.422143114263, 14460.927695361455, 14510.637234069127, 14546.127232365987, 12198.310788977895, 12415.379231038412, 12533.373331333396, 12548.81176782349, 12732.108752387336, 3995.4805875236325, 3996.540397854255, 4081.8163182656554, 4176.812043458051, 4200.726952748061, 57766.7111664439, 58213.41786582165, 58371.416285837025, 59117.704411478524, 59360.40639593592, 11604.466090975082, 11740.0, 11756.647300580997, 11817.172797904064, 12118.091143164122, 20362.0, 20537.58924821495, 20630.0, 20636.896815515825, 20696.48258793542, 8505.702300419456, 8545.914540854512, 8596.312295016383, 8632.611532481053, 8701.26039286655, 4738.123447162286, 4851.417829860439, 5020.297158397827, 5106.693598384109, 5109.948900511022, 3621.420572708354, 3676.5220521332058, 3678.301122786662, 3697.1126929536717, 3707.573629032696, 673.4545018535002, 689.6069240532948, 689.8206466318793, 689.8275431142215, 691.4261163234604, 766.5975362934504, 782.4366456151675, 786.2648423723722, 802.6749166587541, 833.6623667414585, 9571.33000689945, 9646.42121472714, 9683.854742178873, 9756.170725488271, 9848.409095454295, 794.7893808140848, 817.37062461904, 831.1978940322617, 840.9537475438909, 856.4176360075209, 4294.57054294568, 4561.749103799323, 4582.495925448198, 4603.769811509411, 4790.233562629963, 60441.395586044455, 62184.68907655523, 62562.374376256565, 62586.68706656437, 64734.676326618064, 52130.95738085293, 52479.73760131175, 52829.47170528323, 53160.468395316326, 56724.0, 50707.23939140916, 50988.49011509911, 51061.744691276304, 51573.98343279939, 52192.739036303814, 9862.802743944938, 9874.012598740068, 9911.950440248042, 9926.0, 9935.453550054817, 36306.58539022642, 37590.248195036496, 38150.80924595359, 38894.0, 39154.6084539151, 44042.779786100866, 44150.11699765922, 49306.260406094654, 49695.75152124361, 51656.0, 12783.744325113632, 12868.356582171042, 13010.869891301345, 13065.934670326587, 13261.270630115436, 13610.251436171106, 13682.931585342409, 13713.314334283445, 14214.21821799811, 14536.41854325815, 12973.481060757464, 13033.674158146123, 13144.737105258033, 13298.869596084442, 13727.45090196381, 12517.436715347649, 12956.222626642431, 13189.670258243621, 13351.132176408502, 13572.728545429234, 11851.762964740485, 11983.0, 12152.331621760888, 12331.815022774845, 12461.314627695201, 11198.328100314007, 11241.156913231376, 11361.4887330072, 11429.714257143305, 11814.877586629256, 11041.723956901142, 11315.377654229096, 11402.771944561227, 11473.254238474472, 11576.0], "value": 7241.263745100292, "unit": "score"}], "name": "dromaeo_css", "value": 7662.838252033609, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 105.0, 111.0, 113.0, 113.0, 103.0, 112.0, 111.0, 115.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 152.0, 184.0, 134.0, 158.0, 154.0, 127.0, 199.0, 128.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 167.0, 160.0, 162.0, 164.0, 163.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 165.0, 77.0, 77.0, 75.0, 77.0, 168.0, 74.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 165.0, 93.0, 94.0, 95.0, 153.0, 92.0, 93.0, 151.0], "value": 112.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 150.0, 147.0, 150.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 60.0, 56.0, 56.0, 56.0, 55.0, 74.0, 57.0, 54.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 61.0, 58.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 71.0, 72.0, 73.0, 74.0, 76.0, 72.0, 74.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 118.0, 114.0, 116.0, 116.0, 114.0, 117.0, 127.0, 130.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 155.0, 162.0, 158.0, 167.0, 159.0, 159.0, 156.0, 156.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 63.0, 66.0, 67.0, 74.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1529.5000000000002, "alertThreshold": 2.0}]} 13:10:35 INFO - Return code: 0 13:10:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:10:35 ERROR - # TBPL SUCCESS # 13:10:35 INFO - Running post-action listener: _resource_record_post_action 13:10:35 INFO - Running post-run listener: _resource_record_post_run 13:10:36 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 477687808; Read time: 8; Write time: 419864 13:10:36 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 254423040; Read time: 0; Write time: 308704 13:10:36 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222666752; Read time: 8; Write time: 111160 13:10:36 INFO - Running post-run listener: _upload_blobber_files 13:10:36 INFO - Blob upload gear active. 13:10:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:36 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 13:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:10:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:10:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:10:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:38 INFO - (blobuploader) - INFO - Done attempting. 13:10:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:10:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:10:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:38 INFO - (blobuploader) - INFO - Done attempting. 13:10:38 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:38 INFO - Return code: 0 13:10:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41ea258017d4d83be4e627c0b8c276e697210f01415216de78ba2838caab0c4c7c7fd3e70bd2ee52f994dfa5225f7309e6677e7b7dfc333eb67bfd9eec55a2bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdf8a05ea6c8334df3fb842b86c7edc12be5dea7e0664569f2980c4e64c9f35406f9d815b0efe2b9c041c37ae6aecdba275c05ab5e814b2fc999ac01a7e0ece"} 13:10:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:38 INFO - Contents: 13:10:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41ea258017d4d83be4e627c0b8c276e697210f01415216de78ba2838caab0c4c7c7fd3e70bd2ee52f994dfa5225f7309e6677e7b7dfc333eb67bfd9eec55a2bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdf8a05ea6c8334df3fb842b86c7edc12be5dea7e0664569f2980c4e64c9f35406f9d815b0efe2b9c041c37ae6aecdba275c05ab5e814b2fc999ac01a7e0ece"} 13:10:38 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:38 INFO - Copying logs to upload dir... 13:10:38 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.559780 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-09 13:10:38.639890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:38.643678) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 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-Beta/sha512/41ea258017d4d83be4e627c0b8c276e697210f01415216de78ba2838caab0c4c7c7fd3e70bd2ee52f994dfa5225f7309e6677e7b7dfc333eb67bfd9eec55a2bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdf8a05ea6c8334df3fb842b86c7edc12be5dea7e0664569f2980c4e64c9f35406f9d815b0efe2b9c041c37ae6aecdba275c05ab5e814b2fc999ac01a7e0ece"} build_url:https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011640 build_url: 'https://queue.taskcluster.net/v1/task/f737cnUxQG6y-5mnjNwSZA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41ea258017d4d83be4e627c0b8c276e697210f01415216de78ba2838caab0c4c7c7fd3e70bd2ee52f994dfa5225f7309e6677e7b7dfc333eb67bfd9eec55a2bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdf8a05ea6c8334df3fb842b86c7edc12be5dea7e0664569f2980c4e64c9f35406f9d815b0efe2b9c041c37ae6aecdba275c05ab5e814b2fc999ac01a7e0ece"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:38.669352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:38.669675) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465501452.347848-1486759038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:10:38.753234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:10:38.753567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:10:38.753858) ========= ========= Total master_lag: 0.16 =========