builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1461370215.89 results: success (0) buildid: 20160422143012 builduid: 515f4e07440c48688c69809bcd2dbec1 revision: 21c9846c176b04cda630cbccacaccc789a8c963b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.891056) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.891476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.891757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.910520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:15.910793) ========= 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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 17:10:16-- 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% 27.6M=0s 2016-04-22 17:10:16 (27.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.091172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.091530) ========= 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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.141548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.141881) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21c9846c176b04cda630cbccacaccc789a8c963b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 21c9846c176b04cda630cbccacaccc789a8c963b --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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 17:10:16,312 truncating revision to first 12 chars 2016-04-22 17:10:16,312 Setting DEBUG logging. 2016-04-22 17:10:16,312 attempt 1/10 2016-04-22 17:10:16,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21c9846c176b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 17:10:16,670 unpacking tar archive at: fx-team-21c9846c176b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.799239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.799562) ========= script_repo_revision: 21c9846c176b04cda630cbccacaccc789a8c963b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.800023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.800292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 17:10:16.809033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 17:10:16.809381) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:17 INFO - MultiFileLogger online at 20160422 17:10:17 in /builds/slave/test 17:10:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:10:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:17 INFO - {'append_to_log': False, 17:10:17 INFO - 'base_work_dir': '/builds/slave/test', 17:10:17 INFO - 'blob_upload_branch': 'Fx-Team', 17:10:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:17 INFO - 'branch': 'Fx-Team', 17:10:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:17 INFO - 'config_files': ('talos/linux_config.py',), 17:10:17 INFO - 'default_actions': ('clobber', 17:10:17 INFO - 'read-buildbot-config', 17:10:17 INFO - 'download-and-extract', 17:10:17 INFO - 'populate-webroot', 17:10:17 INFO - 'create-virtualenv', 17:10:17 INFO - 'install', 17:10:17 INFO - 'run-tests'), 17:10:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:17 INFO - 'download_minidump_stackwalk': True, 17:10:17 INFO - 'download_symbols': 'ondemand', 17:10:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:17 INFO - 'installer_path': 'installer.exe', 17:10:17 INFO - 'log_level': 'info', 17:10:17 INFO - 'log_name': 'talos', 17:10:17 INFO - 'log_to_console': True, 17:10:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:17 INFO - 'opt_config_files': (), 17:10:17 INFO - 'pip_index': False, 17:10:17 INFO - 'sps_profile': False, 17:10:17 INFO - 'sps_profile_interval': 0, 17:10:17 INFO - 'suite': 'dromaeojs-e10s', 17:10:17 INFO - 'system_bits': '32', 17:10:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:17 INFO - 'title': 'talos-linux64-ix-029', 17:10:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:17 INFO - 'use_talos_json': True, 17:10:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:17 INFO - 'work_dir': 'build'} 17:10:17 INFO - ##### 17:10:17 INFO - ##### Running clobber step. 17:10:17 INFO - ##### 17:10:17 INFO - Running pre-action listener: _resource_record_pre_action 17:10:17 INFO - Running main action method: clobber 17:10:17 INFO - rmtree: /builds/slave/test/build 17:10:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:18 INFO - Running post-action listener: _resource_record_post_action 17:10:18 INFO - ##### 17:10:18 INFO - ##### Running read-buildbot-config step. 17:10:18 INFO - ##### 17:10:18 INFO - Running pre-action listener: _resource_record_pre_action 17:10:18 INFO - Running main action method: read_buildbot_config 17:10:18 INFO - Using buildbot properties: 17:10:18 INFO - { 17:10:18 INFO - "project": "", 17:10:18 INFO - "product": "firefox", 17:10:18 INFO - "script_repo_revision": "production", 17:10:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:10:18 INFO - "repository": "", 17:10:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:10:18 INFO - "buildid": "20160422143012", 17:10:18 INFO - "pgo_build": "True", 17:10:18 INFO - "basedir": "/builds/slave/test", 17:10:18 INFO - "buildnumber": 403, 17:10:18 INFO - "slavename": "talos-linux64-ix-029", 17:10:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:10:18 INFO - "platform": "ubuntu64_hw", 17:10:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:10:18 INFO - "branch": "fx-team", 17:10:18 INFO - "repo_path": "integration/fx-team", 17:10:18 INFO - "revision": "21c9846c176b04cda630cbccacaccc789a8c963b", 17:10:18 INFO - "stage_platform": "linux64-pgo", 17:10:18 INFO - "builduid": "515f4e07440c48688c69809bcd2dbec1", 17:10:18 INFO - "slavebuilddir": "test" 17:10:18 INFO - } 17:10:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:10:18 INFO - Running post-action listener: _resource_record_post_action 17:10:18 INFO - ##### 17:10:18 INFO - ##### Running download-and-extract step. 17:10:18 INFO - ##### 17:10:18 INFO - Running pre-action listener: _resource_record_pre_action 17:10:18 INFO - Running main action method: download_and_extract 17:10:18 INFO - mkdir: /builds/slave/test/build/tests 17:10: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')]} 17:10:18 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:10:18 INFO - Downloaded 1361 bytes. 17:10:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:18 INFO - Using the following test package requirements: 17:10:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:10:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'jsshell-linux-x86_64.zip'], 17:10:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:10:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:10:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10: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')]} 17:10:18 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:20 INFO - Downloaded 23857749 bytes. 17:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:21 INFO - Return code: 0 17:10:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:10: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')]} 17:10:21 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:23 INFO - Downloaded 23857749 bytes. 17:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:24 INFO - Return code: 0 17:10:24 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')]} 17:10:24 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:27 INFO - Downloaded 10840145 bytes. 17:10:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:10:27 INFO - Return code: 0 17:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:27 INFO - https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:10:29 INFO - Downloaded 58349862 bytes. 17:10:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:29 INFO - mkdir: /builds/slave/test/properties 17:10:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:29 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:29 INFO - Contents: 17:10:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:30 INFO - Running post-action listener: _resource_record_post_action 17:10:30 INFO - Running post-action listener: set_extra_try_arguments 17:10:30 INFO - ##### 17:10:30 INFO - ##### Running populate-webroot step. 17:10:30 INFO - ##### 17:10:30 INFO - Running pre-action listener: _resource_record_pre_action 17:10:30 INFO - Running main action method: populate_webroot 17:10:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:30 INFO - '--tppagecycles', 17:10:30 INFO - '7'], 17:10:30 INFO - 'tests': ['tsvgm']}}, 17:10:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['damp', 'tps']}, 17:10:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'tests': ['damp', 'tps']}, 17:10:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['dromaeo_dom']}, 17:10:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['a11yr', 17:10:30 INFO - 'ts_paint', 17:10:30 INFO - 'tpaint', 17:10:30 INFO - 'sessionrestore', 17:10:30 INFO - 'sessionrestore_no_auto_restore', 17:10:30 INFO - 'tabpaint']}, 17:10:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['tsvgx', 17:10:30 INFO - 'tsvgr_opacity', 17:10:30 INFO - 'tart', 17:10:30 INFO - 'tscrollx', 17:10:30 INFO - 'cart']}, 17:10:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:30 INFO - 'tsvgr_opacity', 17:10:30 INFO - 'tart', 17:10:30 INFO - 'tscrollx', 17:10:30 INFO - 'cart']}, 17:10:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'talos_options': ['--disable-e10s'], 17:10:30 INFO - 'tests': ['tp5o']}, 17:10:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'tests': ['tp5o']}, 17:10:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'talos_options': ['--disable-e10s', 17:10:30 INFO - '--xperf_path', 17:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:30 INFO - 'tests': ['tp5n']}, 17:10:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:30 INFO - 'talos_options': ['--xperf_path', 17:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:30 INFO - 'tests': ['tp5n']}}, 17:10:30 INFO - 'talos.zip': {'path': '', 17:10:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:30 INFO - Running post-action listener: _resource_record_post_action 17:10:30 INFO - ##### 17:10:30 INFO - ##### Running create-virtualenv step. 17:10:30 INFO - ##### 17:10:30 INFO - Running pre-action listener: _resource_record_pre_action 17:10:30 INFO - Running main action method: create_virtualenv 17:10:30 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:10:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:30 INFO - Using real prefix '/usr' 17:10:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:31 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:33 INFO - Installing pip.................done. 17:10:33 INFO - Return code: 0 17:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10: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', 'pip>=1.5'] in /builds/slave/test/build 17:10: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 pip>=1.5 17:10:33 INFO - Using env: {'DISPLAY': ':0', 17:10:33 INFO - 'HOME': '/home/cltbld', 17:10:33 INFO - 'LANG': 'en_US.UTF-8', 17:10:33 INFO - 'LANGUAGE': 'en_US:en', 17:10:33 INFO - 'LOGNAME': 'cltbld', 17:10:33 INFO - 'MAIL': '/var/mail/cltbld', 17:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:33 INFO - 'MOZ_NO_REMOTE': '1', 17:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:33 INFO - 'NO_EM_RESTART': '1', 17:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:33 INFO - 'PWD': '/builds/slave/test', 17:10:33 INFO - 'SHELL': '/bin/bash', 17:10:33 INFO - 'SHLVL': '1', 17:10:33 INFO - 'TERM': 'linux', 17:10:33 INFO - 'TMOUT': '86400', 17:10:33 INFO - 'USER': 'cltbld', 17:10:33 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:33 INFO - '_': '/tools/buildbot/bin/python'} 17:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:33 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 17:10:33 INFO - Cleaning up... 17:10:33 INFO - Return code: 0 17:10:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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', '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 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:10: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 psutil>=0.7.1 17:10:33 INFO - Using env: {'DISPLAY': ':0', 17:10:33 INFO - 'HOME': '/home/cltbld', 17:10:33 INFO - 'LANG': 'en_US.UTF-8', 17:10:33 INFO - 'LANGUAGE': 'en_US:en', 17:10:33 INFO - 'LOGNAME': 'cltbld', 17:10:33 INFO - 'MAIL': '/var/mail/cltbld', 17:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:33 INFO - 'MOZ_NO_REMOTE': '1', 17:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:33 INFO - 'NO_EM_RESTART': '1', 17:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:33 INFO - 'PWD': '/builds/slave/test', 17:10:33 INFO - 'SHELL': '/bin/bash', 17:10:33 INFO - 'SHLVL': '1', 17:10:33 INFO - 'TERM': 'linux', 17:10:33 INFO - 'TMOUT': '86400', 17:10:33 INFO - 'USER': 'cltbld', 17:10:33 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:33 INFO - '_': '/tools/buildbot/bin/python'} 17:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:33 INFO - Downloading/unpacking psutil>=0.7.1 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:35 INFO - Installing collected packages: psutil 17:10:35 INFO - Running setup.py install for psutil 17:10:35 INFO - building 'psutil._psutil_linux' extension 17:10:35 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 17:10:35 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 17:10:35 INFO - building 'psutil._psutil_posix' extension 17:10:35 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 17:10:36 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 17:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:36 INFO - Successfully installed psutil 17:10:36 INFO - Cleaning up... 17:10:36 INFO - Return code: 0 17:10:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:10:36 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')]} 17:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:36 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')]} 17:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:36 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 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:36 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 17:10:36 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 17:10:36 INFO - Using env: {'DISPLAY': ':0', 17:10:36 INFO - 'HOME': '/home/cltbld', 17:10:36 INFO - 'LANG': 'en_US.UTF-8', 17:10:36 INFO - 'LANGUAGE': 'en_US:en', 17:10:36 INFO - 'LOGNAME': 'cltbld', 17:10:36 INFO - 'MAIL': '/var/mail/cltbld', 17:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:36 INFO - 'MOZ_NO_REMOTE': '1', 17:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:36 INFO - 'NO_EM_RESTART': '1', 17:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:36 INFO - 'PWD': '/builds/slave/test', 17:10:36 INFO - 'SHELL': '/bin/bash', 17:10:36 INFO - 'SHLVL': '1', 17:10:36 INFO - 'TERM': 'linux', 17:10:36 INFO - 'TMOUT': '86400', 17:10:36 INFO - 'USER': 'cltbld', 17:10:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:36 INFO - '_': '/tools/buildbot/bin/python'} 17:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:10:36 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 17:10:36 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 17:10:36 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 17:10:36 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 17:10:36 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 17:10:36 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 17:10:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:38 INFO - Installing collected packages: mozsystemmonitor 17:10:38 INFO - Running setup.py install for mozsystemmonitor 17:10:38 INFO - Successfully installed mozsystemmonitor 17:10:38 INFO - Cleaning up... 17:10:38 INFO - Return code: 0 17:10:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:10:38 INFO - Using env: {'DISPLAY': ':0', 17:10:38 INFO - 'HOME': '/home/cltbld', 17:10:38 INFO - 'LANG': 'en_US.UTF-8', 17:10:38 INFO - 'LANGUAGE': 'en_US:en', 17:10:38 INFO - 'LOGNAME': 'cltbld', 17:10:38 INFO - 'MAIL': '/var/mail/cltbld', 17:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:38 INFO - 'MOZ_NO_REMOTE': '1', 17:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:38 INFO - 'NO_EM_RESTART': '1', 17:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:38 INFO - 'PWD': '/builds/slave/test', 17:10:38 INFO - 'SHELL': '/bin/bash', 17:10:38 INFO - 'SHLVL': '1', 17:10:38 INFO - 'TERM': 'linux', 17:10:38 INFO - 'TMOUT': '86400', 17:10:38 INFO - 'USER': 'cltbld', 17:10:38 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:38 INFO - '_': '/tools/buildbot/bin/python'} 17:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:41 INFO - Downloading docopt-0.6.1.tar.gz 17:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:41 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:41 INFO - Running setup.py install for blobuploader 17:10:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:41 INFO - Running setup.py install for requests 17:10:41 INFO - Running setup.py install for docopt 17:10:41 INFO - Successfully installed blobuploader requests docopt 17:10:41 INFO - Cleaning up... 17:10:41 INFO - Return code: 0 17:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:41 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')]} 17:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:41 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')]} 17:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:41 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 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:41 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 17:10:41 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 17:10:41 INFO - Using env: {'DISPLAY': ':0', 17:10:41 INFO - 'HOME': '/home/cltbld', 17:10:41 INFO - 'LANG': 'en_US.UTF-8', 17:10:41 INFO - 'LANGUAGE': 'en_US:en', 17:10:41 INFO - 'LOGNAME': 'cltbld', 17:10:41 INFO - 'MAIL': '/var/mail/cltbld', 17:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:41 INFO - 'MOZ_NO_REMOTE': '1', 17:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:41 INFO - 'NO_EM_RESTART': '1', 17:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:41 INFO - 'PWD': '/builds/slave/test', 17:10:41 INFO - 'SHELL': '/bin/bash', 17:10:41 INFO - 'SHLVL': '1', 17:10:41 INFO - 'TERM': 'linux', 17:10:41 INFO - 'TMOUT': '86400', 17:10:41 INFO - 'USER': 'cltbld', 17:10:41 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:41 INFO - '_': '/tools/buildbot/bin/python'} 17:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:42 INFO - Running setup.py (path:/tmp/pip-Aob6Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:42 INFO - Running setup.py (path:/tmp/pip-rIX4ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:42 INFO - Running setup.py (path:/tmp/pip-94NI1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:42 INFO - Running setup.py (path:/tmp/pip-vYaxRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:42 INFO - Running setup.py (path:/tmp/pip-c9sDmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:42 INFO - Running setup.py (path:/tmp/pip-S4nmyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:42 INFO - Running setup.py (path:/tmp/pip-gM0kY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:42 INFO - Running setup.py (path:/tmp/pip-mFUib5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:42 INFO - Running setup.py (path:/tmp/pip-9HgRCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:42 INFO - Running setup.py (path:/tmp/pip-92H4Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:42 INFO - Running setup.py (path:/tmp/pip-oU0wiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:42 INFO - Running setup.py (path:/tmp/pip-ubwD2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:43 INFO - Running setup.py (path:/tmp/pip-iGdKKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:43 INFO - Running setup.py (path:/tmp/pip-FIMwpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:43 INFO - Running setup.py (path:/tmp/pip-nPDEjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:43 INFO - Running setup.py (path:/tmp/pip-66MUJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:43 INFO - Running setup.py (path:/tmp/pip-VrJODz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:43 INFO - Running setup.py install for manifestparser 17:10:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:43 INFO - Running setup.py install for mozcrash 17:10:43 INFO - Running setup.py install for mozdebug 17:10:43 INFO - Running setup.py install for mozdevice 17:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:43 INFO - Running setup.py install for mozfile 17:10:43 INFO - Running setup.py install for mozhttpd 17:10:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozinfo 17:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozInstall 17:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozleak 17:10:44 INFO - Running setup.py install for mozlog 17:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for moznetwork 17:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozprocess 17:10:44 INFO - Running setup.py install for mozprofile 17:10:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozrunner 17:10:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:44 INFO - Running setup.py install for mozscreenshot 17:10:45 INFO - Running setup.py install for moztest 17:10:45 INFO - Running setup.py install for mozversion 17:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:45 INFO - Cleaning up... 17:10:45 INFO - Return code: 0 17:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:45 INFO - Using env: {'DISPLAY': ':0', 17:10:45 INFO - 'HOME': '/home/cltbld', 17:10:45 INFO - 'LANG': 'en_US.UTF-8', 17:10:45 INFO - 'LANGUAGE': 'en_US:en', 17:10:45 INFO - 'LOGNAME': 'cltbld', 17:10:45 INFO - 'MAIL': '/var/mail/cltbld', 17:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:45 INFO - 'MOZ_NO_REMOTE': '1', 17:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:45 INFO - 'NO_EM_RESTART': '1', 17:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:45 INFO - 'PWD': '/builds/slave/test', 17:10:45 INFO - 'SHELL': '/bin/bash', 17:10:45 INFO - 'SHLVL': '1', 17:10:45 INFO - 'TERM': 'linux', 17:10:45 INFO - 'TMOUT': '86400', 17:10:45 INFO - 'USER': 'cltbld', 17:10:45 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:45 INFO - '_': '/tools/buildbot/bin/python'} 17:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:45 INFO - Running setup.py (path:/tmp/pip-0njSv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:45 INFO - Running setup.py (path:/tmp/pip-VIU6kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:45 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)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:45 INFO - Running setup.py (path:/tmp/pip-D8iszr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:45 INFO - Running setup.py (path:/tmp/pip-7mD4Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:45 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)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:45 INFO - Running setup.py (path:/tmp/pip-EgwzTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:45 INFO - Running setup.py (path:/tmp/pip-biYP7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:45 INFO - Running setup.py (path:/tmp/pip-lgBpFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:45 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)) 17:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:45 INFO - Running setup.py (path:/tmp/pip-7kBvYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:46 INFO - Running setup.py (path:/tmp/pip-RuL4Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:46 INFO - Running setup.py (path:/tmp/pip-ATZwKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:46 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)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:46 INFO - Running setup.py (path:/tmp/pip-RtANCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:46 INFO - Running setup.py (path:/tmp/pip-9qy3M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:46 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)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:46 INFO - Running setup.py (path:/tmp/pip-DPbIGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:46 INFO - Running setup.py (path:/tmp/pip-hkhEkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:46 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)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:46 INFO - Running setup.py (path:/tmp/pip-spzTae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:46 INFO - Running setup.py (path:/tmp/pip-fWr2cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:46 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)) 17:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:46 INFO - Running setup.py (path:/tmp/pip-7tO8ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:48 INFO - Downloading blessings-1.6.tar.gz 17:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:48 INFO - Installing collected packages: blessings 17:10:48 INFO - Running setup.py install for blessings 17:10:48 INFO - Successfully installed blessings 17:10:48 INFO - Cleaning up... 17:10:48 INFO - Return code: 0 17:10:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:49 INFO - Reading from file tmpfile_stdout 17:10:49 INFO - Current package versions: 17:10:49 INFO - argparse == 1.2.1 17:10:49 INFO - blessings == 1.6 17:10:49 INFO - blobuploader == 1.2.4 17:10:49 INFO - docopt == 0.6.1 17:10:49 INFO - manifestparser == 1.1 17:10:49 INFO - mozInstall == 1.12 17:10:49 INFO - mozcrash == 0.17 17:10:49 INFO - mozdebug == 0.1 17:10:49 INFO - mozdevice == 0.48 17:10:49 INFO - mozfile == 1.2 17:10:49 INFO - mozhttpd == 0.7 17:10:49 INFO - mozinfo == 0.9 17:10:49 INFO - mozleak == 0.1 17:10:49 INFO - mozlog == 3.1 17:10:49 INFO - moznetwork == 0.27 17:10:49 INFO - mozprocess == 0.22 17:10:49 INFO - mozprofile == 0.28 17:10:49 INFO - mozrunner == 6.11 17:10:49 INFO - mozscreenshot == 0.1 17:10:49 INFO - mozsystemmonitor == 0.0 17:10:49 INFO - moztest == 0.7 17:10:49 INFO - mozversion == 1.4 17:10:49 INFO - psutil == 3.1.1 17:10:49 INFO - requests == 1.2.3 17:10:49 INFO - wsgiref == 0.1.2 17:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:49 INFO - Using env: {'DISPLAY': ':0', 17:10:49 INFO - 'HOME': '/home/cltbld', 17:10:49 INFO - 'LANG': 'en_US.UTF-8', 17:10:49 INFO - 'LANGUAGE': 'en_US:en', 17:10:49 INFO - 'LOGNAME': 'cltbld', 17:10:49 INFO - 'MAIL': '/var/mail/cltbld', 17:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:49 INFO - 'MOZ_NO_REMOTE': '1', 17:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:49 INFO - 'NO_EM_RESTART': '1', 17:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:49 INFO - 'PWD': '/builds/slave/test', 17:10:49 INFO - 'SHELL': '/bin/bash', 17:10:49 INFO - 'SHLVL': '1', 17:10:49 INFO - 'TERM': 'linux', 17:10:49 INFO - 'TMOUT': '86400', 17:10:49 INFO - 'USER': 'cltbld', 17:10:49 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:49 INFO - '_': '/tools/buildbot/bin/python'} 17:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:49 INFO - Cleaning up... 17:10:49 INFO - Return code: 0 17:10:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:49 INFO - Using env: {'DISPLAY': ':0', 17:10:49 INFO - 'HOME': '/home/cltbld', 17:10:49 INFO - 'LANG': 'en_US.UTF-8', 17:10:49 INFO - 'LANGUAGE': 'en_US:en', 17:10:49 INFO - 'LOGNAME': 'cltbld', 17:10:49 INFO - 'MAIL': '/var/mail/cltbld', 17:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:49 INFO - 'MOZ_NO_REMOTE': '1', 17:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:49 INFO - 'NO_EM_RESTART': '1', 17:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:49 INFO - 'PWD': '/builds/slave/test', 17:10:49 INFO - 'SHELL': '/bin/bash', 17:10:49 INFO - 'SHLVL': '1', 17:10:49 INFO - 'TERM': 'linux', 17:10:49 INFO - 'TMOUT': '86400', 17:10:49 INFO - 'USER': 'cltbld', 17:10:49 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:49 INFO - '_': '/tools/buildbot/bin/python'} 17:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:49 INFO - Downloading/unpacking jsonschema 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:51 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:51 INFO - warning: no files found matching '*.txt' 17:10:51 INFO - no previously-included directories found matching 'build' 17:10:51 INFO - no previously-included directories found matching 'dist' 17:10:51 INFO - no previously-included directories found matching '.git*' 17:10:51 INFO - Installing collected packages: jsonschema, functools32 17:10:51 INFO - Running setup.py install for functools32 17:10:51 INFO - warning: no files found matching '*.txt' 17:10:51 INFO - no previously-included directories found matching 'build' 17:10:51 INFO - no previously-included directories found matching 'dist' 17:10:51 INFO - no previously-included directories found matching '.git*' 17:10:51 INFO - Successfully installed jsonschema functools32 17:10:51 INFO - Cleaning up... 17:10:51 INFO - Return code: 0 17:10:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:51 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')]} 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:51 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')]} 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:51 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 0x7f07d29e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, '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': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', '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 17:10:51 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 17:10:51 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 17:10:51 INFO - Using env: {'DISPLAY': ':0', 17:10:51 INFO - 'HOME': '/home/cltbld', 17:10:51 INFO - 'LANG': 'en_US.UTF-8', 17:10:51 INFO - 'LANGUAGE': 'en_US:en', 17:10:51 INFO - 'LOGNAME': 'cltbld', 17:10:51 INFO - 'MAIL': '/var/mail/cltbld', 17:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:51 INFO - 'MOZ_NO_REMOTE': '1', 17:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:51 INFO - 'NO_EM_RESTART': '1', 17:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:51 INFO - 'PWD': '/builds/slave/test', 17:10:51 INFO - 'SHELL': '/bin/bash', 17:10:51 INFO - 'SHLVL': '1', 17:10:51 INFO - 'TERM': 'linux', 17:10:51 INFO - 'TMOUT': '86400', 17:10:51 INFO - 'USER': 'cltbld', 17:10:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:51 INFO - '_': '/tools/buildbot/bin/python'} 17:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:52 INFO - Downloading/unpacking flake8 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:53 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 17:10:53 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 17:10:53 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 17:10:53 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 17:10:53 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 17:10:53 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 17:10:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:54 INFO - no previously-included directories found matching 'docs/_build' 17:10:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:54 INFO - Running setup.py install for pep8 17:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:54 INFO - no previously-included directories found matching 'docs/_build' 17:10:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:54 INFO - Cleaning up... 17:10:54 INFO - Return code: 0 17:10:54 INFO - Running post-action listener: _resource_record_post_action 17:10:54 INFO - Running post-action listener: _start_resource_monitoring 17:10:54 INFO - Starting resource monitoring. 17:10:54 INFO - ##### 17:10:54 INFO - ##### Running install step. 17:10:54 INFO - ##### 17:10:54 INFO - Running pre-action listener: _resource_record_pre_action 17:10:54 INFO - Running main action method: install 17:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:55 INFO - Reading from file tmpfile_stdout 17:10:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:55 INFO - Reading from file tmpfile_stdout 17:10:55 INFO - Output received: 17:10:55 INFO - Usage: mozinstall [options] installer 17:10:55 INFO - Options: 17:10:55 INFO - -h, --help show this help message and exit 17:10:55 INFO - -d DEST, --destination=DEST 17:10:55 INFO - Directory to install application into. [default: 17:10:55 INFO - "/builds/slave/test"] 17:10:55 INFO - --app=APP Application being installed. [default: firefox] 17:10:55 INFO - mkdir: /builds/slave/test/build/application 17:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:11:11 INFO - Reading from file tmpfile_stdout 17:11:11 INFO - Output received: 17:11:11 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:11 INFO - Running post-action listener: _resource_record_post_action 17:11:11 INFO - ##### 17:11:11 INFO - ##### Running run-tests step. 17:11:11 INFO - ##### 17:11:11 INFO - Running pre-action listener: _resource_record_pre_action 17:11:11 INFO - Running main action method: run_tests 17:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:11 INFO - Python 2.7.3 17:11:11 INFO - Return code: 0 17:11:11 INFO - grabbing minidump binary from tooltool 17:11:11 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')]} 17:11:11 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 0x1873410>, '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 0x1874310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18747a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:11 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 17:11:11 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 17:11:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:11 INFO - Return code: 0 17:11:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:11:12 INFO - Return code: 0 17:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 17:11:12 INFO - Using env: {'DISPLAY': ':0', 17:11:12 INFO - 'HOME': '/home/cltbld', 17:11:12 INFO - 'LANG': 'en_US.UTF-8', 17:11:12 INFO - 'LANGUAGE': 'en_US:en', 17:11:12 INFO - 'LOGNAME': 'cltbld', 17:11:12 INFO - 'MAIL': '/var/mail/cltbld', 17:11:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:12 INFO - 'MOZ_NO_REMOTE': '1', 17:11:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:12 INFO - 'NO_EM_RESTART': '1', 17:11:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:12 INFO - 'PWD': '/builds/slave/test', 17:11:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:12 INFO - 'SHELL': '/bin/bash', 17:11:12 INFO - 'SHLVL': '1', 17:11:12 INFO - 'TERM': 'linux', 17:11:12 INFO - 'TMOUT': '86400', 17:11:12 INFO - 'USER': 'cltbld', 17:11:12 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632', 17:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:12 INFO - '_': '/tools/buildbot/bin/python'} 17:11:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:11:12 INFO - mozversion application_buildid: 20160422143012 17:11:12 INFO - mozversion application_changeset: 21c9846c176b04cda630cbccacaccc789a8c963b 17:11:12 INFO - mozversion application_display_name: Nightly 17:11:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:12 INFO - mozversion application_name: Firefox 17:11:12 INFO - mozversion application_remotingname: firefox 17:11:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:11:12 INFO - mozversion application_vendor: Mozilla 17:11:12 INFO - mozversion application_version: 48.0a1 17:11:12 INFO - mozversion platform_buildid: 20160422143012 17:11:12 INFO - mozversion platform_changeset: 21c9846c176b04cda630cbccacaccc789a8c963b 17:11:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:11:12 INFO - mozversion platform_version: 48.0a1 17:11:12 INFO - using testdate: 1461370272 17:11:12 INFO - actual date: 1461370272 17:11:12 INFO - starting webserver on 'localhost:60839' 17:11:12 INFO - SUITE-START | Running 2 tests 17:11:12 INFO - TEST-START | dromaeo_css 17:11:12 INFO - operating with platform_type : linux_ 17:11:12 INFO - Initialising browser for dromaeo_css test... 17:11:12 INFO - TEST-INFO | started process 21233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6jNda/profile http://localhost:60839/getInfo.html) 17:11:16 INFO - PROCESS | 21233 | 17:11:16 INFO - PROCESS | 21233 | (process:21299): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:17 INFO - PROCESS | 21233 | __metrics Screen width/height:1600/1200 17:11:17 INFO - PROCESS | 21233 | colorDepth:24 17:11:17 INFO - PROCESS | 21233 | Browser inner width/height: 1024/697 17:11:17 INFO - PROCESS | 21233 | __metrics 17:11:17 ERROR - PROCESS | 21233 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:11:18 INFO - TEST-INFO | 21233: exit 0 17:11:18 INFO - Browser initialized. 17:11:18 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:18 INFO - TEST-INFO | started process 21350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6jNda/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:20 INFO - PROCESS | 21350 | 17:11:20 INFO - PROCESS | 21350 | (process:21411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:30 INFO - PROCESS | 21350 | RSS: Main: 164646912 17:11:30 INFO - PROCESS | 21350 | 17:12:20 INFO - PROCESS | 21350 | 1461370340014 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] 17:14:27 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60839/tests/dromaeo/cssquery-ext.html) 17:14:28 INFO - PROCESS | 21350 | RSS: Main: 168726528 17:14:28 INFO - PROCESS | 21350 | 17:17:30 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-ext.html (next: http://localhost:60839/tests/dromaeo/cssquery-jquery.html) 17:17:30 INFO - PROCESS | 21350 | RSS: Main: 166506496 17:17:30 INFO - PROCESS | 21350 | 17:20:32 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60839/tests/dromaeo/cssquery-mootools.html) 17:20:33 INFO - PROCESS | 21350 | RSS: Main: 167256064 17:20:33 INFO - PROCESS | 21350 | 17:23:35 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60839/tests/dromaeo/cssquery-prototype.html) 17:23:35 INFO - PROCESS | 21350 | RSS: Main: 164728832 17:23:35 INFO - PROCESS | 21350 | 17:26:38 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60839/tests/dromaeo/cssquery-yui.html) 17:26:38 INFO - PROCESS | 21350 | RSS: Main: 166096896 17:26:38 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | Cycle 1(1): loaded http://localhost:60839/tests/dromaeo/cssquery-yui.html (next: http://localhost:60839/tests/dromaeo/cssquery-dojo.html) 17:29:41 INFO - PROCESS | 21350 | RSS: Main: 168091648 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | __start_tp_report 17:29:41 INFO - PROCESS | 21350 | _x_x_mozilla_page_load 17:29:41 INFO - PROCESS | 21350 | _x_x_mozilla_page_load_details 17:29:41 INFO - PROCESS | 21350 | |i|pagename|runs| 17:29:41 INFO - PROCESS | 21350 | |0;dojo.html;3182.6658200888905;3193.058047875877;3209.165616939595;3236.223306406463;3263;5528.585356098289;5535.944640553594;5551.333839939213;5556.027695153347;5557.972210138943;5374.731263436823;5510.1459273812525;5512.834614961547;5566.721663916798;5623.915641265374;4959.404871415426;4984.501549845023;5040.2439634055;5055.772490237948;5082.161443361841;742.38698694912;4852.902941941159;4929.50704929506;5034.345535080434;5040.445550989388;4910.828121015783;4941.085899108659;4949.30709700644;4972.8508144755715;4975.626827987898;4957.231629097496;4962.982588569334;4965.428975667773;4966.925496117561;4996.1756310208775;4883.340748998875;4932.284818701268;4933.7286449245275;4958.033183529214;4977.477364876672;5419.620626556142;5444.537214336786;5447.618666693294;5493.176023596453;5515.531179849718;5769.798057067983;5794.565407594405;5916.201312822757;5918.319393269743;5924.170616113747;5801.448862358069;5814.534837213013;5817.592768506206;5855.882882342372;5860.208871802295;5392.514673679349;5407.5133238008375;5429.8099566515375;5435.918461223085;5456;5776.277965254343;5896.882062358729;5931.9406805931385;6022.879542409128;6065.272167339947;5768.990426675399;5791.942080579224;5792.362840087587;5802.970985145132;5817.505512031525;5820.94179058204;5856.8535786604825;5859.53123750099;5864.061750120046;5874.676892770854;5785.768569257182;5839.795607153729;5843.1235314703135;5950.285965684146;5967.582269241198;5716.056850619684;5746.1093530502;5747.109198074305;5755.251817263729;5763.6541807491685;4272.957270427318;4305.440292761984;4341.696081274281;4350.869473915787;4381.233284175257;3908.609139086069;3915;3922.921541569153;3929.685625149981;3994.720369574102;5461.15352120422;5521.2270282160525;5565.193047008162;5576.97211513948;5632.85917852057;5775.075987842009;5796.333421656479;5805.332386775575;5820.76716931318;5836.766529338864;5444.673319600757;5524.14375771756;5565.638233514808;5570.303712035996;5618.803341883096;4892.730899800546;4897.412310522689;4913.975430122898;4917.385326834145;4937.061958227925;5891.852703682443;5905.173275741399;5922.3485416604135;5944.375840536682;5972.193753843262;5716.256886604798;5780.075187969905;5820.214271073521;5842.415758424124;5851.707414629337;6069.878602427839;6083.270007599116;6094.177286066324;6097.75608975636;6119.296280927572;5729.997250481232;5784.5083167929515;5827.358990511125;5830.950428922834;5845.590808643354;5867.354590995073;5926.2295901532525;5934.851628709317;5977.043673012297;5985.551083668829;5605.607607467438;5699.088145896637;5723.828285151452;5731.5701322400155;5752.654840709571;5708.429157084258;5713.8285851424525;5725.112607545837;5744.798932037359;5752.9712351437975;5685.715714214355;5714.742836572447;5719.771209151588;5720.056190728649;5747.195392645117;5810.099434587646;5811.27359080115;5821.068629019336;5841.32824725145;5856.619319744203;5461.071617825059;5690.77236910519;5700.771969121354;5708.914366284592;5769.048107062287 17:29:41 INFO - PROCESS | 21350 | |1;ext.html;598.302977031758;656.5437021270218;661.0150875195958;664.7440735316904;688.6935313785361;35859.4621080684;37531.4370284446;37645.24709505812;37753.05617359567;37878.43182352267;40188.19623607526;40434.19131617366;40462.57224566521;40739.18521629566;40818.38772418416;8654.567271636424;8764.342674299422;8779.385443018991;8803.911960880405;8827.426217295888;8685.174908383693;8740.038595754462;8790.64837406503;8800.207981281683;8800.251978581828;8773.736787896374;8794.86807697885;8840.734777956672;8845.601947912359;8853.911460885405;8688.348373871953;8744.737657870273;8789.516576588285;8801.251893589053;8810.64757409706;8663.176998185225;8758.47449153053;8761.21149096578;8767.342449316264;8790.120987901222;32055.83972080148;38076.42885356722;38636;38773.41839872404;38972.610273897466;3178.8092714437207;3261.59230096238;3300.273939733255;3316.6351701312838;3328.9167770805925;27039.594406083925;27164.1850744476;27279.590806137923;27612.861935690195;28153.15540533787;3749.2876353492748;3772.603876592973;3793.8292776824833;3822.4266360045935;3888.727789054767;189080;189731;190328;190464;245917;34223;34309.65690343115;34493.13767155791;34493.48259776105;34549.654503455145;35892.20538973093;36113.45829812555;62809.685951570864;64902.350976490576;64961;15971.36114555428;16049.759253611206;16139.354425822836;16146.596335091717;16161.515154545383;12519.874801251872;12537.247765134121;12553.811692824615;12559.058070644738;12604.11771176009;19266.07335275574;19477.707834382494;19484.63607547458;19501.80498195028;19537.41387758341;7319.670614822346;7371.115466144097;7400.5189662671755;7561.7731468056045;7615.314621684075;1035.0684384054412;1074.7742973975396;1086.3536195963388;1091.3997301484153;1163.743976325207;32135.51796723051;32267;32389.51415728766;32519.512207316908;32991.50512742311;1119.9328040317444;1178.4166837415535;1189.4112414354777;1195.235049568277;1204.8614409342863;16883.577910552336;16934.153292335333;17009.829901700825;17202.913985430245;17317.826821731873;483445;490000;493018;494763;495270;57967.4203257962;58703.41296587065;58978;59152;59202.40797592055;1358.9048766586245;1383.571092961165;1417.4471955937192;1424.4729450103528;1427.1722401007391;30883;31172.37655246928;31456;31564.526532102496;32060;51251.48748512467;53924.19113713219;56191.71904140453;56247.71876140593;56354;434601;442178;443489;443876;444681;43716.34425483684;44033;44313.556864432234;44397.55602443934;44568;48087.27869082036;48238.276425852935;48817.755911220214;49123.75438122787;49389.25916111189;39572.20855582815;40867;40901.1819763609;41038;42415.1516969665;39627;39979.40030899481;41062.58937410707;42016.369754453095;42056;41689.79155104205;41815.1636967265;42693.14613707647;42748.35877461778;42904.35643465413;30683;32616.673833262314;32758;33894.491582625786;35190.76832310857;27235.59146612842;27618.309542261602;27861.16416507508;27958.44083118367;28036.158915232576 17:29:41 INFO - PROCESS | 21350 | |2;jquery.html;392.0766594669554;393.62802151966395;399.48266994242437;399.6023956163618;406.9715119941603;13590.728185436285;15416.845831541681;17796;18571.442856714304;18641.16114774835;15821.129837858913;18626.813731862676;19050.2379904804;19061.714074288895;19177.808221917778;5130.743462826862;5607.523360514361;5711.200431939532;5758.942410575883;5761.9135712964335;5290.550303224211;5350.91973620396;5361.839144825662;5368.382635996872;5371.060064488718;5165.948340516603;5320.707361095138;5458.781648734046;5471.206675032118;5487.670739755607;5380.273663055476;5396.352437707481;5457.126859702448;5495.395506494282;5669.886602267973;5451.3458384994055;5462.808801691962;5497.780088796443;5500.559955203574;5507.091329930557;13053.477860885554;13470.93264533671;13569.253691046988;13579.117357371739;13664.795028074586;2211.9778802212095;2305.319930620471;2311.410590299463;2609.1650671785037;2660.9467810643873;9525.476098814563;9577.377470464467;9962.501874906226;10024.19806415485;12295.877041229653;1855.499015265884;1931.7005864091088;1939.786623471417;1976.8319692826128;1995.2916714566265;78044.60977695131;79527.8070828938;80140.19859801444;80346;81448.18551814466;10398;10506.474676266156;10543.31468454548;10565.841512377321;10696.732581685364;14540.85459145395;14687.55937321882;14743.705125897422;14783.186924719244;14789.334479948428;7633.274838890296;7979.680812767424;7993.400494962901;8056.355491560661;8071.515709057476;7548.924510754932;7600.239976002466;7606.695732170762;7666.578338191342;7895.131535531087;4166.625003749617;4290.978545107255;4307.655387568987;4308.763018034038;4314.71954322968;1827.6892928202237;1871.7941026487076;1885.1893685715274;1895.9856476784853;1920.4910698664864;955.6755680545449;1033.813913495578;1046.4767616191905;1106.9778604427866;1114.7603265298;18164.636707266043;18855.81144188568;18899.527511812314;18920.905395473208;19147.90426047861;982.4007355513131;1025.887152413234;1032.3289861589876;1037.3827572594294;1049.7795462952865;10335.586576537005;10487.265891387682;10572.947135264429;10682.893171068345;10684.893151068545;461362;466023;469798;469848;476044;48695.269570956465;62028.68985655133;96054.51972740091;96219;96881.51559242158;984.9064338887795;1005.4365461707116;1011.0900189829213;1014.518103900656;1060.565168281001;16739;17203.65592688164;17224.741628875327;17251.65496690034;17345.653086938444;37355.81322093372;38050.80974595109;39069;39571.80214098911;40946.795266024674;54171.458285416644;55973.72013139908;56209.156862646276;56360.71819640876;56461.153082704615;7623.542587444771;7949.483283586548;7984.321332686786;8064.6370913307865;8171.79570510742;7849.60751962411;12287.508499659914;12461.626151215478;12612.873871261538;12841.550545730855;11070.39112848801;11290.15323850698;11503.76992460163;11538.480768365276;12129.272243665408;11254.212205145888;11278.661640150809;11588.362640054878;11644.825327620261;11686.298822070703;11280.605178818701;11635.41822908868;11672.739450100482;11723.237989530653;12279.324637145042;8311.501309921425;8541.273991710774;8573;8599.312055035707;8629.09394513567;8285.95857020711;11774.705632358917;11921.52313907434;12066.75866482683;12179.451924663588 17:29:41 INFO - PROCESS | 21350 | |3;mootools.html;1495.6410461489243;1522.3986525322498;1640.3420372569171;1763.6031892824108;1769.4426255729436;7311.488195826294;7904.881426778603;8138.511689298639;8436.072032076467;8486.278666313363;7964.283214510693;7965.402594805384;8002.679892804281;8044.6782128714785;8054.590446671824;2244.607193741093;2261.1520679745095;2275.0444813178506;2282.1327895399727;2285.2458688632796;2211.8783466909313;2215.944601384962;2255.7744225577394;2256.323103069081;2257.16484900587;2220.9000594973186;2242.6523888797265;2250.0999600159985;2256.751757306695;2279.3731723776013;2160.6758986152045;2161.848670593059;2175.6192666283496;2177.074743234119;2182.268939905118;2191.485001024758;2200.7249093863265;2203.6143674856835;2207.315732123047;2210.3258506155776;8363.665453381858;8371.16288371158;8375.371847111492;8419.24226819583;8469.153084691543;4885.951140488621;5033.018561380532;5039.44566097729;5047.747612619354;5054.191329387317;3043.771717121225;3068.156257029335;3085.074477656694;3124.8593813278458;3163.57291765611;2119.395972147946;2137.241279345841;2162.935111946644;2175.8585691929975;2186.2348178137527;10230.693079207562;10341.069303762622;10374.481275936172;10404.271700980935;10415;3922.8038598070552;4106.055607210358;4107.568705285962;4110.198511290329;4143.7306575072525;7952.244536769113;8010.71962481322;8028.277455029075;8033.8393232136195;8038.196180381915;4715;4737.052589482118;4744.240921452551;4769.952300476951;4792.95207047925;4233.153369326147;4463.308187230984;4464.665150113755;4637.211674015425;4666.300054991779;3484.337975784593;3508.1755787389943;3539.2744487380023;3579.391503444421;3648.087978005499;1059.9629012984508;1082.8213344798178;1085.4193006741355;1100.4112799652148;1103.768208676187;916.679162293192;995.348047029197;999;1009.0817356205964;1022.9641962531275;5530.751116199781;5537.529310008614;5593;5650.915236271459;5719;979.6179489998906;1022.6778564752079;1056.2553399853084;1094.9233553651168;1097.2757979733337;4044.6764258859807;4151.8546850860075;4157.189348077096;4167.270727622715;4192.559781222989;10009.69970900874;10386.169106471463;10398.844017339747;10468.738281543023;10513.369197848;10346.22403319754;10380;10393.53229104692;10412.479376031168;10434.68695939123;7174.497785154989;7424.480286379901;7437.367823734935;7508.436867234979;7696.268854458817;5662.094064949588;5897.085951677497;5906.173135761082;5971.134185543159;5971.552133589911;9308.906910931075;9377.390469619453;9459.668911588062;9483.952580237055;9516.19112375456;9282.72151835446;9499.810003799746;9596.23230141573;9619.951900240454;9693;6535.183102112236;6738.528303018742;6904.206016308189;7053.717851285891;7290.161631412456;7320.26797320285;7348.412127029718;7363.042804435389;7364.3372096511575;7367.410607151308;6497.577657452251;6718.093057437183;6789.490788191004;6798.52410331272;6848.383645471931;6683.732650693918;6714.630695311805;6754.628495432798;6810.012548180585;6813.523053386215;6274.466670333073;6333.398327158912;6363.809085727436;6374.490040796818;6397.0724244983285;4913.926291105708;5008.724520151427;5086.923696144487;5101;5130.51260130287;4832.927506087482;4858.295547145714;4890.046440943982;4945.826896058621;4972.950270497248 17:29:41 INFO - PROCESS | 21350 | |4;prototype.html;322.86923795862674;324.1216303816657;330.6825447570333;339.3755489898586;339.8878370137855;5871.794487192949;5973.522118230542;5998.400159983999;6024.9397506024925;6029.306629737576;6005.519558435326;6011.489023433013;6021.879562408749;6027.095935609661;6031.065184896337;4537.2740361542155;4556.84051058213;4569.634429245652;4574.565416285456;4588.816447342102;4442.822287108512;4553.749543775091;4558.5213552577;4585.128825523157;4605;4515.571020753039;4517.141743068806;4532.637389008872;4534.093181363741;4543.636509079282;4539.341795439659;4545.11370282795;4551.908961820778;4553.590176884097;4559.951211221421;3804.505414296124;3955.2287303975736;3965;3975.363941769303;3975.940360894589;5801.158831969341;5810.215620891167;5812.738426770806;5840.182374467578;5849.239598852165;5270.130428479335;5273.709945952971;5282.524572788468;5291.814786482455;5298.814541491068;6158.291796443376;6368.630744389979;6374.458171055419;6382.904256436157;6383.968080159616;4361.498427680825;4379.824807007716;4383.802728877176;4390.143921935224;4399.406080179167;6462.676866156673;6638.269790323061;6654.23476300222;6663.50023748216;6676.365745254193;4453.688241823042;4461.04087621163;4479.776011199427;4502.16709908668;4504.549545045535;4523.072770082191;4527.709602763197;4531.592156705912;4544.18204723153;4547.909041819145;5114.565261952701;5237.633365664443;5247.895042099137;5263.552598029134;5266.4996825302305;6156.445919867144;6262.780802671976;6380.968095159587;6391.712372943229;6400.39196276353;1573.5830005048672;1574.8346423625583;1580.146720770794;1593.6175317923846;1597.961325138669;1051.5215576912487;1071.3197119828965;1074.468138271545;1077.2782235901964;1084.0081325587157;6058.212432383762;6059.333473317932;6072.574919755663;6075.453209211192;6084.969575152096;6500.6424646643945;6534.640594767334;6540.117084193573;6548.443382312556;6570.080188773575;5861.710423706778;5967.582269241111;6034.306054803666;6092.634441933498;6099.268087829489;3492.109512074456;3514.525539052246;3538.5399898013093;3538.5399898013093;3539.2213712983103;6617.139771829631;6742.258351581322;6800.795976120724;6810.969118742112;6811.114555107804;6714.932850671528;6726.529142959946;6731.225909020427;6743.629100399525;6749.865002700017;6546.443552298013;6784.3554862288;6795.932040679629;6799.218089919624;6815.693293801791;6534.803955881332;6550.410463058348;6568.244651864906;6577.539572229898;6594.274629790623;6337.65142917144;6446.742130314735;6452.35476452351;6493.675316234075;6537.5096867736065;6739.898901516383;6754.8649027020165;6767.086443330088;6771.695273712597;6772.5936443813525;4499.640028797754;4523.683342166017;4526.773661316987;4541.659375546913;4544.204764166324;6149.692515374303;6413.775517856852;6553.967230163818;6634.4692424604955;6645.800625981228;6442.710078046593;6466.572716460284;6489.9351006491215;6494.88245642085;6497.382748638872;6269.467095296951;6416.615003099829;6423.325550817097;6429.58207716497;6469.611823290617;6263.060540918898;6306.779262725782;6323.051542268697;6346.809595712136;6349.49204063683;6376.681165941592;6407.231132264158;6446.484281257394;6465.353464653497;6466.579672321284;6142.600730952474;6228.190335256388;6290.182276304051;6335.461485773577;6342.2389313280855 17:29:41 INFO - PROCESS | 21350 | |5;yui.html;847.3517758914429;850.188070392775;863.2921004776082;863.8358711844749;869.0831173112364;13514.054016218868;13783.517576884811;14001.579952601425;14116.435342586297;14153.009289349724;13737.450501979934;13796.655083622914;13804.58586242412;13837.51568695096;13902.096363736375;682.3006418421108;801.3549092980134;807.8909347238135;824.9917500825005;837.0081453477649;832.9333653307751;836.5190015740943;837.7905523619095;838.6854929401475;839.5004972041626;872.9214370706635;872.9214370706635;873.8732883731855;874.8250349930007;874.9387542872001;857.3569822633025;863.4258218284833;865.5369377383101;868.8479516084723;873.5806812729862;624.2571340105305;636.5321488705797;646.0922404022356;649.8440374310131;650.6681592387869;14360.497382591664;14432.639184020378;14439.494617688331;14450.060746051473;14533.854661453355;13935.721285574333;14143.858561414358;14508.347124379428;14613.196274204915;14641.267936603233;11253.437328133643;11319.886801131966;11324.886751132466;11532.077433805276;11603.883961160365;3855.8457661693496;3892.2410130024655;3909.2376986487648;3919.2161567686576;3919.568847426781;54336.184957225676;54765;54916.72541637306;55614;56413;11262.943685281685;11275.097992160607;11295.94352028251;11316.207865449504;11374.260673056391;20365.287214947406;20551.280705175246;20563.485912852;20569.280075197297;20834.062467189015;8518.446300990416;8581.570921453902;8597.676895360863;8630.395872289006;8668.349873759493;4861.878453038702;4864.051509955595;4864.318995340655;4885.706857588556;5007.774650140753;3380.5436266104252;3404.3531728971416;3412.3175364927115;3414.2830005698584;3430.3996800559803;585.7159277750287;590.5452801342942;601.0503404620689;604.211503987292;607.9513638908877;758.7875394889439;776.8135647444685;784.9921500785033;789.2620399926087;790.632355954484;9026.548672566345;9149.954250228839;9211.170994610517;9367.484788336571;9467.90532094684;658.5850913924293;711.2887112887113;717.705740646343;723.6634964741421;737.2774680812834;4273.914521709548;4375.956240437618;4379.781010949439;4408.867733967986;4416.138852923713;56195;57335;57524.712376438685;57755.42244577585;57970.42029579735;50688.74655626772;51268.487315126375;51321;51845.48154518406;52824.47175528272;41856.37215441771;41933.58066419297;42704.57295427068;47557;48579.757101214265;8687.174718401742;8725.912740872764;8918.509481978554;9112.544372781202;9200.125988031126;28026.299342515784;28397.432051358443;28692.713072869003;28986.855065724536;29116.854415727787;35041.64958350384;41604;43179.35230971475;43480;43548.78225608852;11921.403929803648;12184.817227741414;12213;12317.322547259628;12355.505779768708;13317.267550284827;13495.056874665795;13723.862761372658;13822.861771382157;13931.512397066053;12837.229766214057;13100.410481528545;13343.199408035161;13514.459421623418;13774.035817492679;12869.163504372185;12869.420876060412;13509;13544.390502427612;13620;12630.494780208688;13305.268210248529;13376.732465350833;13449.193048417126;13496.325183740577;10604.469776511298;10784.299020563638;10864.239503235014;10884.292520986111;11297.26567773092;10841.295315804447;10851;10977.3962432067;11124.100719424267;11140.777184456103 17:29:41 INFO - PROCESS | 21350 | __end_tp_report 17:29:41 INFO - PROCESS | 21350 | __start_cc_report 17:29:41 INFO - PROCESS | 21350 | _x_x_mozilla_cycle_collect,326 17:29:41 INFO - PROCESS | 21350 | __end_cc_report 17:29:41 INFO - PROCESS | 21350 | __startTimestamp1461371381327__endTimestamp 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | ------- Summary: start ------- 17:29:41 INFO - PROCESS | 21350 | Number of tests: 6 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#0] dojo.html Cycles:165 Average:5404.93 Median:5713.83 stddev:723.70 (12.7%) stddev-sans-first:704.61 17:29:41 INFO - PROCESS | 21350 | Values: 3182.7 3193.1 3209.2 3236.2 3263.0 5528.6 5535.9 5551.3 5556.0 5558.0 5374.7 5510.1 5512.8 5566.7 5623.9 4959.4 4984.5 5040.2 5055.8 5082.2 742.4 4852.9 4929.5 5034.3 5040.4 4910.8 4941.1 4949.3 4972.9 4975.6 4957.2 4963.0 4965.4 4966.9 4996.2 4883.3 4932.3 4933.7 4958.0 4977.5 5419.6 5444.5 5447.6 5493.2 5515.5 5769.8 5794.6 5916.2 5918.3 5924.2 5801.4 5814.5 5817.6 5855.9 5860.2 5392.5 5407.5 5429.8 5435.9 5456.0 5776.3 5896.9 5931.9 6022.9 6065.3 5769.0 5791.9 5792.4 5803.0 5817.5 5820.9 5856.9 5859.5 5864.1 5874.7 5785.8 5839.8 5843.1 5950.3 5967.6 5716.1 5746.1 5747.1 5755.3 5763.7 4273.0 4305.4 4341.7 4350.9 4381.2 3908.6 3915.0 3922.9 3929.7 3994.7 5461.2 5521.2 5565.2 5577.0 5632.9 5775.1 5796.3 5805.3 5820.8 5836.8 5444.7 5524.1 5565.6 5570.3 5618.8 4892.7 4897.4 4914.0 4917.4 4937.1 5891.9 5905.2 5922.3 5944.4 5972.2 5716.3 5780.1 5820.2 5842.4 5851.7 6069.9 6083.3 6094.2 6097.8 6119.3 5730.0 5784.5 5827.4 5831.0 5845.6 5867.4 5926.2 5934.9 5977.0 5985.6 5605.6 5699.1 5723.8 5731.6 5752.7 5708.4 5713.8 5725.1 5744.8 5753.0 5685.7 5714.7 5719.8 5720.1 5747.2 5810.1 5811.3 5821.1 5841.3 5856.6 5461.1 5690.8 5700.8 5708.9 5769.0 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#1] ext.html Cycles:180 Average:54097.15 Median:21430.67 stddev:106089.51 (495.0%) stddev-sans-first:106311.08 17:29:41 INFO - PROCESS | 21350 | Values: 598.3 656.5 661.0 664.7 688.7 35859.5 37531.4 37645.2 37753.1 37878.4 40188.2 40434.2 40462.6 40739.2 40818.4 8654.6 8764.3 8779.4 8803.9 8827.4 8685.2 8740.0 8790.6 8800.2 8800.3 8773.7 8794.9 8840.7 8845.6 8853.9 8688.3 8744.7 8789.5 8801.3 8810.6 8663.2 8758.5 8761.2 8767.3 8790.1 32055.8 38076.4 38636.0 38773.4 38972.6 3178.8 3261.6 3300.3 3316.6 3328.9 27039.6 27164.2 27279.6 27612.9 28153.2 3749.3 3772.6 3793.8 3822.4 3888.7 189080.0 189731.0 190328.0 190464.0 245917.0 34223.0 34309.7 34493.1 34493.5 34549.7 35892.2 36113.5 62809.7 64902.4 64961.0 15971.4 16049.8 16139.4 16146.6 16161.5 12519.9 12537.2 12553.8 12559.1 12604.1 19266.1 19477.7 19484.6 19501.8 19537.4 7319.7 7371.1 7400.5 7561.8 7615.3 1035.1 1074.8 1086.4 1091.4 1163.7 32135.5 32267.0 32389.5 32519.5 32991.5 1119.9 1178.4 1189.4 1195.2 1204.9 16883.6 16934.2 17009.8 17202.9 17317.8 483445.0 490000.0 493018.0 494763.0 495270.0 57967.4 58703.4 58978.0 59152.0 59202.4 1358.9 1383.6 1417.4 1424.5 1427.2 30883.0 31172.4 31456.0 31564.5 32060.0 51251.5 53924.2 56191.7 56247.7 56354.0 434601.0 442178.0 443489.0 443876.0 444681.0 43716.3 44033.0 44313.6 44397.6 44568.0 48087.3 48238.3 48817.8 49123.8 49389.3 39572.2 40867.0 40901.2 41038.0 42415.2 39627.0 39979.4 41062.6 42016.4 42056.0 41689.8 41815.2 42693.1 42748.4 42904.4 30683.0 32616.7 32758.0 33894.5 35190.8 27235.6 27618.3 27861.2 27958.4 28036.2 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#2] jquery.html Cycles:180 Average:27359.53 Median:2635.06 stddev:77248.48 (2931.6%) stddev-sans-first:77438.64 17:29:41 INFO - PROCESS | 21350 | Values: 392.1 393.6 399.5 399.6 407.0 13590.7 15416.8 17796.0 18571.4 18641.2 15821.1 18626.8 19050.2 19061.7 19177.8 5130.7 5607.5 5711.2 5758.9 5761.9 5290.6 5350.9 5361.8 5368.4 5371.1 5165.9 5320.7 5458.8 5471.2 5487.7 5380.3 5396.4 5457.1 5495.4 5669.9 5451.3 5462.8 5497.8 5500.6 5507.1 13053.5 13470.9 13569.3 13579.1 13664.8 2212.0 2305.3 2311.4 2609.2 2660.9 9525.5 9577.4 9962.5 10024.2 12295.9 1855.5 1931.7 1939.8 1976.8 1995.3 78044.6 79527.8 80140.2 80346.0 81448.2 10398.0 10506.5 10543.3 10565.8 10696.7 14540.9 14687.6 14743.7 14783.2 14789.3 7633.3 7979.7 7993.4 8056.4 8071.5 7548.9 7600.2 7606.7 7666.6 7895.1 4166.6 4291.0 4307.7 4308.8 4314.7 1827.7 1871.8 1885.2 1896.0 1920.5 955.7 1033.8 1046.5 1107.0 1114.8 18164.6 18855.8 18899.5 18920.9 19147.9 982.4 1025.9 1032.3 1037.4 1049.8 10335.6 10487.3 10572.9 10682.9 10684.9 461362.0 466023.0 469798.0 469848.0 476044.0 48695.3 62028.7 96054.5 96219.0 96881.5 984.9 1005.4 1011.1 1014.5 1060.6 16739.0 17203.7 17224.7 17251.7 17345.7 37355.8 38050.8 39069.0 39571.8 40946.8 54171.5 55973.7 56209.2 56360.7 56461.2 7623.5 7949.5 7984.3 8064.6 8171.8 7849.6 12287.5 12461.6 12612.9 12841.6 11070.4 11290.2 11503.8 11538.5 12129.3 11254.2 11278.7 11588.4 11644.8 11686.3 11280.6 11635.4 11672.7 11723.2 12279.3 8311.5 8541.3 8573.0 8599.3 8629.1 8286.0 11774.7 11921.5 12066.8 12179.5 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#3] mootools.html Cycles:180 Average:5352.75 Median:4812.94 stddev:2886.63 (60.0%) stddev-sans-first:2880.18 17:29:41 INFO - PROCESS | 21350 | Values: 1495.6 1522.4 1640.3 1763.6 1769.4 7311.5 7904.9 8138.5 8436.1 8486.3 7964.3 7965.4 8002.7 8044.7 8054.6 2244.6 2261.2 2275.0 2282.1 2285.2 2211.9 2215.9 2255.8 2256.3 2257.2 2220.9 2242.7 2250.1 2256.8 2279.4 2160.7 2161.8 2175.6 2177.1 2182.3 2191.5 2200.7 2203.6 2207.3 2210.3 8363.7 8371.2 8375.4 8419.2 8469.2 4886.0 5033.0 5039.4 5047.7 5054.2 3043.8 3068.2 3085.1 3124.9 3163.6 2119.4 2137.2 2162.9 2175.9 2186.2 10230.7 10341.1 10374.5 10404.3 10415.0 3922.8 4106.1 4107.6 4110.2 4143.7 7952.2 8010.7 8028.3 8033.8 8038.2 4715.0 4737.1 4744.2 4770.0 4793.0 4233.2 4463.3 4464.7 4637.2 4666.3 3484.3 3508.2 3539.3 3579.4 3648.1 1060.0 1082.8 1085.4 1100.4 1103.8 916.7 995.3 999.0 1009.1 1023.0 5530.8 5537.5 5593.0 5650.9 5719.0 979.6 1022.7 1056.3 1094.9 1097.3 4044.7 4151.9 4157.2 4167.3 4192.6 10009.7 10386.2 10398.8 10468.7 10513.4 10346.2 10380.0 10393.5 10412.5 10434.7 7174.5 7424.5 7437.4 7508.4 7696.3 5662.1 5897.1 5906.2 5971.1 5971.6 9308.9 9377.4 9459.7 9484.0 9516.2 9282.7 9499.8 9596.2 9620.0 9693.0 6535.2 6738.5 6904.2 7053.7 7290.2 7320.3 7348.4 7363.0 7364.3 7367.4 6497.6 6718.1 6789.5 6798.5 6848.4 6683.7 6714.6 6754.6 6810.0 6813.5 6274.5 6333.4 6363.8 6374.5 6397.1 4913.9 5008.7 5086.9 5101.0 5130.5 4832.9 4858.3 4890.0 4945.8 4973.0 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#4] prototype.html Cycles:180 Average:5310.64 Median:6030.19 stddev:1609.87 (26.7%) stddev-sans-first:1570.26 17:29:41 INFO - PROCESS | 21350 | Values: 322.9 324.1 330.7 339.4 339.9 5871.8 5973.5 5998.4 6024.9 6029.3 6005.5 6011.5 6021.9 6027.1 6031.1 4537.3 4556.8 4569.6 4574.6 4588.8 4442.8 4553.7 4558.5 4585.1 4605.0 4515.6 4517.1 4532.6 4534.1 4543.6 4539.3 4545.1 4551.9 4553.6 4560.0 3804.5 3955.2 3965.0 3975.4 3975.9 5801.2 5810.2 5812.7 5840.2 5849.2 5270.1 5273.7 5282.5 5291.8 5298.8 6158.3 6368.6 6374.5 6382.9 6384.0 4361.5 4379.8 4383.8 4390.1 4399.4 6462.7 6638.3 6654.2 6663.5 6676.4 4453.7 4461.0 4479.8 4502.2 4504.5 4523.1 4527.7 4531.6 4544.2 4547.9 5114.6 5237.6 5247.9 5263.6 5266.5 6156.4 6262.8 6381.0 6391.7 6400.4 1573.6 1574.8 1580.1 1593.6 1598.0 1051.5 1071.3 1074.5 1077.3 1084.0 6058.2 6059.3 6072.6 6075.5 6085.0 6500.6 6534.6 6540.1 6548.4 6570.1 5861.7 5967.6 6034.3 6092.6 6099.3 3492.1 3514.5 3538.5 3538.5 3539.2 6617.1 6742.3 6800.8 6811.0 6811.1 6714.9 6726.5 6731.2 6743.6 6749.9 6546.4 6784.4 6795.9 6799.2 6815.7 6534.8 6550.4 6568.2 6577.5 6594.3 6337.7 6446.7 6452.4 6493.7 6537.5 6739.9 6754.9 6767.1 6771.7 6772.6 4499.6 4523.7 4526.8 4541.7 4544.2 6149.7 6413.8 6554.0 6634.5 6645.8 6442.7 6466.6 6489.9 6494.9 6497.4 6269.5 6416.6 6423.3 6429.6 6469.6 6263.1 6306.8 6323.1 6346.8 6349.5 6376.7 6407.2 6446.5 6465.4 6466.6 6142.6 6228.2 6290.2 6335.5 6342.2 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - PROCESS | 21350 | [#5] yui.html Cycles:180 Average:14344.64 Median:23726.63 stddev:15879.06 (66.9%) stddev-sans-first:15891.25 17:29:41 INFO - PROCESS | 21350 | Values: 847.4 850.2 863.3 863.8 869.1 13514.1 13783.5 14001.6 14116.4 14153.0 13737.5 13796.7 13804.6 13837.5 13902.1 682.3 801.4 807.9 825.0 837.0 832.9 836.5 837.8 838.7 839.5 872.9 872.9 873.9 874.8 874.9 857.4 863.4 865.5 868.8 873.6 624.3 636.5 646.1 649.8 650.7 14360.5 14432.6 14439.5 14450.1 14533.9 13935.7 14143.9 14508.3 14613.2 14641.3 11253.4 11319.9 11324.9 11532.1 11603.9 3855.8 3892.2 3909.2 3919.2 3919.6 54336.2 54765.0 54916.7 55614.0 56413.0 11262.9 11275.1 11295.9 11316.2 11374.3 20365.3 20551.3 20563.5 20569.3 20834.1 8518.4 8581.6 8597.7 8630.4 8668.3 4861.9 4864.1 4864.3 4885.7 5007.8 3380.5 3404.4 3412.3 3414.3 3430.4 585.7 590.5 601.1 604.2 608.0 758.8 776.8 785.0 789.3 790.6 9026.5 9150.0 9211.2 9367.5 9467.9 658.6 711.3 717.7 723.7 737.3 4273.9 4376.0 4379.8 4408.9 4416.1 56195.0 57335.0 57524.7 57755.4 57970.4 50688.7 51268.5 51321.0 51845.5 52824.5 41856.4 41933.6 42704.6 47557.0 48579.8 8687.2 8725.9 8918.5 9112.5 9200.1 28026.3 28397.4 28692.7 28986.9 29116.9 35041.6 41604.0 43179.4 43480.0 43548.8 11921.4 12184.8 12213.0 12317.3 12355.5 13317.3 13495.1 13723.9 13822.9 13931.5 12837.2 13100.4 13343.2 13514.5 13774.0 12869.2 12869.4 13509.0 13544.4 13620.0 12630.5 13305.3 13376.7 13449.2 13496.3 10604.5 10784.3 10864.2 10884.3 11297.3 10841.3 10851.0 10977.4 11124.1 11140.8 17:29:41 INFO - PROCESS | 21350 | -------- Summary: end -------- 17:29:41 INFO - PROCESS | 21350 | 17:29:41 INFO - TEST-INFO | 21350: exit 0 17:29:41 INFO - TEST-OK | dromaeo_css | took 1109071ms 17:29:41 INFO - TEST-START | kraken 17:29:41 INFO - operating with platform_type : linux_ 17:29:41 INFO - Initialising browser for kraken test... 17:29:41 INFO - TEST-INFO | started process 21582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YeNUz/profile http://localhost:60839/getInfo.html) 17:29:45 INFO - PROCESS | 21582 | 17:29:45 INFO - PROCESS | 21582 | (process:21651): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:46 INFO - PROCESS | 21582 | __metrics Screen width/height:1600/1200 17:29:46 INFO - PROCESS | 21582 | colorDepth:24 17:29:46 INFO - PROCESS | 21582 | Browser inner width/height: 1024/697 17:29:46 INFO - PROCESS | 21582 | __metrics 17:29:46 ERROR - PROCESS | 21582 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:29:47 INFO - TEST-INFO | 21582: exit 0 17:29:47 INFO - Browser initialized. 17:29:47 INFO - Running cycle 1/1 for kraken test... 17:29:47 INFO - TEST-INFO | started process 21702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YeNUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:49 INFO - PROCESS | 21702 | 17:29:49 INFO - PROCESS | 21702 | (process:21763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:59 INFO - PROCESS | 21702 | RSS: Main: 164519936 17:29:59 INFO - PROCESS | 21702 | 17:30:01 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60839/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:02 INFO - PROCESS | 21702 | RSS: Main: 169476096 17:30:02 INFO - PROCESS | 21702 | 17:30:05 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60839/tests/kraken/driver.html?testName=audio-dft) 17:30:06 INFO - PROCESS | 21702 | RSS: Main: 172695552 17:30:06 INFO - PROCESS | 21702 | 17:30:08 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60839/tests/kraken/driver.html?testName=audio-fft) 17:30:09 INFO - PROCESS | 21702 | RSS: Main: 163577856 17:30:09 INFO - PROCESS | 21702 | 17:30:11 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60839/tests/kraken/driver.html?testName=audio-oscillator) 17:30:12 INFO - PROCESS | 21702 | RSS: Main: 164020224 17:30:12 INFO - PROCESS | 21702 | 17:30:14 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:15 INFO - PROCESS | 21702 | RSS: Main: 164278272 17:30:15 INFO - PROCESS | 21702 | 17:30:18 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60839/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:18 INFO - PROCESS | 21702 | RSS: Main: 164782080 17:30:18 INFO - PROCESS | 21702 | 17:30:22 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60839/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:22 INFO - PROCESS | 21702 | RSS: Main: 164745216 17:30:22 INFO - PROCESS | 21702 | 17:30:25 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60839/tests/kraken/driver.html?testName=json-parse-financial) 17:30:26 INFO - PROCESS | 21702 | RSS: Main: 166739968 17:30:26 INFO - PROCESS | 21702 | 17:30:27 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:28 INFO - PROCESS | 21702 | RSS: Main: 166854656 17:30:28 INFO - PROCESS | 21702 | 17:30:30 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:30 INFO - PROCESS | 21702 | RSS: Main: 166903808 17:30:30 INFO - PROCESS | 21702 | 17:30:32 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:33 INFO - PROCESS | 21702 | RSS: Main: 168058880 17:30:33 INFO - PROCESS | 21702 | 17:30:36 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:36 INFO - PROCESS | 21702 | RSS: Main: 167235584 17:30:36 INFO - PROCESS | 21702 | 17:30:39 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:40 INFO - PROCESS | 21702 | RSS: Main: 167301120 17:30:40 INFO - PROCESS | 21702 | 17:30:41 INFO - PROCESS | 21702 | Cycle 1(1): loaded http://localhost:60839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60839/tests/kraken/driver.html?testName=ai-astar) 17:30:42 INFO - PROCESS | 21702 | RSS: Main: 169328640 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | __start_tp_report 17:30:42 INFO - PROCESS | 21702 | _x_x_mozilla_page_load 17:30:42 INFO - PROCESS | 21702 | _x_x_mozilla_page_load_details 17:30:42 INFO - PROCESS | 21702 | |i|pagename|runs| 17:30:42 INFO - PROCESS | 21702 | |0;ai-astar;111;107;112;110;112;124;112;112;112;112 17:30:42 INFO - PROCESS | 21702 | |1;audio-beat-detection;160;126;179;189;128;159;159;129;189;135 17:30:42 INFO - PROCESS | 21702 | |2;audio-dft;164;160;162;162;163;166;174;166;166;163 17:30:42 INFO - PROCESS | 21702 | |3;audio-fft;78;75;78;150;76;73;76;76;104;73 17:30:42 INFO - PROCESS | 21702 | |4;audio-oscillator;93;92;163;92;92;93;146;92;93;141 17:30:42 INFO - PROCESS | 21702 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;117;117;117 17:30:42 INFO - PROCESS | 21702 | |6;imaging-darkroom;146;146;150;146;147;146;146;145;147;145 17:30:42 INFO - PROCESS | 21702 | |7;imaging-desaturate;95;97;95;95;95;95;95;95;96;95 17:30:42 INFO - PROCESS | 21702 | |8;json-parse-financial;60;58;58;59;58;56;57;91;56;62 17:30:42 INFO - PROCESS | 21702 | |9;json-stringify-tinderbox;61;60;71;60;62;61;60;61;61;61 17:30:42 INFO - PROCESS | 21702 | |10;stanford-crypto-aes;77;77;83;78;79;79;77;79;78;78 17:30:42 INFO - PROCESS | 21702 | |11;stanford-crypto-ccm;128;125;140;125;135;132;131;125;161;128 17:30:42 INFO - PROCESS | 21702 | |12;stanford-crypto-pbkdf2;168;168;168;165;168;167;167;166;171;166 17:30:42 INFO - PROCESS | 21702 | |13;stanford-crypto-sha256-iterative;72;70;71;69;70;70;69;69;71;71 17:30:42 INFO - PROCESS | 21702 | __end_tp_report 17:30:42 INFO - PROCESS | 21702 | __start_cc_report 17:30:42 INFO - PROCESS | 21702 | _x_x_mozilla_cycle_collect,916 17:30:42 INFO - PROCESS | 21702 | __end_cc_report 17:30:42 INFO - PROCESS | 21702 | __startTimestamp1461371442162__endTimestamp 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | ------- Summary: start ------- 17:30:42 INFO - PROCESS | 21702 | Number of tests: 14 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.61 17:30:42 INFO - PROCESS | 21702 | Values: 111.0 107.0 112.0 110.0 112.0 124.0 112.0 112.0 112.0 112.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:159.50 stddev:24.92 (15.6%) stddev-sans-first:26.38 17:30:42 INFO - PROCESS | 21702 | Values: 160.0 126.0 179.0 189.0 128.0 159.0 159.0 129.0 189.0 135.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:3.86 (2.3%) stddev-sans-first:4.09 17:30:42 INFO - PROCESS | 21702 | Values: 164.0 160.0 162.0 162.0 163.0 166.0 174.0 166.0 166.0 163.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#3] audio-fft Cycles:10 Average:85.90 Median:76.00 stddev:24.28 (32.0%) stddev-sans-first:25.59 17:30:42 INFO - PROCESS | 21702 | Values: 78.0 75.0 78.0 150.0 76.0 73.0 76.0 76.0 104.0 73.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:28.34 (30.8%) stddev-sans-first:29.41 17:30:42 INFO - PROCESS | 21702 | Values: 93.0 92.0 163.0 92.0 92.0 93.0 146.0 92.0 93.0 141.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 17:30:42 INFO - PROCESS | 21702 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 17:30:42 INFO - PROCESS | 21702 | Values: 146.0 146.0 150.0 146.0 147.0 146.0 146.0 145.0 147.0 145.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:30:42 INFO - PROCESS | 21702 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:58.50 stddev:10.52 (18.0%) stddev-sans-first:11.15 17:30:42 INFO - PROCESS | 21702 | Values: 60.0 58.0 58.0 59.0 58.0 56.0 57.0 91.0 56.0 62.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:3.29 (5.4%) stddev-sans-first:3.48 17:30:42 INFO - PROCESS | 21702 | Values: 61.0 60.0 71.0 60.0 62.0 61.0 60.0 61.0 61.0 61.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:1.78 (2.3%) stddev-sans-first:1.80 17:30:42 INFO - PROCESS | 21702 | Values: 77.0 77.0 83.0 78.0 79.0 79.0 77.0 79.0 78.0 78.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:131.50 stddev:10.97 (8.3%) stddev-sans-first:11.49 17:30:42 INFO - PROCESS | 21702 | Values: 128.0 125.0 140.0 125.0 135.0 132.0 131.0 125.0 161.0 128.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:1.65 (1.0%) stddev-sans-first:1.73 17:30:42 INFO - PROCESS | 21702 | Values: 168.0 168.0 168.0 165.0 168.0 167.0 167.0 166.0 171.0 166.0 17:30:42 INFO - PROCESS | 21702 | 17:30:42 INFO - PROCESS | 21702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.03 (1.5%) stddev-sans-first:0.87 17:30:42 INFO - PROCESS | 21702 | Values: 72.0 70.0 71.0 69.0 70.0 70.0 69.0 69.0 71.0 71.0 17:30:42 INFO - PROCESS | 21702 | -------- Summary: end -------- 17:30:42 INFO - PROCESS | 21702 | 17:30:43 INFO - TEST-INFO | 21702: exit 0 17:30:43 INFO - TEST-OK | kraken | took 61105ms 17:30:43 INFO - SUITE-END | took 1170s 17:30:43 INFO - Completed test suite (00:19:30) 17:30:43 INFO - javascript benchmark 17:30:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3182.6658200888905, 3193.058047875877, 3209.165616939595, 3236.223306406463, 3263.0, 5528.585356098289, 5535.944640553594, 5551.333839939213, 5556.027695153347, 5557.972210138943, 5374.731263436823, 5510.1459273812525, 5512.834614961547, 5566.721663916798, 5623.915641265374, 4959.404871415426, 4984.501549845023, 5040.2439634055, 5055.772490237948, 5082.161443361841, 742.38698694912, 4852.902941941159, 4929.50704929506, 5034.345535080434, 5040.445550989388, 4910.828121015783, 4941.085899108659, 4949.30709700644, 4972.8508144755715, 4975.626827987898, 4957.231629097496, 4962.982588569334, 4965.428975667773, 4966.925496117561, 4996.1756310208775, 4883.340748998875, 4932.284818701268, 4933.7286449245275, 4958.033183529214, 4977.477364876672, 5419.620626556142, 5444.537214336786, 5447.618666693294, 5493.176023596453, 5515.531179849718, 5769.798057067983, 5794.565407594405, 5916.201312822757, 5918.319393269743, 5924.170616113747, 5801.448862358069, 5814.534837213013, 5817.592768506206, 5855.882882342372, 5860.208871802295, 5392.514673679349, 5407.5133238008375, 5429.8099566515375, 5435.918461223085, 5456.0, 5776.277965254343, 5896.882062358729, 5931.9406805931385, 6022.879542409128, 6065.272167339947, 5768.990426675399, 5791.942080579224, 5792.362840087587, 5802.970985145132, 5817.505512031525, 5820.94179058204, 5856.8535786604825, 5859.53123750099, 5864.061750120046, 5874.676892770854, 5785.768569257182, 5839.795607153729, 5843.1235314703135, 5950.285965684146, 5967.582269241198, 5716.056850619684, 5746.1093530502, 5747.109198074305, 5755.251817263729, 5763.6541807491685, 4272.957270427318, 4305.440292761984, 4341.696081274281, 4350.869473915787, 4381.233284175257, 3908.609139086069, 3915.0, 3922.921541569153, 3929.685625149981, 3994.720369574102, 5461.15352120422, 5521.2270282160525, 5565.193047008162, 5576.97211513948, 5632.85917852057, 5775.075987842009, 5796.333421656479, 5805.332386775575, 5820.76716931318, 5836.766529338864, 5444.673319600757, 5524.14375771756, 5565.638233514808, 5570.303712035996, 5618.803341883096, 4892.730899800546, 4897.412310522689, 4913.975430122898, 4917.385326834145, 4937.061958227925, 5891.852703682443, 5905.173275741399, 5922.3485416604135, 5944.375840536682, 5972.193753843262, 5716.256886604798, 5780.075187969905, 5820.214271073521, 5842.415758424124, 5851.707414629337, 6069.878602427839, 6083.270007599116, 6094.177286066324, 6097.75608975636, 6119.296280927572, 5729.997250481232, 5784.5083167929515, 5827.358990511125, 5830.950428922834, 5845.590808643354, 5867.354590995073, 5926.2295901532525, 5934.851628709317, 5977.043673012297, 5985.551083668829, 5605.607607467438, 5699.088145896637, 5723.828285151452, 5731.5701322400155, 5752.654840709571, 5708.429157084258, 5713.8285851424525, 5725.112607545837, 5744.798932037359, 5752.9712351437975, 5685.715714214355, 5714.742836572447, 5719.771209151588, 5720.056190728649, 5747.195392645117, 5810.099434587646, 5811.27359080115, 5821.068629019336, 5841.32824725145, 5856.619319744203, 5461.071617825059, 5690.77236910519, 5700.771969121354, 5708.914366284592, 5769.048107062287], "value": 5357.496654306995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.302977031758, 656.5437021270218, 661.0150875195958, 664.7440735316904, 688.6935313785361, 35859.4621080684, 37531.4370284446, 37645.24709505812, 37753.05617359567, 37878.43182352267, 40188.19623607526, 40434.19131617366, 40462.57224566521, 40739.18521629566, 40818.38772418416, 8654.567271636424, 8764.342674299422, 8779.385443018991, 8803.911960880405, 8827.426217295888, 8685.174908383693, 8740.038595754462, 8790.64837406503, 8800.207981281683, 8800.251978581828, 8773.736787896374, 8794.86807697885, 8840.734777956672, 8845.601947912359, 8853.911460885405, 8688.348373871953, 8744.737657870273, 8789.516576588285, 8801.251893589053, 8810.64757409706, 8663.176998185225, 8758.47449153053, 8761.21149096578, 8767.342449316264, 8790.120987901222, 32055.83972080148, 38076.42885356722, 38636.0, 38773.41839872404, 38972.610273897466, 3178.8092714437207, 3261.59230096238, 3300.273939733255, 3316.6351701312838, 3328.9167770805925, 27039.594406083925, 27164.1850744476, 27279.590806137923, 27612.861935690195, 28153.15540533787, 3749.2876353492748, 3772.603876592973, 3793.8292776824833, 3822.4266360045935, 3888.727789054767, 189080.0, 189731.0, 190328.0, 190464.0, 245917.0, 34223.0, 34309.65690343115, 34493.13767155791, 34493.48259776105, 34549.654503455145, 35892.20538973093, 36113.45829812555, 62809.685951570864, 64902.350976490576, 64961.0, 15971.36114555428, 16049.759253611206, 16139.354425822836, 16146.596335091717, 16161.515154545383, 12519.874801251872, 12537.247765134121, 12553.811692824615, 12559.058070644738, 12604.11771176009, 19266.07335275574, 19477.707834382494, 19484.63607547458, 19501.80498195028, 19537.41387758341, 7319.670614822346, 7371.115466144097, 7400.5189662671755, 7561.7731468056045, 7615.314621684075, 1035.0684384054412, 1074.7742973975396, 1086.3536195963388, 1091.3997301484153, 1163.743976325207, 32135.51796723051, 32267.0, 32389.51415728766, 32519.512207316908, 32991.50512742311, 1119.9328040317444, 1178.4166837415535, 1189.4112414354777, 1195.235049568277, 1204.8614409342863, 16883.577910552336, 16934.153292335333, 17009.829901700825, 17202.913985430245, 17317.826821731873, 483445.0, 490000.0, 493018.0, 494763.0, 495270.0, 57967.4203257962, 58703.41296587065, 58978.0, 59152.0, 59202.40797592055, 1358.9048766586245, 1383.571092961165, 1417.4471955937192, 1424.4729450103528, 1427.1722401007391, 30883.0, 31172.37655246928, 31456.0, 31564.526532102496, 32060.0, 51251.48748512467, 53924.19113713219, 56191.71904140453, 56247.71876140593, 56354.0, 434601.0, 442178.0, 443489.0, 443876.0, 444681.0, 43716.34425483684, 44033.0, 44313.556864432234, 44397.55602443934, 44568.0, 48087.27869082036, 48238.276425852935, 48817.755911220214, 49123.75438122787, 49389.25916111189, 39572.20855582815, 40867.0, 40901.1819763609, 41038.0, 42415.1516969665, 39627.0, 39979.40030899481, 41062.58937410707, 42016.369754453095, 42056.0, 41689.79155104205, 41815.1636967265, 42693.14613707647, 42748.35877461778, 42904.35643465413, 30683.0, 32616.673833262314, 32758.0, 33894.491582625786, 35190.76832310857, 27235.59146612842, 27618.309542261602, 27861.16416507508, 27958.44083118367, 28036.158915232576], "value": 19371.278401292988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.0766594669554, 393.62802151966395, 399.48266994242437, 399.6023956163618, 406.9715119941603, 13590.728185436285, 15416.845831541681, 17796.0, 18571.442856714304, 18641.16114774835, 15821.129837858913, 18626.813731862676, 19050.2379904804, 19061.714074288895, 19177.808221917778, 5130.743462826862, 5607.523360514361, 5711.200431939532, 5758.942410575883, 5761.9135712964335, 5290.550303224211, 5350.91973620396, 5361.839144825662, 5368.382635996872, 5371.060064488718, 5165.948340516603, 5320.707361095138, 5458.781648734046, 5471.206675032118, 5487.670739755607, 5380.273663055476, 5396.352437707481, 5457.126859702448, 5495.395506494282, 5669.886602267973, 5451.3458384994055, 5462.808801691962, 5497.780088796443, 5500.559955203574, 5507.091329930557, 13053.477860885554, 13470.93264533671, 13569.253691046988, 13579.117357371739, 13664.795028074586, 2211.9778802212095, 2305.319930620471, 2311.410590299463, 2609.1650671785037, 2660.9467810643873, 9525.476098814563, 9577.377470464467, 9962.501874906226, 10024.19806415485, 12295.877041229653, 1855.499015265884, 1931.7005864091088, 1939.786623471417, 1976.8319692826128, 1995.2916714566265, 78044.60977695131, 79527.8070828938, 80140.19859801444, 80346.0, 81448.18551814466, 10398.0, 10506.474676266156, 10543.31468454548, 10565.841512377321, 10696.732581685364, 14540.85459145395, 14687.55937321882, 14743.705125897422, 14783.186924719244, 14789.334479948428, 7633.274838890296, 7979.680812767424, 7993.400494962901, 8056.355491560661, 8071.515709057476, 7548.924510754932, 7600.239976002466, 7606.695732170762, 7666.578338191342, 7895.131535531087, 4166.625003749617, 4290.978545107255, 4307.655387568987, 4308.763018034038, 4314.71954322968, 1827.6892928202237, 1871.7941026487076, 1885.1893685715274, 1895.9856476784853, 1920.4910698664864, 955.6755680545449, 1033.813913495578, 1046.4767616191905, 1106.9778604427866, 1114.7603265298, 18164.636707266043, 18855.81144188568, 18899.527511812314, 18920.905395473208, 19147.90426047861, 982.4007355513131, 1025.887152413234, 1032.3289861589876, 1037.3827572594294, 1049.7795462952865, 10335.586576537005, 10487.265891387682, 10572.947135264429, 10682.893171068345, 10684.893151068545, 461362.0, 466023.0, 469798.0, 469848.0, 476044.0, 48695.269570956465, 62028.68985655133, 96054.51972740091, 96219.0, 96881.51559242158, 984.9064338887795, 1005.4365461707116, 1011.0900189829213, 1014.518103900656, 1060.565168281001, 16739.0, 17203.65592688164, 17224.741628875327, 17251.65496690034, 17345.653086938444, 37355.81322093372, 38050.80974595109, 39069.0, 39571.80214098911, 40946.795266024674, 54171.458285416644, 55973.72013139908, 56209.156862646276, 56360.71819640876, 56461.153082704615, 7623.542587444771, 7949.483283586548, 7984.321332686786, 8064.6370913307865, 8171.79570510742, 7849.60751962411, 12287.508499659914, 12461.626151215478, 12612.873871261538, 12841.550545730855, 11070.39112848801, 11290.15323850698, 11503.76992460163, 11538.480768365276, 12129.272243665408, 11254.212205145888, 11278.661640150809, 11588.362640054878, 11644.825327620261, 11686.298822070703, 11280.605178818701, 11635.41822908868, 11672.739450100482, 11723.237989530653, 12279.324637145042, 8311.501309921425, 8541.273991710774, 8573.0, 8599.312055035707, 8629.09394513567, 8285.95857020711, 11774.705632358917, 11921.52313907434, 12066.75866482683, 12179.451924663588], "value": 8795.222485324515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.6410461489243, 1522.3986525322498, 1640.3420372569171, 1763.6031892824108, 1769.4426255729436, 7311.488195826294, 7904.881426778603, 8138.511689298639, 8436.072032076467, 8486.278666313363, 7964.283214510693, 7965.402594805384, 8002.679892804281, 8044.6782128714785, 8054.590446671824, 2244.607193741093, 2261.1520679745095, 2275.0444813178506, 2282.1327895399727, 2285.2458688632796, 2211.8783466909313, 2215.944601384962, 2255.7744225577394, 2256.323103069081, 2257.16484900587, 2220.9000594973186, 2242.6523888797265, 2250.0999600159985, 2256.751757306695, 2279.3731723776013, 2160.6758986152045, 2161.848670593059, 2175.6192666283496, 2177.074743234119, 2182.268939905118, 2191.485001024758, 2200.7249093863265, 2203.6143674856835, 2207.315732123047, 2210.3258506155776, 8363.665453381858, 8371.16288371158, 8375.371847111492, 8419.24226819583, 8469.153084691543, 4885.951140488621, 5033.018561380532, 5039.44566097729, 5047.747612619354, 5054.191329387317, 3043.771717121225, 3068.156257029335, 3085.074477656694, 3124.8593813278458, 3163.57291765611, 2119.395972147946, 2137.241279345841, 2162.935111946644, 2175.8585691929975, 2186.2348178137527, 10230.693079207562, 10341.069303762622, 10374.481275936172, 10404.271700980935, 10415.0, 3922.8038598070552, 4106.055607210358, 4107.568705285962, 4110.198511290329, 4143.7306575072525, 7952.244536769113, 8010.71962481322, 8028.277455029075, 8033.8393232136195, 8038.196180381915, 4715.0, 4737.052589482118, 4744.240921452551, 4769.952300476951, 4792.95207047925, 4233.153369326147, 4463.308187230984, 4464.665150113755, 4637.211674015425, 4666.300054991779, 3484.337975784593, 3508.1755787389943, 3539.2744487380023, 3579.391503444421, 3648.087978005499, 1059.9629012984508, 1082.8213344798178, 1085.4193006741355, 1100.4112799652148, 1103.768208676187, 916.679162293192, 995.348047029197, 999.0, 1009.0817356205964, 1022.9641962531275, 5530.751116199781, 5537.529310008614, 5593.0, 5650.915236271459, 5719.0, 979.6179489998906, 1022.6778564752079, 1056.2553399853084, 1094.9233553651168, 1097.2757979733337, 4044.6764258859807, 4151.8546850860075, 4157.189348077096, 4167.270727622715, 4192.559781222989, 10009.69970900874, 10386.169106471463, 10398.844017339747, 10468.738281543023, 10513.369197848, 10346.22403319754, 10380.0, 10393.53229104692, 10412.479376031168, 10434.68695939123, 7174.497785154989, 7424.480286379901, 7437.367823734935, 7508.436867234979, 7696.268854458817, 5662.094064949588, 5897.085951677497, 5906.173135761082, 5971.134185543159, 5971.552133589911, 9308.906910931075, 9377.390469619453, 9459.668911588062, 9483.952580237055, 9516.19112375456, 9282.72151835446, 9499.810003799746, 9596.23230141573, 9619.951900240454, 9693.0, 6535.183102112236, 6738.528303018742, 6904.206016308189, 7053.717851285891, 7290.161631412456, 7320.26797320285, 7348.412127029718, 7363.042804435389, 7364.3372096511575, 7367.410607151308, 6497.577657452251, 6718.093057437183, 6789.490788191004, 6798.52410331272, 6848.383645471931, 6683.732650693918, 6714.630695311805, 6754.628495432798, 6810.012548180585, 6813.523053386215, 6274.466670333073, 6333.398327158912, 6363.809085727436, 6374.490040796818, 6397.0724244983285, 4913.926291105708, 5008.724520151427, 5086.923696144487, 5101.0, 5130.51260130287, 4832.927506087482, 4858.295547145714, 4890.046440943982, 4945.826896058621, 4972.950270497248], "value": 4417.39235610677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.86923795862674, 324.1216303816657, 330.6825447570333, 339.3755489898586, 339.8878370137855, 5871.794487192949, 5973.522118230542, 5998.400159983999, 6024.9397506024925, 6029.306629737576, 6005.519558435326, 6011.489023433013, 6021.879562408749, 6027.095935609661, 6031.065184896337, 4537.2740361542155, 4556.84051058213, 4569.634429245652, 4574.565416285456, 4588.816447342102, 4442.822287108512, 4553.749543775091, 4558.5213552577, 4585.128825523157, 4605.0, 4515.571020753039, 4517.141743068806, 4532.637389008872, 4534.093181363741, 4543.636509079282, 4539.341795439659, 4545.11370282795, 4551.908961820778, 4553.590176884097, 4559.951211221421, 3804.505414296124, 3955.2287303975736, 3965.0, 3975.363941769303, 3975.940360894589, 5801.158831969341, 5810.215620891167, 5812.738426770806, 5840.182374467578, 5849.239598852165, 5270.130428479335, 5273.709945952971, 5282.524572788468, 5291.814786482455, 5298.814541491068, 6158.291796443376, 6368.630744389979, 6374.458171055419, 6382.904256436157, 6383.968080159616, 4361.498427680825, 4379.824807007716, 4383.802728877176, 4390.143921935224, 4399.406080179167, 6462.676866156673, 6638.269790323061, 6654.23476300222, 6663.50023748216, 6676.365745254193, 4453.688241823042, 4461.04087621163, 4479.776011199427, 4502.16709908668, 4504.549545045535, 4523.072770082191, 4527.709602763197, 4531.592156705912, 4544.18204723153, 4547.909041819145, 5114.565261952701, 5237.633365664443, 5247.895042099137, 5263.552598029134, 5266.4996825302305, 6156.445919867144, 6262.780802671976, 6380.968095159587, 6391.712372943229, 6400.39196276353, 1573.5830005048672, 1574.8346423625583, 1580.146720770794, 1593.6175317923846, 1597.961325138669, 1051.5215576912487, 1071.3197119828965, 1074.468138271545, 1077.2782235901964, 1084.0081325587157, 6058.212432383762, 6059.333473317932, 6072.574919755663, 6075.453209211192, 6084.969575152096, 6500.6424646643945, 6534.640594767334, 6540.117084193573, 6548.443382312556, 6570.080188773575, 5861.710423706778, 5967.582269241111, 6034.306054803666, 6092.634441933498, 6099.268087829489, 3492.109512074456, 3514.525539052246, 3538.5399898013093, 3538.5399898013093, 3539.2213712983103, 6617.139771829631, 6742.258351581322, 6800.795976120724, 6810.969118742112, 6811.114555107804, 6714.932850671528, 6726.529142959946, 6731.225909020427, 6743.629100399525, 6749.865002700017, 6546.443552298013, 6784.3554862288, 6795.932040679629, 6799.218089919624, 6815.693293801791, 6534.803955881332, 6550.410463058348, 6568.244651864906, 6577.539572229898, 6594.274629790623, 6337.65142917144, 6446.742130314735, 6452.35476452351, 6493.675316234075, 6537.5096867736065, 6739.898901516383, 6754.8649027020165, 6767.086443330088, 6771.695273712597, 6772.5936443813525, 4499.640028797754, 4523.683342166017, 4526.773661316987, 4541.659375546913, 4544.204764166324, 6149.692515374303, 6413.775517856852, 6553.967230163818, 6634.4692424604955, 6645.800625981228, 6442.710078046593, 6466.572716460284, 6489.9351006491215, 6494.88245642085, 6497.382748638872, 6269.467095296951, 6416.615003099829, 6423.325550817097, 6429.58207716497, 6469.611823290617, 6263.060540918898, 6306.779262725782, 6323.051542268697, 6346.809595712136, 6349.49204063683, 6376.681165941592, 6407.231132264158, 6446.484281257394, 6465.353464653497, 6466.579672321284, 6142.600730952474, 6228.190335256388, 6290.182276304051, 6335.461485773577, 6342.2389313280855], "value": 4784.194658855614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.3517758914429, 850.188070392775, 863.2921004776082, 863.8358711844749, 869.0831173112364, 13514.054016218868, 13783.517576884811, 14001.579952601425, 14116.435342586297, 14153.009289349724, 13737.450501979934, 13796.655083622914, 13804.58586242412, 13837.51568695096, 13902.096363736375, 682.3006418421108, 801.3549092980134, 807.8909347238135, 824.9917500825005, 837.0081453477649, 832.9333653307751, 836.5190015740943, 837.7905523619095, 838.6854929401475, 839.5004972041626, 872.9214370706635, 872.9214370706635, 873.8732883731855, 874.8250349930007, 874.9387542872001, 857.3569822633025, 863.4258218284833, 865.5369377383101, 868.8479516084723, 873.5806812729862, 624.2571340105305, 636.5321488705797, 646.0922404022356, 649.8440374310131, 650.6681592387869, 14360.497382591664, 14432.639184020378, 14439.494617688331, 14450.060746051473, 14533.854661453355, 13935.721285574333, 14143.858561414358, 14508.347124379428, 14613.196274204915, 14641.267936603233, 11253.437328133643, 11319.886801131966, 11324.886751132466, 11532.077433805276, 11603.883961160365, 3855.8457661693496, 3892.2410130024655, 3909.2376986487648, 3919.2161567686576, 3919.568847426781, 54336.184957225676, 54765.0, 54916.72541637306, 55614.0, 56413.0, 11262.943685281685, 11275.097992160607, 11295.94352028251, 11316.207865449504, 11374.260673056391, 20365.287214947406, 20551.280705175246, 20563.485912852, 20569.280075197297, 20834.062467189015, 8518.446300990416, 8581.570921453902, 8597.676895360863, 8630.395872289006, 8668.349873759493, 4861.878453038702, 4864.051509955595, 4864.318995340655, 4885.706857588556, 5007.774650140753, 3380.5436266104252, 3404.3531728971416, 3412.3175364927115, 3414.2830005698584, 3430.3996800559803, 585.7159277750287, 590.5452801342942, 601.0503404620689, 604.211503987292, 607.9513638908877, 758.7875394889439, 776.8135647444685, 784.9921500785033, 789.2620399926087, 790.632355954484, 9026.548672566345, 9149.954250228839, 9211.170994610517, 9367.484788336571, 9467.90532094684, 658.5850913924293, 711.2887112887113, 717.705740646343, 723.6634964741421, 737.2774680812834, 4273.914521709548, 4375.956240437618, 4379.781010949439, 4408.867733967986, 4416.138852923713, 56195.0, 57335.0, 57524.712376438685, 57755.42244577585, 57970.42029579735, 50688.74655626772, 51268.487315126375, 51321.0, 51845.48154518406, 52824.47175528272, 41856.37215441771, 41933.58066419297, 42704.57295427068, 47557.0, 48579.757101214265, 8687.174718401742, 8725.912740872764, 8918.509481978554, 9112.544372781202, 9200.125988031126, 28026.299342515784, 28397.432051358443, 28692.713072869003, 28986.855065724536, 29116.854415727787, 35041.64958350384, 41604.0, 43179.35230971475, 43480.0, 43548.78225608852, 11921.403929803648, 12184.817227741414, 12213.0, 12317.322547259628, 12355.505779768708, 13317.267550284827, 13495.056874665795, 13723.862761372658, 13822.861771382157, 13931.512397066053, 12837.229766214057, 13100.410481528545, 13343.199408035161, 13514.459421623418, 13774.035817492679, 12869.163504372185, 12869.420876060412, 13509.0, 13544.390502427612, 13620.0, 12630.494780208688, 13305.268210248529, 13376.732465350833, 13449.193048417126, 13496.325183740577, 10604.469776511298, 10784.299020563638, 10864.239503235014, 10884.292520986111, 11297.26567773092, 10841.295315804447, 10851.0, 10977.3962432067, 11124.100719424267, 11140.777184456103], "value": 6769.111830236344, "unit": "score"}], "name": "dromaeo_css", "value": 7122.825405129133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 110.0, 112.0, 124.0, 112.0, 112.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 179.0, 189.0, 128.0, 159.0, 159.0, 129.0, 189.0, 135.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 162.0, 162.0, 163.0, 166.0, 174.0, 166.0, 166.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 78.0, 150.0, 76.0, 73.0, 76.0, 76.0, 104.0, 73.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 163.0, 92.0, 92.0, 93.0, 146.0, 92.0, 93.0, 141.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 150.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 59.0, 58.0, 56.0, 57.0, 91.0, 56.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 71.0, 60.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 83.0, 78.0, 79.0, 79.0, 77.0, 79.0, 78.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 140.0, 125.0, 135.0, 132.0, 131.0, 125.0, 161.0, 128.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 165.0, 168.0, 167.0, 167.0, 166.0, 171.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 69.0, 70.0, 70.0, 69.0, 69.0, 71.0, 71.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1559.1000000000001, "alertThreshold": 2.0}]} 17:30:43 INFO - Return code: 0 17:30:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:43 ERROR - # TBPL SUCCESS # 17:30:43 INFO - Running post-action listener: _resource_record_post_action 17:30:43 INFO - Running post-run listener: _resource_record_post_run 17:30:44 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551178240; Read time: 12; Write time: 674828 17:30:44 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257646592; Read time: 0; Write time: 477720 17:30:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293531648; Read time: 12; Write time: 197108 17:30:44 INFO - Running post-run listener: _upload_blobber_files 17:30:44 INFO - Blob upload gear active. 17:30:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:44 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 17:30:44 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:30:44 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:46 INFO - (blobuploader) - INFO - Done attempting. 17:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:46 INFO - (blobuploader) - INFO - Done attempting. 17:30:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:46 INFO - Return code: 0 17:30:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1155acda7efc12d8b570386db3a401db119fc53c8ff2d0931dc25c36567d649508a157fb78e2165f5b2fbae3dc0f24f87d865c0f5cbe210edaaa81160732c169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4990ae1ed931ad5e817fc6788777a2f103022f0ca30c5bd546411c4d275d353740e41f7b0cb45ae9f6d886919460ce785438188447bdd61df2acabff081f453a"} 17:30:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:46 INFO - Contents: 17:30:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1155acda7efc12d8b570386db3a401db119fc53c8ff2d0931dc25c36567d649508a157fb78e2165f5b2fbae3dc0f24f87d865c0f5cbe210edaaa81160732c169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4990ae1ed931ad5e817fc6788777a2f103022f0ca30c5bd546411c4d275d353740e41f7b0cb45ae9f6d886919460ce785438188447bdd61df2acabff081f453a"} 17:30:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:46 INFO - Copying logs to upload dir... 17:30:46 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.830512 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 17:30:46.650202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:46.655467) ========= 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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 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/Fx-Team/sha512/1155acda7efc12d8b570386db3a401db119fc53c8ff2d0931dc25c36567d649508a157fb78e2165f5b2fbae3dc0f24f87d865c0f5cbe210edaaa81160732c169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4990ae1ed931ad5e817fc6788777a2f103022f0ca30c5bd546411c4d275d353740e41f7b0cb45ae9f6d886919460ce785438188447bdd61df2acabff081f453a"} build_url:https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/Zs43ax2DRgSIbO7dL994EQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1155acda7efc12d8b570386db3a401db119fc53c8ff2d0931dc25c36567d649508a157fb78e2165f5b2fbae3dc0f24f87d865c0f5cbe210edaaa81160732c169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4990ae1ed931ad5e817fc6788777a2f103022f0ca30c5bd546411c4d275d353740e41f7b0cb45ae9f6d886919460ce785438188447bdd61df2acabff081f453a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:46.680910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:46.681264) ========= 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=0274524eba3bdaad075c2247000001d4-1461365352.294952-982106632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 17:30:46.764153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:30:46.764465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 17:30:46.764807) ========= ========= Total master_lag: 0.16 =========