builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1461772145.49 results: success (0) buildid: 20160427080654 builduid: 1b1d5ee532db4ef3829a9cf7e04d2456 revision: a308ab434d13684999626b4bac86924ed550fe7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.492220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.493143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.493802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.583213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.583524) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 08:49:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.7M=0s 2016-04-27 08:49:06 (89.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.721985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.722315) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016183 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.776638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:05.776974) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a308ab434d13684999626b4bac86924ed550fe7a --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 a308ab434d13684999626b4bac86924ed550fe7a --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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 08:49:06,797 truncating revision to first 12 chars 2016-04-27 08:49:06,797 Setting DEBUG logging. 2016-04-27 08:49:06,797 attempt 1/10 2016-04-27 08:49:06,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a308ab434d13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 08:49:07,060 unpacking tar archive at: fx-team-a308ab434d13/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:06.326386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:06.327071) ========= script_repo_revision: a308ab434d13684999626b4bac86924ed550fe7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:06.327994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:06.328666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 08:49:06.349131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-27 08:49:06.349420) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:07 INFO - MultiFileLogger online at 20160427 08:49:07 in /builds/slave/test 08:49:07 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 08:49:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:07 INFO - {'append_to_log': False, 08:49:07 INFO - 'base_work_dir': '/builds/slave/test', 08:49:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:49:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:07 INFO - 'branch': 'Fx-Team-Non-PGO', 08:49:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:07 INFO - 'config_files': ('talos/linux_config.py',), 08:49:07 INFO - 'default_actions': ('clobber', 08:49:07 INFO - 'read-buildbot-config', 08:49:07 INFO - 'download-and-extract', 08:49:07 INFO - 'populate-webroot', 08:49:07 INFO - 'create-virtualenv', 08:49:07 INFO - 'install', 08:49:07 INFO - 'run-tests'), 08:49:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:07 INFO - 'download_minidump_stackwalk': True, 08:49:07 INFO - 'download_symbols': 'ondemand', 08:49:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:07 INFO - 'installer_path': 'installer.exe', 08:49:07 INFO - 'log_level': 'info', 08:49:07 INFO - 'log_name': 'talos', 08:49:07 INFO - 'log_to_console': True, 08:49:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:07 INFO - 'opt_config_files': (), 08:49:07 INFO - 'pip_index': False, 08:49:07 INFO - 'sps_profile': False, 08:49:07 INFO - 'sps_profile_interval': 0, 08:49:07 INFO - 'suite': 'dromaeojs-e10s', 08:49:07 INFO - 'system_bits': '32', 08:49:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:07 INFO - 'title': 'talos-linux64-ix-014', 08:49:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:07 INFO - 'use_talos_json': True, 08:49:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:07 INFO - 'work_dir': 'build'} 08:49:07 INFO - ##### 08:49:07 INFO - ##### Running clobber step. 08:49:07 INFO - ##### 08:49:07 INFO - Running pre-action listener: _resource_record_pre_action 08:49:07 INFO - Running main action method: clobber 08:49:07 INFO - rmtree: /builds/slave/test/build 08:49:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:07 INFO - Running post-action listener: _resource_record_post_action 08:49:07 INFO - ##### 08:49:07 INFO - ##### Running read-buildbot-config step. 08:49:07 INFO - ##### 08:49:07 INFO - Running pre-action listener: _resource_record_pre_action 08:49:07 INFO - Running main action method: read_buildbot_config 08:49:07 INFO - Using buildbot properties: 08:49:07 INFO - { 08:49:07 INFO - "project": "", 08:49:07 INFO - "product": "firefox", 08:49:07 INFO - "script_repo_revision": "production", 08:49:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:49:07 INFO - "repository": "", 08:49:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:49:07 INFO - "buildid": "20160427080654", 08:49:07 INFO - "pgo_build": "False", 08:49:07 INFO - "basedir": "/builds/slave/test", 08:49:07 INFO - "buildnumber": 1212, 08:49:07 INFO - "slavename": "talos-linux64-ix-014", 08:49:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:49:07 INFO - "platform": "ubuntu64_hw", 08:49:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:49:07 INFO - "branch": "fx-team", 08:49:07 INFO - "repo_path": "integration/fx-team", 08:49:07 INFO - "revision": "a308ab434d13684999626b4bac86924ed550fe7a", 08:49:07 INFO - "stage_platform": "linux64", 08:49:07 INFO - "builduid": "1b1d5ee532db4ef3829a9cf7e04d2456", 08:49:07 INFO - "slavebuilddir": "test" 08:49:07 INFO - } 08:49:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:49:07 INFO - Running post-action listener: _resource_record_post_action 08:49:07 INFO - ##### 08:49:07 INFO - ##### Running download-and-extract step. 08:49:07 INFO - ##### 08:49:07 INFO - Running pre-action listener: _resource_record_pre_action 08:49:07 INFO - Running main action method: download_and_extract 08:49:07 INFO - mkdir: /builds/slave/test/build/tests 08:49:07 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')]} 08:49:07 INFO - https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:49:12 INFO - Downloaded 1361 bytes. 08:49:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:49:12 INFO - Using the following test package requirements: 08:49:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:49:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:49:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'jsshell-linux-x86_64.zip'], 08:49:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:49:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:49:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:49:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:49:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:49:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:49:12 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')]} 08:49:12 INFO - https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:18 INFO - Downloaded 22294440 bytes. 08:49:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:49:19 INFO - Return code: 0 08:49:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:49:19 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')]} 08:49:19 INFO - https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:20 INFO - Downloaded 22294440 bytes. 08:49:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:49:22 INFO - Return code: 0 08:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:22 INFO - https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:49:24 INFO - Downloaded 10840145 bytes. 08:49:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:49:24 INFO - Return code: 0 08:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:24 INFO - https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:49:26 INFO - Downloaded 54834684 bytes. 08:49:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:26 INFO - mkdir: /builds/slave/test/properties 08:49:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:26 INFO - Contents: 08:49:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:49:27 INFO - Running post-action listener: _resource_record_post_action 08:49:27 INFO - Running post-action listener: set_extra_try_arguments 08:49:27 INFO - ##### 08:49:27 INFO - ##### Running populate-webroot step. 08:49:27 INFO - ##### 08:49:27 INFO - Running pre-action listener: _resource_record_pre_action 08:49:27 INFO - Running main action method: populate_webroot 08:49:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:27 INFO - '--tppagecycles', 08:49:27 INFO - '7'], 08:49:27 INFO - 'tests': ['tsvgm']}}, 08:49:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['damp', 'tps']}, 08:49:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'tests': ['damp', 'tps']}, 08:49:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['dromaeo_dom']}, 08:49:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['a11yr', 08:49:27 INFO - 'ts_paint', 08:49:27 INFO - 'tpaint', 08:49:27 INFO - 'sessionrestore', 08:49:27 INFO - 'sessionrestore_no_auto_restore', 08:49:27 INFO - 'tabpaint']}, 08:49:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['tsvgx', 08:49:27 INFO - 'tsvgr_opacity', 08:49:27 INFO - 'tart', 08:49:27 INFO - 'tscrollx', 08:49:27 INFO - 'cart']}, 08:49:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:27 INFO - 'tsvgr_opacity', 08:49:27 INFO - 'tart', 08:49:27 INFO - 'tscrollx', 08:49:27 INFO - 'cart']}, 08:49:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'talos_options': ['--disable-e10s'], 08:49:27 INFO - 'tests': ['tp5o']}, 08:49:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'tests': ['tp5o']}, 08:49:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'talos_options': ['--disable-e10s', 08:49:27 INFO - '--xperf_path', 08:49:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:27 INFO - 'tests': ['tp5n']}, 08:49:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:27 INFO - 'talos_options': ['--xperf_path', 08:49:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:27 INFO - 'tests': ['tp5n']}}, 08:49:27 INFO - 'talos.zip': {'path': '', 08:49:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:27 INFO - Running post-action listener: _resource_record_post_action 08:49:27 INFO - ##### 08:49:27 INFO - ##### Running create-virtualenv step. 08:49:27 INFO - ##### 08:49:27 INFO - Running pre-action listener: _resource_record_pre_action 08:49:27 INFO - Running main action method: create_virtualenv 08:49:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:49:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:27 INFO - Using real prefix '/usr' 08:49:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:30 INFO - Installing pip.................done. 08:49:30 INFO - Return code: 0 08:49:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:49:30 INFO - Using env: {'DISPLAY': ':0', 08:49:30 INFO - 'HOME': '/home/cltbld', 08:49:30 INFO - 'LANG': 'en_US.UTF-8', 08:49:30 INFO - 'LANGUAGE': 'en_US:en', 08:49:30 INFO - 'LOGNAME': 'cltbld', 08:49:30 INFO - 'MAIL': '/var/mail/cltbld', 08:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:30 INFO - 'MOZ_NO_REMOTE': '1', 08:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:30 INFO - 'NO_EM_RESTART': '1', 08:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:30 INFO - 'PWD': '/builds/slave/test', 08:49:30 INFO - 'SHELL': '/bin/bash', 08:49:30 INFO - 'SHLVL': '1', 08:49:30 INFO - 'TERM': 'linux', 08:49:30 INFO - 'TMOUT': '86400', 08:49:30 INFO - 'USER': 'cltbld', 08:49:30 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:30 INFO - '_': '/tools/buildbot/bin/python'} 08:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:49:30 INFO - Cleaning up... 08:49:30 INFO - Return code: 0 08:49:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:49:30 INFO - Using env: {'DISPLAY': ':0', 08:49:30 INFO - 'HOME': '/home/cltbld', 08:49:30 INFO - 'LANG': 'en_US.UTF-8', 08:49:30 INFO - 'LANGUAGE': 'en_US:en', 08:49:30 INFO - 'LOGNAME': 'cltbld', 08:49:30 INFO - 'MAIL': '/var/mail/cltbld', 08:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:30 INFO - 'MOZ_NO_REMOTE': '1', 08:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:30 INFO - 'NO_EM_RESTART': '1', 08:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:30 INFO - 'PWD': '/builds/slave/test', 08:49:30 INFO - 'SHELL': '/bin/bash', 08:49:30 INFO - 'SHLVL': '1', 08:49:30 INFO - 'TERM': 'linux', 08:49:30 INFO - 'TMOUT': '86400', 08:49:30 INFO - 'USER': 'cltbld', 08:49:30 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:30 INFO - '_': '/tools/buildbot/bin/python'} 08:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:30 INFO - Downloading/unpacking psutil>=0.7.1 08:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:32 INFO - Installing collected packages: psutil 08:49:32 INFO - Running setup.py install for psutil 08:49:32 INFO - building 'psutil._psutil_linux' extension 08:49:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:49:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:49:32 INFO - building 'psutil._psutil_posix' extension 08:49:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:49:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:32 INFO - Successfully installed psutil 08:49:32 INFO - Cleaning up... 08:49:32 INFO - Return code: 0 08:49:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:49:33 INFO - Using env: {'DISPLAY': ':0', 08:49:33 INFO - 'HOME': '/home/cltbld', 08:49:33 INFO - 'LANG': 'en_US.UTF-8', 08:49:33 INFO - 'LANGUAGE': 'en_US:en', 08:49:33 INFO - 'LOGNAME': 'cltbld', 08:49:33 INFO - 'MAIL': '/var/mail/cltbld', 08:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:33 INFO - 'MOZ_NO_REMOTE': '1', 08:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:33 INFO - 'NO_EM_RESTART': '1', 08:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:33 INFO - 'PWD': '/builds/slave/test', 08:49:33 INFO - 'SHELL': '/bin/bash', 08:49:33 INFO - 'SHLVL': '1', 08:49:33 INFO - 'TERM': 'linux', 08:49:33 INFO - 'TMOUT': '86400', 08:49:33 INFO - 'USER': 'cltbld', 08:49:33 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:33 INFO - '_': '/tools/buildbot/bin/python'} 08:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:49:35 INFO - Installing collected packages: mozsystemmonitor 08:49:35 INFO - Running setup.py install for mozsystemmonitor 08:49:35 INFO - Successfully installed mozsystemmonitor 08:49:35 INFO - Cleaning up... 08:49:35 INFO - Return code: 0 08:49:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:35 INFO - Using env: {'DISPLAY': ':0', 08:49:35 INFO - 'HOME': '/home/cltbld', 08:49:35 INFO - 'LANG': 'en_US.UTF-8', 08:49:35 INFO - 'LANGUAGE': 'en_US:en', 08:49:35 INFO - 'LOGNAME': 'cltbld', 08:49:35 INFO - 'MAIL': '/var/mail/cltbld', 08:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:35 INFO - 'MOZ_NO_REMOTE': '1', 08:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:35 INFO - 'NO_EM_RESTART': '1', 08:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:35 INFO - 'PWD': '/builds/slave/test', 08:49:35 INFO - 'SHELL': '/bin/bash', 08:49:35 INFO - 'SHLVL': '1', 08:49:35 INFO - 'TERM': 'linux', 08:49:35 INFO - 'TMOUT': '86400', 08:49:35 INFO - 'USER': 'cltbld', 08:49:35 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:35 INFO - '_': '/tools/buildbot/bin/python'} 08:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:38 INFO - Downloading docopt-0.6.1.tar.gz 08:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:38 INFO - Running setup.py install for blobuploader 08:49:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:38 INFO - Running setup.py install for requests 08:49:38 INFO - Running setup.py install for docopt 08:49:38 INFO - Successfully installed blobuploader requests docopt 08:49:38 INFO - Cleaning up... 08:49:38 INFO - Return code: 0 08:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:38 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 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:38 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 08:49:38 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 08:49:38 INFO - Using env: {'DISPLAY': ':0', 08:49:38 INFO - 'HOME': '/home/cltbld', 08:49:38 INFO - 'LANG': 'en_US.UTF-8', 08:49:38 INFO - 'LANGUAGE': 'en_US:en', 08:49:38 INFO - 'LOGNAME': 'cltbld', 08:49:38 INFO - 'MAIL': '/var/mail/cltbld', 08:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:38 INFO - 'MOZ_NO_REMOTE': '1', 08:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:38 INFO - 'NO_EM_RESTART': '1', 08:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:38 INFO - 'PWD': '/builds/slave/test', 08:49:38 INFO - 'SHELL': '/bin/bash', 08:49:38 INFO - 'SHLVL': '1', 08:49:38 INFO - 'TERM': 'linux', 08:49:38 INFO - 'TMOUT': '86400', 08:49:38 INFO - 'USER': 'cltbld', 08:49:38 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:38 INFO - '_': '/tools/buildbot/bin/python'} 08:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:39 INFO - Running setup.py (path:/tmp/pip-sFKDhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:39 INFO - Running setup.py (path:/tmp/pip-sVg9wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:39 INFO - Running setup.py (path:/tmp/pip-dyGQss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:39 INFO - Running setup.py (path:/tmp/pip-zpdG5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:39 INFO - Running setup.py (path:/tmp/pip-jtK_8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:39 INFO - Running setup.py (path:/tmp/pip-18Lw_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:39 INFO - Running setup.py (path:/tmp/pip-b_CrKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:39 INFO - Running setup.py (path:/tmp/pip-JLyrdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:39 INFO - Running setup.py (path:/tmp/pip-u800mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:39 INFO - Running setup.py (path:/tmp/pip-tdcZvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:39 INFO - Running setup.py (path:/tmp/pip-ypfIzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:39 INFO - Running setup.py (path:/tmp/pip-J3crWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:39 INFO - Running setup.py (path:/tmp/pip-uRPyVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:40 INFO - Running setup.py (path:/tmp/pip-nBDm0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:40 INFO - Running setup.py (path:/tmp/pip-o1p1vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:40 INFO - Running setup.py (path:/tmp/pip-bmUI5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:40 INFO - Running setup.py (path:/tmp/pip-Ruwn19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:40 INFO - Running setup.py install for manifestparser 08:49:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:40 INFO - Running setup.py install for mozcrash 08:49:40 INFO - Running setup.py install for mozdebug 08:49:40 INFO - Running setup.py install for mozdevice 08:49:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:40 INFO - Running setup.py install for mozfile 08:49:40 INFO - Running setup.py install for mozhttpd 08:49:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:40 INFO - Running setup.py install for mozinfo 08:49:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for mozInstall 08:49:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for mozleak 08:49:41 INFO - Running setup.py install for mozlog 08:49:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for moznetwork 08:49:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for mozprocess 08:49:41 INFO - Running setup.py install for mozprofile 08:49:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for mozrunner 08:49:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:41 INFO - Running setup.py install for mozscreenshot 08:49:41 INFO - Running setup.py install for moztest 08:49:41 INFO - Running setup.py install for mozversion 08:49:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:42 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'DISPLAY': ':0', 08:49:42 INFO - 'HOME': '/home/cltbld', 08:49:42 INFO - 'LANG': 'en_US.UTF-8', 08:49:42 INFO - 'LANGUAGE': 'en_US:en', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MAIL': '/var/mail/cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SHLVL': '1', 08:49:42 INFO - 'TERM': 'linux', 08:49:42 INFO - 'TMOUT': '86400', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - '_': '/tools/buildbot/bin/python'} 08:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:42 INFO - Running setup.py (path:/tmp/pip-B06jR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:42 INFO - Running setup.py (path:/tmp/pip-GA1tiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:42 INFO - Running setup.py (path:/tmp/pip-Eti1EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:42 INFO - Running setup.py (path:/tmp/pip-sH5Wio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:42 INFO - Running setup.py (path:/tmp/pip-Fh6wRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:42 INFO - Running setup.py (path:/tmp/pip-lZkHJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:42 INFO - Running setup.py (path:/tmp/pip-3Bys0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:42 INFO - Running setup.py (path:/tmp/pip-LW46En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:42 INFO - Running setup.py (path:/tmp/pip-Uftpvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:42 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)) 08:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:42 INFO - Running setup.py (path:/tmp/pip-flchaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:43 INFO - Running setup.py (path:/tmp/pip-defiPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:43 INFO - Running setup.py (path:/tmp/pip-f7It1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:43 INFO - Running setup.py (path:/tmp/pip-Nsxa6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:43 INFO - Running setup.py (path:/tmp/pip-1UjSV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:43 INFO - Running setup.py (path:/tmp/pip-VdW9Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:43 INFO - Running setup.py (path:/tmp/pip-M0O3Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:43 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)) 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:43 INFO - Running setup.py (path:/tmp/pip-RHNe_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:43 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)) 08:49:43 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)) 08:49:43 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)) 08:49:43 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)) 08:49:43 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)) 08:49:43 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)) 08:49:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:45 INFO - Downloading blessings-1.6.tar.gz 08:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:45 INFO - Installing collected packages: blessings 08:49:45 INFO - Running setup.py install for blessings 08:49:45 INFO - Successfully installed blessings 08:49:45 INFO - Cleaning up... 08:49:45 INFO - Return code: 0 08:49:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:45 INFO - Reading from file tmpfile_stdout 08:49:45 INFO - Current package versions: 08:49:45 INFO - argparse == 1.2.1 08:49:45 INFO - blessings == 1.6 08:49:45 INFO - blobuploader == 1.2.4 08:49:45 INFO - docopt == 0.6.1 08:49:45 INFO - manifestparser == 1.1 08:49:45 INFO - mozInstall == 1.12 08:49:45 INFO - mozcrash == 0.17 08:49:45 INFO - mozdebug == 0.1 08:49:45 INFO - mozdevice == 0.48 08:49:45 INFO - mozfile == 1.2 08:49:45 INFO - mozhttpd == 0.7 08:49:45 INFO - mozinfo == 0.9 08:49:45 INFO - mozleak == 0.1 08:49:45 INFO - mozlog == 3.1 08:49:45 INFO - moznetwork == 0.27 08:49:45 INFO - mozprocess == 0.22 08:49:45 INFO - mozprofile == 0.28 08:49:45 INFO - mozrunner == 6.11 08:49:45 INFO - mozscreenshot == 0.1 08:49:45 INFO - mozsystemmonitor == 0.0 08:49:45 INFO - moztest == 0.7 08:49:45 INFO - mozversion == 1.4 08:49:45 INFO - psutil == 3.1.1 08:49:45 INFO - requests == 1.2.3 08:49:45 INFO - wsgiref == 0.1.2 08:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 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 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49:45 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 08:49:45 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 08:49:45 INFO - Using env: {'DISPLAY': ':0', 08:49:45 INFO - 'HOME': '/home/cltbld', 08:49:45 INFO - 'LANG': 'en_US.UTF-8', 08:49:45 INFO - 'LANGUAGE': 'en_US:en', 08:49:45 INFO - 'LOGNAME': 'cltbld', 08:49:45 INFO - 'MAIL': '/var/mail/cltbld', 08:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:45 INFO - 'MOZ_NO_REMOTE': '1', 08:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:45 INFO - 'NO_EM_RESTART': '1', 08:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:45 INFO - 'PWD': '/builds/slave/test', 08:49:45 INFO - 'SHELL': '/bin/bash', 08:49:45 INFO - 'SHLVL': '1', 08:49:45 INFO - 'TERM': 'linux', 08:49:45 INFO - 'TMOUT': '86400', 08:49:45 INFO - 'USER': 'cltbld', 08:49:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:45 INFO - '_': '/tools/buildbot/bin/python'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 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)) 08:49:46 INFO - Cleaning up... 08:49:46 INFO - Return code: 0 08:49:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49: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', 'jsonschema'] in /builds/slave/test/build 08:49: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 jsonschema 08:49:46 INFO - Using env: {'DISPLAY': ':0', 08:49:46 INFO - 'HOME': '/home/cltbld', 08:49:46 INFO - 'LANG': 'en_US.UTF-8', 08:49:46 INFO - 'LANGUAGE': 'en_US:en', 08:49:46 INFO - 'LOGNAME': 'cltbld', 08:49:46 INFO - 'MAIL': '/var/mail/cltbld', 08:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:46 INFO - 'MOZ_NO_REMOTE': '1', 08:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:46 INFO - 'NO_EM_RESTART': '1', 08:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:46 INFO - 'PWD': '/builds/slave/test', 08:49:46 INFO - 'SHELL': '/bin/bash', 08:49:46 INFO - 'SHLVL': '1', 08:49:46 INFO - 'TERM': 'linux', 08:49:46 INFO - 'TMOUT': '86400', 08:49:46 INFO - 'USER': 'cltbld', 08:49:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:46 INFO - '_': '/tools/buildbot/bin/python'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 INFO - Downloading/unpacking jsonschema 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:48 INFO - Downloading/unpacking functools32 (from jsonschema) 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:48 INFO - warning: no files found matching '*.txt' 08:49:48 INFO - no previously-included directories found matching 'build' 08:49:48 INFO - no previously-included directories found matching 'dist' 08:49:48 INFO - no previously-included directories found matching '.git*' 08:49:48 INFO - Installing collected packages: jsonschema, functools32 08:49:48 INFO - Running setup.py install for functools32 08:49:48 INFO - warning: no files found matching '*.txt' 08:49:48 INFO - no previously-included directories found matching 'build' 08:49:48 INFO - no previously-included directories found matching 'dist' 08:49:48 INFO - no previously-included directories found matching '.git*' 08:49:48 INFO - Successfully installed jsonschema functools32 08:49:48 INFO - Cleaning up... 08:49:48 INFO - Return code: 0 08:49:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d27df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', '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 08:49: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', 'flake8'] in /builds/slave/test/build 08:49: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 flake8 08:49:48 INFO - Using env: {'DISPLAY': ':0', 08:49:48 INFO - 'HOME': '/home/cltbld', 08:49:48 INFO - 'LANG': 'en_US.UTF-8', 08:49:48 INFO - 'LANGUAGE': 'en_US:en', 08:49:48 INFO - 'LOGNAME': 'cltbld', 08:49:48 INFO - 'MAIL': '/var/mail/cltbld', 08:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:48 INFO - 'MOZ_NO_REMOTE': '1', 08:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:48 INFO - 'NO_EM_RESTART': '1', 08:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:48 INFO - 'PWD': '/builds/slave/test', 08:49:48 INFO - 'SHELL': '/bin/bash', 08:49:48 INFO - 'SHLVL': '1', 08:49:48 INFO - 'TERM': 'linux', 08:49:48 INFO - 'TMOUT': '86400', 08:49:48 INFO - 'USER': 'cltbld', 08:49:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:48 INFO - '_': '/tools/buildbot/bin/python'} 08:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:48 INFO - Downloading/unpacking flake8 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:48 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 08:49:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:49:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:49:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:49:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:51 INFO - no previously-included directories found matching 'docs/_build' 08:49:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:49:51 INFO - Running setup.py install for pep8 08:49:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:51 INFO - no previously-included directories found matching 'docs/_build' 08:49:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:49:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:49:51 INFO - Cleaning up... 08:49:51 INFO - Return code: 0 08:49:51 INFO - Running post-action listener: _resource_record_post_action 08:49:51 INFO - Running post-action listener: _start_resource_monitoring 08:49:51 INFO - Starting resource monitoring. 08:49:51 INFO - ##### 08:49:51 INFO - ##### Running install step. 08:49:51 INFO - ##### 08:49:51 INFO - Running pre-action listener: _resource_record_pre_action 08:49:51 INFO - Running main action method: install 08:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:52 INFO - Reading from file tmpfile_stdout 08:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:52 INFO - Reading from file tmpfile_stdout 08:49:52 INFO - Output received: 08:49:52 INFO - Usage: mozinstall [options] installer 08:49:52 INFO - Options: 08:49:52 INFO - -h, --help show this help message and exit 08:49:52 INFO - -d DEST, --destination=DEST 08:49:52 INFO - Directory to install application into. [default: 08:49:52 INFO - "/builds/slave/test"] 08:49:52 INFO - --app=APP Application being installed. [default: firefox] 08:49:52 INFO - mkdir: /builds/slave/test/build/application 08:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:50:07 INFO - Reading from file tmpfile_stdout 08:50:07 INFO - Output received: 08:50:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:07 INFO - Running post-action listener: _resource_record_post_action 08:50:07 INFO - ##### 08:50:07 INFO - ##### Running run-tests step. 08:50:07 INFO - ##### 08:50:07 INFO - Running pre-action listener: _resource_record_pre_action 08:50:07 INFO - Running main action method: run_tests 08:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:07 INFO - Python 2.7.3 08:50:07 INFO - Return code: 0 08:50:07 INFO - grabbing minidump binary from tooltool 08:50:07 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')]} 08:50:07 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 0xf20410>, '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 0xf21310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:07 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 08:50:07 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 08:50:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:08 INFO - Return code: 0 08:50:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:50:08 INFO - Return code: 0 08:50:08 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/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:50:08 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/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 08:50:08 INFO - Using env: {'DISPLAY': ':0', 08:50:08 INFO - 'HOME': '/home/cltbld', 08:50:08 INFO - 'LANG': 'en_US.UTF-8', 08:50:08 INFO - 'LANGUAGE': 'en_US:en', 08:50:08 INFO - 'LOGNAME': 'cltbld', 08:50:08 INFO - 'MAIL': '/var/mail/cltbld', 08:50:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:08 INFO - 'MOZ_NO_REMOTE': '1', 08:50:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:08 INFO - 'NO_EM_RESTART': '1', 08:50:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:08 INFO - 'PWD': '/builds/slave/test', 08:50:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:08 INFO - 'SHELL': '/bin/bash', 08:50:08 INFO - 'SHLVL': '1', 08:50:08 INFO - 'TERM': 'linux', 08:50:08 INFO - 'TMOUT': '86400', 08:50:08 INFO - 'USER': 'cltbld', 08:50:08 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511', 08:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:08 INFO - '_': '/tools/buildbot/bin/python'} 08:50:08 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/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:50:09 INFO - mozversion application_buildid: 20160427080654 08:50:09 INFO - mozversion application_changeset: a308ab434d13684999626b4bac86924ed550fe7a 08:50:09 INFO - mozversion application_display_name: Nightly 08:50:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:09 INFO - mozversion application_name: Firefox 08:50:09 INFO - mozversion application_remotingname: firefox 08:50:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:50:09 INFO - mozversion application_vendor: Mozilla 08:50:09 INFO - mozversion application_version: 49.0a1 08:50:09 INFO - mozversion platform_buildid: 20160427080654 08:50:09 INFO - mozversion platform_changeset: a308ab434d13684999626b4bac86924ed550fe7a 08:50:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:50:09 INFO - mozversion platform_version: 49.0a1 08:50:09 INFO - using testdate: 1461772209 08:50:09 INFO - actual date: 1461772209 08:50:09 INFO - starting webserver on 'localhost:41775' 08:50:09 INFO - SUITE-START | Running 2 tests 08:50:09 INFO - TEST-START | dromaeo_css 08:50:09 INFO - operating with platform_type : linux_ 08:50:09 INFO - Initialising browser for dromaeo_css test... 08:50:09 INFO - TEST-INFO | started process 7536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvPOcg/profile http://localhost:41775/getInfo.html) 08:50:13 INFO - PROCESS | 7536 | 08:50:13 INFO - PROCESS | 7536 | (process:7604): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:50:14 INFO - PROCESS | 7536 | __metrics Screen width/height:1600/1200 08:50:14 INFO - PROCESS | 7536 | colorDepth:24 08:50:14 INFO - PROCESS | 7536 | Browser inner width/height: 1024/697 08:50:14 INFO - PROCESS | 7536 | __metrics 08:50:14 ERROR - PROCESS | 7536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:50:15 INFO - TEST-INFO | 7536: exit 0 08:50:15 INFO - Browser initialized. 08:50:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:15 INFO - TEST-INFO | started process 7655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvPOcg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:17 INFO - PROCESS | 7655 | 08:50:17 INFO - PROCESS | 7655 | (process:7714): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:50:27 INFO - PROCESS | 7655 | RSS: Main: 166137856 08:50:27 INFO - PROCESS | 7655 | 08:51:17 INFO - PROCESS | 7655 | 1461772277165 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] 08:53:28 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41775/tests/dromaeo/cssquery-ext.html) 08:53:29 INFO - PROCESS | 7655 | RSS: Main: 168689664 08:53:29 INFO - PROCESS | 7655 | 08:56:31 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-ext.html (next: http://localhost:41775/tests/dromaeo/cssquery-jquery.html) 08:56:32 INFO - PROCESS | 7655 | RSS: Main: 167133184 08:56:32 INFO - PROCESS | 7655 | 08:59:34 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41775/tests/dromaeo/cssquery-mootools.html) 08:59:34 INFO - PROCESS | 7655 | RSS: Main: 168464384 08:59:34 INFO - PROCESS | 7655 | 09:02:36 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41775/tests/dromaeo/cssquery-prototype.html) 09:02:37 INFO - PROCESS | 7655 | RSS: Main: 165847040 09:02:37 INFO - PROCESS | 7655 | 09:05:40 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41775/tests/dromaeo/cssquery-yui.html) 09:05:40 INFO - PROCESS | 7655 | RSS: Main: 167108608 09:05:40 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | Cycle 1(1): loaded http://localhost:41775/tests/dromaeo/cssquery-yui.html (next: http://localhost:41775/tests/dromaeo/cssquery-dojo.html) 09:08:43 INFO - PROCESS | 7655 | RSS: Main: 169566208 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | __start_tp_report 09:08:43 INFO - PROCESS | 7655 | _x_x_mozilla_page_load 09:08:43 INFO - PROCESS | 7655 | _x_x_mozilla_page_load_details 09:08:43 INFO - PROCESS | 7655 | |i|pagename|runs| 09:08:43 INFO - PROCESS | 7655 | |0;dojo.html;2623.855687937163;2698.015224443078;2714.199311203195;2723.7820974322044;2726.073135134054;4744.715317080973;4762.166620841347;4768.356271903292;4775.164346239411;4840.080384726908;4662.790174442158;4777.355057067295;4823.807047718095;4827.6137908967285;4835.782389792459;4421.4915284742265;4447.599716025557;4499.6400287976885;4500.032493014001;4501.077279157765;4439.112177564484;4534.229181039214;4540.772961351936;4579.290210017436;4594.977025114869;4322.7190232634775;4372.475302963665;4432.800523976429;4463.732176069414;4512;4403.36151258069;4451.933221001687;4452.443444569429;4455.532169122228;4496.2581174106235;4411.580899814545;4413.602775750198;4428.601425871655;4445.866624001285;4477.731336119843;4664.32367306742;4703.741294228816;4720.716756994591;4747.596454301389;4757.5480329369;5107.463716309771;5108.744562771846;5119.590432765407;5127.512886275797;5156.845294641167;5013.523715247045;5175.792968281265;5179.948200517984;5181.611379146579;5187.533122019036;4784.5933095686905;4800.255960326155;4802.423709154854;4806.255030470283;4850.781714822806;5184.248283998799;5191.688498690015;5197.324347834758;5208.374995000549;5220.1647736362;4815;4962.057209130254;4971.477994810492;5016.749162541858;5084.567811736044;5090.880006398586;5138.409082955433;5146.665466744649;5147.5881929446305;5155.458676838878;4911.582515486224;4985.302057711923;5045.419776725724;5062.038212739568;5091.770870310771;4956.182229932093;5001.774920128603;5021.623378246646;5040.47075057121;5130.896857175725;4258.74447533149;4259.936100958426;4268.487781466244;4300.290452075373;4310;3696.74122811406;3761.5298087739034;3786.3373909565717;3802.9809850951124;3809.0858194033785;4346.565343465628;4414.514403415622;4472.262076757299;4477.507474177838;4481.148581769454;5140.614453915971;5157;5173.922391164136;5187.0922588546855;5219.243209734567;4444.511103778646;4455.353973673799;4473.865784026484;4478.9552104478535;4500.639948804088;4420.734755914656;4430.246858034142;4462.419885414875;4493.1013797240685;4502.414686090853;4922.827701030518;4923.606111510999;4935.555799977948;4948.158813001726;5000.549950504472;5045.672031317952;5188.325517682677;5222.55608273301;5232.9738351308;5281.656692314988;4889.46215916256;4911.140550403737;4922.803087876445;4939.086269040239;4959.876003099951;5006.674566153189;5053.772580233972;5056.82301119459;5060.190369541003;5105.897882042413;4953.18272485036;5061.924071138862;5116.4627714090975;5124;5142.1772516397195;4864.562189402971;4940.851774446773;5032.295478633067;5056.216286475602;5102.336696229615;4952.5542701157065;4963.454020057863;4971.154903666313;4973.030259099441;5025.824096156617;4730.455997560324;4856;4912.6561140719805;4919.704817710949;4959.851204463872;5028.723420211777;5065.645404821627;5076.619253555924;5123.410807757155;5128.487151284841;4890.853274401774;4891.461939186615;4922.384701912261;4950.900981980412;4987.700737955589 09:08:43 INFO - PROCESS | 7655 | |1;ext.html;590.4095904095905;598.838313655313;607.6809674920669;623.875224955009;637.8582337615666;32778;33957.490637640454;34125.82937085317;34141.31717365651;34160.145996350104;34694.306113877705;35262.8236858816;35301.293974120505;35315;35348.469772953365;7414.332710056094;7605.619719014055;7622.580758058304;7625.694972201105;7625.885611715801;7604.581748003858;7683.654235559413;7705.73029943952;7733.767986960372;7745.690172393126;7786.571738554378;7794.337481314067;7803.102643196048;7833.177516360785;7881.17247688993;7674;7724.497907636042;7749.573773442458;7793.961030194812;7809.882851757228;7695.499792513525;7725.034370703662;7799.7270095546955;7812.257835505675;7819.569923654197;36609.45085823715;36965.63034369649;37141.62858371409;37148.442773358154;37169.81415092907;2556.463142740027;3005.6543497497632;3028.757699384044;3068.47835867903;3073.339232065117;25701.614475782877;25735.485290294277;25978.411926738074;26031.479370412675;26136.477270454674;3499.403060491539;3546.4680297955256;3561.0919215600115;3599.7120230381506;3601.4777857210556;185053;186656.99999999863;188196.0590197054;188390;188407;49863.50136498589;49871;49987.25019124716;50031.24953125706;50053;49752.25371619429;50844.49155508397;51024.74487627538;51122.233166502534;51187;13560.457581696819;13774.380152893144;13778.379972901244;13785.310734463237;13802.17186968785;10637.734056648645;10655.30740501865;10724.839127413095;10735.248532602644;10738.838917416246;16745.16274186286;16846.24191911367;16953.83046169547;17070.48788536346;17493.38773142934;6679.127974970809;6707.3963343298365;6714.832129196711;6952.2352541220425;6970.128733908262;891.6834523744108;907.5371560504191;951.8048799995984;953.9475328856979;1018.1040684197859;26835;27005.594916076276;27367;27371.178864634094;27456.45087098247;977.6724797192878;1017.6845177994845;1033.8914413986574;1035.6737627647267;1113.6770336602294;13936.303184840717;14307.709226877876;14656.332391596796;14801.481948131765;14898.255087245594;274188;280130;281641;282635;282867;45193.54806451959;45357.77321113373;45931;45955;46013.5398646016;1242.6085782978332;1248.4631608408472;1251.0742050882463;1259.9937000315124;1273.4778740716263;26100.608490873034;26681.466370672864;26920.192394228205;26950.191494255203;27214.72785272122;40547.1890562193;40784.59215407808;41011.7949410251;41105;41122.1775564493;236986;237547;237818;237904;239583;24004;24469.632955505327;24492.14277500279;35566.64433355633;36451.81774091112;39148.41277380899;39866.2026759469;39881;40044.399334010595;40628;34240.65759342375;34252.657473424944;34376.48435273423;34378;34645.48031779475;33008.1747956303;33540.49689254712;34200.65799341975;34488.655113449546;35085;30972.380552388375;31525;31990.84004579962;34166.31667366589;34400.311993760486;28521.42957140887;29080.7091929078;29085.709142909145;29097.709022910345;29467.705322946495;23635.763642364043;24530.632040519762;24625.507489849744;24735.134270300452;24786.25641230766 09:08:43 INFO - PROCESS | 7655 | |2;jquery.html;376.868096166342;387.3144534174511;388.3979831261545;393.5316972802365;396.57764480827933;14806.259687015647;16260.512184634465;16269.105199214038;16359.509214723577;16363.672726545461;15206.315715792789;15518.84481155188;16113;16206.837931620681;16335.26491307891;5067.1385864402955;5206.947930520684;5210.218467229908;5240.790368385279;5256.8685782855355;4965.751712414383;5108.208227724708;5174.896502069956;5183.248428977796;5219.895602087956;5121.590272778169;5136.845894623168;5139.614528910328;5170.121079416508;5174.146265866147;4929.482404347527;5138.7944482220855;5140.9228861566735;5155.40712818027;5158.767855446514;4588.49526552079;4598.655100867415;4602.723836569783;4622.676412651116;4629.8148074077;18384.17271222785;18578.814211857978;19283;19309.806901931082;19346.61306773871;1954.1499447740277;2057.989710051455;2079.272254710854;2342.7540108288727;2361.7402085770723;12378.81431778524;12462.252264864137;12476.75046499065;12808.167469114478;12998.870011299861;1676.3629820668068;1714.9571260718458;1762.942234659207;1764.5235786337746;1766.8321509456582;57210;59896.40103598952;60237.397626023616;60343.99999999956;60628.09057864136;9139.954300228455;9441.90558094424;9469.195118414875;9528;9718.173955213744;12981.545645902348;13095.541656042184;13100.672483187996;13127.343632818322;13204.537841175512;7207.783766487014;7337.605854887554;7537.434692398092;7591.582462964479;7614.162442131361;7196.10048743907;7296.927030729625;7317.597532135784;7385.3722433592675;7459.477836551389;5744.827655170268;5979.402059793986;6013.4888534474185;6075.1774467659525;6130;1790.9910450447926;1811.3026484803445;1842.6591080650123;1851.1484717030316;1883.2467013194832;955.3980991975011;975.9072888075764;977.3158788847693;990.8563258327503;1042.2599954032721;15901.52295431139;16401.83598164027;16560.834391655928;16592.419265325654;16753.748693769605;876.373393023991;901.9323550733722;909.7316291693966;924.3390975452584;977.2670497127154;9494.240460763122;9630.711078667651;9672.371295865747;9732.41605503672;9835.164011058998;360836;382527;383078;388025;388761;44990.775046125214;49932.750336248086;51899.22151167736;57621.711891440274;57970.42029579735;987.629638885418;989.6635144050913;1014.2849291249652;1029.341221618165;1030.9329843611827;13665.931670341584;14766.778498322748;14849.034812737138;14861.479848205694;15107.32017059257;30797.23006924845;31813;32486.350272993936;33014.17464563405;33679;42941.355879661205;42983.140337193705;43040.493582724455;43156.78421607872;43161.56838431575;7540.736074237376;7751.6124193788955;7774.222577742181;7775;7908.248716371935;9718.70843874685;11296.265742726697;11406.258593191747;11417.942910285396;11546.480408381474;5967.880642387215;6604.603723776589;10041.698749037541;10198.490075496344;10346.172306215334;9943.602255909682;9980.900190998287;10018.499075046073;10081.69754907354;10221;10101.292909496266;10250.692479225636;10289.897101028893;10358.223133264884;10421.114205292635;7718.53688778675;7836.294733473786;7844.843103137791;8049.83900322002;8095.9880014998125;9133;9908.25688073383;9944.801103978025;10030.247731420319;10305.381677099398 09:08:43 INFO - PROCESS | 7655 | |3;mootools.html;1422.4950142699338;1463.2025546077386;1537.2697968464981;1706.2577778666289;1746.3974928649611;6357.777477788279;6890.793276201715;6919.757808476705;7130.893036604449;7155.212926578072;6959.373656370925;6979.232284448706;6999.545029573074;7018.122734658168;7074.398676112537;2183.410479170623;2228.053077442081;2228.075348730275;2230.710007698997;2231.4867580456503;2121.4166104321357;2144.0994782191437;2166.8483206175497;2170.6092903277404;2186.9453263668374;2134.583756167548;2166.566686662674;2171.565686862626;2189.9233526826565;2191.276878630048;2114.6299397605435;2129.58473097746;2130.637791575436;2132.232396337333;2137.5190582118976;2120.427484579155;2149.1725685610995;2161.6001039807684;2170.218721260345;2184.5740080684272;7058.153021637385;7080.681369338392;7159.176694680074;7162.785116446515;7175.748848790267;4497.8425755098415;4630.236011058171;4647.256438969748;4653.720776753372;4655.557722016403;2804.4110736745306;2869.239651492356;2906.0410064678604;2916.0522830080095;2917.0519581136004;907.3648446087699;925.208946350867;976.9218462523053;982.1357205659045;982.7543114221445;8988.640454381817;9141.954290228572;9164.358494905358;9168.495732734631;9177.311701622339;4127.33962565994;4180.519240287345;4253.510846252659;4262.829486820555;4286.89282767927;7749.922500775033;7751.961240193763;7753.418493613001;7762.883556746653;7768.7669369918995;4574.153781550423;4620.1221767864;4632.096741135513;4633.166030114612;4643.048175124091;3676.338259113332;4112.506499220112;4242.300020496646;4285.121550082225;4320.503142138631;3307.751918606066;3339.2987472630534;3406.67636574525;3433.9828300858335;3460.3079384123275;1087.075985412409;1094.819354806448;1100.3837850803416;1101.8181999970075;1105.8285965675334;748.6593599912027;769.7190525458279;837.8701301298308;848.4188330993289;862.6721845698594;4738.739369334719;5013.373328333958;5083.085044691917;5139.922901156486;5188.63679542436;836.05943313772;883.6023789294843;927.4110939553298;935.3265648733037;936.7564433247405;3529.576450825917;3530.6645868642436;3601.2617413430185;3612.1330880588994;3622.637736226356;8109.43233973628;8352.248297653241;8355.373346999;8371.330293576499;8387.874181887277;8243.95878020618;8305;8314.750557483285;8394.076651568445;8397.958010210032;6684.16447944007;6720.697568609425;6759.087523184307;6785.9321406786285;6805.149356330359;5011.072951503984;5044.646874718735;5078.21287700407;5085.160948443466;5093.006863661551;7923.564203968606;7940.483868548526;7971.641276142472;8084.514929104273;8168.142345053684;8062.677492900219;8180.754577362689;8193.549354785306;8291.295239904675;8362.45644033136;5412.702301373305;5801.013827649394;6051.213342265477;6081.452669259788;6133.9079913802225;6878.965605171942;6906.240313565403;6921.1002569667635;6927.515073944977;6949.3745562899585;6194.287656919512;6346.270178929482;6392.4246817786625;6477.4494167996245;6480.481561474976;6349.206349206349;6392.712327945161;6435.549511534147;6456.9354306456335;6542.607443553402;6005.969970150121;6056.273247210363;6097.176881120992;6105;6107.786227482017;4296.162248361665;4522.706024108423;4542.931856022228;4544.727316361029;4568.680192386501;4126.116021578542;4127.545969943244;4172.687048471316;4183.874483765492;4205.369194620709 09:08:43 INFO - PROCESS | 7655 | |4;prototype.html;306.55702509873214;318.3680394417082;322.9628592711836;323.0711703851426;326.4140867143477;4747.928781068278;4867.975660121703;4927.2855435961765;4947.282644016615;5018.84943451697;4886.584640305578;4956.975215123919;4963.205887058071;4966.180580204271;4988.102141614508;3839.9040023999346;3888.0754026756795;3899.6490315871565;3911.1395492991496;3918.666913312358;3645.54430696163;3916.511725544289;3921.29416704993;3924.529056513208;3938.054866831954;3807.733458657895;3828.25349056934;3836.7122465815037;3847.3267178243836;3856.3058649443087;3826.770393776382;3833.821134962876;3838.2899163654815;3856.84572617095;3871.7870517121546;3399.2861499084975;3408.9147771305666;3409.130671678731;3409.147713071732;3425.092350527112;4610.76946152691;4706.647001474903;4710.31700403443;4771.71369717818;4780.928286075712;4354.238008348526;4361.672874534391;4367.45406824147;4378.058717375748;4383.671224658164;5116.795328186868;5125.897482050338;5145.279660847485;5153.66501177426;5166.43169251382;3609.927801443983;3685.3734865073;3689.6494832990825;3692.483052372643;3694.704423646102;5368.355797304349;5441.347038355383;5453.754581043823;5459.481349271852;5482.369527504348;3776.3957766757185;3786.583475817658;3788.049154685339;3791.3554695701796;3802.7338086334244;3834.194819087967;3840.9615903841163;3841.4045822897497;3849.8075096245075;3852.614738526181;4254.744715317091;4262.914741705148;4347.195768782785;4350.32569951658;4359.057636095623;5166.3025491558155;5186.084506197872;5187.974060129751;5197.922031169535;5206.349206349207;1308.339288659221;1336.1248382309602;1382.1637909065073;1385.819843420349;1387.6461502317047;904.8506996345529;913.6939125393068;927.6114006433461;948.1798244518442;949.5489642419795;4787.928181077286;4811.508432385902;4818;4824.662273640812;4827.468978412372;5618.494335509824;5663.773449061991;5671.801486947937;5671.914921276184;5677.602567820296;4718.693284936537;4821.4696383397795;4825.420949486014;4828.734419606885;4843.321934929113;2974.3605124897817;3003.294225856922;3014.095771268611;3017.3211027518632;3043.0566524377514;5292.867678307996;5314.973425132927;5318.441563635763;5319.46805319465;5333.813316533902;5620.747066382022;5735.971320143456;5759.884802303931;5799.1011393233275;5800.390958949334;5302.257683924254;5305.628605997543;5332.73336333174;5340.118880384771;5341.412444631165;5484.753186106715;5622.409646987171;5647.322321321468;5654.745536450787;5671.17767923657;5505.449455054462;5509.834704958857;5514.696691681996;5528.391876893458;5533.889322213614;5331.493508116722;5358.7320633967365;5360.276362690986;5373.919391209057;5390.730463476889;3563.3051554947574;3971.62269584389;3975.463312452782;3980.3034468967235;3994.121293315466;5066.733316670832;5243.475652434879;5286.154215325683;5327.254184414262;5394.514493695587;4997.9750101249265;5085.237214417867;5158;5182.559482444034;5198.506141916512;5138.332016837787;5173.22401639757;5178.533931946143;5187.342923239183;5211.166213405989;4946.777395017161;5118.309028281284;5118.877484734235;5127.46161653036;5130.48695130484;5168.457311982188;5208.4270730220405;5228.790848366023;5231.189165679326;5243.370795504564;5066.569341606005;5071.416787069386;5076.949230507647;5095.464976177448;5102.209157580581 09:08:43 INFO - PROCESS | 7655 | |5;yui.html;711.0223442766196;732.6336831584208;741.8182545276406;773.5242825662219;785.9174786647402;11220.158488113393;11958.7608247835;12099.697507562316;12228.205166664171;12245.32650704211;12023.338716370617;12027.458764355602;12078.15452918296;12125.090618203649;12126.757464850698;633.4710516718523;767.7044337929881;774.930256276935;793.4287313134563;794.1224946434194;780.9687612495493;787.9015123109612;790.0243199648459;794.2057942057942;796.6972550430858;833.7790485521342;833.9708110216113;834.7662654456732;834.7829564313292;837.8785076163953;822.8107535266862;828.4615000249826;832.309183377798;833.1626715151294;836.0552575589605;607.2652090969932;609.0590038390653;614.5206738743786;615.0436071908181;615.0651010464114;12222.938885305517;12314.199577027553;12315.4458049388;12366.381680915918;12398.504059837596;12168.26990380571;12611.684707882285;12643.17819341749;12757.55348562796;12960.092793504458;9965.65120220796;10175.542100605491;10189.745256368577;10450.111740502067;10584.947075264652;3345.2974875276223;3371.9494207586904;3430.9313813723834;3434.8110853903027;3459.221675123077;42675.14649707019;42943.14113717708;43873;45269.32096018562;45586.544134558564;10207.795844083077;10227.7443063924;10274.434906080238;10294.279400442047;10512.57949682004;17404.738928916075;17961.101944902963;17980.820191798175;17981;18044.27822887096;6694.330566943364;6723.562968407038;6754.054432379471;6776.254611992776;6884.277150899184;3676.3933950898336;3724.7951362675312;3778.3576791945434;3781.9243615128094;3920.17676287977;2711.1730922068564;2771.708970558103;2785.804993650425;2791.4277573097465;2793.8184018038764;492.20508878161513;492.42632333331267;504.38716958895117;510.93868735751204;511.0596502435536;505.375860811897;568.5196009372074;584.2754983820117;585.4145854145854;587.3451102021215;6967.33810288032;7335.596542190231;7377.077865266841;7506.13679426862;7527.8118047048165;519.5921201856524;529.9735013249399;536.2894165231085;541.6019225868984;555.6721534294785;2951.6605590357385;3300.207950091961;3392.2028323343993;3428.9828550857087;3469.0633528947546;49178.26232606514;50005.74997124991;50021;50528.494715053115;50960.49039509631;46526.069478610916;46567.53432465632;46656.300155497695;46904;47579.5242047582;40005;41832;42028.36957445641;42150.367744483854;42575.148497029884;7078.362947334765;7082.327178917994;7147.749828755968;7165.713371465083;7326;29317.560236596895;29828.315451608592;29841.403171936872;29857;30215.09354719362;35610.82194589011;37939.62060379471;38166;38352.6164738349;38986;9848.704538863845;10174.898251017396;10340.793184136426;10368.118709909742;10373.325733827278;9832.410055396698;10324.638637647646;10341.37951722899;10802.945985270024;10972.396518191257;9359.953200233955;9388;9520.333576649567;9591.9040809591;9753.804923901624;8999.280057595246;10217.74455638615;10393.9480302598;10488.528016239135;10714.357138571711;9833.16418104469;10086.94956525242;10141.695749127539;10207;10412.062914337746;7722.446538058786;7803.92196078032;7808.609569521387;7909.288164065261;7911.478845609342;8085.63614637331;8231.670733170606;8290.83418331618;8382.622781974704;8407.579621019047 09:08:43 INFO - PROCESS | 7655 | __end_tp_report 09:08:43 INFO - PROCESS | 7655 | __start_cc_report 09:08:43 INFO - PROCESS | 7655 | _x_x_mozilla_cycle_collect,382 09:08:43 INFO - PROCESS | 7655 | __end_cc_report 09:08:43 INFO - PROCESS | 7655 | __startTimestamp1461773323249__endTimestamp 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | ------- Summary: start ------- 09:08:43 INFO - PROCESS | 7655 | Number of tests: 6 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#0] dojo.html Cycles:165 Average:4739.37 Median:4911.14 stddev:491.41 (10.0%) stddev-sans-first:464.05 09:08:43 INFO - PROCESS | 7655 | Values: 2623.9 2698.0 2714.2 2723.8 2726.1 4744.7 4762.2 4768.4 4775.2 4840.1 4662.8 4777.4 4823.8 4827.6 4835.8 4421.5 4447.6 4499.6 4500.0 4501.1 4439.1 4534.2 4540.8 4579.3 4595.0 4322.7 4372.5 4432.8 4463.7 4512.0 4403.4 4451.9 4452.4 4455.5 4496.3 4411.6 4413.6 4428.6 4445.9 4477.7 4664.3 4703.7 4720.7 4747.6 4757.5 5107.5 5108.7 5119.6 5127.5 5156.8 5013.5 5175.8 5179.9 5181.6 5187.5 4784.6 4800.3 4802.4 4806.3 4850.8 5184.2 5191.7 5197.3 5208.4 5220.2 4815.0 4962.1 4971.5 5016.7 5084.6 5090.9 5138.4 5146.7 5147.6 5155.5 4911.6 4985.3 5045.4 5062.0 5091.8 4956.2 5001.8 5021.6 5040.5 5130.9 4258.7 4259.9 4268.5 4300.3 4310.0 3696.7 3761.5 3786.3 3803.0 3809.1 4346.6 4414.5 4472.3 4477.5 4481.1 5140.6 5157.0 5173.9 5187.1 5219.2 4444.5 4455.4 4473.9 4479.0 4500.6 4420.7 4430.2 4462.4 4493.1 4502.4 4922.8 4923.6 4935.6 4948.2 5000.5 5045.7 5188.3 5222.6 5233.0 5281.7 4889.5 4911.1 4922.8 4939.1 4959.9 5006.7 5053.8 5056.8 5060.2 5105.9 4953.2 5061.9 5116.5 5124.0 5142.2 4864.6 4940.9 5032.3 5056.2 5102.3 4952.6 4963.5 4971.2 4973.0 5025.8 4730.5 4856.0 4912.7 4919.7 4959.9 5028.7 5065.6 5076.6 5123.4 5128.5 4890.9 4891.5 4922.4 4950.9 4987.7 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#1] ext.html Cycles:180 Average:39280.71 Median:34246.66 stddev:62078.78 (181.3%) stddev-sans-first:62184.95 09:08:43 INFO - PROCESS | 7655 | Values: 590.4 598.8 607.7 623.9 637.9 32778.0 33957.5 34125.8 34141.3 34160.1 34694.3 35262.8 35301.3 35315.0 35348.5 7414.3 7605.6 7622.6 7625.7 7625.9 7604.6 7683.7 7705.7 7733.8 7745.7 7786.6 7794.3 7803.1 7833.2 7881.2 7674.0 7724.5 7749.6 7794.0 7809.9 7695.5 7725.0 7799.7 7812.3 7819.6 36609.5 36965.6 37141.6 37148.4 37169.8 2556.5 3005.7 3028.8 3068.5 3073.3 25701.6 25735.5 25978.4 26031.5 26136.5 3499.4 3546.5 3561.1 3599.7 3601.5 185053.0 186657.0 188196.1 188390.0 188407.0 49863.5 49871.0 49987.3 50031.2 50053.0 49752.3 50844.5 51024.7 51122.2 51187.0 13560.5 13774.4 13778.4 13785.3 13802.2 10637.7 10655.3 10724.8 10735.2 10738.8 16745.2 16846.2 16953.8 17070.5 17493.4 6679.1 6707.4 6714.8 6952.2 6970.1 891.7 907.5 951.8 953.9 1018.1 26835.0 27005.6 27367.0 27371.2 27456.5 977.7 1017.7 1033.9 1035.7 1113.7 13936.3 14307.7 14656.3 14801.5 14898.3 274188.0 280130.0 281641.0 282635.0 282867.0 45193.5 45357.8 45931.0 45955.0 46013.5 1242.6 1248.5 1251.1 1260.0 1273.5 26100.6 26681.5 26920.2 26950.2 27214.7 40547.2 40784.6 41011.8 41105.0 41122.2 236986.0 237547.0 237818.0 237904.0 239583.0 24004.0 24469.6 24492.1 35566.6 36451.8 39148.4 39866.2 39881.0 40044.4 40628.0 34240.7 34252.7 34376.5 34378.0 34645.5 33008.2 33540.5 34200.7 34488.7 35085.0 30972.4 31525.0 31990.8 34166.3 34400.3 28521.4 29080.7 29085.7 29097.7 29467.7 23635.8 24530.6 24625.5 24735.1 24786.3 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#2] jquery.html Cycles:180 Average:22655.41 Median:44076.17 stddev:62208.64 (141.1%) stddev-sans-first:62360.66 09:08:43 INFO - PROCESS | 7655 | Values: 376.9 387.3 388.4 393.5 396.6 14806.3 16260.5 16269.1 16359.5 16363.7 15206.3 15518.8 16113.0 16206.8 16335.3 5067.1 5206.9 5210.2 5240.8 5256.9 4965.8 5108.2 5174.9 5183.2 5219.9 5121.6 5136.8 5139.6 5170.1 5174.1 4929.5 5138.8 5140.9 5155.4 5158.8 4588.5 4598.7 4602.7 4622.7 4629.8 18384.2 18578.8 19283.0 19309.8 19346.6 1954.1 2058.0 2079.3 2342.8 2361.7 12378.8 12462.3 12476.8 12808.2 12998.9 1676.4 1715.0 1762.9 1764.5 1766.8 57210.0 59896.4 60237.4 60344.0 60628.1 9140.0 9441.9 9469.2 9528.0 9718.2 12981.5 13095.5 13100.7 13127.3 13204.5 7207.8 7337.6 7537.4 7591.6 7614.2 7196.1 7296.9 7317.6 7385.4 7459.5 5744.8 5979.4 6013.5 6075.2 6130.0 1791.0 1811.3 1842.7 1851.1 1883.2 955.4 975.9 977.3 990.9 1042.3 15901.5 16401.8 16560.8 16592.4 16753.7 876.4 901.9 909.7 924.3 977.3 9494.2 9630.7 9672.4 9732.4 9835.2 360836.0 382527.0 383078.0 388025.0 388761.0 44990.8 49932.8 51899.2 57621.7 57970.4 987.6 989.7 1014.3 1029.3 1030.9 13665.9 14766.8 14849.0 14861.5 15107.3 30797.2 31813.0 32486.4 33014.2 33679.0 42941.4 42983.1 43040.5 43156.8 43161.6 7540.7 7751.6 7774.2 7775.0 7908.2 9718.7 11296.3 11406.3 11417.9 11546.5 5967.9 6604.6 10041.7 10198.5 10346.2 9943.6 9980.9 10018.5 10081.7 10221.0 10101.3 10250.7 10289.9 10358.2 10421.1 7718.5 7836.3 7844.8 8049.8 8096.0 9133.0 9908.3 9944.8 10030.2 10305.4 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#3] mootools.html Cycles:180 Average:4767.11 Median:5606.86 stddev:2472.42 (44.1%) stddev-sans-first:2466.58 09:08:43 INFO - PROCESS | 7655 | Values: 1422.5 1463.2 1537.3 1706.3 1746.4 6357.8 6890.8 6919.8 7130.9 7155.2 6959.4 6979.2 6999.5 7018.1 7074.4 2183.4 2228.1 2228.1 2230.7 2231.5 2121.4 2144.1 2166.8 2170.6 2186.9 2134.6 2166.6 2171.6 2189.9 2191.3 2114.6 2129.6 2130.6 2132.2 2137.5 2120.4 2149.2 2161.6 2170.2 2184.6 7058.2 7080.7 7159.2 7162.8 7175.7 4497.8 4630.2 4647.3 4653.7 4655.6 2804.4 2869.2 2906.0 2916.1 2917.1 907.4 925.2 976.9 982.1 982.8 8988.6 9142.0 9164.4 9168.5 9177.3 4127.3 4180.5 4253.5 4262.8 4286.9 7749.9 7752.0 7753.4 7762.9 7768.8 4574.2 4620.1 4632.1 4633.2 4643.0 3676.3 4112.5 4242.3 4285.1 4320.5 3307.8 3339.3 3406.7 3434.0 3460.3 1087.1 1094.8 1100.4 1101.8 1105.8 748.7 769.7 837.9 848.4 862.7 4738.7 5013.4 5083.1 5139.9 5188.6 836.1 883.6 927.4 935.3 936.8 3529.6 3530.7 3601.3 3612.1 3622.6 8109.4 8352.2 8355.4 8371.3 8387.9 8244.0 8305.0 8314.8 8394.1 8398.0 6684.2 6720.7 6759.1 6785.9 6805.1 5011.1 5044.6 5078.2 5085.2 5093.0 7923.6 7940.5 7971.6 8084.5 8168.1 8062.7 8180.8 8193.5 8291.3 8362.5 5412.7 5801.0 6051.2 6081.5 6133.9 6879.0 6906.2 6921.1 6927.5 6949.4 6194.3 6346.3 6392.4 6477.4 6480.5 6349.2 6392.7 6435.5 6456.9 6542.6 6006.0 6056.3 6097.2 6105.0 6107.8 4296.2 4522.7 4542.9 4544.7 4568.7 4126.1 4127.5 4172.7 4183.9 4205.4 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#4] prototype.html Cycles:180 Average:4383.79 Median:4952.13 stddev:1284.35 (25.9%) stddev-sans-first:1250.97 09:08:43 INFO - PROCESS | 7655 | Values: 306.6 318.4 323.0 323.1 326.4 4747.9 4868.0 4927.3 4947.3 5018.8 4886.6 4957.0 4963.2 4966.2 4988.1 3839.9 3888.1 3899.6 3911.1 3918.7 3645.5 3916.5 3921.3 3924.5 3938.1 3807.7 3828.3 3836.7 3847.3 3856.3 3826.8 3833.8 3838.3 3856.8 3871.8 3399.3 3408.9 3409.1 3409.1 3425.1 4610.8 4706.6 4710.3 4771.7 4780.9 4354.2 4361.7 4367.5 4378.1 4383.7 5116.8 5125.9 5145.3 5153.7 5166.4 3609.9 3685.4 3689.6 3692.5 3694.7 5368.4 5441.3 5453.8 5459.5 5482.4 3776.4 3786.6 3788.0 3791.4 3802.7 3834.2 3841.0 3841.4 3849.8 3852.6 4254.7 4262.9 4347.2 4350.3 4359.1 5166.3 5186.1 5188.0 5197.9 5206.3 1308.3 1336.1 1382.2 1385.8 1387.6 904.9 913.7 927.6 948.2 949.5 4787.9 4811.5 4818.0 4824.7 4827.5 5618.5 5663.8 5671.8 5671.9 5677.6 4718.7 4821.5 4825.4 4828.7 4843.3 2974.4 3003.3 3014.1 3017.3 3043.1 5292.9 5315.0 5318.4 5319.5 5333.8 5620.7 5736.0 5759.9 5799.1 5800.4 5302.3 5305.6 5332.7 5340.1 5341.4 5484.8 5622.4 5647.3 5654.7 5671.2 5505.4 5509.8 5514.7 5528.4 5533.9 5331.5 5358.7 5360.3 5373.9 5390.7 3563.3 3971.6 3975.5 3980.3 3994.1 5066.7 5243.5 5286.2 5327.3 5394.5 4998.0 5085.2 5158.0 5182.6 5198.5 5138.3 5173.2 5178.5 5187.3 5211.2 4946.8 5118.3 5118.9 5127.5 5130.5 5168.5 5208.4 5228.8 5231.2 5243.4 5066.6 5071.4 5076.9 5095.5 5102.2 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - PROCESS | 7655 | [#5] yui.html Cycles:180 Average:12365.04 Median:46546.80 stddev:14163.68 (30.4%) stddev-sans-first:14176.37 09:08:43 INFO - PROCESS | 7655 | Values: 711.0 732.6 741.8 773.5 785.9 11220.2 11958.8 12099.7 12228.2 12245.3 12023.3 12027.5 12078.2 12125.1 12126.8 633.5 767.7 774.9 793.4 794.1 781.0 787.9 790.0 794.2 796.7 833.8 834.0 834.8 834.8 837.9 822.8 828.5 832.3 833.2 836.1 607.3 609.1 614.5 615.0 615.1 12222.9 12314.2 12315.4 12366.4 12398.5 12168.3 12611.7 12643.2 12757.6 12960.1 9965.7 10175.5 10189.7 10450.1 10584.9 3345.3 3371.9 3430.9 3434.8 3459.2 42675.1 42943.1 43873.0 45269.3 45586.5 10207.8 10227.7 10274.4 10294.3 10512.6 17404.7 17961.1 17980.8 17981.0 18044.3 6694.3 6723.6 6754.1 6776.3 6884.3 3676.4 3724.8 3778.4 3781.9 3920.2 2711.2 2771.7 2785.8 2791.4 2793.8 492.2 492.4 504.4 510.9 511.1 505.4 568.5 584.3 585.4 587.3 6967.3 7335.6 7377.1 7506.1 7527.8 519.6 530.0 536.3 541.6 555.7 2951.7 3300.2 3392.2 3429.0 3469.1 49178.3 50005.7 50021.0 50528.5 50960.5 46526.1 46567.5 46656.3 46904.0 47579.5 40005.0 41832.0 42028.4 42150.4 42575.1 7078.4 7082.3 7147.7 7165.7 7326.0 29317.6 29828.3 29841.4 29857.0 30215.1 35610.8 37939.6 38166.0 38352.6 38986.0 9848.7 10174.9 10340.8 10368.1 10373.3 9832.4 10324.6 10341.4 10802.9 10972.4 9360.0 9388.0 9520.3 9591.9 9753.8 8999.3 10217.7 10393.9 10488.5 10714.4 9833.2 10086.9 10141.7 10207.0 10412.1 7722.4 7803.9 7808.6 7909.3 7911.5 8085.6 8231.7 8290.8 8382.6 8407.6 09:08:43 INFO - PROCESS | 7655 | -------- Summary: end -------- 09:08:43 INFO - PROCESS | 7655 | 09:08:43 INFO - TEST-INFO | 7655: exit 0 09:08:44 INFO - TEST-OK | dromaeo_css | took 1114820ms 09:08:44 INFO - TEST-START | kraken 09:08:44 INFO - operating with platform_type : linux_ 09:08:44 INFO - Initialising browser for kraken test... 09:08:44 INFO - TEST-INFO | started process 7887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps8pheW/profile http://localhost:41775/getInfo.html) 09:08:47 INFO - PROCESS | 7887 | 09:08:47 INFO - PROCESS | 7887 | (process:7952): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:08:48 INFO - PROCESS | 7887 | __metrics Screen width/height:1600/1200 09:08:48 INFO - PROCESS | 7887 | colorDepth:24 09:08:48 INFO - PROCESS | 7887 | Browser inner width/height: 1024/697 09:08:48 INFO - PROCESS | 7887 | __metrics 09:08:49 ERROR - PROCESS | 7887 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:08:50 INFO - TEST-INFO | 7887: exit 0 09:08:50 INFO - Browser initialized. 09:08:50 INFO - Running cycle 1/1 for kraken test... 09:08:50 INFO - TEST-INFO | started process 8003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps8pheW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:51 INFO - PROCESS | 8003 | 09:08:51 INFO - PROCESS | 8003 | (process:8062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:09:01 INFO - PROCESS | 8003 | RSS: Main: 166141952 09:09:01 INFO - PROCESS | 8003 | 09:09:04 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41775/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:05 INFO - PROCESS | 8003 | RSS: Main: 170315776 09:09:05 INFO - PROCESS | 8003 | 09:09:08 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41775/tests/kraken/driver.html?testName=audio-dft) 09:09:09 INFO - PROCESS | 8003 | RSS: Main: 174084096 09:09:09 INFO - PROCESS | 8003 | 09:09:11 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41775/tests/kraken/driver.html?testName=audio-fft) 09:09:12 INFO - PROCESS | 8003 | RSS: Main: 164507648 09:09:12 INFO - PROCESS | 8003 | 09:09:14 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41775/tests/kraken/driver.html?testName=audio-oscillator) 09:09:15 INFO - PROCESS | 8003 | RSS: Main: 164888576 09:09:15 INFO - PROCESS | 8003 | 09:09:17 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:18 INFO - PROCESS | 8003 | RSS: Main: 166481920 09:09:18 INFO - PROCESS | 8003 | 09:09:21 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41775/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:22 INFO - PROCESS | 8003 | RSS: Main: 166748160 09:09:22 INFO - PROCESS | 8003 | 09:09:25 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41775/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:26 INFO - PROCESS | 8003 | RSS: Main: 165982208 09:09:26 INFO - PROCESS | 8003 | 09:09:29 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41775/tests/kraken/driver.html?testName=json-parse-financial) 09:09:29 INFO - PROCESS | 8003 | RSS: Main: 166535168 09:09:29 INFO - PROCESS | 8003 | 09:09:31 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:32 INFO - PROCESS | 8003 | RSS: Main: 167100416 09:09:32 INFO - PROCESS | 8003 | 09:09:34 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:34 INFO - PROCESS | 8003 | RSS: Main: 167129088 09:09:34 INFO - PROCESS | 8003 | 09:09:36 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:37 INFO - PROCESS | 8003 | RSS: Main: 167440384 09:09:37 INFO - PROCESS | 8003 | 09:09:40 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:41 INFO - PROCESS | 8003 | RSS: Main: 167845888 09:09:41 INFO - PROCESS | 8003 | 09:09:44 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:45 INFO - PROCESS | 8003 | RSS: Main: 167931904 09:09:45 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | Cycle 1(1): loaded http://localhost:41775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41775/tests/kraken/driver.html?testName=ai-astar) 09:09:47 INFO - PROCESS | 8003 | RSS: Main: 169586688 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | __start_tp_report 09:09:47 INFO - PROCESS | 8003 | _x_x_mozilla_page_load 09:09:47 INFO - PROCESS | 8003 | _x_x_mozilla_page_load_details 09:09:47 INFO - PROCESS | 8003 | |i|pagename|runs| 09:09:47 INFO - PROCESS | 8003 | |0;ai-astar;113;109;115;113;116;125;114;114;116;113 09:09:47 INFO - PROCESS | 8003 | |1;audio-beat-detection;167;136;156;194;143;156;158;139;185;137 09:09:47 INFO - PROCESS | 8003 | |2;audio-dft;163;165;165;171;167;163;164;163;167;163 09:09:47 INFO - PROCESS | 8003 | |3;audio-fft;77;74;77;162;77;77;74;74;164;77 09:09:47 INFO - PROCESS | 8003 | |4;audio-oscillator;95;96;148;97;95;95;142;94;95;146 09:09:47 INFO - PROCESS | 8003 | |5;imaging-gaussian-blur;119;118;117;118;119;118;118;119;118;118 09:09:47 INFO - PROCESS | 8003 | |6;imaging-darkroom;146;148;147;148;148;148;148;148;148;146 09:09:47 INFO - PROCESS | 8003 | |7;imaging-desaturate;96;95;95;95;95;96;96;96;95;95 09:09:47 INFO - PROCESS | 8003 | |8;json-parse-financial;64;77;65;64;65;65;64;85;63;63 09:09:47 INFO - PROCESS | 8003 | |9;json-stringify-tinderbox;65;65;64;64;65;67;66;65;65;72 09:09:47 INFO - PROCESS | 8003 | |10;stanford-crypto-aes;80;79;88;82;83;81;81;81;88;81 09:09:47 INFO - PROCESS | 8003 | |11;stanford-crypto-ccm;139;137;147;139;140;143;143;135;248;138 09:09:47 INFO - PROCESS | 8003 | |12;stanford-crypto-pbkdf2;215;224;216;215;217;218;214;218;216;216 09:09:47 INFO - PROCESS | 8003 | |13;stanford-crypto-sha256-iterative;77;77;75;76;76;75;74;76;75;81 09:09:47 INFO - PROCESS | 8003 | __end_tp_report 09:09:47 INFO - PROCESS | 8003 | __start_cc_report 09:09:47 INFO - PROCESS | 8003 | _x_x_mozilla_cycle_collect,916 09:09:47 INFO - PROCESS | 8003 | __end_cc_report 09:09:47 INFO - PROCESS | 8003 | __startTimestamp1461773387294__endTimestamp 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | ------- Summary: start ------- 09:09:47 INFO - PROCESS | 8003 | Number of tests: 14 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.10 (3.6%) stddev-sans-first:4.30 09:09:47 INFO - PROCESS | 8003 | Values: 113.0 109.0 115.0 113.0 116.0 125.0 114.0 114.0 116.0 113.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:157.00 stddev:20.05 (12.8%) stddev-sans-first:20.94 09:09:47 INFO - PROCESS | 8003 | Values: 167.0 136.0 156.0 194.0 143.0 156.0 158.0 139.0 185.0 137.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.60 (1.6%) stddev-sans-first:2.65 09:09:47 INFO - PROCESS | 8003 | Values: 163.0 165.0 165.0 171.0 167.0 163.0 164.0 163.0 167.0 163.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#3] audio-fft Cycles:10 Average:93.30 Median:77.00 stddev:36.76 (47.7%) stddev-sans-first:38.52 09:09:47 INFO - PROCESS | 8003 | Values: 77.0 74.0 77.0 162.0 77.0 77.0 74.0 74.0 164.0 77.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.00 stddev:24.23 (25.5%) stddev-sans-first:25.06 09:09:47 INFO - PROCESS | 8003 | Values: 95.0 96.0 148.0 97.0 95.0 95.0 142.0 94.0 95.0 146.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 09:09:47 INFO - PROCESS | 8003 | Values: 119.0 118.0 117.0 118.0 119.0 118.0 118.0 119.0 118.0 118.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 09:09:47 INFO - PROCESS | 8003 | Values: 146.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 146.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:09:47 INFO - PROCESS | 8003 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:65.00 stddev:7.40 (11.4%) stddev-sans-first:7.74 09:09:47 INFO - PROCESS | 8003 | Values: 64.0 77.0 65.0 64.0 65.0 65.0 64.0 85.0 63.0 63.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:2.35 (3.6%) stddev-sans-first:2.47 09:09:47 INFO - PROCESS | 8003 | Values: 65.0 65.0 64.0 64.0 65.0 67.0 66.0 65.0 65.0 72.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.50 stddev:3.13 (3.8%) stddev-sans-first:3.20 09:09:47 INFO - PROCESS | 8003 | Values: 80.0 79.0 88.0 82.0 83.0 81.0 81.0 81.0 88.0 81.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:141.50 stddev:34.29 (24.2%) stddev-sans-first:36.10 09:09:47 INFO - PROCESS | 8003 | Values: 139.0 137.0 147.0 139.0 140.0 143.0 143.0 135.0 248.0 138.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.90 Median:216.50 stddev:2.81 (1.3%) stddev-sans-first:2.89 09:09:47 INFO - PROCESS | 8003 | Values: 215.0 224.0 216.0 215.0 217.0 218.0 214.0 218.0 216.0 216.0 09:09:47 INFO - PROCESS | 8003 | 09:09:47 INFO - PROCESS | 8003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.00 stddev:1.93 (2.5%) stddev-sans-first:2.03 09:09:47 INFO - PROCESS | 8003 | Values: 77.0 77.0 75.0 76.0 76.0 75.0 74.0 76.0 75.0 81.0 09:09:47 INFO - PROCESS | 8003 | -------- Summary: end -------- 09:09:47 INFO - PROCESS | 8003 | 09:09:48 INFO - TEST-INFO | 8003: exit 0 09:09:48 INFO - TEST-OK | kraken | took 64309ms 09:09:48 INFO - SUITE-END | took 1179s 09:09:48 INFO - Completed test suite (00:19:39) 09:09:48 INFO - javascript benchmark 09:09:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.855687937163, 2698.015224443078, 2714.199311203195, 2723.7820974322044, 2726.073135134054, 4744.715317080973, 4762.166620841347, 4768.356271903292, 4775.164346239411, 4840.080384726908, 4662.790174442158, 4777.355057067295, 4823.807047718095, 4827.6137908967285, 4835.782389792459, 4421.4915284742265, 4447.599716025557, 4499.6400287976885, 4500.032493014001, 4501.077279157765, 4439.112177564484, 4534.229181039214, 4540.772961351936, 4579.290210017436, 4594.977025114869, 4322.7190232634775, 4372.475302963665, 4432.800523976429, 4463.732176069414, 4512.0, 4403.36151258069, 4451.933221001687, 4452.443444569429, 4455.532169122228, 4496.2581174106235, 4411.580899814545, 4413.602775750198, 4428.601425871655, 4445.866624001285, 4477.731336119843, 4664.32367306742, 4703.741294228816, 4720.716756994591, 4747.596454301389, 4757.5480329369, 5107.463716309771, 5108.744562771846, 5119.590432765407, 5127.512886275797, 5156.845294641167, 5013.523715247045, 5175.792968281265, 5179.948200517984, 5181.611379146579, 5187.533122019036, 4784.5933095686905, 4800.255960326155, 4802.423709154854, 4806.255030470283, 4850.781714822806, 5184.248283998799, 5191.688498690015, 5197.324347834758, 5208.374995000549, 5220.1647736362, 4815.0, 4962.057209130254, 4971.477994810492, 5016.749162541858, 5084.567811736044, 5090.880006398586, 5138.409082955433, 5146.665466744649, 5147.5881929446305, 5155.458676838878, 4911.582515486224, 4985.302057711923, 5045.419776725724, 5062.038212739568, 5091.770870310771, 4956.182229932093, 5001.774920128603, 5021.623378246646, 5040.47075057121, 5130.896857175725, 4258.74447533149, 4259.936100958426, 4268.487781466244, 4300.290452075373, 4310.0, 3696.74122811406, 3761.5298087739034, 3786.3373909565717, 3802.9809850951124, 3809.0858194033785, 4346.565343465628, 4414.514403415622, 4472.262076757299, 4477.507474177838, 4481.148581769454, 5140.614453915971, 5157.0, 5173.922391164136, 5187.0922588546855, 5219.243209734567, 4444.511103778646, 4455.353973673799, 4473.865784026484, 4478.9552104478535, 4500.639948804088, 4420.734755914656, 4430.246858034142, 4462.419885414875, 4493.1013797240685, 4502.414686090853, 4922.827701030518, 4923.606111510999, 4935.555799977948, 4948.158813001726, 5000.549950504472, 5045.672031317952, 5188.325517682677, 5222.55608273301, 5232.9738351308, 5281.656692314988, 4889.46215916256, 4911.140550403737, 4922.803087876445, 4939.086269040239, 4959.876003099951, 5006.674566153189, 5053.772580233972, 5056.82301119459, 5060.190369541003, 5105.897882042413, 4953.18272485036, 5061.924071138862, 5116.4627714090975, 5124.0, 5142.1772516397195, 4864.562189402971, 4940.851774446773, 5032.295478633067, 5056.216286475602, 5102.336696229615, 4952.5542701157065, 4963.454020057863, 4971.154903666313, 4973.030259099441, 5025.824096156617, 4730.455997560324, 4856.0, 4912.6561140719805, 4919.704817710949, 4959.851204463872, 5028.723420211777, 5065.645404821627, 5076.619253555924, 5123.410807757155, 5128.487151284841, 4890.853274401774, 4891.461939186615, 4922.384701912261, 4950.900981980412, 4987.700737955589], "value": 4708.341063312958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.4095904095905, 598.838313655313, 607.6809674920669, 623.875224955009, 637.8582337615666, 32778.0, 33957.490637640454, 34125.82937085317, 34141.31717365651, 34160.145996350104, 34694.306113877705, 35262.8236858816, 35301.293974120505, 35315.0, 35348.469772953365, 7414.332710056094, 7605.619719014055, 7622.580758058304, 7625.694972201105, 7625.885611715801, 7604.581748003858, 7683.654235559413, 7705.73029943952, 7733.767986960372, 7745.690172393126, 7786.571738554378, 7794.337481314067, 7803.102643196048, 7833.177516360785, 7881.17247688993, 7674.0, 7724.497907636042, 7749.573773442458, 7793.961030194812, 7809.882851757228, 7695.499792513525, 7725.034370703662, 7799.7270095546955, 7812.257835505675, 7819.569923654197, 36609.45085823715, 36965.63034369649, 37141.62858371409, 37148.442773358154, 37169.81415092907, 2556.463142740027, 3005.6543497497632, 3028.757699384044, 3068.47835867903, 3073.339232065117, 25701.614475782877, 25735.485290294277, 25978.411926738074, 26031.479370412675, 26136.477270454674, 3499.403060491539, 3546.4680297955256, 3561.0919215600115, 3599.7120230381506, 3601.4777857210556, 185053.0, 186656.99999999863, 188196.0590197054, 188390.0, 188407.0, 49863.50136498589, 49871.0, 49987.25019124716, 50031.24953125706, 50053.0, 49752.25371619429, 50844.49155508397, 51024.74487627538, 51122.233166502534, 51187.0, 13560.457581696819, 13774.380152893144, 13778.379972901244, 13785.310734463237, 13802.17186968785, 10637.734056648645, 10655.30740501865, 10724.839127413095, 10735.248532602644, 10738.838917416246, 16745.16274186286, 16846.24191911367, 16953.83046169547, 17070.48788536346, 17493.38773142934, 6679.127974970809, 6707.3963343298365, 6714.832129196711, 6952.2352541220425, 6970.128733908262, 891.6834523744108, 907.5371560504191, 951.8048799995984, 953.9475328856979, 1018.1040684197859, 26835.0, 27005.594916076276, 27367.0, 27371.178864634094, 27456.45087098247, 977.6724797192878, 1017.6845177994845, 1033.8914413986574, 1035.6737627647267, 1113.6770336602294, 13936.303184840717, 14307.709226877876, 14656.332391596796, 14801.481948131765, 14898.255087245594, 274188.0, 280130.0, 281641.0, 282635.0, 282867.0, 45193.54806451959, 45357.77321113373, 45931.0, 45955.0, 46013.5398646016, 1242.6085782978332, 1248.4631608408472, 1251.0742050882463, 1259.9937000315124, 1273.4778740716263, 26100.608490873034, 26681.466370672864, 26920.192394228205, 26950.191494255203, 27214.72785272122, 40547.1890562193, 40784.59215407808, 41011.7949410251, 41105.0, 41122.1775564493, 236986.0, 237547.0, 237818.0, 237904.0, 239583.0, 24004.0, 24469.632955505327, 24492.14277500279, 35566.64433355633, 36451.81774091112, 39148.41277380899, 39866.2026759469, 39881.0, 40044.399334010595, 40628.0, 34240.65759342375, 34252.657473424944, 34376.48435273423, 34378.0, 34645.48031779475, 33008.1747956303, 33540.49689254712, 34200.65799341975, 34488.655113449546, 35085.0, 30972.380552388375, 31525.0, 31990.84004579962, 34166.31667366589, 34400.311993760486, 28521.42957140887, 29080.7091929078, 29085.709142909145, 29097.709022910345, 29467.705322946495, 23635.763642364043, 24530.632040519762, 24625.507489849744, 24735.134270300452, 24786.25641230766], "value": 16596.257133563955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.868096166342, 387.3144534174511, 388.3979831261545, 393.5316972802365, 396.57764480827933, 14806.259687015647, 16260.512184634465, 16269.105199214038, 16359.509214723577, 16363.672726545461, 15206.315715792789, 15518.84481155188, 16113.0, 16206.837931620681, 16335.26491307891, 5067.1385864402955, 5206.947930520684, 5210.218467229908, 5240.790368385279, 5256.8685782855355, 4965.751712414383, 5108.208227724708, 5174.896502069956, 5183.248428977796, 5219.895602087956, 5121.590272778169, 5136.845894623168, 5139.614528910328, 5170.121079416508, 5174.146265866147, 4929.482404347527, 5138.7944482220855, 5140.9228861566735, 5155.40712818027, 5158.767855446514, 4588.49526552079, 4598.655100867415, 4602.723836569783, 4622.676412651116, 4629.8148074077, 18384.17271222785, 18578.814211857978, 19283.0, 19309.806901931082, 19346.61306773871, 1954.1499447740277, 2057.989710051455, 2079.272254710854, 2342.7540108288727, 2361.7402085770723, 12378.81431778524, 12462.252264864137, 12476.75046499065, 12808.167469114478, 12998.870011299861, 1676.3629820668068, 1714.9571260718458, 1762.942234659207, 1764.5235786337746, 1766.8321509456582, 57210.0, 59896.40103598952, 60237.397626023616, 60343.99999999956, 60628.09057864136, 9139.954300228455, 9441.90558094424, 9469.195118414875, 9528.0, 9718.173955213744, 12981.545645902348, 13095.541656042184, 13100.672483187996, 13127.343632818322, 13204.537841175512, 7207.783766487014, 7337.605854887554, 7537.434692398092, 7591.582462964479, 7614.162442131361, 7196.10048743907, 7296.927030729625, 7317.597532135784, 7385.3722433592675, 7459.477836551389, 5744.827655170268, 5979.402059793986, 6013.4888534474185, 6075.1774467659525, 6130.0, 1790.9910450447926, 1811.3026484803445, 1842.6591080650123, 1851.1484717030316, 1883.2467013194832, 955.3980991975011, 975.9072888075764, 977.3158788847693, 990.8563258327503, 1042.2599954032721, 15901.52295431139, 16401.83598164027, 16560.834391655928, 16592.419265325654, 16753.748693769605, 876.373393023991, 901.9323550733722, 909.7316291693966, 924.3390975452584, 977.2670497127154, 9494.240460763122, 9630.711078667651, 9672.371295865747, 9732.41605503672, 9835.164011058998, 360836.0, 382527.0, 383078.0, 388025.0, 388761.0, 44990.775046125214, 49932.750336248086, 51899.22151167736, 57621.711891440274, 57970.42029579735, 987.629638885418, 989.6635144050913, 1014.2849291249652, 1029.341221618165, 1030.9329843611827, 13665.931670341584, 14766.778498322748, 14849.034812737138, 14861.479848205694, 15107.32017059257, 30797.23006924845, 31813.0, 32486.350272993936, 33014.17464563405, 33679.0, 42941.355879661205, 42983.140337193705, 43040.493582724455, 43156.78421607872, 43161.56838431575, 7540.736074237376, 7751.6124193788955, 7774.222577742181, 7775.0, 7908.248716371935, 9718.70843874685, 11296.265742726697, 11406.258593191747, 11417.942910285396, 11546.480408381474, 5967.880642387215, 6604.603723776589, 10041.698749037541, 10198.490075496344, 10346.172306215334, 9943.602255909682, 9980.900190998287, 10018.499075046073, 10081.69754907354, 10221.0, 10101.292909496266, 10250.692479225636, 10289.897101028893, 10358.223133264884, 10421.114205292635, 7718.53688778675, 7836.294733473786, 7844.843103137791, 8049.83900322002, 8095.9880014998125, 9133.0, 9908.25688073383, 9944.801103978025, 10030.247731420319, 10305.381677099398], "value": 8075.506237878201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.4950142699338, 1463.2025546077386, 1537.2697968464981, 1706.2577778666289, 1746.3974928649611, 6357.777477788279, 6890.793276201715, 6919.757808476705, 7130.893036604449, 7155.212926578072, 6959.373656370925, 6979.232284448706, 6999.545029573074, 7018.122734658168, 7074.398676112537, 2183.410479170623, 2228.053077442081, 2228.075348730275, 2230.710007698997, 2231.4867580456503, 2121.4166104321357, 2144.0994782191437, 2166.8483206175497, 2170.6092903277404, 2186.9453263668374, 2134.583756167548, 2166.566686662674, 2171.565686862626, 2189.9233526826565, 2191.276878630048, 2114.6299397605435, 2129.58473097746, 2130.637791575436, 2132.232396337333, 2137.5190582118976, 2120.427484579155, 2149.1725685610995, 2161.6001039807684, 2170.218721260345, 2184.5740080684272, 7058.153021637385, 7080.681369338392, 7159.176694680074, 7162.785116446515, 7175.748848790267, 4497.8425755098415, 4630.236011058171, 4647.256438969748, 4653.720776753372, 4655.557722016403, 2804.4110736745306, 2869.239651492356, 2906.0410064678604, 2916.0522830080095, 2917.0519581136004, 907.3648446087699, 925.208946350867, 976.9218462523053, 982.1357205659045, 982.7543114221445, 8988.640454381817, 9141.954290228572, 9164.358494905358, 9168.495732734631, 9177.311701622339, 4127.33962565994, 4180.519240287345, 4253.510846252659, 4262.829486820555, 4286.89282767927, 7749.922500775033, 7751.961240193763, 7753.418493613001, 7762.883556746653, 7768.7669369918995, 4574.153781550423, 4620.1221767864, 4632.096741135513, 4633.166030114612, 4643.048175124091, 3676.338259113332, 4112.506499220112, 4242.300020496646, 4285.121550082225, 4320.503142138631, 3307.751918606066, 3339.2987472630534, 3406.67636574525, 3433.9828300858335, 3460.3079384123275, 1087.075985412409, 1094.819354806448, 1100.3837850803416, 1101.8181999970075, 1105.8285965675334, 748.6593599912027, 769.7190525458279, 837.8701301298308, 848.4188330993289, 862.6721845698594, 4738.739369334719, 5013.373328333958, 5083.085044691917, 5139.922901156486, 5188.63679542436, 836.05943313772, 883.6023789294843, 927.4110939553298, 935.3265648733037, 936.7564433247405, 3529.576450825917, 3530.6645868642436, 3601.2617413430185, 3612.1330880588994, 3622.637736226356, 8109.43233973628, 8352.248297653241, 8355.373346999, 8371.330293576499, 8387.874181887277, 8243.95878020618, 8305.0, 8314.750557483285, 8394.076651568445, 8397.958010210032, 6684.16447944007, 6720.697568609425, 6759.087523184307, 6785.9321406786285, 6805.149356330359, 5011.072951503984, 5044.646874718735, 5078.21287700407, 5085.160948443466, 5093.006863661551, 7923.564203968606, 7940.483868548526, 7971.641276142472, 8084.514929104273, 8168.142345053684, 8062.677492900219, 8180.754577362689, 8193.549354785306, 8291.295239904675, 8362.45644033136, 5412.702301373305, 5801.013827649394, 6051.213342265477, 6081.452669259788, 6133.9079913802225, 6878.965605171942, 6906.240313565403, 6921.1002569667635, 6927.515073944977, 6949.3745562899585, 6194.287656919512, 6346.270178929482, 6392.4246817786625, 6477.4494167996245, 6480.481561474976, 6349.206349206349, 6392.712327945161, 6435.549511534147, 6456.9354306456335, 6542.607443553402, 6005.969970150121, 6056.273247210363, 6097.176881120992, 6105.0, 6107.786227482017, 4296.162248361665, 4522.706024108423, 4542.931856022228, 4544.727316361029, 4568.680192386501, 4126.116021578542, 4127.545969943244, 4172.687048471316, 4183.874483765492, 4205.369194620709], "value": 3940.475223582582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.55702509873214, 318.3680394417082, 322.9628592711836, 323.0711703851426, 326.4140867143477, 4747.928781068278, 4867.975660121703, 4927.2855435961765, 4947.282644016615, 5018.84943451697, 4886.584640305578, 4956.975215123919, 4963.205887058071, 4966.180580204271, 4988.102141614508, 3839.9040023999346, 3888.0754026756795, 3899.6490315871565, 3911.1395492991496, 3918.666913312358, 3645.54430696163, 3916.511725544289, 3921.29416704993, 3924.529056513208, 3938.054866831954, 3807.733458657895, 3828.25349056934, 3836.7122465815037, 3847.3267178243836, 3856.3058649443087, 3826.770393776382, 3833.821134962876, 3838.2899163654815, 3856.84572617095, 3871.7870517121546, 3399.2861499084975, 3408.9147771305666, 3409.130671678731, 3409.147713071732, 3425.092350527112, 4610.76946152691, 4706.647001474903, 4710.31700403443, 4771.71369717818, 4780.928286075712, 4354.238008348526, 4361.672874534391, 4367.45406824147, 4378.058717375748, 4383.671224658164, 5116.795328186868, 5125.897482050338, 5145.279660847485, 5153.66501177426, 5166.43169251382, 3609.927801443983, 3685.3734865073, 3689.6494832990825, 3692.483052372643, 3694.704423646102, 5368.355797304349, 5441.347038355383, 5453.754581043823, 5459.481349271852, 5482.369527504348, 3776.3957766757185, 3786.583475817658, 3788.049154685339, 3791.3554695701796, 3802.7338086334244, 3834.194819087967, 3840.9615903841163, 3841.4045822897497, 3849.8075096245075, 3852.614738526181, 4254.744715317091, 4262.914741705148, 4347.195768782785, 4350.32569951658, 4359.057636095623, 5166.3025491558155, 5186.084506197872, 5187.974060129751, 5197.922031169535, 5206.349206349207, 1308.339288659221, 1336.1248382309602, 1382.1637909065073, 1385.819843420349, 1387.6461502317047, 904.8506996345529, 913.6939125393068, 927.6114006433461, 948.1798244518442, 949.5489642419795, 4787.928181077286, 4811.508432385902, 4818.0, 4824.662273640812, 4827.468978412372, 5618.494335509824, 5663.773449061991, 5671.801486947937, 5671.914921276184, 5677.602567820296, 4718.693284936537, 4821.4696383397795, 4825.420949486014, 4828.734419606885, 4843.321934929113, 2974.3605124897817, 3003.294225856922, 3014.095771268611, 3017.3211027518632, 3043.0566524377514, 5292.867678307996, 5314.973425132927, 5318.441563635763, 5319.46805319465, 5333.813316533902, 5620.747066382022, 5735.971320143456, 5759.884802303931, 5799.1011393233275, 5800.390958949334, 5302.257683924254, 5305.628605997543, 5332.73336333174, 5340.118880384771, 5341.412444631165, 5484.753186106715, 5622.409646987171, 5647.322321321468, 5654.745536450787, 5671.17767923657, 5505.449455054462, 5509.834704958857, 5514.696691681996, 5528.391876893458, 5533.889322213614, 5331.493508116722, 5358.7320633967365, 5360.276362690986, 5373.919391209057, 5390.730463476889, 3563.3051554947574, 3971.62269584389, 3975.463312452782, 3980.3034468967235, 3994.121293315466, 5066.733316670832, 5243.475652434879, 5286.154215325683, 5327.254184414262, 5394.514493695587, 4997.9750101249265, 5085.237214417867, 5158.0, 5182.559482444034, 5198.506141916512, 5138.332016837787, 5173.22401639757, 5178.533931946143, 5187.342923239183, 5211.166213405989, 4946.777395017161, 5118.309028281284, 5118.877484734235, 5127.46161653036, 5130.48695130484, 5168.457311982188, 5208.4270730220405, 5228.790848366023, 5231.189165679326, 5243.370795504564, 5066.569341606005, 5071.416787069386, 5076.949230507647, 5095.464976177448, 5102.209157580581], "value": 3982.1759442102484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.0223442766196, 732.6336831584208, 741.8182545276406, 773.5242825662219, 785.9174786647402, 11220.158488113393, 11958.7608247835, 12099.697507562316, 12228.205166664171, 12245.32650704211, 12023.338716370617, 12027.458764355602, 12078.15452918296, 12125.090618203649, 12126.757464850698, 633.4710516718523, 767.7044337929881, 774.930256276935, 793.4287313134563, 794.1224946434194, 780.9687612495493, 787.9015123109612, 790.0243199648459, 794.2057942057942, 796.6972550430858, 833.7790485521342, 833.9708110216113, 834.7662654456732, 834.7829564313292, 837.8785076163953, 822.8107535266862, 828.4615000249826, 832.309183377798, 833.1626715151294, 836.0552575589605, 607.2652090969932, 609.0590038390653, 614.5206738743786, 615.0436071908181, 615.0651010464114, 12222.938885305517, 12314.199577027553, 12315.4458049388, 12366.381680915918, 12398.504059837596, 12168.26990380571, 12611.684707882285, 12643.17819341749, 12757.55348562796, 12960.092793504458, 9965.65120220796, 10175.542100605491, 10189.745256368577, 10450.111740502067, 10584.947075264652, 3345.2974875276223, 3371.9494207586904, 3430.9313813723834, 3434.8110853903027, 3459.221675123077, 42675.14649707019, 42943.14113717708, 43873.0, 45269.32096018562, 45586.544134558564, 10207.795844083077, 10227.7443063924, 10274.434906080238, 10294.279400442047, 10512.57949682004, 17404.738928916075, 17961.101944902963, 17980.820191798175, 17981.0, 18044.27822887096, 6694.330566943364, 6723.562968407038, 6754.054432379471, 6776.254611992776, 6884.277150899184, 3676.3933950898336, 3724.7951362675312, 3778.3576791945434, 3781.9243615128094, 3920.17676287977, 2711.1730922068564, 2771.708970558103, 2785.804993650425, 2791.4277573097465, 2793.8184018038764, 492.20508878161513, 492.42632333331267, 504.38716958895117, 510.93868735751204, 511.0596502435536, 505.375860811897, 568.5196009372074, 584.2754983820117, 585.4145854145854, 587.3451102021215, 6967.33810288032, 7335.596542190231, 7377.077865266841, 7506.13679426862, 7527.8118047048165, 519.5921201856524, 529.9735013249399, 536.2894165231085, 541.6019225868984, 555.6721534294785, 2951.6605590357385, 3300.207950091961, 3392.2028323343993, 3428.9828550857087, 3469.0633528947546, 49178.26232606514, 50005.74997124991, 50021.0, 50528.494715053115, 50960.49039509631, 46526.069478610916, 46567.53432465632, 46656.300155497695, 46904.0, 47579.5242047582, 40005.0, 41832.0, 42028.36957445641, 42150.367744483854, 42575.148497029884, 7078.362947334765, 7082.327178917994, 7147.749828755968, 7165.713371465083, 7326.0, 29317.560236596895, 29828.315451608592, 29841.403171936872, 29857.0, 30215.09354719362, 35610.82194589011, 37939.62060379471, 38166.0, 38352.6164738349, 38986.0, 9848.704538863845, 10174.898251017396, 10340.793184136426, 10368.118709909742, 10373.325733827278, 9832.410055396698, 10324.638637647646, 10341.37951722899, 10802.945985270024, 10972.396518191257, 9359.953200233955, 9388.0, 9520.333576649567, 9591.9040809591, 9753.804923901624, 8999.280057595246, 10217.74455638615, 10393.9480302598, 10488.528016239135, 10714.357138571711, 9833.16418104469, 10086.94956525242, 10141.695749127539, 10207.0, 10412.062914337746, 7722.446538058786, 7803.92196078032, 7808.609569521387, 7909.288164065261, 7911.478845609342, 8085.63614637331, 8231.670733170606, 8290.83418331618, 8382.622781974704, 8407.579621019047], "value": 5708.801664831605, "unit": "score"}], "name": "dromaeo_css", "value": 6195.144713017217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 113.0, 116.0, 125.0, 114.0, 114.0, 116.0, 113.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 136.0, 156.0, 194.0, 143.0, 156.0, 158.0, 139.0, 185.0, 137.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 171.0, 167.0, 163.0, 164.0, 163.0, 167.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 162.0, 77.0, 77.0, 74.0, 74.0, 164.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 148.0, 97.0, 95.0, 95.0, 142.0, 94.0, 95.0, 146.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 77.0, 65.0, 64.0, 65.0, 65.0, 64.0, 85.0, 63.0, 63.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 67.0, 66.0, 65.0, 65.0, 72.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 88.0, 82.0, 83.0, 81.0, 81.0, 81.0, 88.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 147.0, 139.0, 140.0, 143.0, 143.0, 135.0, 248.0, 138.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 224.0, 216.0, 215.0, 217.0, 218.0, 214.0, 218.0, 216.0, 216.0], "value": 216.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 76.0, 76.0, 75.0, 74.0, 76.0, 75.0, 81.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1661.4, "alertThreshold": 2.0}]} 09:09:48 INFO - Return code: 0 09:09:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:09:48 ERROR - # TBPL SUCCESS # 09:09:48 INFO - Running post-action listener: _resource_record_post_action 09:09:48 INFO - Running post-run listener: _resource_record_post_run 09:09:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 477630464; Read time: 0; Write time: 456188 09:09:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 139378688; Read time: 0; Write time: 154184 09:09:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287084544; Read time: 0; Write time: 173888 09:09:49 INFO - Running post-run listener: _upload_blobber_files 09:09:49 INFO - Blob upload gear active. 09:09:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:49 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 09:09:49 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'] 09:09:49 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 09:09:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:50 INFO - (blobuploader) - INFO - Done attempting. 09:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:51 INFO - (blobuploader) - INFO - Done attempting. 09:09:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:51 INFO - Return code: 0 09:09:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ce2532eb17558c691266a479c2f48a34236163fc73607e7584b0a9841c593bd61eebac6e46e4d0a46d124b15123dd5ee1481afbd26fb805fba16b1424a975a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceec9afdeebfc2afb0a437ad92219116e1e4d33759f025f4e6c89aea5189901aa6e67d8f20b1b5be3a658464e51d849cce6e7b57010e713bbcbdd2b63778ca21"} 09:09:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:51 INFO - Contents: 09:09:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9ce2532eb17558c691266a479c2f48a34236163fc73607e7584b0a9841c593bd61eebac6e46e4d0a46d124b15123dd5ee1481afbd26fb805fba16b1424a975a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceec9afdeebfc2afb0a437ad92219116e1e4d33759f025f4e6c89aea5189901aa6e67d8f20b1b5be3a658464e51d849cce6e7b57010e713bbcbdd2b63778ca21"} 09:09:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:51 INFO - Copying logs to upload dir... 09:09:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.358291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-27 09:09:50.730551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 09:09:50.733995) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 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/9ce2532eb17558c691266a479c2f48a34236163fc73607e7584b0a9841c593bd61eebac6e46e4d0a46d124b15123dd5ee1481afbd26fb805fba16b1424a975a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceec9afdeebfc2afb0a437ad92219116e1e4d33759f025f4e6c89aea5189901aa6e67d8f20b1b5be3a658464e51d849cce6e7b57010e713bbcbdd2b63778ca21"} build_url:https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/GwrNtHoFSyeLcbVhL8n86w/artifacts/public/build/firefox-49.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/9ce2532eb17558c691266a479c2f48a34236163fc73607e7584b0a9841c593bd61eebac6e46e4d0a46d124b15123dd5ee1481afbd26fb805fba16b1424a975a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceec9afdeebfc2afb0a437ad92219116e1e4d33759f025f4e6c89aea5189901aa6e67d8f20b1b5be3a658464e51d849cce6e7b57010e713bbcbdd2b63778ca21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 09:09:50.760389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:09:50.760707) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461757339.312383-754803511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004336 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:09:50.809508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 09:09:50.809908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 09:09:50.810173) ========= ========= Total master_lag: 0.16 =========