builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1461329306.25 results: success (0) buildid: 20160422040708 builduid: b9e272a215664943b1f854a2d2a2adcc revision: 4832ac37867f93eb09ec5f057b82c7195de54456 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.246842) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.247320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.247606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.262784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.263199) ========= 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=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 05:48:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-22 05:48:26 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.359739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.360086) ========= 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=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014423 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.410571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:26.411182) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4832ac37867f93eb09ec5f057b82c7195de54456 --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 4832ac37867f93eb09ec5f057b82c7195de54456 --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=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 05:48:26,586 truncating revision to first 12 chars 2016-04-22 05:48:26,586 Setting DEBUG logging. 2016-04-22 05:48:26,586 attempt 1/10 2016-04-22 05:48:26,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4832ac37867f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:48:27,135 unpacking tar archive at: fx-team-4832ac37867f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:27.257333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:27.257736) ========= script_repo_revision: 4832ac37867f93eb09ec5f057b82c7195de54456 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:27.258181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:27.258490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:27.268266) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 05:48:27.268701) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:27 INFO - MultiFileLogger online at 20160422 05:48:27 in /builds/slave/test 05:48:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:27 INFO - {'append_to_log': False, 05:48:27 INFO - 'base_work_dir': '/builds/slave/test', 05:48:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:27 INFO - 'branch': 'Fx-Team-Non-PGO', 05:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:27 INFO - 'config_files': ('talos/linux_config.py',), 05:48:27 INFO - 'default_actions': ('clobber', 05:48:27 INFO - 'read-buildbot-config', 05:48:27 INFO - 'download-and-extract', 05:48:27 INFO - 'populate-webroot', 05:48:27 INFO - 'create-virtualenv', 05:48:27 INFO - 'install', 05:48:27 INFO - 'run-tests'), 05:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:27 INFO - 'download_minidump_stackwalk': True, 05:48:27 INFO - 'download_symbols': 'ondemand', 05:48:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:27 INFO - 'installer_path': 'installer.exe', 05:48:27 INFO - 'log_level': 'info', 05:48:27 INFO - 'log_name': 'talos', 05:48:27 INFO - 'log_to_console': True, 05:48:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:27 INFO - 'opt_config_files': (), 05:48:27 INFO - 'pip_index': False, 05:48:27 INFO - 'sps_profile': False, 05:48:27 INFO - 'sps_profile_interval': 0, 05:48:27 INFO - 'suite': 'dromaeojs-e10s', 05:48:27 INFO - 'system_bits': '32', 05:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:27 INFO - 'title': 'talos-linux64-ix-053', 05:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:27 INFO - 'use_talos_json': True, 05:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:27 INFO - 'work_dir': 'build'} 05:48:27 INFO - ##### 05:48:27 INFO - ##### Running clobber step. 05:48:27 INFO - ##### 05:48:27 INFO - Running pre-action listener: _resource_record_pre_action 05:48:27 INFO - Running main action method: clobber 05:48:27 INFO - rmtree: /builds/slave/test/build 05:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:27 INFO - Running post-action listener: _resource_record_post_action 05:48:27 INFO - ##### 05:48:27 INFO - ##### Running read-buildbot-config step. 05:48:27 INFO - ##### 05:48:27 INFO - Running pre-action listener: _resource_record_pre_action 05:48:27 INFO - Running main action method: read_buildbot_config 05:48:27 INFO - Using buildbot properties: 05:48:27 INFO - { 05:48:27 INFO - "project": "", 05:48:27 INFO - "product": "firefox", 05:48:27 INFO - "script_repo_revision": "production", 05:48:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:48:27 INFO - "repository": "", 05:48:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:48:27 INFO - "buildid": "20160422040708", 05:48:27 INFO - "pgo_build": "False", 05:48:27 INFO - "basedir": "/builds/slave/test", 05:48:27 INFO - "buildnumber": 1185, 05:48:27 INFO - "slavename": "talos-linux64-ix-053", 05:48:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:48:27 INFO - "platform": "ubuntu64_hw", 05:48:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:48:27 INFO - "branch": "fx-team", 05:48:27 INFO - "repo_path": "integration/fx-team", 05:48:27 INFO - "revision": "4832ac37867f93eb09ec5f057b82c7195de54456", 05:48:27 INFO - "stage_platform": "linux64", 05:48:27 INFO - "builduid": "b9e272a215664943b1f854a2d2a2adcc", 05:48:27 INFO - "slavebuilddir": "test" 05:48:27 INFO - } 05:48:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:48:27 INFO - Running post-action listener: _resource_record_post_action 05:48:27 INFO - ##### 05:48:27 INFO - ##### Running download-and-extract step. 05:48:27 INFO - ##### 05:48:27 INFO - Running pre-action listener: _resource_record_pre_action 05:48:27 INFO - Running main action method: download_and_extract 05:48:27 INFO - mkdir: /builds/slave/test/build/tests 05:48: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')]} 05:48:27 INFO - https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:29 INFO - Downloaded 1361 bytes. 05:48:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:29 INFO - Using the following test package requirements: 05:48:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'jsshell-linux-x86_64.zip'], 05:48:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:29 INFO - https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:32 INFO - Downloaded 22281373 bytes. 05:48:32 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'] 05:48:32 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 05:48:33 INFO - Return code: 0 05:48:33 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 05:48: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')]} 05:48:33 INFO - https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:36 INFO - Downloaded 22281373 bytes. 05:48:36 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'] 05:48:36 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 05:48:37 INFO - Return code: 0 05:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:37 INFO - https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:38 INFO - Downloaded 10845952 bytes. 05:48:38 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'] 05:48:38 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 05:48:38 INFO - Return code: 0 05:48: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')]} 05:48:38 INFO - https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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 05:48:40 INFO - Downloaded 54721603 bytes. 05:48:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:40 INFO - mkdir: /builds/slave/test/properties 05:48:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:40 INFO - Contents: 05:48:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:41 INFO - Running post-action listener: _resource_record_post_action 05:48:41 INFO - Running post-action listener: set_extra_try_arguments 05:48:41 INFO - ##### 05:48:41 INFO - ##### Running populate-webroot step. 05:48:41 INFO - ##### 05:48:41 INFO - Running pre-action listener: _resource_record_pre_action 05:48:41 INFO - Running main action method: populate_webroot 05:48:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:41 INFO - '--tppagecycles', 05:48:41 INFO - '7'], 05:48:41 INFO - 'tests': ['tsvgm']}}, 05:48:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['damp', 'tps']}, 05:48:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'tests': ['damp', 'tps']}, 05:48:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['dromaeo_dom']}, 05:48:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['a11yr', 05:48:41 INFO - 'ts_paint', 05:48:41 INFO - 'tpaint', 05:48:41 INFO - 'sessionrestore', 05:48:41 INFO - 'sessionrestore_no_auto_restore', 05:48:41 INFO - 'tabpaint']}, 05:48:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['tsvgx', 05:48:41 INFO - 'tsvgr_opacity', 05:48:41 INFO - 'tart', 05:48:41 INFO - 'tscrollx', 05:48:41 INFO - 'cart']}, 05:48:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:41 INFO - 'tsvgr_opacity', 05:48:41 INFO - 'tart', 05:48:41 INFO - 'tscrollx', 05:48:41 INFO - 'cart']}, 05:48:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'talos_options': ['--disable-e10s'], 05:48:41 INFO - 'tests': ['tp5o']}, 05:48:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'tests': ['tp5o']}, 05:48:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'talos_options': ['--disable-e10s', 05:48:41 INFO - '--xperf_path', 05:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:41 INFO - 'tests': ['tp5n']}, 05:48:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:41 INFO - 'talos_options': ['--xperf_path', 05:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:41 INFO - 'tests': ['tp5n']}}, 05:48:41 INFO - 'talos.zip': {'path': '', 05:48:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:41 INFO - Running post-action listener: _resource_record_post_action 05:48:41 INFO - ##### 05:48:41 INFO - ##### Running create-virtualenv step. 05:48:41 INFO - ##### 05:48:41 INFO - Running pre-action listener: _resource_record_pre_action 05:48:41 INFO - Running main action method: create_virtualenv 05:48:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:48:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:41 INFO - Using real prefix '/usr' 05:48:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:43 INFO - Installing pip.................done. 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:44 INFO - Downloading/unpacking psutil>=0.7.1 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:46 INFO - Installing collected packages: psutil 05:48:46 INFO - Running setup.py install for psutil 05:48:46 INFO - building 'psutil._psutil_linux' extension 05:48:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:48:46 INFO - building 'psutil._psutil_posix' extension 05:48:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:48:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:48:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:46 INFO - Successfully installed psutil 05:48:46 INFO - Cleaning up... 05:48:46 INFO - Return code: 0 05:48:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:46 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:46 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 05:48:46 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 05:48:46 INFO - Using env: {'DISPLAY': ':0', 05:48:46 INFO - 'HOME': '/home/cltbld', 05:48:46 INFO - 'LANG': 'en_US.UTF-8', 05:48:46 INFO - 'LANGUAGE': 'en_US:en', 05:48:46 INFO - 'LOGNAME': 'cltbld', 05:48:46 INFO - 'MAIL': '/var/mail/cltbld', 05:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:46 INFO - 'MOZ_NO_REMOTE': '1', 05:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:46 INFO - 'NO_EM_RESTART': '1', 05:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:46 INFO - 'PWD': '/builds/slave/test', 05:48:46 INFO - 'SHELL': '/bin/bash', 05:48:46 INFO - 'SHLVL': '1', 05:48:46 INFO - 'TERM': 'linux', 05:48:46 INFO - 'TMOUT': '86400', 05:48:46 INFO - 'USER': 'cltbld', 05:48:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:46 INFO - '_': '/tools/buildbot/bin/python'} 05:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:48:48 INFO - Installing collected packages: mozsystemmonitor 05:48:48 INFO - Running setup.py install for mozsystemmonitor 05:48:48 INFO - Successfully installed mozsystemmonitor 05:48:48 INFO - Cleaning up... 05:48:48 INFO - Return code: 0 05:48:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:48 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')]} 05:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:48 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')]} 05:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:48 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:48 INFO - Using env: {'DISPLAY': ':0', 05:48:48 INFO - 'HOME': '/home/cltbld', 05:48:48 INFO - 'LANG': 'en_US.UTF-8', 05:48:48 INFO - 'LANGUAGE': 'en_US:en', 05:48:48 INFO - 'LOGNAME': 'cltbld', 05:48:48 INFO - 'MAIL': '/var/mail/cltbld', 05:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:48 INFO - 'MOZ_NO_REMOTE': '1', 05:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:48 INFO - 'NO_EM_RESTART': '1', 05:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:48 INFO - 'PWD': '/builds/slave/test', 05:48:48 INFO - 'SHELL': '/bin/bash', 05:48:48 INFO - 'SHLVL': '1', 05:48:48 INFO - 'TERM': 'linux', 05:48:48 INFO - 'TMOUT': '86400', 05:48:48 INFO - 'USER': 'cltbld', 05:48:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:48 INFO - '_': '/tools/buildbot/bin/python'} 05:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:51 INFO - Downloading docopt-0.6.1.tar.gz 05:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:51 INFO - Running setup.py install for blobuploader 05:48:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:51 INFO - Running setup.py install for requests 05:48:52 INFO - Running setup.py install for docopt 05:48:52 INFO - Successfully installed blobuploader requests docopt 05:48:52 INFO - Cleaning up... 05:48:52 INFO - Return code: 0 05:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:52 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')]} 05:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:52 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')]} 05:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:52 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:52 INFO - Using env: {'DISPLAY': ':0', 05:48:52 INFO - 'HOME': '/home/cltbld', 05:48:52 INFO - 'LANG': 'en_US.UTF-8', 05:48:52 INFO - 'LANGUAGE': 'en_US:en', 05:48:52 INFO - 'LOGNAME': 'cltbld', 05:48:52 INFO - 'MAIL': '/var/mail/cltbld', 05:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:52 INFO - 'MOZ_NO_REMOTE': '1', 05:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:52 INFO - 'NO_EM_RESTART': '1', 05:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:52 INFO - 'PWD': '/builds/slave/test', 05:48:52 INFO - 'SHELL': '/bin/bash', 05:48:52 INFO - 'SHLVL': '1', 05:48:52 INFO - 'TERM': 'linux', 05:48:52 INFO - 'TMOUT': '86400', 05:48:52 INFO - 'USER': 'cltbld', 05:48:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:52 INFO - '_': '/tools/buildbot/bin/python'} 05:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:52 INFO - Running setup.py (path:/tmp/pip-JMgeLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:52 INFO - Running setup.py (path:/tmp/pip-48KF7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:52 INFO - Running setup.py (path:/tmp/pip-LFYuRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:52 INFO - Running setup.py (path:/tmp/pip-sX2Enj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:52 INFO - Running setup.py (path:/tmp/pip-y2bGFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:52 INFO - Running setup.py (path:/tmp/pip-6j3fvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:53 INFO - Running setup.py (path:/tmp/pip-sHqVXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:53 INFO - Running setup.py (path:/tmp/pip-CMYznD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:53 INFO - Running setup.py (path:/tmp/pip-jYG7DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:53 INFO - Running setup.py (path:/tmp/pip-dx29Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:53 INFO - Running setup.py (path:/tmp/pip-CsBZv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:53 INFO - Running setup.py (path:/tmp/pip-UQy6cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:53 INFO - Running setup.py (path:/tmp/pip-1BdqAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:53 INFO - Running setup.py (path:/tmp/pip-k70dLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:53 INFO - Running setup.py (path:/tmp/pip-ck24cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:53 INFO - Running setup.py (path:/tmp/pip-_SgWQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:53 INFO - Running setup.py (path:/tmp/pip-GzLU6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:53 INFO - Running setup.py install for manifestparser 05:48:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:53 INFO - Running setup.py install for mozcrash 05:48:54 INFO - Running setup.py install for mozdebug 05:48:54 INFO - Running setup.py install for mozdevice 05:48:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozfile 05:48:54 INFO - Running setup.py install for mozhttpd 05:48:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozinfo 05:48:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozInstall 05:48:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozleak 05:48:54 INFO - Running setup.py install for mozlog 05:48:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for moznetwork 05:48:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozprocess 05:48:55 INFO - Running setup.py install for mozprofile 05:48:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozrunner 05:48:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozscreenshot 05:48:55 INFO - Running setup.py install for moztest 05:48:55 INFO - Running setup.py install for mozversion 05:48:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:55 INFO - Cleaning up... 05:48:55 INFO - Return code: 0 05:48:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:55 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:55 INFO - Using env: {'DISPLAY': ':0', 05:48:55 INFO - 'HOME': '/home/cltbld', 05:48:55 INFO - 'LANG': 'en_US.UTF-8', 05:48:55 INFO - 'LANGUAGE': 'en_US:en', 05:48:55 INFO - 'LOGNAME': 'cltbld', 05:48:55 INFO - 'MAIL': '/var/mail/cltbld', 05:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:55 INFO - 'MOZ_NO_REMOTE': '1', 05:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:55 INFO - 'NO_EM_RESTART': '1', 05:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:55 INFO - 'PWD': '/builds/slave/test', 05:48:55 INFO - 'SHELL': '/bin/bash', 05:48:55 INFO - 'SHLVL': '1', 05:48:55 INFO - 'TERM': 'linux', 05:48:55 INFO - 'TMOUT': '86400', 05:48:55 INFO - 'USER': 'cltbld', 05:48:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:55 INFO - '_': '/tools/buildbot/bin/python'} 05:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:55 INFO - Running setup.py (path:/tmp/pip-m0v6MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:55 INFO - Running setup.py (path:/tmp/pip-FAfuYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:55 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)) 05:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:55 INFO - Running setup.py (path:/tmp/pip-NCd_3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:56 INFO - Running setup.py (path:/tmp/pip-ESxFbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:56 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)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:56 INFO - Running setup.py (path:/tmp/pip-KOPDkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:56 INFO - Running setup.py (path:/tmp/pip-_yL6Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:56 INFO - Running setup.py (path:/tmp/pip-P74ErS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:56 INFO - Running setup.py (path:/tmp/pip-JHpmo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:56 INFO - Running setup.py (path:/tmp/pip-fo4pCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:56 INFO - Running setup.py (path:/tmp/pip-69511d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:56 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)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:56 INFO - Running setup.py (path:/tmp/pip-F5rK8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:56 INFO - Running setup.py (path:/tmp/pip-uIqd9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:56 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)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:56 INFO - Running setup.py (path:/tmp/pip-RqS4us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:56 INFO - Running setup.py (path:/tmp/pip-jdwqeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:56 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)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:56 INFO - Running setup.py (path:/tmp/pip-_J2HAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:56 INFO - Running setup.py (path:/tmp/pip-ZwpFlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:56 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)) 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:56 INFO - Running setup.py (path:/tmp/pip-l_vrxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:48:57 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)) 05:48:57 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)) 05:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:57 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)) 05:48:57 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)) 05:48:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:58 INFO - Downloading blessings-1.6.tar.gz 05:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:59 INFO - Installing collected packages: blessings 05:48:59 INFO - Running setup.py install for blessings 05:48:59 INFO - Successfully installed blessings 05:48:59 INFO - Cleaning up... 05:48:59 INFO - Return code: 0 05:48:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:59 INFO - Reading from file tmpfile_stdout 05:48:59 INFO - Current package versions: 05:48:59 INFO - argparse == 1.2.1 05:48:59 INFO - blessings == 1.6 05:48:59 INFO - blobuploader == 1.2.4 05:48:59 INFO - docopt == 0.6.1 05:48:59 INFO - manifestparser == 1.1 05:48:59 INFO - mozInstall == 1.12 05:48:59 INFO - mozcrash == 0.17 05:48:59 INFO - mozdebug == 0.1 05:48:59 INFO - mozdevice == 0.48 05:48:59 INFO - mozfile == 1.2 05:48:59 INFO - mozhttpd == 0.7 05:48:59 INFO - mozinfo == 0.9 05:48:59 INFO - mozleak == 0.1 05:48:59 INFO - mozlog == 3.1 05:48:59 INFO - moznetwork == 0.27 05:48:59 INFO - mozprocess == 0.22 05:48:59 INFO - mozprofile == 0.28 05:48:59 INFO - mozrunner == 6.11 05:48:59 INFO - mozscreenshot == 0.1 05:48:59 INFO - mozsystemmonitor == 0.0 05:48:59 INFO - moztest == 0.7 05:48:59 INFO - mozversion == 1.4 05:48:59 INFO - psutil == 3.1.1 05:48:59 INFO - requests == 1.2.3 05:48:59 INFO - wsgiref == 0.1.2 05:48:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:59 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')]} 05:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:59 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')]} 05:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:59 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:59 INFO - Using env: {'DISPLAY': ':0', 05:48:59 INFO - 'HOME': '/home/cltbld', 05:48:59 INFO - 'LANG': 'en_US.UTF-8', 05:48:59 INFO - 'LANGUAGE': 'en_US:en', 05:48:59 INFO - 'LOGNAME': 'cltbld', 05:48:59 INFO - 'MAIL': '/var/mail/cltbld', 05:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:59 INFO - 'MOZ_NO_REMOTE': '1', 05:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:59 INFO - 'NO_EM_RESTART': '1', 05:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:59 INFO - 'PWD': '/builds/slave/test', 05:48:59 INFO - 'SHELL': '/bin/bash', 05:48:59 INFO - 'SHLVL': '1', 05:48:59 INFO - 'TERM': 'linux', 05:48:59 INFO - 'TMOUT': '86400', 05:48:59 INFO - 'USER': 'cltbld', 05:48:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:59 INFO - '_': '/tools/buildbot/bin/python'} 05:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:59 INFO - Cleaning up... 05:48:59 INFO - Return code: 0 05:48:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:59 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')]} 05:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:59 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')]} 05:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:59 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:48:59 INFO - Using env: {'DISPLAY': ':0', 05:48:59 INFO - 'HOME': '/home/cltbld', 05:48:59 INFO - 'LANG': 'en_US.UTF-8', 05:48:59 INFO - 'LANGUAGE': 'en_US:en', 05:48:59 INFO - 'LOGNAME': 'cltbld', 05:48:59 INFO - 'MAIL': '/var/mail/cltbld', 05:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:59 INFO - 'MOZ_NO_REMOTE': '1', 05:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:59 INFO - 'NO_EM_RESTART': '1', 05:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:59 INFO - 'PWD': '/builds/slave/test', 05:48:59 INFO - 'SHELL': '/bin/bash', 05:48:59 INFO - 'SHLVL': '1', 05:48:59 INFO - 'TERM': 'linux', 05:48:59 INFO - 'TMOUT': '86400', 05:48:59 INFO - 'USER': 'cltbld', 05:48:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:59 INFO - '_': '/tools/buildbot/bin/python'} 05:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:59 INFO - Downloading/unpacking jsonschema 05:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:01 INFO - warning: no files found matching '*.txt' 05:49:01 INFO - no previously-included directories found matching 'build' 05:49:01 INFO - no previously-included directories found matching 'dist' 05:49:01 INFO - no previously-included directories found matching '.git*' 05:49:01 INFO - Installing collected packages: jsonschema, functools32 05:49:02 INFO - Running setup.py install for functools32 05:49:02 INFO - warning: no files found matching '*.txt' 05:49:02 INFO - no previously-included directories found matching 'build' 05:49:02 INFO - no previously-included directories found matching 'dist' 05:49:02 INFO - no previously-included directories found matching '.git*' 05:49:02 INFO - Successfully installed jsonschema functools32 05:49:02 INFO - Cleaning up... 05:49:02 INFO - Return code: 0 05:49:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:02 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')]} 05:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:02 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')]} 05:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:02 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 0x7fadd55edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, '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': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:02 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 05:49:02 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 05:49:02 INFO - Using env: {'DISPLAY': ':0', 05:49:02 INFO - 'HOME': '/home/cltbld', 05:49:02 INFO - 'LANG': 'en_US.UTF-8', 05:49:02 INFO - 'LANGUAGE': 'en_US:en', 05:49:02 INFO - 'LOGNAME': 'cltbld', 05:49:02 INFO - 'MAIL': '/var/mail/cltbld', 05:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:02 INFO - 'MOZ_NO_REMOTE': '1', 05:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:02 INFO - 'NO_EM_RESTART': '1', 05:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:02 INFO - 'PWD': '/builds/slave/test', 05:49:02 INFO - 'SHELL': '/bin/bash', 05:49:02 INFO - 'SHLVL': '1', 05:49:02 INFO - 'TERM': 'linux', 05:49:02 INFO - 'TMOUT': '86400', 05:49:02 INFO - 'USER': 'cltbld', 05:49:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:02 INFO - '_': '/tools/buildbot/bin/python'} 05:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:02 INFO - Downloading/unpacking flake8 05:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:04 INFO - no previously-included directories found matching 'docs/_build' 05:49:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:05 INFO - Running setup.py install for pep8 05:49:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:05 INFO - no previously-included directories found matching 'docs/_build' 05:49:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:05 INFO - Cleaning up... 05:49:05 INFO - Return code: 0 05:49:05 INFO - Running post-action listener: _resource_record_post_action 05:49:05 INFO - Running post-action listener: _start_resource_monitoring 05:49:05 INFO - Starting resource monitoring. 05:49:05 INFO - ##### 05:49:05 INFO - ##### Running install step. 05:49:05 INFO - ##### 05:49:05 INFO - Running pre-action listener: _resource_record_pre_action 05:49:05 INFO - Running main action method: install 05:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:05 INFO - Reading from file tmpfile_stdout 05:49:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:05 INFO - Reading from file tmpfile_stdout 05:49:05 INFO - Output received: 05:49:05 INFO - Usage: mozinstall [options] installer 05:49:05 INFO - Options: 05:49:05 INFO - -h, --help show this help message and exit 05:49:05 INFO - -d DEST, --destination=DEST 05:49:05 INFO - Directory to install application into. [default: 05:49:05 INFO - "/builds/slave/test"] 05:49:05 INFO - --app=APP Application being installed. [default: firefox] 05:49:05 INFO - mkdir: /builds/slave/test/build/application 05:49:05 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'] 05:49:05 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 05:49:21 INFO - Reading from file tmpfile_stdout 05:49:21 INFO - Output received: 05:49:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:21 INFO - Running post-action listener: _resource_record_post_action 05:49:21 INFO - ##### 05:49:21 INFO - ##### Running run-tests step. 05:49:21 INFO - ##### 05:49:21 INFO - Running pre-action listener: _resource_record_pre_action 05:49:21 INFO - Running main action method: run_tests 05:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:21 INFO - Python 2.7.3 05:49:21 INFO - Return code: 0 05:49:21 INFO - grabbing minidump binary from tooltool 05:49: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')]} 05:49:21 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 0x2b1c410>, '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 0x2b1d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:21 INFO - Return code: 0 05:49:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:49:22 INFO - Return code: 0 05:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:49:22 INFO - Using env: {'DISPLAY': ':0', 05:49:22 INFO - 'HOME': '/home/cltbld', 05:49:22 INFO - 'LANG': 'en_US.UTF-8', 05:49:22 INFO - 'LANGUAGE': 'en_US:en', 05:49:22 INFO - 'LOGNAME': 'cltbld', 05:49:22 INFO - 'MAIL': '/var/mail/cltbld', 05:49:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:22 INFO - 'MOZ_NO_REMOTE': '1', 05:49:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:22 INFO - 'NO_EM_RESTART': '1', 05:49:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:22 INFO - 'PWD': '/builds/slave/test', 05:49:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:22 INFO - 'SHELL': '/bin/bash', 05:49:22 INFO - 'SHLVL': '1', 05:49:22 INFO - 'TERM': 'linux', 05:49:22 INFO - 'TMOUT': '86400', 05:49:22 INFO - 'USER': 'cltbld', 05:49:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997', 05:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:22 INFO - '_': '/tools/buildbot/bin/python'} 05:49:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:49:22 INFO - mozversion application_buildid: 20160422040708 05:49:22 INFO - mozversion application_changeset: 4832ac37867f93eb09ec5f057b82c7195de54456 05:49:22 INFO - mozversion application_display_name: Nightly 05:49:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:22 INFO - mozversion application_name: Firefox 05:49:22 INFO - mozversion application_remotingname: firefox 05:49:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:49:22 INFO - mozversion application_vendor: Mozilla 05:49:22 INFO - mozversion application_version: 48.0a1 05:49:22 INFO - mozversion platform_buildid: 20160422040708 05:49:22 INFO - mozversion platform_changeset: 4832ac37867f93eb09ec5f057b82c7195de54456 05:49:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:49:22 INFO - mozversion platform_version: 48.0a1 05:49:22 INFO - using testdate: 1461329362 05:49:22 INFO - actual date: 1461329362 05:49:22 INFO - starting webserver on 'localhost:44192' 05:49:22 INFO - SUITE-START | Running 2 tests 05:49:22 INFO - TEST-START | dromaeo_css 05:49:22 INFO - operating with platform_type : linux_ 05:49:22 INFO - Initialising browser for dromaeo_css test... 05:49:22 INFO - TEST-INFO | started process 15354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeeouo/profile http://localhost:44192/getInfo.html) 05:49:26 INFO - PROCESS | 15354 | 05:49:26 INFO - PROCESS | 15354 | (process:15421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:27 INFO - PROCESS | 15354 | __metrics Screen width/height:1600/1200 05:49:27 INFO - PROCESS | 15354 | colorDepth:24 05:49:27 INFO - PROCESS | 15354 | Browser inner width/height: 1024/697 05:49:27 INFO - PROCESS | 15354 | __metrics 05:49:28 ERROR - PROCESS | 15354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:49:29 INFO - TEST-INFO | 15354: exit 0 05:49:29 INFO - Browser initialized. 05:49:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:29 INFO - TEST-INFO | started process 15472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeeouo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:31 INFO - PROCESS | 15472 | 05:49:31 INFO - PROCESS | 15472 | (process:15531): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:41 INFO - PROCESS | 15472 | RSS: Main: 164921344 05:49:41 INFO - PROCESS | 15472 | 05:50:31 INFO - PROCESS | 15472 | 1461329431066 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] 05:52:42 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44192/tests/dromaeo/cssquery-ext.html) 05:52:43 INFO - PROCESS | 15472 | RSS: Main: 169656320 05:52:43 INFO - PROCESS | 15472 | 05:55:45 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-ext.html (next: http://localhost:44192/tests/dromaeo/cssquery-jquery.html) 05:55:46 INFO - PROCESS | 15472 | RSS: Main: 166105088 05:55:46 INFO - PROCESS | 15472 | 05:58:48 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44192/tests/dromaeo/cssquery-mootools.html) 05:58:48 INFO - PROCESS | 15472 | RSS: Main: 166961152 05:58:48 INFO - PROCESS | 15472 | 06:01:50 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44192/tests/dromaeo/cssquery-prototype.html) 06:01:51 INFO - PROCESS | 15472 | RSS: Main: 164372480 06:01:51 INFO - PROCESS | 15472 | 06:04:53 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44192/tests/dromaeo/cssquery-yui.html) 06:04:54 INFO - PROCESS | 15472 | RSS: Main: 165703680 06:04:54 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-yui.html (next: http://localhost:44192/tests/dromaeo/cssquery-dojo.html) 06:07:56 INFO - PROCESS | 15472 | RSS: Main: 167612416 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | __start_tp_report 06:07:56 INFO - PROCESS | 15472 | _x_x_mozilla_page_load 06:07:56 INFO - PROCESS | 15472 | _x_x_mozilla_page_load_details 06:07:56 INFO - PROCESS | 15472 | |i|pagename|runs| 06:07:56 INFO - PROCESS | 15472 | |0;dojo.html;2623.9868800655995;2686.11358251777;2688.516067107922;2710.8780104895277;2719.2250208690525;4704.458987216467;4756.334113224147;4764.356811830402;4773.0692514959555;4798.544138306864;4699.060187962404;4766.642501812361;4792.1134590100855;4829.9275510867365;4846.636502262327;4383.934240986379;4450.792572689945;4509.436320459942;4525.977370113162;4560.863174104782;564.297885921803;4308.181445525356;4360.040791025969;4417.977910110461;4419.0057237121555;4414.955850441519;4427.53510881356;4436.800343984529;4458.933116003246;4470.284754439274;4435.711678740871;4436.223660859337;4453.51011388747;4464.464264288274;4483.753393563353;4318.287482565373;4346.500152482442;4406.6694997874965;4420.84527041552;4440.467143942716;4615.930761038587;4694.155052090622;4714.316424118484;4741.9288710669025;4749.382580264578;4956.653034287601;5132.923006154911;5148.0476111919415;5177;5228.058949389108;5155.329807125087;5184.6629969052265;5205.609579281531;5224.947750522484;5243.082460569385;4804.639652026077;4857.684250523705;4858.02839432115;4864.6594738368685;4894.755262236874;5175.378954525481;5253.1857562077175;5310.283111779938;5320.12217984036;5343.599230057761;4952.47998960104;5051.520105589963;5096.61775366849;5101.413337466165;5120.155174396183;5146.459621739738;5158.303629010111;5165.096108181053;5169.06956747789;5232.92150617741;4975.850724478271;5078.339815823919;5118.744062796845;5123.436421993578;5135.409427915837;5050.191969284971;5076.035553244872;5098.515641014098;5104.2088476286235;5123.948760512421;4286.142771445723;4292.399064131024;4303.338711679285;4311.525732169459;4334.284843000933;3730.776153430803;3736.5702944161226;3766.2844059628583;3790.7346485745734;3821.6560509554274;4405.911881762347;4407.2507673695545;4409.0520538084465;4428.13651337986;4464.799084041226;5095.515925987025;5095.694258344512;5096.694198348111;5117.360329958755;5133.4609865964285;4338.566143385699;4421.668374871898;4439.889002774892;4473.530279320625;4505.031418245027;4545.0000999779995;4571.657125715585;4582.518835522289;4607.170709272363;4617.353570500132;4774.116788394089;4797.736124513185;4807.903841923142;4812.06164797861;4850.49069847675;5038.899222015612;5050.74746262678;5090.7709153088945;5142.04872098663;5167.302414174189;4735.928961065518;4780.641451891052;4796;4799.088173247072;4848.80604775805;4999.750012499288;5007;5033.446320904624;5042.596592272683;5089.949100508948;4992.650514463952;5092.745362731775;5215.087359711959;5232.555232805102;5232.686038837682;4946.455889852042;4976.776045077908;4980.053789780075;4990.725510096834;5036.320096786887;4900.14247506692;4956.534316194845;4973.6269779765935;4975.154223781893;4976.576990955665;4752;4914.778834952507;4923.606111511142;4983.700977941335;5001.624878134082;4985.451600324034;5012.1980483122525;5021.824236151717;5023.799048038038;5032.672876263031;4910.140725373117;4914.533119353799;4916.631252656137;4919.212925931977;4951.950480495149 06:07:56 INFO - PROCESS | 15472 | |1;ext.html;576.6597707352661;587.0460501684762;600.1477901380041;622.355861683158;637.982418043221;34420;35016.94949151526;35019.4747078794;35127.473087903636;35444;37961.62038379615;38543.80728096363;38721.41917871234;38744.80627596858;38804;7610.2770236827555;7820.100688420847;7837.608119594026;7855.489393189453;7857.764267071997;7680.3087722105;7774.41691873109;7821.76534703957;7933.563653999027;7986.201379861996;7837;7902.288794008538;7987.480813747117;7988.360931125525;7999.840003199933;7832.647530861096;7909.0113735783025;7983.920160798376;7986.2013798620255;7993.44045916786;7725.304722574939;7765.650545725456;7830.921690783076;7957.960210198912;7983.361331093499;37943.81028094842;38021.42967855484;38323.041923951845;38386.61613383859;38425.42361864574;2406.843555168926;2647.1529110684587;2743.4238809849953;2996.790224684273;3139.9843000785077;23923.162689305966;23953.281401557982;23967;24069.398265043514;24446.388840278956;3323.302106557626;3431.4166591679473;3497.178163131662;3571.8035508047305;3648.1791596890753;163989;164498.1775091117;165010;165804;166668.16665916715;52546.73726631419;53370;53493.732531337875;53787.462125379025;53932.46067539353;56364.71817640885;56689;58286.708566456895;60362.69818650879;60517.69741151354;13217.206967581977;13565.05044646885;13600.183988960694;13625.386857591433;13684.178949263076;10565.154787616972;10599.894001060045;10697.946510267398;10711.678649640524;10714.089302409382;18746.156422961;18795.248190072518;18836.81163188378;18895.638045244345;18965.715514267296;6743.5953842769595;6937.7571784988295;6975.128108986377;7121.323474269936;7147.356737893615;864.5590748718199;876.8114855306012;954.2223088183108;984.601236499219;1011.7521207304258;27343.86328068347;27882.721172788417;28594.142175734345;28699.56950645742;28913.42173156567;947.9194268487117;981.548487695668;1002.1882275356984;1054.852320675106;1056.9101626361692;15026.69946601062;15248.542543723484;15249.3900243989;15254.161021143722;15334.823762553748;345707;350812;350884;351250;351920;49641.50358496441;50062.499375005784;50575.999999999265;50615.493845061814;50642.493575063774;1158.7334912970064;1199.7180662544295;1211.4124649544963;1227.0919519555464;1238.3003602964297;26522.336941576614;27613.447731044864;27986.720132799226;28245.43509129847;28531.714682852904;43929.34105988477;47388.7630561845;49272;49373;49529;327426;331425;334252;334959;335359;38356.80821595874;38572.6142738569;38689;38763;39081.609183908935;41139.588604114775;41411.37882931698;42458.363124553776;42578;43090.353644694726;36176.27647447089;36222.09444763902;36299.81850090733;36442.27115457623;36755;35443.291134177685;35793.82103089468;37078;37433.43849842309;37648.62351376451;31902.840485797424;32594.185145371557;33036.834815825765;33090.66909330876;34181.65818341884;30422.847885761315;31964;32361.67638323681;32425.27109382451;32470.35059298848;24267.39331516726;24346.878265609266;24434.389140271636;24608.753912460645;24790.25629231126 06:07:56 INFO - PROCESS | 15472 | |2;jquery.html;377.84686788747905;382.1554364853673;386.1273521840641;388.1944964199286;395.3338624417858;15578.45475408361;16217.75673364899;16682.916585417086;16763.580910477212;16784.748228776563;15608.141552214624;15821.525354239362;16607.169641517936;16644.417445389412;16653.583660408465;5057.1908494640775;5186.403563590179;5204.453532379102;5213.765380557865;5223.555997740196;4861.611071114302;5155.948440515603;5164.483551644843;5254.185601231815;5254.710990895518;5133.5893128549815;5139.665921715076;5151.356080489939;5153.433122356538;5157.6131790115705;5116.8976620467565;5854.414558544154;5866.941330586682;5880.471077519833;5882.647041177543;4986.276989836453;5218.191180367049;5231.738413079369;5240.056789777838;5251.68489890604;12374.75250494994;12546.68633284166;12581.433835477334;12585.74828503434;12628.873711262862;1772.087375001875;1820.836124748779;1910.121344181678;1918.2518817660984;1934.6130773845146;8956.328275379308;8982.146696063863;9473.289503287213;9551.665691700826;9614.134727874525;1522.961925951849;1761.6636941282886;1785.4375871600535;1790.5523619095227;1800.8919464832152;69060.3093969059;69858;70636.64681676558;70919;71275.64362178207;10016.49917504122;10229.693109206735;10319.329243599143;10399.32404393712;10427.113695335982;14079.71840563183;14092.929535352258;14111.435542578387;14150.929245353913;14235.857641423454;6939.6877140528795;6980.441564674814;7019.29807019294;7197.604131772698;7225.277472252733;6495.3179916109075;6539.117219175446;6566.376194261537;6702.463802895757;6755.7973260802255;4366.454193225847;4395.670324725658;4409.8456554021095;4419.381286619876;4532.342810292555;1811.7916439609614;1859.3213477081038;1865.3191585071352;1902.4387805597382;1908.5896532245633;876.2814492116403;890.7105190813012;891.7101941868918;919.1635611593418;932;16120.435784747477;16549.6690066198;16617.833821661872;16775.412860549823;16928.984260944384;845.9196376344238;849.562475325208;868.70898249086;883.7702197428715;929.702495201529;9336.95331523338;9341.953290233505;9363.531823408939;9529.666461673809;9619.636556016458;307971;313944;314738;411395;415557;59081.40918590845;73541.26458735343;74889;77536;88646;916.7708072981754;958.3195930889146;960.1790469148917;971.6453494474607;978.3885071830106;15066.171360575274;15189.240537972835;15298.770518442456;15344.693106138038;15769.605759856095;35251.47122793212;35814.820925895205;35896.820515897256;36468.45297320595;36511.269774603825;50770.492295076576;51613.22580161376;52012.219816702025;53942.460575395315;54397.72801135969;7734.381249499914;7775.844483110193;7842.215778422112;7859.567723775247;7939.722109726132;10692.946535267274;11483.138764592522;11572.132090093444;11609.419529023346;11723.648290551297;10309.123724483503;10365.170786336925;10416.531256093342;10472.581096756045;10478;10356.792864142524;10391.272610917465;10395;10513.526891289757;10526.578936842441;10504.579816807242;10553.261271710906;10656.25406221557;10688.41213733221;10733.94633026861;7837.098733645704;7858.292753652198;7923.207679232261;8012.679492820222;8079.272865442138;9403.952980235328;10293.53679084428;10317;10438.791224175322;10633.043026127685 06:07:56 INFO - PROCESS | 15472 | |3;mootools.html;1437.985620143799;1445.205137174554;1579.0999130495616;1713.5459103337625;1746.7117925542286;6980.860382792341;7378.077740282465;7595.392368610512;7619.390448764107;7628.580428076453;7566.735164269252;7674;7691.153973062958;7695;7760.49556778809;2242.551489702058;2264.705588273522;2266.161520237506;2266.3314322274887;2282.942926426836;2223.2440970070174;2226.3877433705698;2268.3875353654503;2274.2040285899884;2274.8180145588394;2258.9096436142536;2287.439577303563;2295.1393227539675;2338.8012018978407;2343.355577216262;2226.031676220849;2237.183428048767;2240.7311122665383;2242.3273018094587;2244.9775502244934;2240.462289050616;2248.808851247646;2251.7860803223666;2269.807066399358;2272.5000499889998;7905.209479052049;7917.881231781528;7975.162607926142;7981.441299109065;8006.959965200195;4604.631629469634;4677.298405239208;4732.266498692708;4747.477777444478;4757.976210118927;2889.653241610999;2906.161948456193;2981.195077329109;3001.0846691759007;3035.05913166919;982.0572250639324;982.0670363155032;985.5367977050774;1001.464216644092;1002.7543251903257;10434;10468;10472.057514823702;10505.789884202273;10534.789304213873;4173.6661067114555;4272.4445822042935;4443.488998765119;4454.888627784267;4456.532064133284;8798.912010879809;8816.51509167002;8832.249258813074;8861.424007439497;8917.197452229331;4763.118823017753;4773.594244489257;4800.375951126401;4837.782299796518;4846.975765121152;3825.407061905409;4067.633912947849;4182.874513764592;4399.186150562156;4430.025394413224;3679.300932822755;3719.9814000929823;3731.8134093295225;3834.539855217336;3848.9807550962064;1249.2941488059218;1291.8708129187194;1294.9287789171685;1299.6815780133927;1307.2222027893388;695.5166159519187;734.1153909538992;747;761.824780300534;772.0658003815446;5203;5324.494173053554;5389.326334208224;5393.083175860113;5432.29380180574;413.7600191888697;416.1136778661492;416.8561846163069;419.1198483185286;443.33942425785995;3462.8961131166106;3585.3008663310925;3630.43728222126;3648.1426864686778;3656.3966945453703;9527.666531671359;9884.357516761387;9926.404415735078;9979.850302245472;9994.10053095225;9260;9792;9863.80272394548;9882.703518894445;9895.554700038516;7268.309510596485;7396.704131834666;7422.703091876265;7473.701051957861;7489.925100749032;5173.844784656466;5210.348706411699;5435.402105768283;5464.316960379952;5478.863028424321;8778.166074222938;8813.118688131135;8886.911130888868;8930.240929520804;8936.642534298555;8708.60811263482;9023.278137749096;9034.593443295198;9074.500902450429;9122.722818805505;6018.127371531016;6515.446187074152;6642.136522252076;6645.734170633121;6845.418139458202;7273.454490913308;7309.232530584425;7355.2277010913085;7369.926300736924;7409.184989651027;6259.123722678738;6483.708233129615;6498.837529061811;6505.186851643544;6583.3087525811015;6412.045974280509;6458.483321334188;6591.307912669293;6609.768658096944;6619.338066193534;6221.751129954751;6289.685515724287;6295.464885484785;6315.873682526416;6316.431521163117;4385.101054283928;4480.843170489017;4497.437820272466;4526.162659907796;4528.049109687003;4580.473245576802;4592.839250626212;4593.150267200579;4649.325847752125;4655.906881862412 06:07:56 INFO - PROCESS | 15472 | |4;prototype.html;314.184690727562;318.30926888651624;322.2041557353337;324.2606856367483;329.0687354785956;5362.195670649405;5371.301730774999;5419.810306639269;5467.808626698066;5476.507114359707;5370.650907690997;5380.946190538093;5391.81128660497;5393.83818485446;5421.810236641718;3962.148138150297;4083.4895638045246;4219.641330486912;4220.4091427200065;4222.282212023963;4198.160367926412;4211.178820130076;4216.451861258032;4225.218334608092;4232.915341693164;4182;4186.853460128896;4194.140201258735;4197.8530751423705;4204.453421055258;4101.118259574191;4178.603032711888;4189.49726032878;4191.643710284629;4204.264253755596;3671.94492082619;3698.537682789651;3701.9444708329397;3703.3519134151416;3709.2766910452474;5136.820211292624;5149.871253218699;5177.508136727005;5179.896402071938;5196.480351964811;4740.2889566564945;4740.416473022176;4818.975905120487;4842.467328593852;4849.709017458964;5625.54995600351;5666.631668941505;5679.053058124605;5684.772609095631;5686.289213848269;4024.3359845625437;4026.6577340926056;4031.5565287818317;4045.575214602454;4059.106996460774;5875.41245875409;5980.8504787380225;6011.218541589566;6022.217111775485;6038.728257228435;4124.711270211116;4130.984381401594;4153.190127925026;4154.50145982484;4183.1215444756945;4206.242876282298;4208.705390622627;4219.641330486943;4223.598758117974;4225.746455212697;4623.9075218495445;4809.302651115569;4815.277708343777;4829.975850120727;4840.854774356704;5704.402767225183;5720.599558030981;5727.398623144593;5736.6558006519745;5744.281964754406;1461.7734251191082;1472.5508719840336;1473.710503309604;1485.0792508644709;1487.5239923224465;915.5422288855572;980.9558569864373;998.4823068935178;1000.3197825478599;1028.7449311839543;4848.345473361122;4886.486918873538;4938.802447902043;4954.603631709455;4958.851234462972;5839.416058394211;5892.410758924073;5893.852653683606;5903.35063143054;5932.79235226765;4849.2726091086615;4891.877703057452;4940.7035577865445;4944.678595891256;4946.851594452172;3145.732612727898;3160.762942779255;3171.1913462067027;3173.5398367237085;3183.5702180205376;5370.711029352927;5377.919331210035;5411.431799661058;5468.125099983983;5476.452354764571;5829.271341082364;5996.490298324691;6020.187274717857;6040.154378387029;6049.606775559574;5424.213489044146;5438.755256013489;5459.563234941115;5465.480779325958;5474.507294343528;5559.138333558305;5837.503812176013;5845.77238779861;5859.326177489644;5881.882442335943;5678.971605141948;5705.714714264187;5710.057840456278;5712.457316554921;5729.3984131665575;5360.70516121617;5391.110466772939;5391.379991301051;5407.432219616883;5408.323959505062;4083.612056854594;4149.730267532601;4154;4172.812223450012;4173.478315210598;5820.962663067892;5835.2122463466885;5841.883162336814;5854.853628659318;5860.970695146497;5657.5473962082115;5662.357916204254;5668.773249069991;5675.432456754292;5677.290338707661;5437.293151890229;5673.978683836949;5683.431656834284;5683.5453163747625;5684.573656975826;5334.653247538898;5472.945270547243;5510.724463776875;5526.447355264441;5570.2201691762375;5582.49757521825;5771;5771.884562308815;5773.740181691918;5809.070548712186;5587.804426845203;5600.60795744294;5608.130739735348;5612.550995920398;5645.887082258249 06:07:56 INFO - PROCESS | 15472 | |5;yui.html;666.1739443090567;745.1542499263338;751.4026844306983;756.833496630741;783.0329543014379;11857.76284474311;12473.68815779606;12876.80684789729;12920.095593308472;12936.870631293685;13550.254735989542;13599.32003399831;13619.455221791117;13648.112872663294;13729.313534323293;628.7422156915666;787.9251471110235;793.3851265269404;794.2732399854126;798.5488199167481;764.8279137194143;791.0823444804029;793.7698067560401;794.8847417124514;795.9761207163795;825.8018075661828;826.9627866745981;832.309183377798;832.904216015157;833.1168960901433;818.423011776696;819.2872201184948;822.0915887943796;823.0411570520337;825.7481468152212;594.7620951619343;599.1851082527759;600.0579090827403;604.8306474187235;606.9696515174223;12936.288504132363;12992.155509891827;13126.212427254395;13132.737345253137;13148.934255328757;11419.257748246337;11652.242604230698;11782.234154779997;11889.167758256925;12130;9216.400933939272;9218.631254749802;9244.768880777967;9356.157945784911;9386;3268.526063720771;3334;3380.4253276942977;3381;3454.5336379588935;47488;47490.28764568534;47575;47582.28626570604;48491.03017939657;8715.52064636451;8838.07200243978;8939.597718102701;8997.955010225038;9029.322800789967;17348.30606775715;17413;17439;17470.388536401166;17490.125493725263;6672.5329226953645;7002.494463690331;7047.119110111236;7063.929360706327;7105.786826395217;3803.448499967489;3847.730658853853;3886.689064874803;3888.2223555289056;3891.2217556488818;2910.825350478978;2963.037012970793;2973.5391014392803;2980.344324248662;2980.3592227671156;491.2876329322425;495.8066354121895;498.4965185162939;501.54860625437396;520.2040877457496;418.2346306259538;430.32009425108254;481.4439322582423;508.6083715539014;532.579262382721;7123.679434425463;7581.696732130763;7658.310752032233;7723.150453450116;8039.236272554098;553.9279893613805;560.8317504748559;571.9170720245625;580.2340909998845;582.8222392170429;3463.428534291814;3570.2145527983803;3607;3631.94552081719;3645.872394466181;51261;51939;52017.47982520202;52481.475185248426;52649.473505265225;45010.77494612506;45621.5437845624;46205.30692039622;47092.293615595794;47474.762626186646;42258;42412;42600.14799703989;43075;43266.91832704144;6859.416949559343;6894.9035071996095;7007.544509606859;7084.2561531040565;7162.534435261691;28428.57357139686;29120.27199320034;29292.70707292985;29335.266618334714;29582.556261655664;33803;33966.79215851061;34082.82958585191;34148.65851341554;34740.652593474755;9931.602735890772;9942.105210531086;10028.247881408777;10151.137153342048;10188.083072523508;10195.337303075275;10200.234982376203;10279.229057820843;10333.586656533655;10412.791744164922;10289.794204116026;10316.948415257875;10365.481725913523;10652.041316281571;10742.946285268523;10988.560457581607;11011.28426652265;11017.889821101686;11034.724131896766;11063.723406914569;9454.33819632619;9722.659706910224;9766.462844543334;9839;10013.349132306377;8614.505380319162;8816.603252853509;8836.317453993179;9158.313126515404;9165.908340916505;8221.95889020575;8606;8770.649174032967;8891.555422228734;9297.72106836796 06:07:56 INFO - PROCESS | 15472 | __end_tp_report 06:07:56 INFO - PROCESS | 15472 | __start_cc_report 06:07:56 INFO - PROCESS | 15472 | _x_x_mozilla_cycle_collect,357 06:07:56 INFO - PROCESS | 15472 | __end_cc_report 06:07:56 INFO - PROCESS | 15472 | __startTimestamp1461330476939__endTimestamp 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | ------- Summary: start ------- 06:07:56 INFO - PROCESS | 15472 | Number of tests: 6 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#0] dojo.html Cycles:165 Average:4712.40 Median:4858.03 stddev:593.44 (12.2%) stddev-sans-first:572.20 06:07:56 INFO - PROCESS | 15472 | Values: 2624.0 2686.1 2688.5 2710.9 2719.2 4704.5 4756.3 4764.4 4773.1 4798.5 4699.1 4766.6 4792.1 4829.9 4846.6 4383.9 4450.8 4509.4 4526.0 4560.9 564.3 4308.2 4360.0 4418.0 4419.0 4415.0 4427.5 4436.8 4458.9 4470.3 4435.7 4436.2 4453.5 4464.5 4483.8 4318.3 4346.5 4406.7 4420.8 4440.5 4615.9 4694.2 4714.3 4741.9 4749.4 4956.7 5132.9 5148.0 5177.0 5228.1 5155.3 5184.7 5205.6 5224.9 5243.1 4804.6 4857.7 4858.0 4864.7 4894.8 5175.4 5253.2 5310.3 5320.1 5343.6 4952.5 5051.5 5096.6 5101.4 5120.2 5146.5 5158.3 5165.1 5169.1 5232.9 4975.9 5078.3 5118.7 5123.4 5135.4 5050.2 5076.0 5098.5 5104.2 5123.9 4286.1 4292.4 4303.3 4311.5 4334.3 3730.8 3736.6 3766.3 3790.7 3821.7 4405.9 4407.3 4409.1 4428.1 4464.8 5095.5 5095.7 5096.7 5117.4 5133.5 4338.6 4421.7 4439.9 4473.5 4505.0 4545.0 4571.7 4582.5 4607.2 4617.4 4774.1 4797.7 4807.9 4812.1 4850.5 5038.9 5050.7 5090.8 5142.0 5167.3 4735.9 4780.6 4796.0 4799.1 4848.8 4999.8 5007.0 5033.4 5042.6 5089.9 4992.7 5092.7 5215.1 5232.6 5232.7 4946.5 4976.8 4980.1 4990.7 5036.3 4900.1 4956.5 4973.6 4975.2 4976.6 4752.0 4914.8 4923.6 4983.7 5001.6 4985.5 5012.2 5021.8 5023.8 5032.7 4910.1 4914.5 4916.6 4919.2 4952.0 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#1] ext.html Cycles:180 Average:44664.41 Median:36199.19 stddev:77692.00 (214.6%) stddev-sans-first:77839.43 06:07:56 INFO - PROCESS | 15472 | Values: 576.7 587.0 600.1 622.4 638.0 34420.0 35016.9 35019.5 35127.5 35444.0 37961.6 38543.8 38721.4 38744.8 38804.0 7610.3 7820.1 7837.6 7855.5 7857.8 7680.3 7774.4 7821.8 7933.6 7986.2 7837.0 7902.3 7987.5 7988.4 7999.8 7832.6 7909.0 7983.9 7986.2 7993.4 7725.3 7765.7 7830.9 7958.0 7983.4 37943.8 38021.4 38323.0 38386.6 38425.4 2406.8 2647.2 2743.4 2996.8 3140.0 23923.2 23953.3 23967.0 24069.4 24446.4 3323.3 3431.4 3497.2 3571.8 3648.2 163989.0 164498.2 165010.0 165804.0 166668.2 52546.7 53370.0 53493.7 53787.5 53932.5 56364.7 56689.0 58286.7 60362.7 60517.7 13217.2 13565.1 13600.2 13625.4 13684.2 10565.2 10599.9 10697.9 10711.7 10714.1 18746.2 18795.2 18836.8 18895.6 18965.7 6743.6 6937.8 6975.1 7121.3 7147.4 864.6 876.8 954.2 984.6 1011.8 27343.9 27882.7 28594.1 28699.6 28913.4 947.9 981.5 1002.2 1054.9 1056.9 15026.7 15248.5 15249.4 15254.2 15334.8 345707.0 350812.0 350884.0 351250.0 351920.0 49641.5 50062.5 50576.0 50615.5 50642.5 1158.7 1199.7 1211.4 1227.1 1238.3 26522.3 27613.4 27986.7 28245.4 28531.7 43929.3 47388.8 49272.0 49373.0 49529.0 327426.0 331425.0 334252.0 334959.0 335359.0 38356.8 38572.6 38689.0 38763.0 39081.6 41139.6 41411.4 42458.4 42578.0 43090.4 36176.3 36222.1 36299.8 36442.3 36755.0 35443.3 35793.8 37078.0 37433.4 37648.6 31902.8 32594.2 33036.8 33090.7 34181.7 30422.8 31964.0 32361.7 32425.3 32470.4 24267.4 24346.9 24434.4 24608.8 24790.3 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#2] jquery.html Cycles:180 Average:23016.91 Median:4402.76 stddev:59120.79 (1342.8%) stddev-sans-first:59262.20 06:07:56 INFO - PROCESS | 15472 | Values: 377.8 382.2 386.1 388.2 395.3 15578.5 16217.8 16682.9 16763.6 16784.7 15608.1 15821.5 16607.2 16644.4 16653.6 5057.2 5186.4 5204.5 5213.8 5223.6 4861.6 5155.9 5164.5 5254.2 5254.7 5133.6 5139.7 5151.4 5153.4 5157.6 5116.9 5854.4 5866.9 5880.5 5882.6 4986.3 5218.2 5231.7 5240.1 5251.7 12374.8 12546.7 12581.4 12585.7 12628.9 1772.1 1820.8 1910.1 1918.3 1934.6 8956.3 8982.1 9473.3 9551.7 9614.1 1523.0 1761.7 1785.4 1790.6 1800.9 69060.3 69858.0 70636.6 70919.0 71275.6 10016.5 10229.7 10319.3 10399.3 10427.1 14079.7 14092.9 14111.4 14150.9 14235.9 6939.7 6980.4 7019.3 7197.6 7225.3 6495.3 6539.1 6566.4 6702.5 6755.8 4366.5 4395.7 4409.8 4419.4 4532.3 1811.8 1859.3 1865.3 1902.4 1908.6 876.3 890.7 891.7 919.2 932.0 16120.4 16549.7 16617.8 16775.4 16929.0 845.9 849.6 868.7 883.8 929.7 9337.0 9342.0 9363.5 9529.7 9619.6 307971.0 313944.0 314738.0 411395.0 415557.0 59081.4 73541.3 74889.0 77536.0 88646.0 916.8 958.3 960.2 971.6 978.4 15066.2 15189.2 15298.8 15344.7 15769.6 35251.5 35814.8 35896.8 36468.5 36511.3 50770.5 51613.2 52012.2 53942.5 54397.7 7734.4 7775.8 7842.2 7859.6 7939.7 10692.9 11483.1 11572.1 11609.4 11723.6 10309.1 10365.2 10416.5 10472.6 10478.0 10356.8 10391.3 10395.0 10513.5 10526.6 10504.6 10553.3 10656.3 10688.4 10733.9 7837.1 7858.3 7923.2 8012.7 8079.3 9404.0 10293.5 10317.0 10438.8 10633.0 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#3] mootools.html Cycles:180 Average:5137.82 Median:4842.38 stddev:2850.34 (58.9%) stddev-sans-first:2844.78 06:07:56 INFO - PROCESS | 15472 | Values: 1438.0 1445.2 1579.1 1713.5 1746.7 6980.9 7378.1 7595.4 7619.4 7628.6 7566.7 7674.0 7691.2 7695.0 7760.5 2242.6 2264.7 2266.2 2266.3 2282.9 2223.2 2226.4 2268.4 2274.2 2274.8 2258.9 2287.4 2295.1 2338.8 2343.4 2226.0 2237.2 2240.7 2242.3 2245.0 2240.5 2248.8 2251.8 2269.8 2272.5 7905.2 7917.9 7975.2 7981.4 8007.0 4604.6 4677.3 4732.3 4747.5 4758.0 2889.7 2906.2 2981.2 3001.1 3035.1 982.1 982.1 985.5 1001.5 1002.8 10434.0 10468.0 10472.1 10505.8 10534.8 4173.7 4272.4 4443.5 4454.9 4456.5 8798.9 8816.5 8832.2 8861.4 8917.2 4763.1 4773.6 4800.4 4837.8 4847.0 3825.4 4067.6 4182.9 4399.2 4430.0 3679.3 3720.0 3731.8 3834.5 3849.0 1249.3 1291.9 1294.9 1299.7 1307.2 695.5 734.1 747.0 761.8 772.1 5203.0 5324.5 5389.3 5393.1 5432.3 413.8 416.1 416.9 419.1 443.3 3462.9 3585.3 3630.4 3648.1 3656.4 9527.7 9884.4 9926.4 9979.9 9994.1 9260.0 9792.0 9863.8 9882.7 9895.6 7268.3 7396.7 7422.7 7473.7 7489.9 5173.8 5210.3 5435.4 5464.3 5478.9 8778.2 8813.1 8886.9 8930.2 8936.6 8708.6 9023.3 9034.6 9074.5 9122.7 6018.1 6515.4 6642.1 6645.7 6845.4 7273.5 7309.2 7355.2 7369.9 7409.2 6259.1 6483.7 6498.8 6505.2 6583.3 6412.0 6458.5 6591.3 6609.8 6619.3 6221.8 6289.7 6295.5 6315.9 6316.4 4385.1 4480.8 4497.4 4526.2 4528.0 4580.5 4592.8 4593.2 4649.3 4655.9 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#4] prototype.html Cycles:180 Average:4703.44 Median:5370.68 stddev:1364.34 (25.4%) stddev-sans-first:1327.80 06:07:56 INFO - PROCESS | 15472 | Values: 314.2 318.3 322.2 324.3 329.1 5362.2 5371.3 5419.8 5467.8 5476.5 5370.7 5380.9 5391.8 5393.8 5421.8 3962.1 4083.5 4219.6 4220.4 4222.3 4198.2 4211.2 4216.5 4225.2 4232.9 4182.0 4186.9 4194.1 4197.9 4204.5 4101.1 4178.6 4189.5 4191.6 4204.3 3671.9 3698.5 3701.9 3703.4 3709.3 5136.8 5149.9 5177.5 5179.9 5196.5 4740.3 4740.4 4819.0 4842.5 4849.7 5625.5 5666.6 5679.1 5684.8 5686.3 4024.3 4026.7 4031.6 4045.6 4059.1 5875.4 5980.9 6011.2 6022.2 6038.7 4124.7 4131.0 4153.2 4154.5 4183.1 4206.2 4208.7 4219.6 4223.6 4225.7 4623.9 4809.3 4815.3 4830.0 4840.9 5704.4 5720.6 5727.4 5736.7 5744.3 1461.8 1472.6 1473.7 1485.1 1487.5 915.5 981.0 998.5 1000.3 1028.7 4848.3 4886.5 4938.8 4954.6 4958.9 5839.4 5892.4 5893.9 5903.4 5932.8 4849.3 4891.9 4940.7 4944.7 4946.9 3145.7 3160.8 3171.2 3173.5 3183.6 5370.7 5377.9 5411.4 5468.1 5476.5 5829.3 5996.5 6020.2 6040.2 6049.6 5424.2 5438.8 5459.6 5465.5 5474.5 5559.1 5837.5 5845.8 5859.3 5881.9 5679.0 5705.7 5710.1 5712.5 5729.4 5360.7 5391.1 5391.4 5407.4 5408.3 4083.6 4149.7 4154.0 4172.8 4173.5 5821.0 5835.2 5841.9 5854.9 5861.0 5657.5 5662.4 5668.8 5675.4 5677.3 5437.3 5674.0 5683.4 5683.5 5684.6 5334.7 5472.9 5510.7 5526.4 5570.2 5582.5 5771.0 5771.9 5773.7 5809.1 5587.8 5600.6 5608.1 5612.6 5645.9 06:07:56 INFO - PROCESS | 15472 | 06:07:56 INFO - PROCESS | 15472 | [#5] yui.html Cycles:180 Average:12487.04 Median:24486.24 stddev:14359.68 (58.6%) stddev-sans-first:14372.52 06:07:56 INFO - PROCESS | 15472 | Values: 666.2 745.2 751.4 756.8 783.0 11857.8 12473.7 12876.8 12920.1 12936.9 13550.3 13599.3 13619.5 13648.1 13729.3 628.7 787.9 793.4 794.3 798.5 764.8 791.1 793.8 794.9 796.0 825.8 827.0 832.3 832.9 833.1 818.4 819.3 822.1 823.0 825.7 594.8 599.2 600.1 604.8 607.0 12936.3 12992.2 13126.2 13132.7 13148.9 11419.3 11652.2 11782.2 11889.2 12130.0 9216.4 9218.6 9244.8 9356.2 9386.0 3268.5 3334.0 3380.4 3381.0 3454.5 47488.0 47490.3 47575.0 47582.3 48491.0 8715.5 8838.1 8939.6 8998.0 9029.3 17348.3 17413.0 17439.0 17470.4 17490.1 6672.5 7002.5 7047.1 7063.9 7105.8 3803.4 3847.7 3886.7 3888.2 3891.2 2910.8 2963.0 2973.5 2980.3 2980.4 491.3 495.8 498.5 501.5 520.2 418.2 430.3 481.4 508.6 532.6 7123.7 7581.7 7658.3 7723.2 8039.2 553.9 560.8 571.9 580.2 582.8 3463.4 3570.2 3607.0 3631.9 3645.9 51261.0 51939.0 52017.5 52481.5 52649.5 45010.8 45621.5 46205.3 47092.3 47474.8 42258.0 42412.0 42600.1 43075.0 43266.9 6859.4 6894.9 7007.5 7084.3 7162.5 28428.6 29120.3 29292.7 29335.3 29582.6 33803.0 33966.8 34082.8 34148.7 34740.7 9931.6 9942.1 10028.2 10151.1 10188.1 10195.3 10200.2 10279.2 10333.6 10412.8 10289.8 10316.9 10365.5 10652.0 10742.9 10988.6 11011.3 11017.9 11034.7 11063.7 9454.3 9722.7 9766.5 9839.0 10013.3 8614.5 8816.6 8836.3 9158.3 9165.9 8222.0 8606.0 8770.6 8891.6 9297.7 06:07:56 INFO - PROCESS | 15472 | -------- Summary: end -------- 06:07:56 INFO - PROCESS | 15472 | 06:07:57 INFO - TEST-INFO | 15472: exit 0 06:07:57 INFO - TEST-OK | dromaeo_css | took 1115079ms 06:07:57 INFO - TEST-START | kraken 06:07:57 INFO - operating with platform_type : linux_ 06:07:57 INFO - Initialising browser for kraken test... 06:07:57 INFO - TEST-INFO | started process 15706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOv8UM7/profile http://localhost:44192/getInfo.html) 06:08:01 INFO - PROCESS | 15706 | 06:08:01 INFO - PROCESS | 15706 | (process:15774): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:08:02 INFO - PROCESS | 15706 | __metrics Screen width/height:1600/1200 06:08:02 INFO - PROCESS | 15706 | colorDepth:24 06:08:02 INFO - PROCESS | 15706 | Browser inner width/height: 1024/697 06:08:02 INFO - PROCESS | 15706 | __metrics 06:08:03 ERROR - PROCESS | 15706 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:08:04 INFO - TEST-INFO | 15706: exit 0 06:08:04 INFO - Browser initialized. 06:08:04 INFO - Running cycle 1/1 for kraken test... 06:08:04 INFO - TEST-INFO | started process 15825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOv8UM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:06 INFO - PROCESS | 15825 | 06:08:06 INFO - PROCESS | 15825 | (process:15884): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:08:16 INFO - PROCESS | 15825 | RSS: Main: 164958208 06:08:16 INFO - PROCESS | 15825 | 06:08:18 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:19 INFO - PROCESS | 15825 | RSS: Main: 169562112 06:08:19 INFO - PROCESS | 15825 | 06:08:22 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-dft) 06:08:23 INFO - PROCESS | 15825 | RSS: Main: 173072384 06:08:23 INFO - PROCESS | 15825 | 06:08:26 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-fft) 06:08:26 INFO - PROCESS | 15825 | RSS: Main: 164298752 06:08:26 INFO - PROCESS | 15825 | 06:08:28 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-oscillator) 06:08:29 INFO - PROCESS | 15825 | RSS: Main: 164683776 06:08:29 INFO - PROCESS | 15825 | 06:08:31 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:32 INFO - PROCESS | 15825 | RSS: Main: 165441536 06:08:32 INFO - PROCESS | 15825 | 06:08:35 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:36 INFO - PROCESS | 15825 | RSS: Main: 165634048 06:08:36 INFO - PROCESS | 15825 | 06:08:39 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:40 INFO - PROCESS | 15825 | RSS: Main: 165199872 06:08:40 INFO - PROCESS | 15825 | 06:08:43 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44192/tests/kraken/driver.html?testName=json-parse-financial) 06:08:43 INFO - PROCESS | 15825 | RSS: Main: 165572608 06:08:43 INFO - PROCESS | 15825 | 06:08:45 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:46 INFO - PROCESS | 15825 | RSS: Main: 165908480 06:08:46 INFO - PROCESS | 15825 | 06:08:48 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:48 INFO - PROCESS | 15825 | RSS: Main: 166096896 06:08:48 INFO - PROCESS | 15825 | 06:08:50 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:51 INFO - PROCESS | 15825 | RSS: Main: 166440960 06:08:51 INFO - PROCESS | 15825 | 06:08:54 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:54 INFO - PROCESS | 15825 | RSS: Main: 166793216 06:08:54 INFO - PROCESS | 15825 | 06:08:57 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:58 INFO - PROCESS | 15825 | RSS: Main: 166440960 06:08:58 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44192/tests/kraken/driver.html?testName=ai-astar) 06:09:00 INFO - PROCESS | 15825 | RSS: Main: 167911424 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | __start_tp_report 06:09:00 INFO - PROCESS | 15825 | _x_x_mozilla_page_load 06:09:00 INFO - PROCESS | 15825 | _x_x_mozilla_page_load_details 06:09:00 INFO - PROCESS | 15825 | |i|pagename|runs| 06:09:00 INFO - PROCESS | 15825 | |0;ai-astar;113;107;112;112;113;125;113;114;113;112 06:09:00 INFO - PROCESS | 15825 | |1;audio-beat-detection;158;131;155;180;139;155;158;132;190;134 06:09:00 INFO - PROCESS | 15825 | |2;audio-dft;161;162;161;164;172;166;163;162;164;161 06:09:00 INFO - PROCESS | 15825 | |3;audio-fft;77;72;75;157;74;79;77;72;152;75 06:09:00 INFO - PROCESS | 15825 | |4;audio-oscillator;100;96;153;94;93;94;151;94;93;138 06:09:00 INFO - PROCESS | 15825 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;117;117 06:09:00 INFO - PROCESS | 15825 | |6;imaging-darkroom;147;148;148;150;148;147;147;147;148;146 06:09:00 INFO - PROCESS | 15825 | |7;imaging-desaturate;96;95;96;96;96;96;95;96;95;95 06:09:00 INFO - PROCESS | 15825 | |8;json-parse-financial;65;66;68;67;65;65;65;85;65;63 06:09:00 INFO - PROCESS | 15825 | |9;json-stringify-tinderbox;65;65;65;65;64;66;65;67;64;65 06:09:00 INFO - PROCESS | 15825 | |10;stanford-crypto-aes;88;78;79;80;81;80;86;82;87;80 06:09:00 INFO - PROCESS | 15825 | |11;stanford-crypto-ccm;138;144;136;146;134;142;136;137;175;134 06:09:00 INFO - PROCESS | 15825 | |12;stanford-crypto-pbkdf2;176;179;180;174;177;182;181;183;176;177 06:09:00 INFO - PROCESS | 15825 | |13;stanford-crypto-sha256-iterative;77;75;75;72;75;72;71;72;74;74 06:09:00 INFO - PROCESS | 15825 | __end_tp_report 06:09:00 INFO - PROCESS | 15825 | __start_cc_report 06:09:00 INFO - PROCESS | 15825 | _x_x_mozilla_cycle_collect,907 06:09:00 INFO - PROCESS | 15825 | __end_cc_report 06:09:00 INFO - PROCESS | 15825 | __startTimestamp1461330540646__endTimestamp 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | ------- Summary: start ------- 06:09:00 INFO - PROCESS | 15825 | Number of tests: 14 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 06:09:00 INFO - PROCESS | 15825 | Values: 113.0 107.0 112.0 112.0 113.0 125.0 113.0 114.0 113.0 112.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:156.50 stddev:20.10 (12.8%) stddev-sans-first:21.25 06:09:00 INFO - PROCESS | 15825 | Values: 158.0 131.0 155.0 180.0 139.0 155.0 158.0 132.0 190.0 134.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.37 (2.1%) stddev-sans-first:3.44 06:09:00 INFO - PROCESS | 15825 | Values: 161.0 162.0 161.0 164.0 172.0 166.0 163.0 162.0 164.0 161.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#3] audio-fft Cycles:10 Average:91.00 Median:75.00 stddev:33.56 (44.7%) stddev-sans-first:35.21 06:09:00 INFO - PROCESS | 15825 | Values: 77.0 72.0 75.0 157.0 74.0 79.0 77.0 72.0 152.0 75.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:93.50 stddev:25.72 (27.5%) stddev-sans-first:26.99 06:09:00 INFO - PROCESS | 15825 | Values: 100.0 96.0 153.0 94.0 93.0 94.0 151.0 94.0 93.0 138.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:09:00 INFO - PROCESS | 15825 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 06:09:00 INFO - PROCESS | 15825 | Values: 147.0 148.0 148.0 150.0 148.0 147.0 147.0 147.0 148.0 146.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:09:00 INFO - PROCESS | 15825 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:65.50 stddev:6.33 (9.7%) stddev-sans-first:6.65 06:09:00 INFO - PROCESS | 15825 | Values: 65.0 66.0 68.0 67.0 65.0 65.0 65.0 85.0 65.0 63.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 06:09:00 INFO - PROCESS | 15825 | Values: 65.0 65.0 65.0 65.0 64.0 66.0 65.0 67.0 64.0 65.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.50 stddev:3.57 (4.4%) stddev-sans-first:3.09 06:09:00 INFO - PROCESS | 15825 | Values: 88.0 78.0 79.0 80.0 81.0 80.0 86.0 82.0 87.0 80.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:140.00 stddev:12.25 (8.7%) stddev-sans-first:12.89 06:09:00 INFO - PROCESS | 15825 | Values: 138.0 144.0 136.0 146.0 134.0 142.0 136.0 137.0 175.0 134.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:179.50 stddev:2.95 (1.6%) stddev-sans-first:2.99 06:09:00 INFO - PROCESS | 15825 | Values: 176.0 179.0 180.0 174.0 177.0 182.0 181.0 183.0 176.0 177.0 06:09:00 INFO - PROCESS | 15825 | 06:09:00 INFO - PROCESS | 15825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:74.50 stddev:1.89 (2.5%) stddev-sans-first:1.58 06:09:00 INFO - PROCESS | 15825 | Values: 77.0 75.0 75.0 72.0 75.0 72.0 71.0 72.0 74.0 74.0 06:09:00 INFO - PROCESS | 15825 | -------- Summary: end -------- 06:09:00 INFO - PROCESS | 15825 | 06:09:01 INFO - TEST-INFO | 15825: exit 0 06:09:01 INFO - TEST-OK | kraken | took 64030ms 06:09:01 INFO - SUITE-END | took 1179s 06:09:01 INFO - Completed test suite (00:19:39) 06:09:01 INFO - javascript benchmark 06:09:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.9868800655995, 2686.11358251777, 2688.516067107922, 2710.8780104895277, 2719.2250208690525, 4704.458987216467, 4756.334113224147, 4764.356811830402, 4773.0692514959555, 4798.544138306864, 4699.060187962404, 4766.642501812361, 4792.1134590100855, 4829.9275510867365, 4846.636502262327, 4383.934240986379, 4450.792572689945, 4509.436320459942, 4525.977370113162, 4560.863174104782, 564.297885921803, 4308.181445525356, 4360.040791025969, 4417.977910110461, 4419.0057237121555, 4414.955850441519, 4427.53510881356, 4436.800343984529, 4458.933116003246, 4470.284754439274, 4435.711678740871, 4436.223660859337, 4453.51011388747, 4464.464264288274, 4483.753393563353, 4318.287482565373, 4346.500152482442, 4406.6694997874965, 4420.84527041552, 4440.467143942716, 4615.930761038587, 4694.155052090622, 4714.316424118484, 4741.9288710669025, 4749.382580264578, 4956.653034287601, 5132.923006154911, 5148.0476111919415, 5177.0, 5228.058949389108, 5155.329807125087, 5184.6629969052265, 5205.609579281531, 5224.947750522484, 5243.082460569385, 4804.639652026077, 4857.684250523705, 4858.02839432115, 4864.6594738368685, 4894.755262236874, 5175.378954525481, 5253.1857562077175, 5310.283111779938, 5320.12217984036, 5343.599230057761, 4952.47998960104, 5051.520105589963, 5096.61775366849, 5101.413337466165, 5120.155174396183, 5146.459621739738, 5158.303629010111, 5165.096108181053, 5169.06956747789, 5232.92150617741, 4975.850724478271, 5078.339815823919, 5118.744062796845, 5123.436421993578, 5135.409427915837, 5050.191969284971, 5076.035553244872, 5098.515641014098, 5104.2088476286235, 5123.948760512421, 4286.142771445723, 4292.399064131024, 4303.338711679285, 4311.525732169459, 4334.284843000933, 3730.776153430803, 3736.5702944161226, 3766.2844059628583, 3790.7346485745734, 3821.6560509554274, 4405.911881762347, 4407.2507673695545, 4409.0520538084465, 4428.13651337986, 4464.799084041226, 5095.515925987025, 5095.694258344512, 5096.694198348111, 5117.360329958755, 5133.4609865964285, 4338.566143385699, 4421.668374871898, 4439.889002774892, 4473.530279320625, 4505.031418245027, 4545.0000999779995, 4571.657125715585, 4582.518835522289, 4607.170709272363, 4617.353570500132, 4774.116788394089, 4797.736124513185, 4807.903841923142, 4812.06164797861, 4850.49069847675, 5038.899222015612, 5050.74746262678, 5090.7709153088945, 5142.04872098663, 5167.302414174189, 4735.928961065518, 4780.641451891052, 4796.0, 4799.088173247072, 4848.80604775805, 4999.750012499288, 5007.0, 5033.446320904624, 5042.596592272683, 5089.949100508948, 4992.650514463952, 5092.745362731775, 5215.087359711959, 5232.555232805102, 5232.686038837682, 4946.455889852042, 4976.776045077908, 4980.053789780075, 4990.725510096834, 5036.320096786887, 4900.14247506692, 4956.534316194845, 4973.6269779765935, 4975.154223781893, 4976.576990955665, 4752.0, 4914.778834952507, 4923.606111511142, 4983.700977941335, 5001.624878134082, 4985.451600324034, 5012.1980483122525, 5021.824236151717, 5023.799048038038, 5032.672876263031, 4910.140725373117, 4914.533119353799, 4916.631252656137, 4919.212925931977, 4951.950480495149], "value": 4676.558433418338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6597707352661, 587.0460501684762, 600.1477901380041, 622.355861683158, 637.982418043221, 34420.0, 35016.94949151526, 35019.4747078794, 35127.473087903636, 35444.0, 37961.62038379615, 38543.80728096363, 38721.41917871234, 38744.80627596858, 38804.0, 7610.2770236827555, 7820.100688420847, 7837.608119594026, 7855.489393189453, 7857.764267071997, 7680.3087722105, 7774.41691873109, 7821.76534703957, 7933.563653999027, 7986.201379861996, 7837.0, 7902.288794008538, 7987.480813747117, 7988.360931125525, 7999.840003199933, 7832.647530861096, 7909.0113735783025, 7983.920160798376, 7986.2013798620255, 7993.44045916786, 7725.304722574939, 7765.650545725456, 7830.921690783076, 7957.960210198912, 7983.361331093499, 37943.81028094842, 38021.42967855484, 38323.041923951845, 38386.61613383859, 38425.42361864574, 2406.843555168926, 2647.1529110684587, 2743.4238809849953, 2996.790224684273, 3139.9843000785077, 23923.162689305966, 23953.281401557982, 23967.0, 24069.398265043514, 24446.388840278956, 3323.302106557626, 3431.4166591679473, 3497.178163131662, 3571.8035508047305, 3648.1791596890753, 163989.0, 164498.1775091117, 165010.0, 165804.0, 166668.16665916715, 52546.73726631419, 53370.0, 53493.732531337875, 53787.462125379025, 53932.46067539353, 56364.71817640885, 56689.0, 58286.708566456895, 60362.69818650879, 60517.69741151354, 13217.206967581977, 13565.05044646885, 13600.183988960694, 13625.386857591433, 13684.178949263076, 10565.154787616972, 10599.894001060045, 10697.946510267398, 10711.678649640524, 10714.089302409382, 18746.156422961, 18795.248190072518, 18836.81163188378, 18895.638045244345, 18965.715514267296, 6743.5953842769595, 6937.7571784988295, 6975.128108986377, 7121.323474269936, 7147.356737893615, 864.5590748718199, 876.8114855306012, 954.2223088183108, 984.601236499219, 1011.7521207304258, 27343.86328068347, 27882.721172788417, 28594.142175734345, 28699.56950645742, 28913.42173156567, 947.9194268487117, 981.548487695668, 1002.1882275356984, 1054.852320675106, 1056.9101626361692, 15026.69946601062, 15248.542543723484, 15249.3900243989, 15254.161021143722, 15334.823762553748, 345707.0, 350812.0, 350884.0, 351250.0, 351920.0, 49641.50358496441, 50062.499375005784, 50575.999999999265, 50615.493845061814, 50642.493575063774, 1158.7334912970064, 1199.7180662544295, 1211.4124649544963, 1227.0919519555464, 1238.3003602964297, 26522.336941576614, 27613.447731044864, 27986.720132799226, 28245.43509129847, 28531.714682852904, 43929.34105988477, 47388.7630561845, 49272.0, 49373.0, 49529.0, 327426.0, 331425.0, 334252.0, 334959.0, 335359.0, 38356.80821595874, 38572.6142738569, 38689.0, 38763.0, 39081.609183908935, 41139.588604114775, 41411.37882931698, 42458.363124553776, 42578.0, 43090.353644694726, 36176.27647447089, 36222.09444763902, 36299.81850090733, 36442.27115457623, 36755.0, 35443.291134177685, 35793.82103089468, 37078.0, 37433.43849842309, 37648.62351376451, 31902.840485797424, 32594.185145371557, 33036.834815825765, 33090.66909330876, 34181.65818341884, 30422.847885761315, 31964.0, 32361.67638323681, 32425.27109382451, 32470.35059298848, 24267.39331516726, 24346.878265609266, 24434.389140271636, 24608.753912460645, 24790.25629231126], "value": 17412.437145601572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.84686788747905, 382.1554364853673, 386.1273521840641, 388.1944964199286, 395.3338624417858, 15578.45475408361, 16217.75673364899, 16682.916585417086, 16763.580910477212, 16784.748228776563, 15608.141552214624, 15821.525354239362, 16607.169641517936, 16644.417445389412, 16653.583660408465, 5057.1908494640775, 5186.403563590179, 5204.453532379102, 5213.765380557865, 5223.555997740196, 4861.611071114302, 5155.948440515603, 5164.483551644843, 5254.185601231815, 5254.710990895518, 5133.5893128549815, 5139.665921715076, 5151.356080489939, 5153.433122356538, 5157.6131790115705, 5116.8976620467565, 5854.414558544154, 5866.941330586682, 5880.471077519833, 5882.647041177543, 4986.276989836453, 5218.191180367049, 5231.738413079369, 5240.056789777838, 5251.68489890604, 12374.75250494994, 12546.68633284166, 12581.433835477334, 12585.74828503434, 12628.873711262862, 1772.087375001875, 1820.836124748779, 1910.121344181678, 1918.2518817660984, 1934.6130773845146, 8956.328275379308, 8982.146696063863, 9473.289503287213, 9551.665691700826, 9614.134727874525, 1522.961925951849, 1761.6636941282886, 1785.4375871600535, 1790.5523619095227, 1800.8919464832152, 69060.3093969059, 69858.0, 70636.64681676558, 70919.0, 71275.64362178207, 10016.49917504122, 10229.693109206735, 10319.329243599143, 10399.32404393712, 10427.113695335982, 14079.71840563183, 14092.929535352258, 14111.435542578387, 14150.929245353913, 14235.857641423454, 6939.6877140528795, 6980.441564674814, 7019.29807019294, 7197.604131772698, 7225.277472252733, 6495.3179916109075, 6539.117219175446, 6566.376194261537, 6702.463802895757, 6755.7973260802255, 4366.454193225847, 4395.670324725658, 4409.8456554021095, 4419.381286619876, 4532.342810292555, 1811.7916439609614, 1859.3213477081038, 1865.3191585071352, 1902.4387805597382, 1908.5896532245633, 876.2814492116403, 890.7105190813012, 891.7101941868918, 919.1635611593418, 932.0, 16120.435784747477, 16549.6690066198, 16617.833821661872, 16775.412860549823, 16928.984260944384, 845.9196376344238, 849.562475325208, 868.70898249086, 883.7702197428715, 929.702495201529, 9336.95331523338, 9341.953290233505, 9363.531823408939, 9529.666461673809, 9619.636556016458, 307971.0, 313944.0, 314738.0, 411395.0, 415557.0, 59081.40918590845, 73541.26458735343, 74889.0, 77536.0, 88646.0, 916.7708072981754, 958.3195930889146, 960.1790469148917, 971.6453494474607, 978.3885071830106, 15066.171360575274, 15189.240537972835, 15298.770518442456, 15344.693106138038, 15769.605759856095, 35251.47122793212, 35814.820925895205, 35896.820515897256, 36468.45297320595, 36511.269774603825, 50770.492295076576, 51613.22580161376, 52012.219816702025, 53942.460575395315, 54397.72801135969, 7734.381249499914, 7775.844483110193, 7842.215778422112, 7859.567723775247, 7939.722109726132, 10692.946535267274, 11483.138764592522, 11572.132090093444, 11609.419529023346, 11723.648290551297, 10309.123724483503, 10365.170786336925, 10416.531256093342, 10472.581096756045, 10478.0, 10356.792864142524, 10391.272610917465, 10395.0, 10513.526891289757, 10526.578936842441, 10504.579816807242, 10553.261271710906, 10656.25406221557, 10688.41213733221, 10733.94633026861, 7837.098733645704, 7858.292753652198, 7923.207679232261, 8012.679492820222, 8079.272865442138, 9403.952980235328, 10293.53679084428, 10317.0, 10438.791224175322, 10633.043026127685], "value": 8086.345465423003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.985620143799, 1445.205137174554, 1579.0999130495616, 1713.5459103337625, 1746.7117925542286, 6980.860382792341, 7378.077740282465, 7595.392368610512, 7619.390448764107, 7628.580428076453, 7566.735164269252, 7674.0, 7691.153973062958, 7695.0, 7760.49556778809, 2242.551489702058, 2264.705588273522, 2266.161520237506, 2266.3314322274887, 2282.942926426836, 2223.2440970070174, 2226.3877433705698, 2268.3875353654503, 2274.2040285899884, 2274.8180145588394, 2258.9096436142536, 2287.439577303563, 2295.1393227539675, 2338.8012018978407, 2343.355577216262, 2226.031676220849, 2237.183428048767, 2240.7311122665383, 2242.3273018094587, 2244.9775502244934, 2240.462289050616, 2248.808851247646, 2251.7860803223666, 2269.807066399358, 2272.5000499889998, 7905.209479052049, 7917.881231781528, 7975.162607926142, 7981.441299109065, 8006.959965200195, 4604.631629469634, 4677.298405239208, 4732.266498692708, 4747.477777444478, 4757.976210118927, 2889.653241610999, 2906.161948456193, 2981.195077329109, 3001.0846691759007, 3035.05913166919, 982.0572250639324, 982.0670363155032, 985.5367977050774, 1001.464216644092, 1002.7543251903257, 10434.0, 10468.0, 10472.057514823702, 10505.789884202273, 10534.789304213873, 4173.6661067114555, 4272.4445822042935, 4443.488998765119, 4454.888627784267, 4456.532064133284, 8798.912010879809, 8816.51509167002, 8832.249258813074, 8861.424007439497, 8917.197452229331, 4763.118823017753, 4773.594244489257, 4800.375951126401, 4837.782299796518, 4846.975765121152, 3825.407061905409, 4067.633912947849, 4182.874513764592, 4399.186150562156, 4430.025394413224, 3679.300932822755, 3719.9814000929823, 3731.8134093295225, 3834.539855217336, 3848.9807550962064, 1249.2941488059218, 1291.8708129187194, 1294.9287789171685, 1299.6815780133927, 1307.2222027893388, 695.5166159519187, 734.1153909538992, 747.0, 761.824780300534, 772.0658003815446, 5203.0, 5324.494173053554, 5389.326334208224, 5393.083175860113, 5432.29380180574, 413.7600191888697, 416.1136778661492, 416.8561846163069, 419.1198483185286, 443.33942425785995, 3462.8961131166106, 3585.3008663310925, 3630.43728222126, 3648.1426864686778, 3656.3966945453703, 9527.666531671359, 9884.357516761387, 9926.404415735078, 9979.850302245472, 9994.10053095225, 9260.0, 9792.0, 9863.80272394548, 9882.703518894445, 9895.554700038516, 7268.309510596485, 7396.704131834666, 7422.703091876265, 7473.701051957861, 7489.925100749032, 5173.844784656466, 5210.348706411699, 5435.402105768283, 5464.316960379952, 5478.863028424321, 8778.166074222938, 8813.118688131135, 8886.911130888868, 8930.240929520804, 8936.642534298555, 8708.60811263482, 9023.278137749096, 9034.593443295198, 9074.500902450429, 9122.722818805505, 6018.127371531016, 6515.446187074152, 6642.136522252076, 6645.734170633121, 6845.418139458202, 7273.454490913308, 7309.232530584425, 7355.2277010913085, 7369.926300736924, 7409.184989651027, 6259.123722678738, 6483.708233129615, 6498.837529061811, 6505.186851643544, 6583.3087525811015, 6412.045974280509, 6458.483321334188, 6591.307912669293, 6609.768658096944, 6619.338066193534, 6221.751129954751, 6289.685515724287, 6295.464885484785, 6315.873682526416, 6316.431521163117, 4385.101054283928, 4480.843170489017, 4497.437820272466, 4526.162659907796, 4528.049109687003, 4580.473245576802, 4592.839250626212, 4593.150267200579, 4649.325847752125, 4655.906881862412], "value": 4097.893515083517, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.184690727562, 318.30926888651624, 322.2041557353337, 324.2606856367483, 329.0687354785956, 5362.195670649405, 5371.301730774999, 5419.810306639269, 5467.808626698066, 5476.507114359707, 5370.650907690997, 5380.946190538093, 5391.81128660497, 5393.83818485446, 5421.810236641718, 3962.148138150297, 4083.4895638045246, 4219.641330486912, 4220.4091427200065, 4222.282212023963, 4198.160367926412, 4211.178820130076, 4216.451861258032, 4225.218334608092, 4232.915341693164, 4182.0, 4186.853460128896, 4194.140201258735, 4197.8530751423705, 4204.453421055258, 4101.118259574191, 4178.603032711888, 4189.49726032878, 4191.643710284629, 4204.264253755596, 3671.94492082619, 3698.537682789651, 3701.9444708329397, 3703.3519134151416, 3709.2766910452474, 5136.820211292624, 5149.871253218699, 5177.508136727005, 5179.896402071938, 5196.480351964811, 4740.2889566564945, 4740.416473022176, 4818.975905120487, 4842.467328593852, 4849.709017458964, 5625.54995600351, 5666.631668941505, 5679.053058124605, 5684.772609095631, 5686.289213848269, 4024.3359845625437, 4026.6577340926056, 4031.5565287818317, 4045.575214602454, 4059.106996460774, 5875.41245875409, 5980.8504787380225, 6011.218541589566, 6022.217111775485, 6038.728257228435, 4124.711270211116, 4130.984381401594, 4153.190127925026, 4154.50145982484, 4183.1215444756945, 4206.242876282298, 4208.705390622627, 4219.641330486943, 4223.598758117974, 4225.746455212697, 4623.9075218495445, 4809.302651115569, 4815.277708343777, 4829.975850120727, 4840.854774356704, 5704.402767225183, 5720.599558030981, 5727.398623144593, 5736.6558006519745, 5744.281964754406, 1461.7734251191082, 1472.5508719840336, 1473.710503309604, 1485.0792508644709, 1487.5239923224465, 915.5422288855572, 980.9558569864373, 998.4823068935178, 1000.3197825478599, 1028.7449311839543, 4848.345473361122, 4886.486918873538, 4938.802447902043, 4954.603631709455, 4958.851234462972, 5839.416058394211, 5892.410758924073, 5893.852653683606, 5903.35063143054, 5932.79235226765, 4849.2726091086615, 4891.877703057452, 4940.7035577865445, 4944.678595891256, 4946.851594452172, 3145.732612727898, 3160.762942779255, 3171.1913462067027, 3173.5398367237085, 3183.5702180205376, 5370.711029352927, 5377.919331210035, 5411.431799661058, 5468.125099983983, 5476.452354764571, 5829.271341082364, 5996.490298324691, 6020.187274717857, 6040.154378387029, 6049.606775559574, 5424.213489044146, 5438.755256013489, 5459.563234941115, 5465.480779325958, 5474.507294343528, 5559.138333558305, 5837.503812176013, 5845.77238779861, 5859.326177489644, 5881.882442335943, 5678.971605141948, 5705.714714264187, 5710.057840456278, 5712.457316554921, 5729.3984131665575, 5360.70516121617, 5391.110466772939, 5391.379991301051, 5407.432219616883, 5408.323959505062, 4083.612056854594, 4149.730267532601, 4154.0, 4172.812223450012, 4173.478315210598, 5820.962663067892, 5835.2122463466885, 5841.883162336814, 5854.853628659318, 5860.970695146497, 5657.5473962082115, 5662.357916204254, 5668.773249069991, 5675.432456754292, 5677.290338707661, 5437.293151890229, 5673.978683836949, 5683.431656834284, 5683.5453163747625, 5684.573656975826, 5334.653247538898, 5472.945270547243, 5510.724463776875, 5526.447355264441, 5570.2201691762375, 5582.49757521825, 5771.0, 5771.884562308815, 5773.740181691918, 5809.070548712186, 5587.804426845203, 5600.60795744294, 5608.130739735348, 5612.550995920398, 5645.887082258249], "value": 4268.671924739791, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.1739443090567, 745.1542499263338, 751.4026844306983, 756.833496630741, 783.0329543014379, 11857.76284474311, 12473.68815779606, 12876.80684789729, 12920.095593308472, 12936.870631293685, 13550.254735989542, 13599.32003399831, 13619.455221791117, 13648.112872663294, 13729.313534323293, 628.7422156915666, 787.9251471110235, 793.3851265269404, 794.2732399854126, 798.5488199167481, 764.8279137194143, 791.0823444804029, 793.7698067560401, 794.8847417124514, 795.9761207163795, 825.8018075661828, 826.9627866745981, 832.309183377798, 832.904216015157, 833.1168960901433, 818.423011776696, 819.2872201184948, 822.0915887943796, 823.0411570520337, 825.7481468152212, 594.7620951619343, 599.1851082527759, 600.0579090827403, 604.8306474187235, 606.9696515174223, 12936.288504132363, 12992.155509891827, 13126.212427254395, 13132.737345253137, 13148.934255328757, 11419.257748246337, 11652.242604230698, 11782.234154779997, 11889.167758256925, 12130.0, 9216.400933939272, 9218.631254749802, 9244.768880777967, 9356.157945784911, 9386.0, 3268.526063720771, 3334.0, 3380.4253276942977, 3381.0, 3454.5336379588935, 47488.0, 47490.28764568534, 47575.0, 47582.28626570604, 48491.03017939657, 8715.52064636451, 8838.07200243978, 8939.597718102701, 8997.955010225038, 9029.322800789967, 17348.30606775715, 17413.0, 17439.0, 17470.388536401166, 17490.125493725263, 6672.5329226953645, 7002.494463690331, 7047.119110111236, 7063.929360706327, 7105.786826395217, 3803.448499967489, 3847.730658853853, 3886.689064874803, 3888.2223555289056, 3891.2217556488818, 2910.825350478978, 2963.037012970793, 2973.5391014392803, 2980.344324248662, 2980.3592227671156, 491.2876329322425, 495.8066354121895, 498.4965185162939, 501.54860625437396, 520.2040877457496, 418.2346306259538, 430.32009425108254, 481.4439322582423, 508.6083715539014, 532.579262382721, 7123.679434425463, 7581.696732130763, 7658.310752032233, 7723.150453450116, 8039.236272554098, 553.9279893613805, 560.8317504748559, 571.9170720245625, 580.2340909998845, 582.8222392170429, 3463.428534291814, 3570.2145527983803, 3607.0, 3631.94552081719, 3645.872394466181, 51261.0, 51939.0, 52017.47982520202, 52481.475185248426, 52649.473505265225, 45010.77494612506, 45621.5437845624, 46205.30692039622, 47092.293615595794, 47474.762626186646, 42258.0, 42412.0, 42600.14799703989, 43075.0, 43266.91832704144, 6859.416949559343, 6894.9035071996095, 7007.544509606859, 7084.2561531040565, 7162.534435261691, 28428.57357139686, 29120.27199320034, 29292.70707292985, 29335.266618334714, 29582.556261655664, 33803.0, 33966.79215851061, 34082.82958585191, 34148.65851341554, 34740.652593474755, 9931.602735890772, 9942.105210531086, 10028.247881408777, 10151.137153342048, 10188.083072523508, 10195.337303075275, 10200.234982376203, 10279.229057820843, 10333.586656533655, 10412.791744164922, 10289.794204116026, 10316.948415257875, 10365.481725913523, 10652.041316281571, 10742.946285268523, 10988.560457581607, 11011.28426652265, 11017.889821101686, 11034.724131896766, 11063.723406914569, 9454.33819632619, 9722.659706910224, 9766.462844543334, 9839.0, 10013.349132306377, 8614.505380319162, 8816.603252853509, 8836.317453993179, 9158.313126515404, 9165.908340916505, 8221.95889020575, 8606.0, 8770.649174032967, 8891.555422228734, 9297.72106836796], "value": 5745.947067431991, "unit": "score"}], "name": "dromaeo_css", "value": 6360.135934656583, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 112.0, 113.0, 125.0, 113.0, 114.0, 113.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 155.0, 180.0, 139.0, 155.0, 158.0, 132.0, 190.0, 134.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 164.0, 172.0, 166.0, 163.0, 162.0, 164.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 75.0, 157.0, 74.0, 79.0, 77.0, 72.0, 152.0, 75.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 153.0, 94.0, 93.0, 94.0, 151.0, 94.0, 93.0, 138.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 150.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 67.0, 65.0, 65.0, 65.0, 85.0, 65.0, 63.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 67.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 79.0, 80.0, 81.0, 80.0, 86.0, 82.0, 87.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 136.0, 146.0, 134.0, 142.0, 136.0, 137.0, 175.0, 134.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 180.0, 174.0, 177.0, 182.0, 181.0, 183.0, 176.0, 177.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 72.0, 75.0, 72.0, 71.0, 72.0, 74.0, 74.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1601.2, "alertThreshold": 2.0}]} 06:09:01 INFO - Return code: 0 06:09:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:01 ERROR - # TBPL SUCCESS # 06:09:01 INFO - Running post-action listener: _resource_record_post_action 06:09:01 INFO - Running post-run listener: _resource_record_post_run 06:09:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518758400; Read time: 16; Write time: 594736 06:09:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234446848; Read time: 0; Write time: 297108 06:09:03 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284311552; Read time: 16; Write time: 297628 06:09:03 INFO - Running post-run listener: _upload_blobber_files 06:09:03 INFO - Blob upload gear active. 06:09:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:03 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 06:09:03 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:03 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:04 INFO - (blobuploader) - INFO - Done attempting. 06:09:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:09:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:05 INFO - (blobuploader) - INFO - Done attempting. 06:09:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:05 INFO - Return code: 0 06:09:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d98a33d72d2516cada6dd148f08f873e5617e15ad48250cbbcf17298776ab554d99f9d2b7e4dd8fda7cbe1f5c9547a03f829d6ae48e21cd29611a26dfab012a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f35bab58a2e7df445353b4ea34389eef6f7b6ba40890a6886a13affe916e0c350224a2257fbbb9e3c5e7d1e02030da0d88015ab23b010a30f7c9898bc65f89f"} 06:09:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:05 INFO - Contents: 06:09:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d98a33d72d2516cada6dd148f08f873e5617e15ad48250cbbcf17298776ab554d99f9d2b7e4dd8fda7cbe1f5c9547a03f829d6ae48e21cd29611a26dfab012a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f35bab58a2e7df445353b4ea34389eef6f7b6ba40890a6886a13affe916e0c350224a2257fbbb9e3c5e7d1e02030da0d88015ab23b010a30f7c9898bc65f89f"} 06:09:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:05 INFO - Copying logs to upload dir... 06:09:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.915278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:09:05.200908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:05.204414) ========= 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=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 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-Non-PGO/sha512/d98a33d72d2516cada6dd148f08f873e5617e15ad48250cbbcf17298776ab554d99f9d2b7e4dd8fda7cbe1f5c9547a03f829d6ae48e21cd29611a26dfab012a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f35bab58a2e7df445353b4ea34389eef6f7b6ba40890a6886a13affe916e0c350224a2257fbbb9e3c5e7d1e02030da0d88015ab23b010a30f7c9898bc65f89f"} build_url:https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/DVTS7rNzS9-fxDdD2JrMOQ/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-Non-PGO/sha512/d98a33d72d2516cada6dd148f08f873e5617e15ad48250cbbcf17298776ab554d99f9d2b7e4dd8fda7cbe1f5c9547a03f829d6ae48e21cd29611a26dfab012a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f35bab58a2e7df445353b4ea34389eef6f7b6ba40890a6886a13affe916e0c350224a2257fbbb9e3c5e7d1e02030da0d88015ab23b010a30f7c9898bc65f89f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:05.229733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:05.230069) ========= 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=920470bf432669ad7e3a5387000001ca-1461329305.592859-637783997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:05.315919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:05.316283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:05.316592) ========= ========= Total master_lag: 0.18 =========