builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1465488317.06 results: success (0) buildid: 20160609082929 builduid: 81ccf73b36bd41218424baecddad7816 revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.063973) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.064438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.064743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.081563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.081871) ========= 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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 09:05:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-06-09 09:05:17 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.205313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.205618) ========= 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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.255179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.255539) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c88261bd7310a5837cccffc767df53737fd9ce --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 f1c88261bd7310a5837cccffc767df53737fd9ce --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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 09:05:17,578 truncating revision to first 12 chars 2016-06-09 09:05:17,578 Setting DEBUG logging. 2016-06-09 09:05:17,578 attempt 1/10 2016-06-09 09:05:17,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c88261bd73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 09:05:17,921 unpacking tar archive at: fx-team-f1c88261bd73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.936967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.937282) ========= script_repo_revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.937715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.937988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:17.946690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-09 09:05:17.947074) ========= /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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:18 INFO - MultiFileLogger online at 20160609 09:05:18 in /builds/slave/test 09:05:18 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 09:05:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:18 INFO - {'append_to_log': False, 09:05:18 INFO - 'base_work_dir': '/builds/slave/test', 09:05:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:05:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:18 INFO - 'branch': 'Fx-Team-Non-PGO', 09:05:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:18 INFO - 'config_files': ('talos/linux_config.py',), 09:05:18 INFO - 'default_actions': ('clobber', 09:05:18 INFO - 'read-buildbot-config', 09:05:18 INFO - 'download-and-extract', 09:05:18 INFO - 'populate-webroot', 09:05:18 INFO - 'create-virtualenv', 09:05:18 INFO - 'install', 09:05:18 INFO - 'run-tests'), 09:05:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:18 INFO - 'download_minidump_stackwalk': True, 09:05:18 INFO - 'download_symbols': 'ondemand', 09:05:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:18 INFO - 'installer_path': 'installer.exe', 09:05:18 INFO - 'log_level': 'info', 09:05:18 INFO - 'log_name': 'talos', 09:05:18 INFO - 'log_to_console': True, 09:05:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:18 INFO - 'opt_config_files': (), 09:05:18 INFO - 'pip_index': False, 09:05:18 INFO - 'sps_profile': False, 09:05:18 INFO - 'sps_profile_interval': 0, 09:05:18 INFO - 'suite': 'dromaeojs-e10s', 09:05:18 INFO - 'system_bits': '32', 09:05:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:18 INFO - 'title': 'talos-linux64-ix-007', 09:05:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:18 INFO - 'use_talos_json': True, 09:05:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:18 INFO - 'work_dir': 'build'} 09:05:18 INFO - ##### 09:05:18 INFO - ##### Running clobber step. 09:05:18 INFO - ##### 09:05:18 INFO - Running pre-action listener: _resource_record_pre_action 09:05:18 INFO - Running main action method: clobber 09:05:18 INFO - rmtree: /builds/slave/test/build 09:05:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - ##### 09:05:19 INFO - ##### Finished clobber step (success) 09:05:19 INFO - ##### 09:05:19 INFO - ##### 09:05:19 INFO - ##### Running read-buildbot-config step. 09:05:19 INFO - ##### 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: read_buildbot_config 09:05:19 INFO - Using buildbot properties: 09:05:19 INFO - { 09:05:19 INFO - "project": "", 09:05:19 INFO - "product": "firefox", 09:05:19 INFO - "script_repo_revision": "production", 09:05:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:05:19 INFO - "repository": "", 09:05:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:05:19 INFO - "buildid": "20160609082929", 09:05:19 INFO - "pgo_build": "False", 09:05:19 INFO - "basedir": "/builds/slave/test", 09:05:19 INFO - "buildnumber": 1577, 09:05:19 INFO - "slavename": "talos-linux64-ix-007", 09:05:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:05:19 INFO - "platform": "ubuntu64_hw", 09:05:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:05:19 INFO - "branch": "fx-team", 09:05:19 INFO - "repo_path": "integration/fx-team", 09:05:19 INFO - "revision": "f1c88261bd7310a5837cccffc767df53737fd9ce", 09:05:19 INFO - "stage_platform": "linux64", 09:05:19 INFO - "builduid": "81ccf73b36bd41218424baecddad7816", 09:05:19 INFO - "slavebuilddir": "test" 09:05:19 INFO - } 09:05:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - ##### 09:05:19 INFO - ##### Finished read-buildbot-config step (success) 09:05:19 INFO - ##### 09:05:19 INFO - ##### 09:05:19 INFO - ##### Running download-and-extract step. 09:05:19 INFO - ##### 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: download_and_extract 09:05:19 INFO - mkdir: /builds/slave/test/build/tests 09:05: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')]} 09:05:19 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:05:23 INFO - Downloaded 1361 bytes. 09:05:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:23 INFO - Using the following test package requirements: 09:05:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:05:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:05:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'jsshell-linux-x86_64.zip'], 09:05:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:05:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:05:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:05:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:05:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:05:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:23 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:05:29 INFO - Downloaded 22879604 bytes. 09:05:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:05:30 INFO - Return code: 0 09:05:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:05: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')]} 09:05:30 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:05:31 INFO - Downloaded 22879604 bytes. 09:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:05:32 INFO - Return code: 0 09:05: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')]} 09:05:32 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:05:34 INFO - Downloaded 10833377 bytes. 09:05:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:05:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:05:34 INFO - Return code: 0 09:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:34 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:05:36 INFO - Downloaded 55366398 bytes. 09:05:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:36 INFO - mkdir: /builds/slave/test/properties 09:05:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:36 INFO - Contents: 09:05:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:37 INFO - Running post-action listener: _resource_record_post_action 09:05:37 INFO - Running post-action listener: set_extra_try_arguments 09:05:37 INFO - ##### 09:05:37 INFO - ##### Finished download-and-extract step (success) 09:05:37 INFO - ##### 09:05:37 INFO - ##### 09:05:37 INFO - ##### Running populate-webroot step. 09:05:37 INFO - ##### 09:05:37 INFO - Running pre-action listener: _resource_record_pre_action 09:05:37 INFO - Running main action method: populate_webroot 09:05:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:37 INFO - '--tppagecycles', 09:05:37 INFO - '7'], 09:05:37 INFO - 'tests': ['tsvgm']}}, 09:05:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['damp', 'tps']}, 09:05:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'tests': ['damp', 'tps']}, 09:05:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['dromaeo_dom']}, 09:05:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['a11yr', 09:05:37 INFO - 'ts_paint', 09:05:37 INFO - 'tpaint', 09:05:37 INFO - 'sessionrestore', 09:05:37 INFO - 'sessionrestore_no_auto_restore', 09:05:37 INFO - 'tabpaint']}, 09:05:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['tsvgx', 09:05:37 INFO - 'tsvgr_opacity', 09:05:37 INFO - 'tart', 09:05:37 INFO - 'tscrollx', 09:05:37 INFO - 'cart']}, 09:05:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:37 INFO - 'tsvgr_opacity', 09:05:37 INFO - 'tart', 09:05:37 INFO - 'tscrollx', 09:05:37 INFO - 'cart']}, 09:05:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'talos_options': ['--disable-e10s'], 09:05:37 INFO - 'tests': ['tp5o']}, 09:05:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'tests': ['tp5o']}, 09:05:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'talos_options': ['--disable-e10s', 09:05:37 INFO - '--xperf_path', 09:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:37 INFO - 'tests': ['tp5n']}, 09:05:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:37 INFO - 'talos_options': ['--xperf_path', 09:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:37 INFO - 'tests': ['tp5n']}}, 09:05:37 INFO - 'talos.zip': {'path': '', 09:05:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:37 INFO - Running post-action listener: _resource_record_post_action 09:05:37 INFO - ##### 09:05:37 INFO - ##### Finished populate-webroot step (success) 09:05:37 INFO - ##### 09:05:37 INFO - ##### 09:05:37 INFO - ##### Running create-virtualenv step. 09:05:37 INFO - ##### 09:05:37 INFO - Running pre-action listener: _resource_record_pre_action 09:05:37 INFO - Running main action method: create_virtualenv 09:05:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:37 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 09:05:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:37 INFO - Using real prefix '/usr' 09:05:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:39 INFO - Installing pip.................done. 09:05:39 INFO - Return code: 0 09:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:39 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')]} 09:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 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')]} 09:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:39 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 09:05:39 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 09:05:39 INFO - Using env: {'DISPLAY': ':0', 09:05:39 INFO - 'HOME': '/home/cltbld', 09:05:39 INFO - 'LANG': 'en_US.UTF-8', 09:05:39 INFO - 'LANGUAGE': 'en_US:en', 09:05:39 INFO - 'LOGNAME': 'cltbld', 09:05:39 INFO - 'MAIL': '/var/mail/cltbld', 09:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:39 INFO - 'MOZ_NO_REMOTE': '1', 09:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:39 INFO - 'NO_EM_RESTART': '1', 09:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:39 INFO - 'PWD': '/builds/slave/test', 09:05:39 INFO - 'SHELL': '/bin/bash', 09:05:39 INFO - 'SHLVL': '1', 09:05:39 INFO - 'TERM': 'linux', 09:05:39 INFO - 'TMOUT': '86400', 09:05:39 INFO - 'USER': 'cltbld', 09:05:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:39 INFO - '_': '/tools/buildbot/bin/python'} 09:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:39 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 09:05:39 INFO - Cleaning up... 09:05:39 INFO - Return code: 0 09:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:39 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')]} 09:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 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')]} 09:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:39 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>=3.1.1'] in /builds/slave/test/build 09:05:39 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>=3.1.1 09:05:39 INFO - Using env: {'DISPLAY': ':0', 09:05:39 INFO - 'HOME': '/home/cltbld', 09:05:39 INFO - 'LANG': 'en_US.UTF-8', 09:05:39 INFO - 'LANGUAGE': 'en_US:en', 09:05:39 INFO - 'LOGNAME': 'cltbld', 09:05:39 INFO - 'MAIL': '/var/mail/cltbld', 09:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:39 INFO - 'MOZ_NO_REMOTE': '1', 09:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:39 INFO - 'NO_EM_RESTART': '1', 09:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:39 INFO - 'PWD': '/builds/slave/test', 09:05:39 INFO - 'SHELL': '/bin/bash', 09:05:39 INFO - 'SHLVL': '1', 09:05:39 INFO - 'TERM': 'linux', 09:05:39 INFO - 'TMOUT': '86400', 09:05:39 INFO - 'USER': 'cltbld', 09:05:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:39 INFO - '_': '/tools/buildbot/bin/python'} 09:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:40 INFO - Downloading/unpacking psutil>=3.1.1 09:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:42 INFO - Installing collected packages: psutil 09:05:42 INFO - Running setup.py install for psutil 09:05:42 INFO - building 'psutil._psutil_linux' extension 09:05:42 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 09:05:42 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 09:05:42 INFO - building 'psutil._psutil_posix' extension 09:05:42 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 09:05:42 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 09:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:42 INFO - Successfully installed psutil 09:05:42 INFO - Cleaning up... 09:05:42 INFO - Return code: 0 09:05:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:42 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:42 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.3'] in /builds/slave/test/build 09:05:42 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.3 09:05:42 INFO - Using env: {'DISPLAY': ':0', 09:05:42 INFO - 'HOME': '/home/cltbld', 09:05:42 INFO - 'LANG': 'en_US.UTF-8', 09:05:42 INFO - 'LANGUAGE': 'en_US:en', 09:05:42 INFO - 'LOGNAME': 'cltbld', 09:05:42 INFO - 'MAIL': '/var/mail/cltbld', 09:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:42 INFO - 'MOZ_NO_REMOTE': '1', 09:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:42 INFO - 'NO_EM_RESTART': '1', 09:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:42 INFO - 'PWD': '/builds/slave/test', 09:05:42 INFO - 'SHELL': '/bin/bash', 09:05:42 INFO - 'SHLVL': '1', 09:05:42 INFO - 'TERM': 'linux', 09:05:42 INFO - 'TMOUT': '86400', 09:05:42 INFO - 'USER': 'cltbld', 09:05:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:42 INFO - '_': '/tools/buildbot/bin/python'} 09:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:45 INFO - Installing collected packages: mozsystemmonitor 09:05:45 INFO - Running setup.py install for mozsystemmonitor 09:05:45 INFO - Successfully installed mozsystemmonitor 09:05:45 INFO - Cleaning up... 09:05:45 INFO - Return code: 0 09:05:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:45 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:45 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==2.5.1'] in /builds/slave/test/build 09:05:45 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==2.5.1 09:05:45 INFO - Using env: {'DISPLAY': ':0', 09:05:45 INFO - 'HOME': '/home/cltbld', 09:05:45 INFO - 'LANG': 'en_US.UTF-8', 09:05:45 INFO - 'LANGUAGE': 'en_US:en', 09:05:45 INFO - 'LOGNAME': 'cltbld', 09:05:45 INFO - 'MAIL': '/var/mail/cltbld', 09:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:45 INFO - 'MOZ_NO_REMOTE': '1', 09:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:45 INFO - 'NO_EM_RESTART': '1', 09:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:45 INFO - 'PWD': '/builds/slave/test', 09:05:45 INFO - 'SHELL': '/bin/bash', 09:05:45 INFO - 'SHLVL': '1', 09:05:45 INFO - 'TERM': 'linux', 09:05:45 INFO - 'TMOUT': '86400', 09:05:45 INFO - 'USER': 'cltbld', 09:05:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:45 INFO - '_': '/tools/buildbot/bin/python'} 09:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:47 INFO - warning: no files found matching '*.txt' 09:05:47 INFO - no previously-included directories found matching 'build' 09:05:47 INFO - no previously-included directories found matching 'dist' 09:05:47 INFO - no previously-included directories found matching '.git*' 09:05:47 INFO - Installing collected packages: jsonschema, functools32 09:05:47 INFO - Running setup.py install for functools32 09:05:47 INFO - warning: no files found matching '*.txt' 09:05:47 INFO - no previously-included directories found matching 'build' 09:05:47 INFO - no previously-included directories found matching 'dist' 09:05:47 INFO - no previously-included directories found matching '.git*' 09:05:47 INFO - Successfully installed jsonschema functools32 09:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:47 INFO - Using env: {'DISPLAY': ':0', 09:05:47 INFO - 'HOME': '/home/cltbld', 09:05:47 INFO - 'LANG': 'en_US.UTF-8', 09:05:47 INFO - 'LANGUAGE': 'en_US:en', 09:05:47 INFO - 'LOGNAME': 'cltbld', 09:05:47 INFO - 'MAIL': '/var/mail/cltbld', 09:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:47 INFO - 'MOZ_NO_REMOTE': '1', 09:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:47 INFO - 'NO_EM_RESTART': '1', 09:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:47 INFO - 'PWD': '/builds/slave/test', 09:05:47 INFO - 'SHELL': '/bin/bash', 09:05:47 INFO - 'SHLVL': '1', 09:05:47 INFO - 'TERM': 'linux', 09:05:47 INFO - 'TMOUT': '86400', 09:05:47 INFO - 'USER': 'cltbld', 09:05:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:47 INFO - '_': '/tools/buildbot/bin/python'} 09:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:50 INFO - Downloading docopt-0.6.1.tar.gz 09:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:50 INFO - Running setup.py install for blobuploader 09:05:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:50 INFO - Running setup.py install for requests 09:05:51 INFO - Running setup.py install for docopt 09:05:51 INFO - Successfully installed blobuploader requests docopt 09:05:51 INFO - Cleaning up... 09:05:51 INFO - Return code: 0 09:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:51 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:51 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 09:05:51 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 09:05:51 INFO - Using env: {'DISPLAY': ':0', 09:05:51 INFO - 'HOME': '/home/cltbld', 09:05:51 INFO - 'LANG': 'en_US.UTF-8', 09:05:51 INFO - 'LANGUAGE': 'en_US:en', 09:05:51 INFO - 'LOGNAME': 'cltbld', 09:05:51 INFO - 'MAIL': '/var/mail/cltbld', 09:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:51 INFO - 'MOZ_NO_REMOTE': '1', 09:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:51 INFO - 'NO_EM_RESTART': '1', 09:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:51 INFO - 'PWD': '/builds/slave/test', 09:05:51 INFO - 'SHELL': '/bin/bash', 09:05:51 INFO - 'SHLVL': '1', 09:05:51 INFO - 'TERM': 'linux', 09:05:51 INFO - 'TMOUT': '86400', 09:05:51 INFO - 'USER': 'cltbld', 09:05:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:51 INFO - '_': '/tools/buildbot/bin/python'} 09:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:51 INFO - Running setup.py (path:/tmp/pip-lC_BHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:51 INFO - Running setup.py (path:/tmp/pip-0tsKRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:51 INFO - Running setup.py (path:/tmp/pip-7xkTp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:51 INFO - Running setup.py (path:/tmp/pip-rGEFHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:51 INFO - Running setup.py (path:/tmp/pip-bSKKG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:52 INFO - Running setup.py (path:/tmp/pip-gRXF6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:52 INFO - Running setup.py (path:/tmp/pip-9sG99c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:52 INFO - Running setup.py (path:/tmp/pip-aPed_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:52 INFO - Running setup.py (path:/tmp/pip-uRDVzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:52 INFO - Running setup.py (path:/tmp/pip-sEuTBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:52 INFO - Running setup.py (path:/tmp/pip-bnES4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:52 INFO - Running setup.py (path:/tmp/pip-8caNPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:52 INFO - Running setup.py (path:/tmp/pip-qPAF0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:52 INFO - Running setup.py (path:/tmp/pip-uJcU2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:52 INFO - Running setup.py (path:/tmp/pip-6QDsCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:52 INFO - Running setup.py (path:/tmp/pip-BgsnrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:52 INFO - Running setup.py (path:/tmp/pip-EaIt1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:52 INFO - Running setup.py install for manifestparser 09:05:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozcrash 09:05:53 INFO - Running setup.py install for mozdebug 09:05:53 INFO - Running setup.py install for mozdevice 09:05:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozfile 09:05:53 INFO - Running setup.py install for mozhttpd 09:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozinfo 09:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozInstall 09:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozleak 09:05:53 INFO - Running setup.py install for mozlog 09:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for moznetwork 09:05:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Running setup.py install for mozprocess 09:05:54 INFO - Running setup.py install for mozprofile 09:05:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Running setup.py install for mozrunner 09:05:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Running setup.py install for mozscreenshot 09:05:54 INFO - Running setup.py install for moztest 09:05:54 INFO - Running setup.py install for mozversion 09:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:54 INFO - Cleaning up... 09:05:54 INFO - Return code: 0 09:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:54 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')]} 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:54 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')]} 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:54 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:54 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 09:05:54 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 09:05:54 INFO - Using env: {'DISPLAY': ':0', 09:05:54 INFO - 'HOME': '/home/cltbld', 09:05:54 INFO - 'LANG': 'en_US.UTF-8', 09:05:54 INFO - 'LANGUAGE': 'en_US:en', 09:05:54 INFO - 'LOGNAME': 'cltbld', 09:05:54 INFO - 'MAIL': '/var/mail/cltbld', 09:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:54 INFO - 'MOZ_NO_REMOTE': '1', 09:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:54 INFO - 'NO_EM_RESTART': '1', 09:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:54 INFO - 'PWD': '/builds/slave/test', 09:05:54 INFO - 'SHELL': '/bin/bash', 09:05:54 INFO - 'SHLVL': '1', 09:05:54 INFO - 'TERM': 'linux', 09:05:54 INFO - 'TMOUT': '86400', 09:05:54 INFO - 'USER': 'cltbld', 09:05:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:54 INFO - '_': '/tools/buildbot/bin/python'} 09:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:54 INFO - Running setup.py (path:/tmp/pip-yBUh4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:54 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)) 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:55 INFO - Running setup.py (path:/tmp/pip-WxmVvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:55 INFO - Running setup.py (path:/tmp/pip-trQTfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:55 INFO - Running setup.py (path:/tmp/pip-wqHwol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:55 INFO - Running setup.py (path:/tmp/pip-bDLH08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:55 INFO - Running setup.py (path:/tmp/pip-Ps5fhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:55 INFO - Running setup.py (path:/tmp/pip-ovhUzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:55 INFO - Running setup.py (path:/tmp/pip-WCiaqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:55 INFO - Running setup.py (path:/tmp/pip-iuMvZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:55 INFO - Running setup.py (path:/tmp/pip-CiVJs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:55 INFO - Running setup.py (path:/tmp/pip-wpTHP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:55 INFO - Running setup.py (path:/tmp/pip-GdrJPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:55 INFO - Running setup.py (path:/tmp/pip-57ENds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:55 INFO - Running setup.py (path:/tmp/pip-FlXxlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:55 INFO - Running setup.py (path:/tmp/pip-BhPjQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:56 INFO - Running setup.py (path:/tmp/pip-vcLThs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:56 INFO - Running setup.py (path:/tmp/pip-6_bpMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:56 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)) 09:05:56 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)) 09:05:56 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)) 09:05:56 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)) 09:05:56 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)) 09:05:56 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)) 09:05:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:58 INFO - Downloading blessings-1.6.tar.gz 09:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:58 INFO - Installing collected packages: blessings 09:05:58 INFO - Running setup.py install for blessings 09:05:58 INFO - Successfully installed blessings 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:58 INFO - Reading from file tmpfile_stdout 09:05:58 INFO - Current package versions: 09:05:58 INFO - argparse == 1.2.1 09:05:58 INFO - blessings == 1.6 09:05:58 INFO - blobuploader == 1.2.4 09:05:58 INFO - docopt == 0.6.1 09:05:58 INFO - functools32 == 3.2.3-2 09:05:58 INFO - jsonschema == 2.5.1 09:05:58 INFO - manifestparser == 1.1 09:05:58 INFO - mozInstall == 1.12 09:05:58 INFO - mozcrash == 0.17 09:05:58 INFO - mozdebug == 0.1 09:05:58 INFO - mozdevice == 0.48 09:05:58 INFO - mozfile == 1.2 09:05:58 INFO - mozhttpd == 0.7 09:05:58 INFO - mozinfo == 0.9 09:05:58 INFO - mozleak == 0.1 09:05:58 INFO - mozlog == 3.2 09:05:58 INFO - moznetwork == 0.27 09:05:58 INFO - mozprocess == 0.22 09:05:58 INFO - mozprofile == 0.28 09:05:58 INFO - mozrunner == 6.11 09:05:58 INFO - mozscreenshot == 0.1 09:05:58 INFO - mozsystemmonitor == 0.3 09:05:58 INFO - moztest == 0.7 09:05:58 INFO - mozversion == 1.4 09:05:58 INFO - psutil == 3.1.1 09:05:58 INFO - requests == 1.2.3 09:05:58 INFO - wsgiref == 0.1.2 09:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:58 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')]} 09:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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')]} 09:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:58 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 09:05:58 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 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 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)) 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:58 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')]} 09:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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')]} 09:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:58 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 09:05:58 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 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:05:58 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')]} 09:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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')]} 09:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 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 0x7f9b3db49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, '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': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', '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 09:05:58 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 09:05:58 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 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:59 INFO - Downloading/unpacking flake8 09:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:06:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:06:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:01 INFO - no previously-included directories found matching 'docs/_build' 09:06:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:06:01 INFO - Running setup.py install for pep8 09:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:01 INFO - no previously-included directories found matching 'docs/_build' 09:06:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:06:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:06:02 INFO - Cleaning up... 09:06:02 INFO - Return code: 0 09:06:02 INFO - Running post-action listener: _resource_record_post_action 09:06:02 INFO - Running post-action listener: _start_resource_monitoring 09:06:02 INFO - Starting resource monitoring. 09:06:02 INFO - ##### 09:06:02 INFO - ##### Finished create-virtualenv step (success) 09:06:02 INFO - ##### 09:06:02 INFO - ##### 09:06:02 INFO - ##### Running install step. 09:06:02 INFO - ##### 09:06:02 INFO - Running pre-action listener: _resource_record_pre_action 09:06:02 INFO - Running main action method: install 09:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:02 INFO - Reading from file tmpfile_stdout 09:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:02 INFO - Reading from file tmpfile_stdout 09:06:02 INFO - Output received: 09:06:02 INFO - Usage: mozinstall [options] installer 09:06:02 INFO - Options: 09:06:02 INFO - -h, --help show this help message and exit 09:06:02 INFO - -d DEST, --destination=DEST 09:06:02 INFO - Directory to install application into. [default: 09:06:02 INFO - "/builds/slave/test"] 09:06:02 INFO - --app=APP Application being installed. [default: firefox] 09:06:02 INFO - mkdir: /builds/slave/test/build/application 09:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:06:18 INFO - Reading from file tmpfile_stdout 09:06:18 INFO - Output received: 09:06:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:18 INFO - Running post-action listener: _resource_record_post_action 09:06:18 INFO - ##### 09:06:18 INFO - ##### Finished install step (success) 09:06:18 INFO - ##### 09:06:18 INFO - ##### 09:06:18 INFO - ##### Running run-tests step. 09:06:18 INFO - ##### 09:06:18 INFO - Running pre-action listener: _resource_record_pre_action 09:06:18 INFO - Running main action method: run_tests 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:18 INFO - Python 2.7.3 09:06:18 INFO - Return code: 0 09:06:18 INFO - grabbing minidump binary from tooltool 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:18 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27492e0>, '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 0x26b5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:18 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 09:06:18 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 09:06:18 INFO - Calling ['/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'] with output_timeout 600 09:06:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:18 INFO - Return code: 0 09:06:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:06:19 INFO - Return code: 0 09:06:19 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 09:06:19 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 09:06:19 INFO - Using env: {'DISPLAY': ':0', 09:06:19 INFO - 'HOME': '/home/cltbld', 09:06:19 INFO - 'LANG': 'en_US.UTF-8', 09:06:19 INFO - 'LANGUAGE': 'en_US:en', 09:06:19 INFO - 'LOGNAME': 'cltbld', 09:06:19 INFO - 'MAIL': '/var/mail/cltbld', 09:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:19 INFO - 'MOZ_NO_REMOTE': '1', 09:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:19 INFO - 'NO_EM_RESTART': '1', 09:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:19 INFO - 'PWD': '/builds/slave/test', 09:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:19 INFO - 'SHELL': '/bin/bash', 09:06:19 INFO - 'SHLVL': '1', 09:06:19 INFO - 'TERM': 'linux', 09:06:19 INFO - 'TMOUT': '86400', 09:06:19 INFO - 'USER': 'cltbld', 09:06:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980', 09:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:19 INFO - '_': '/tools/buildbot/bin/python'} 09:06:19 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 09:06:19 INFO - mozversion application_buildid: 20160609082929 09:06:19 INFO - mozversion application_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 09:06:19 INFO - mozversion application_display_name: Nightly 09:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:19 INFO - mozversion application_name: Firefox 09:06:19 INFO - mozversion application_remotingname: firefox 09:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:06:19 INFO - mozversion application_vendor: Mozilla 09:06:19 INFO - mozversion application_version: 50.0a1 09:06:19 INFO - mozversion platform_buildid: 20160609082929 09:06:19 INFO - mozversion platform_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 09:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:06:19 INFO - mozversion platform_version: 50.0a1 09:06:19 INFO - using testdate: 1465488379 09:06:19 INFO - actual date: 1465488379 09:06:19 INFO - starting webserver on 'localhost:48266' 09:06:19 INFO - SUITE-START | Running 2 tests 09:06:19 INFO - TEST-START | dromaeo_css 09:06:19 INFO - operating with platform_type : linux_ 09:06:19 INFO - Initialising browser for dromaeo_css test... 09:06:19 INFO - TEST-INFO | started process 2488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfQVZsz/profile http://localhost:48266/getInfo.html) 09:06:24 INFO - PROCESS | 2488 | __metrics Screen width/height:1600/1200 09:06:24 INFO - PROCESS | 2488 | colorDepth:24 09:06:24 INFO - PROCESS | 2488 | Browser inner width/height: 1024/697 09:06:24 INFO - PROCESS | 2488 | __metrics 09:06:24 ERROR - PROCESS | 2488 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:06:25 INFO - TEST-INFO | 2488: exit 0 09:06:25 INFO - Browser initialized. 09:06:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:25 INFO - TEST-INFO | started process 2624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfQVZsz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:37 INFO - PROCESS | 2624 | RSS: Main: 185896960 09:06:37 INFO - PROCESS | 2624 | 09:07:27 INFO - PROCESS | 2624 | 1465488447350 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] 09:09:38 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48266/tests/dromaeo/cssquery-ext.html) 09:09:39 INFO - PROCESS | 2624 | RSS: Main: 188059648 09:09:39 INFO - PROCESS | 2624 | 09:12:41 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-ext.html (next: http://localhost:48266/tests/dromaeo/cssquery-jquery.html) 09:12:42 INFO - PROCESS | 2624 | RSS: Main: 187441152 09:12:42 INFO - PROCESS | 2624 | 09:15:44 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48266/tests/dromaeo/cssquery-mootools.html) 09:15:45 INFO - PROCESS | 2624 | RSS: Main: 189067264 09:15:45 INFO - PROCESS | 2624 | 09:18:46 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48266/tests/dromaeo/cssquery-prototype.html) 09:18:47 INFO - PROCESS | 2624 | RSS: Main: 187039744 09:18:47 INFO - PROCESS | 2624 | 09:21:50 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48266/tests/dromaeo/cssquery-yui.html) 09:21:50 INFO - PROCESS | 2624 | RSS: Main: 188985344 09:21:50 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-yui.html (next: http://localhost:48266/tests/dromaeo/cssquery-dojo.html) 09:24:53 INFO - PROCESS | 2624 | RSS: Main: 189665280 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | __start_tp_report 09:24:53 INFO - PROCESS | 2624 | _x_x_mozilla_page_load 09:24:53 INFO - PROCESS | 2624 | _x_x_mozilla_page_load_details 09:24:53 INFO - PROCESS | 2624 | |i|pagename|runs| 09:24:53 INFO - PROCESS | 2624 | |0;dojo.html;2564.5640241159;2644.8942042318304;2656.3890305229806;2658.8670566471674;2669.012465387807;4662.230731929232;4695.553922377378;4730.858074257773;4781.258904869742;4825.396825396825;4540.772961351928;4707.082118986799;4720.480747117823;4744;4783.258594917794;4299.505556860962;4364.585364390377;4410.470743510783;4415.2494076007;4418.80115394808;491.034166048672;4260.97869510652;4306.590873866978;4312.676549258803;4349.565043495657;4367.323064924942;4402.911941761179;4403.053343531156;4405.140997505488;4432.867013989553;4363.410939523187;4407.713498622579;4411.933820992687;4419.381286619876;4448.5551444855255;4344.565543445662;4423.159599676052;4447.866564003085;4448.5551444855255;4452.3989261449615;4840.104580652591;4843.612510999147;4865.148598995162;4875.8781030474165;4876.414830220361;4875.731834749087;5085.949140508585;5198;5202.791888324463;5255.0278198533015;5146.202338637517;5150.613703972217;5179.04187725272;5188.481151884819;5219.869503262411;4813.15769740294;4813.3983252093485;4813.638977076734;4815.807367705253;4861.416630004422;5221.530062294336;5253.185756207794;5262.02652509287;5262.210668399694;5278.841634750964;5051.949480505148;5055.797768089309;5058.924116138261;5069.7465126744255;5106.565941894906;5168.586513078944;5169.276301317818;5170.1469257572835;5170.327857378592;5172.922406163911;4880.536349046835;5022.497750225021;5045.899082018339;5062.012907483079;5087.949120508748;4971.229459433794;5028.296038554606;5031.4465408805;5043.36957880265;5104.668196567211;4122.113745544722;4221.430106935524;4223.556526564728;4237.6821738369745;4268.210381079511;3573.12458447682;3702.3520883845217;3728.8694895678523;3737.71967102463;3754.981225093857;4460.86617401472;4471.418715566955;4475.552444755498;4526.841560545365;4552.521985191574;5027.3464449621315;5138.254953031789;5144.819931302386;5149.9742501287255;5153.948460515422;4432;4448.955510444919;4486.035502366942;4487.259602165672;4488.528704486047;4545.613622842029;4554.954450455453;4555.681102322872;4573.679842411066;4592.2193227151465;4745.335653008513;4767.499412561631;4794.376731024944;4830.106430310404;4834.951650483591;5028.120078986236;5035.597152227886;5037.596992240685;5044.8234311798915;5064.164412871834;4807.471178170328;4815.566599006106;4836.008618233183;4844.709317440965;4860.3681521401995;4984.302197692398;4999.325091112799;5018.974905125597;5019;5025.070361983045;4850.296706977539;5024.397072351341;5055.974720126376;5085.160948443613;5139.254808052737;4939.407271127488;4939.506049395175;4944.431390390151;4964.255361695775;4988.825391111293;4941.925871112008;4954.900901982012;4956.835143741146;4968.726720030289;5008.649394542347;4703.952960470351;4885.804567817389;4910.21436570147;4915.729634870117;4926.926096108633;5025.095482813129;5053.267276244997;5065.265536497113;5067.037262920034;5107.208382700687;4655.697379670446;4950.727709975986;4956.330895329084;4959.652824302264;5000.7999680013845 09:24:53 INFO - PROCESS | 2624 | |1;ext.html;562.322401506185;563.1861959468567;588.7438964050637;591.7159763313609;597.3130899465611;35271.470927936105;39393.40909886351;39427.80286098573;39451.802740986255;39575.60424395763;40177.39733903994;40766.18467630645;40912;41019.38470922939;41089.56186533472;7709.267619576131;7795.532268063906;7849.45053846231;7850.371970242395;7870.842583148334;7680.807979800522;7721.343685786715;7813.101493328255;7834.177411371809;7868.095169055546;7898.091719452251;7915.089764677049;7922.920770792305;7932.563708996003;7939.5633240171765;7832.56920869352;7853.175416581234;7856.410769192334;7870.212978702112;7870.527768333918;7776.105747839014;7805.258500442449;7824.217578242187;7825.765227043198;7844.882326765103;37968.24063518714;38021.23957520834;38238.42642360367;38275.617243827764;38385.23229535422;2083.489470134156;2702.540568103427;2716.9456610867674;2790.734880186379;2833.6457942757156;26964.865175673996;29177.56233656497;29578;30005.549916751264;30365.392692146255;2961.9111426657237;2977.4640564698348;3020.909372718822;3021.3504096619113;3025.3344264261827;266142;266636;267568;267615;268361.6581917097;54934;55469;55607.443925561034;55909.720451398294;56017.719911401;33550.664493355245;34612.30775384478;58531.41468585259;58612.41387586155;58638;15710.450134245475;15713.292901819446;15717.371305147895;15720.29258683362;15830.683386332208;11815.995640370493;12020.519179232908;12028.218165819193;12051.276923384625;12076.154669173073;18375.356862509747;18471.076446177638;18553.35063272806;18570.628587428175;18646;6851.383375496229;7015.193252775996;7076.115485564304;7078.186008608973;7212.206657267697;774.728844904279;930.930180236485;958.7842735384482;964.5659453246068;1031.5615863258085;28041.859790700917;28497.287567810556;28737;28886.133415997552;28984.855075724907;935.4480856294683;950.7147855643279;965.9227261819037;1018.3228153278135;1057.5188289328337;15315.540533784004;15372.692546149237;15383.08060654416;15419.306131224123;15507.612309692347;384715;387443;388539;389132;390239;50588;50851;50890.74554627203;50914.236286455736;51404;1147.6098126636984;1157.6411312492985;1159.4956194055612;1170.126880027113;1198.0714945916984;26987.865060674572;27363.79062395777;27848.443031139668;28121.43757124805;28354.574681380207;43967;47684;49482.25776613426;49518.257226140915;53312;342788;346116;347320;350740;351634;39911.800440997606;40064;40264;40467.3929891046;40520.594794051685;43582.56417435912;43850.342244865715;44005;44670;44840.55159448364;36186.8190659045;37648.24703505969;37659;37920.62079379281;38035.42946855855;35632;35869.46195807117;35882;36417.453738194476;36446.63553364432;36659.81670091632;36755.63244367629;36914.63085369219;37403.25193496169;37412;31777.20556986094;32936;33042.834785825915;33675;33768.1557961053;25441.236762897144;25538.872305638353;25648.358791030372;25749.613755793303;25934.22197334083 09:24:53 INFO - PROCESS | 2624 | |2;jquery.html;337.7180054654364;345.14748571029554;350.82984752395083;360.4989065199372;368.5890232390883;15866;16126.435574754885;16988.49034528963;17007.65984680307;17029.148542572882;16035.919820400912;16695.66608667826;17017.064061476613;17048.147592620382;17150.113487516363;4741.478437371887;5108.2848401223855;5148.3564554430695;5171.715555644457;5179.352580927384;5036.7481625918745;5059.822906198284;5081.7459127043685;5094.974525127369;5098.643094983353;4787.928181077286;5017.49825017499;5031.6729412588065;5051.595872330223;5055.368078990126;4973.204287314031;4985.277134815431;4993.575546078588;5002.449730529639;5016.046951079302;4301.204277208726;4482.708623939434;4513.142502924434;4527.479339875924;4559.931601025987;19230.423087307405;19417.417477475698;19697.704534431996;19999.500012499804;20195.596088078157;1886.6321916610484;1906.6949288113835;2010.9698354524694;2029.2998915374171;2249.752527222004;12834.101612887102;13163;13210.141340812816;13290.401931912991;13436.731265374736;1494.6338147153908;1512.705022520609;1538.7768773527887;1865.6268746250805;2105.189502041725;83369.58315208445;83377;84784.99999999939;84821;88619.55690221571;15613.68772624541;15682.451114210948;16134.677306453805;16737.33050677959;16983.91508042452;29938.101856944326;30002.399952001273;30307.848460757996;30362.089137325915;30396.392072158433;8950.23922966555;9384.137837959352;9430;9670.274729395183;9735.902640973642;8033.277005069572;8091.514509129471;8126.471779334324;8223.753287401387;8226.917730822615;8031.357491400674;8302.584870756438;8306.70926517569;8322.019008066385;8408.873866892001;3236.0098539398573;3346.1300061983575;3444.8277586120594;3452.5684289463816;3486.3567571886933;367.5772861209577;369.2356821379718;384.45407521319794;808.5270116981632;918.4764684130115;10747;10846.891531084588;10977.615783447542;10983.945080274707;10997.450127493594;387.7324645994311;398.21750260737787;405.4728852491749;407.1064014488229;416.510600044946;9497.952510237543;10262.409326554396;10494.632687856041;10500.789984200273;10524.842127368096;410838;414239;416617;420799;421371;83850;85363.57318213493;86567.56716216379;87053.56473217593;87440;905.9570668143294;933.3513208320152;966.1546147121269;966.7389804752818;967.5210770668424;15673.529794106194;15727.05637661744;15778.36886524572;15864.76202856935;15905.125218113115;36344.81827590845;36645.816770915975;36819.63180368162;38099.61900380961;39285.41071883981;49733.75133124456;52497.47502524926;52577.21134183067;53296.2005569909;53879.73060134831;7671.808204794925;7858.764237072897;7914.2085791420395;7971.441999060242;7980.401469889665;8771.692990745294;11668.368510275259;11786.11604129711;11934.880651193724;12132.75734485323;10132.594696212363;10200.489975501047;10254.794904102026;10342.482875856327;10732.248742588255;10154.898451015692;10501.842472362769;10579.94710026445;10733.409662468326;10748.516316765608;10312.742181445525;10460.476976151314;10549.789004220027;10577.259591828499;10712.089472394622;7792.064952205772;7862.646180921986;7979.680812767424;7986.2013798622;8087.353011758927;7957.403194760532;9235.815283694154;10458.26792124544;10544.78910421772;10600.681979540626 09:24:53 INFO - PROCESS | 2624 | |3;mootools.html;1339.9062065655405;1386.5008596905113;1457.4097490516338;1601.4635097242424;1648.6290584618462;6593.241777195612;7293.562386256828;7445.218252083534;7775.300222979938;7789.376849852012;7512.286332798375;7739.303462688357;7742.612869356538;7776.416768742352;7797.53214807112;2160.114353115227;2191.7698641642637;2191.9780802191935;2194.308792730285;2198.351486311542;2139.379579921821;2172.6089303925287;2187.890605469728;2190.299104286629;2193.8025577698004;2082.2920207129573;2083.8853863037525;2086.926957556478;2093.528955984899;2206.6579680149603;2090.049027692404;2102.190656597206;2102.2536999365157;2111.6515774897125;2118.5127420693175;2067.286786058807;2072.958540829175;2094.413564202026;2096.8217701495237;2101.569178318441;7748.147703752583;7786.377089832799;7838.960805195938;7844.4901081429525;7910.129885712567;4524.819007239739;4599.954000459986;4623.42207224097;4636.652251081183;4644.117617652635;2730.167298973812;2800.8879644814183;2827.123591686584;2835.815671981335;2855.971440285612;841.494165249516;886.9201771840566;891.8617614269799;910.7267819654078;1551.9767203491956;9547.331686781929;9848.162906152986;9886.604535818558;9977;9982.351147175483;3773.1699026214187;3888.8055597220027;3919.412088186738;3919.4904662393706;3942.605739426092;7889.566073865993;7910.446268761131;7936.4047696423;7945.48354356965;7958.323542498837;4406.757628330409;4425.645948324126;4430.556944305544;4443.688941774045;4446.9777651111535;3445.7243420526297;3938.3501722215515;3962.980185099056;3963.5441924178513;4072.1244932339096;3372.274960883422;3379.3579219948133;3410.079278594815;3435.2957643682985;3437.5187473753695;974.2449601558849;994.5077186792439;997.5411310796969;1002.8646132772128;1006.0291818395284;662.9668516574152;677.1704661789269;727.4326025699962;784.9646765895549;834.6744769539885;4965.652404331734;5067.113255180328;5134.614903882224;5189.351331083614;5222.508275101146;398.08043419700005;405.561993047508;408.24270977337204;411.0873860030727;411.3356928560413;3521.7886926784477;3537.6285490023693;3566.625504322061;3586.1931065510053;3596.7662101963288;8830.690925817566;9018.503982280907;9056.320775941831;9142.177204051668;9144.497052662035;8973.775655608662;8996.190342869042;8997.145271199226;9016.098390161063;9129.589168487433;6884.862302754017;6959.860802783916;7129.750458734024;7130.964345178345;7140.464465165133;4856.077345304522;4864.075825593126;4868.853934381974;4902.8774280643265;4926.113299605962;8324.375671824759;8507.95746021266;8533.487990720576;8538.10349913275;8549.487030778173;8544.871826922477;8634.266087382643;8672;8707.172818582225;8708.04211536743;5732.582709339801;5861.1501332307425;5877.941220587911;5884.852878677896;5898.3216930053595;6897.689603967934;6913.308669133247;6966.616836073862;6970.79087627372;7009.1589009319205;6212.099245609452;6386.233651961795;6408.647524386203;6427.485801135805;6594.274629790623;6061;6076.756929722938;6097.451229389376;6111.5110791137495;6366.808995730135;5692.971535142297;5762.740676669476;5781.248437703071;5788.855278618068;5795.420457954171;4065.6950728694874;4108.979455102705;4189.0574620710095;4200.1179752252365;4247.936280955726;4231.724937879028;4240.766757828349;4487.08014856947;4550.635949124128;4583.954160458353 09:24:53 INFO - PROCESS | 2624 | |4;prototype.html;282.93351062500307;288.9266375415333;290.2699710228775;292.7219141815275;293.69015688448707;5056.241563765432;5070.797168113276;5074.391073071228;5089.9491005089985;5117.130087885059;5044.495550444954;5047.596192304616;5050.6969581825115;5056.519630635084;5070.163423035195;3686.225892562565;3766.924661506768;3886.8250928708135;3890.435886796413;3892.6691231245236;3880.72834901557;3906.121122747373;3912.902177445558;3913.8043097845134;3927.9018024549473;3879.7478163919395;3908.863189788358;3930.1943101664233;3935.685145188378;3942.4086387041884;3781.773093614392;3838.596947320547;3867.9226415471812;3875.767453952772;3882.864099756523;3350.564426624523;3397.3545026444895;3400.2179498715436;3403.6936675699308;3406.608240052401;4879.926801097987;4881.219004959225;4882.951170488285;4920.458749537548;4943.604511639061;4391.824327026915;4433.645308375322;4440.844570440051;4463.620592249663;4499.955000449986;5137.869668672886;5140.280360749498;5146.459621739738;5171.379434467888;5185.55922746567;3640.3083414151492;3688.5942546320152;3711.2391959648476;3718.1076541629814;3722.181120153562;5513.558915286768;5517.97917385285;5520.861978450531;5525.972370138124;5545.889082218373;3665.596784353719;3765.134019175605;3799.677027452642;3800.809959502014;3807.9428808567895;3837.1750073733724;3838.405047217686;3841.961580384216;3866.0721426857913;3869.3228684980018;4368.672349573794;4388.5830846069575;4444.488883778342;4450.265706158512;4467.441569803775;5116.9744151279;5154.407243167084;5192.870178245574;5228;5329.507737833413;1330.7138965122545;1340.3432318164225;1352.939117739704;1353.15427857589;1364.6179069860455;812.6586833529932;838.8382090804158;847.9062010007021;874.8993865705398;877.8551538996122;4560.8141883109965;4715.834945776881;4732.716037037789;4747.7626118693925;4751.524847515221;5488.1493368527945;5525.171224316305;5527.972360138254;5542.75057622408;5542.806001789999;4474.217012022883;4719.480857105716;4725.416985309959;4759.262314341283;4774.212254977959;2872.4255148970287;2902.956455653167;2936.9559456608167;2938.7363433723704;2942.823430594171;5104.744762761847;5105.157648987875;5149.682642810675;5203.713795741271;5237.240600112962;5367.275417818622;5474.260974768435;5545.473180047889;5562.610617256834;5566.582506312043;5100.5718398848385;5133.435322114565;5166.870828229249;5176.98097741881;5184.222366645109;5485.670859748428;5488.615796894339;5504.366997795145;5520.309961254843;5526.392096869261;5041.630433696157;5283.286756287852;5352.357717073976;5382.815780528277;5384.9730751346;5218.634695571425;5230.241614965885;5233.555147812479;5250.976059668328;5254.6847189168775;3689.870854520079;3712.8886133414962;3734.0104872208344;3739.439084137401;3748.194138260287;5216.139337009503;5505.532029777513;5519.254900588369;5529.695866727207;5568.805091821767;5332.9733351333;5358.919616205682;5369.899170669925;5392.406835248041;5395.730213489388;5177.948220517746;5285.814996475105;5321.255024296524;5349.438308977657;5390.568754499553;5256.39551451588;5259.763955470538;5285.68285902847;5287.709175995357;5292.179712144623;5132.9743351283005;5208.713520756395;5387.033732687619;5395.163749618815;5405.6756094755465;5288;5289.836236028068;5299.443558426464;5307.681539107666;5326.307580014573 09:24:53 INFO - PROCESS | 2624 | |5;yui.html;563.475967350364;588.3234280577338;600.8648054187809;614.4408588184752;625.199744327261;10967.780644387107;11366.090712742982;11561.07511399088;11598;11845.170838041318;14102.78845817311;14375.209363485004;14854.108753474799;14884.702305953875;14909.40362385506;615.2278889993053;759.9012128423298;766.4826242286463;773.5436092705303;778.1090651204368;780.1223623423648;785.8467598818232;787.7518581646791;790.7509134622604;792.3621484704811;822.5599304372162;823.1562648285525;825.8141918068417;826.6362800367849;827.1645637905698;811.9147489513634;813.32494029955;814.8411059843303;817.8364327134567;820.827626198499;599.7151353107283;601.1163589523394;603.0562170203617;604.0064094564417;604.3895665377956;11796.705082372924;11926.344051077187;11964.70088247792;11970.162088653798;12030.4586293617;12613.810792838114;12871.648476909882;13054.804177937338;13121.934390328082;13130;10130.64542741008;10284.228682848741;10309.123724483354;10484.161267098614;10605.310654807412;3295.489199174108;3338.165458635341;3358.84885180165;3372.4266874631126;3465.8267086645565;63477.36522634761;63624.363756362305;63718.36281637217;63876.68061659662;64646.67676661586;10094.949525252327;10147.69556913279;10189.286749927434;10196.3372380795;10243.07812296897;17670.293188272582;17879.37422190217;17914.91042544805;17958.640827183382;18090.27638894456;6144.600600961013;6149.877002459926;6277.686115694197;6361.586496877688;6368.77709280173;3396.133985833646;3484.337975784593;3638;3647.1429214134655;3649.0512466758832;2562;2655.4025344297766;2690;2761.351082495612;2777.5000499909806;451.5236425571054;453.29286313351275;454.1099445087599;455.70606958511576;464.2015732939339;460.80646128626057;467.4250671673792;488.9193283108247;512.034814374906;525.3249574297087;6721;6794.694238759268;6884.759033433806;6903.516753827284;6918.37734603878;454.9294859296748;504.6870940017213;512.9358830146232;520.1443625236465;537.9515843574019;3303.223742420529;3355.748318876094;3386.153461634591;3447.67247111524;3471.7743346682387;87689.56155219184;90093.54953225191;91683.54158229165;96960;98579;50161.24758128631;61246.693766531775;68983.31016689769;75608.62195689096;81643;45964.77017614958;51189.232161517604;75294.62352688311;75988.62005689937;76357.23642763612;7305.780826575211;7436.73971410998;7447.99452073963;7451.739189128354;7532.924670753222;42224.78887605665;43055.569444305154;43329.350059748496;43805.56194438015;44421.77789111034;59014;59870.70064649649;60288.69855650693;61225.693871530355;62117;9795.314327996972;9889.703308900744;9923.206143508358;10039.949800250952;10130.29087963865;10696.197785165989;11012.889871101186;11157.832632510357;11236.550537978716;11325.433728313716;9600.375975561845;9604.903950960681;9628.47043412619;9883.752906177404;10119.848202277119;9639.18066964316;9658;10086;10307.278490505592;10341.84487232677;9469.337146399961;9699.321047526606;9729.659461918798;9779.706608801464;9929.602815887572;7899.447038707235;8746.125387461203;9076.591553379982;9078.863817042618;9173.587188576397;8380.24577788002;8417.452865563719;8500.659973600987;8660.350473714623;8747.16901894319 09:24:53 INFO - PROCESS | 2624 | __end_tp_report 09:24:53 INFO - PROCESS | 2624 | __start_cc_report 09:24:53 INFO - PROCESS | 2624 | _x_x_mozilla_cycle_collect,380 09:24:53 INFO - PROCESS | 2624 | __end_cc_report 09:24:53 INFO - PROCESS | 2624 | __startTimestamp1465489493594__endTimestamp 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | ------- Summary: start ------- 09:24:53 INFO - PROCESS | 2624 | Number of tests: 6 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#0] dojo.html Cycles:165 Average:4691.15 Median:4860.37 stddev:602.36 (12.4%) stddev-sans-first:580.64 09:24:53 INFO - PROCESS | 2624 | Values: 2564.6 2644.9 2656.4 2658.9 2669.0 4662.2 4695.6 4730.9 4781.3 4825.4 4540.8 4707.1 4720.5 4744.0 4783.3 4299.5 4364.6 4410.5 4415.2 4418.8 491.0 4261.0 4306.6 4312.7 4349.6 4367.3 4402.9 4403.1 4405.1 4432.9 4363.4 4407.7 4411.9 4419.4 4448.6 4344.6 4423.2 4447.9 4448.6 4452.4 4840.1 4843.6 4865.1 4875.9 4876.4 4875.7 5085.9 5198.0 5202.8 5255.0 5146.2 5150.6 5179.0 5188.5 5219.9 4813.2 4813.4 4813.6 4815.8 4861.4 5221.5 5253.2 5262.0 5262.2 5278.8 5051.9 5055.8 5058.9 5069.7 5106.6 5168.6 5169.3 5170.1 5170.3 5172.9 4880.5 5022.5 5045.9 5062.0 5087.9 4971.2 5028.3 5031.4 5043.4 5104.7 4122.1 4221.4 4223.6 4237.7 4268.2 3573.1 3702.4 3728.9 3737.7 3755.0 4460.9 4471.4 4475.6 4526.8 4552.5 5027.3 5138.3 5144.8 5150.0 5153.9 4432.0 4449.0 4486.0 4487.3 4488.5 4545.6 4555.0 4555.7 4573.7 4592.2 4745.3 4767.5 4794.4 4830.1 4835.0 5028.1 5035.6 5037.6 5044.8 5064.2 4807.5 4815.6 4836.0 4844.7 4860.4 4984.3 4999.3 5019.0 5019.0 5025.1 4850.3 5024.4 5056.0 5085.2 5139.3 4939.4 4939.5 4944.4 4964.3 4988.8 4941.9 4954.9 4956.8 4968.7 5008.6 4704.0 4885.8 4910.2 4915.7 4926.9 5025.1 5053.3 5065.3 5067.0 5107.2 4655.7 4950.7 4956.3 4959.7 5000.8 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#1] ext.html Cycles:180 Average:49476.96 Median:37994.74 stddev:88939.97 (234.1%) stddev-sans-first:89113.64 09:24:53 INFO - PROCESS | 2624 | Values: 562.3 563.2 588.7 591.7 597.3 35271.5 39393.4 39427.8 39451.8 39575.6 40177.4 40766.2 40912.0 41019.4 41089.6 7709.3 7795.5 7849.5 7850.4 7870.8 7680.8 7721.3 7813.1 7834.2 7868.1 7898.1 7915.1 7922.9 7932.6 7939.6 7832.6 7853.2 7856.4 7870.2 7870.5 7776.1 7805.3 7824.2 7825.8 7844.9 37968.2 38021.2 38238.4 38275.6 38385.2 2083.5 2702.5 2716.9 2790.7 2833.6 26964.9 29177.6 29578.0 30005.5 30365.4 2961.9 2977.5 3020.9 3021.4 3025.3 266142.0 266636.0 267568.0 267615.0 268361.7 54934.0 55469.0 55607.4 55909.7 56017.7 33550.7 34612.3 58531.4 58612.4 58638.0 15710.5 15713.3 15717.4 15720.3 15830.7 11816.0 12020.5 12028.2 12051.3 12076.2 18375.4 18471.1 18553.4 18570.6 18646.0 6851.4 7015.2 7076.1 7078.2 7212.2 774.7 930.9 958.8 964.6 1031.6 28041.9 28497.3 28737.0 28886.1 28984.9 935.4 950.7 965.9 1018.3 1057.5 15315.5 15372.7 15383.1 15419.3 15507.6 384715.0 387443.0 388539.0 389132.0 390239.0 50588.0 50851.0 50890.7 50914.2 51404.0 1147.6 1157.6 1159.5 1170.1 1198.1 26987.9 27363.8 27848.4 28121.4 28354.6 43967.0 47684.0 49482.3 49518.3 53312.0 342788.0 346116.0 347320.0 350740.0 351634.0 39911.8 40064.0 40264.0 40467.4 40520.6 43582.6 43850.3 44005.0 44670.0 44840.6 36186.8 37648.2 37659.0 37920.6 38035.4 35632.0 35869.5 35882.0 36417.5 36446.6 36659.8 36755.6 36914.6 37403.3 37412.0 31777.2 32936.0 33042.8 33675.0 33768.2 25441.2 25538.9 25648.4 25749.6 25934.2 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#2] jquery.html Cycles:180 Average:26539.20 Median:19234.43 stddev:69104.15 (359.3%) stddev-sans-first:69270.01 09:24:53 INFO - PROCESS | 2624 | Values: 337.7 345.1 350.8 360.5 368.6 15866.0 16126.4 16988.5 17007.7 17029.1 16035.9 16695.7 17017.1 17048.1 17150.1 4741.5 5108.3 5148.4 5171.7 5179.4 5036.7 5059.8 5081.7 5095.0 5098.6 4787.9 5017.5 5031.7 5051.6 5055.4 4973.2 4985.3 4993.6 5002.4 5016.0 4301.2 4482.7 4513.1 4527.5 4559.9 19230.4 19417.4 19697.7 19999.5 20195.6 1886.6 1906.7 2011.0 2029.3 2249.8 12834.1 13163.0 13210.1 13290.4 13436.7 1494.6 1512.7 1538.8 1865.6 2105.2 83369.6 83377.0 84785.0 84821.0 88619.6 15613.7 15682.5 16134.7 16737.3 16983.9 29938.1 30002.4 30307.8 30362.1 30396.4 8950.2 9384.1 9430.0 9670.3 9735.9 8033.3 8091.5 8126.5 8223.8 8226.9 8031.4 8302.6 8306.7 8322.0 8408.9 3236.0 3346.1 3444.8 3452.6 3486.4 367.6 369.2 384.5 808.5 918.5 10747.0 10846.9 10977.6 10983.9 10997.5 387.7 398.2 405.5 407.1 416.5 9498.0 10262.4 10494.6 10500.8 10524.8 410838.0 414239.0 416617.0 420799.0 421371.0 83850.0 85363.6 86567.6 87053.6 87440.0 906.0 933.4 966.2 966.7 967.5 15673.5 15727.1 15778.4 15864.8 15905.1 36344.8 36645.8 36819.6 38099.6 39285.4 49733.8 52497.5 52577.2 53296.2 53879.7 7671.8 7858.8 7914.2 7971.4 7980.4 8771.7 11668.4 11786.1 11934.9 12132.8 10132.6 10200.5 10254.8 10342.5 10732.2 10154.9 10501.8 10579.9 10733.4 10748.5 10312.7 10460.5 10549.8 10577.3 10712.1 7792.1 7862.6 7979.7 7986.2 8087.4 7957.4 9235.8 10458.3 10544.8 10600.7 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#3] mootools.html Cycles:180 Average:4848.18 Median:5161.98 stddev:2702.32 (52.4%) stddev-sans-first:2697.04 09:24:53 INFO - PROCESS | 2624 | Values: 1339.9 1386.5 1457.4 1601.5 1648.6 6593.2 7293.6 7445.2 7775.3 7789.4 7512.3 7739.3 7742.6 7776.4 7797.5 2160.1 2191.8 2192.0 2194.3 2198.4 2139.4 2172.6 2187.9 2190.3 2193.8 2082.3 2083.9 2086.9 2093.5 2206.7 2090.0 2102.2 2102.3 2111.7 2118.5 2067.3 2073.0 2094.4 2096.8 2101.6 7748.1 7786.4 7839.0 7844.5 7910.1 4524.8 4600.0 4623.4 4636.7 4644.1 2730.2 2800.9 2827.1 2835.8 2856.0 841.5 886.9 891.9 910.7 1552.0 9547.3 9848.2 9886.6 9977.0 9982.4 3773.2 3888.8 3919.4 3919.5 3942.6 7889.6 7910.4 7936.4 7945.5 7958.3 4406.8 4425.6 4430.6 4443.7 4447.0 3445.7 3938.4 3963.0 3963.5 4072.1 3372.3 3379.4 3410.1 3435.3 3437.5 974.2 994.5 997.5 1002.9 1006.0 663.0 677.2 727.4 785.0 834.7 4965.7 5067.1 5134.6 5189.4 5222.5 398.1 405.6 408.2 411.1 411.3 3521.8 3537.6 3566.6 3586.2 3596.8 8830.7 9018.5 9056.3 9142.2 9144.5 8973.8 8996.2 8997.1 9016.1 9129.6 6884.9 6959.9 7129.8 7131.0 7140.5 4856.1 4864.1 4868.9 4902.9 4926.1 8324.4 8508.0 8533.5 8538.1 8549.5 8544.9 8634.3 8672.0 8707.2 8708.0 5732.6 5861.2 5877.9 5884.9 5898.3 6897.7 6913.3 6966.6 6970.8 7009.2 6212.1 6386.2 6408.6 6427.5 6594.3 6061.0 6076.8 6097.5 6111.5 6366.8 5693.0 5762.7 5781.2 5788.9 5795.4 4065.7 4109.0 4189.1 4200.1 4247.9 4231.7 4240.8 4487.1 4550.6 4584.0 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#4] prototype.html Cycles:180 Average:4386.81 Median:5063.34 stddev:1298.10 (25.6%) stddev-sans-first:1264.67 09:24:53 INFO - PROCESS | 2624 | Values: 282.9 288.9 290.3 292.7 293.7 5056.2 5070.8 5074.4 5089.9 5117.1 5044.5 5047.6 5050.7 5056.5 5070.2 3686.2 3766.9 3886.8 3890.4 3892.7 3880.7 3906.1 3912.9 3913.8 3927.9 3879.7 3908.9 3930.2 3935.7 3942.4 3781.8 3838.6 3867.9 3875.8 3882.9 3350.6 3397.4 3400.2 3403.7 3406.6 4879.9 4881.2 4883.0 4920.5 4943.6 4391.8 4433.6 4440.8 4463.6 4500.0 5137.9 5140.3 5146.5 5171.4 5185.6 3640.3 3688.6 3711.2 3718.1 3722.2 5513.6 5518.0 5520.9 5526.0 5545.9 3665.6 3765.1 3799.7 3800.8 3807.9 3837.2 3838.4 3842.0 3866.1 3869.3 4368.7 4388.6 4444.5 4450.3 4467.4 5117.0 5154.4 5192.9 5228.0 5329.5 1330.7 1340.3 1352.9 1353.2 1364.6 812.7 838.8 847.9 874.9 877.9 4560.8 4715.8 4732.7 4747.8 4751.5 5488.1 5525.2 5528.0 5542.8 5542.8 4474.2 4719.5 4725.4 4759.3 4774.2 2872.4 2903.0 2937.0 2938.7 2942.8 5104.7 5105.2 5149.7 5203.7 5237.2 5367.3 5474.3 5545.5 5562.6 5566.6 5100.6 5133.4 5166.9 5177.0 5184.2 5485.7 5488.6 5504.4 5520.3 5526.4 5041.6 5283.3 5352.4 5382.8 5385.0 5218.6 5230.2 5233.6 5251.0 5254.7 3689.9 3712.9 3734.0 3739.4 3748.2 5216.1 5505.5 5519.3 5529.7 5568.8 5333.0 5358.9 5369.9 5392.4 5395.7 5177.9 5285.8 5321.3 5349.4 5390.6 5256.4 5259.8 5285.7 5287.7 5292.2 5133.0 5208.7 5387.0 5395.2 5405.7 5288.0 5289.8 5299.4 5307.7 5326.3 09:24:53 INFO - PROCESS | 2624 | 09:24:53 INFO - PROCESS | 2624 | [#5] yui.html Cycles:180 Average:16386.15 Median:29801.16 stddev:23484.20 (78.8%) stddev-sans-first:23520.02 09:24:53 INFO - PROCESS | 2624 | Values: 563.5 588.3 600.9 614.4 625.2 10967.8 11366.1 11561.1 11598.0 11845.2 14102.8 14375.2 14854.1 14884.7 14909.4 615.2 759.9 766.5 773.5 778.1 780.1 785.8 787.8 790.8 792.4 822.6 823.2 825.8 826.6 827.2 811.9 813.3 814.8 817.8 820.8 599.7 601.1 603.1 604.0 604.4 11796.7 11926.3 11964.7 11970.2 12030.5 12613.8 12871.6 13054.8 13121.9 13130.0 10130.6 10284.2 10309.1 10484.2 10605.3 3295.5 3338.2 3358.8 3372.4 3465.8 63477.4 63624.4 63718.4 63876.7 64646.7 10094.9 10147.7 10189.3 10196.3 10243.1 17670.3 17879.4 17914.9 17958.6 18090.3 6144.6 6149.9 6277.7 6361.6 6368.8 3396.1 3484.3 3638.0 3647.1 3649.1 2562.0 2655.4 2690.0 2761.4 2777.5 451.5 453.3 454.1 455.7 464.2 460.8 467.4 488.9 512.0 525.3 6721.0 6794.7 6884.8 6903.5 6918.4 454.9 504.7 512.9 520.1 538.0 3303.2 3355.7 3386.2 3447.7 3471.8 87689.6 90093.5 91683.5 96960.0 98579.0 50161.2 61246.7 68983.3 75608.6 81643.0 45964.8 51189.2 75294.6 75988.6 76357.2 7305.8 7436.7 7448.0 7451.7 7532.9 42224.8 43055.6 43329.4 43805.6 44421.8 59014.0 59870.7 60288.7 61225.7 62117.0 9795.3 9889.7 9923.2 10039.9 10130.3 10696.2 11012.9 11157.8 11236.6 11325.4 9600.4 9604.9 9628.5 9883.8 10119.8 9639.2 9658.0 10086.0 10307.3 10341.8 9469.3 9699.3 9729.7 9779.7 9929.6 7899.4 8746.1 9076.6 9078.9 9173.6 8380.2 8417.5 8500.7 8660.4 8747.2 09:24:53 INFO - PROCESS | 2624 | -------- Summary: end -------- 09:24:53 INFO - PROCESS | 2624 | 09:24:54 INFO - TEST-INFO | 2624: exit 0 09:24:54 INFO - TEST-OK | dromaeo_css | took 1114857ms 09:24:54 INFO - TEST-START | kraken 09:24:54 INFO - operating with platform_type : linux_ 09:24:54 INFO - Initialising browser for kraken test... 09:24:54 INFO - TEST-INFO | started process 2964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5bPNj/profile http://localhost:48266/getInfo.html) 09:24:59 INFO - PROCESS | 2964 | __metrics Screen width/height:1600/1200 09:24:59 INFO - PROCESS | 2964 | colorDepth:24 09:24:59 INFO - PROCESS | 2964 | Browser inner width/height: 1024/697 09:24:59 INFO - PROCESS | 2964 | __metrics 09:24:59 ERROR - PROCESS | 2964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:25:00 INFO - TEST-INFO | 2964: exit 0 09:25:00 INFO - Browser initialized. 09:25:00 INFO - Running cycle 1/1 for kraken test... 09:25:00 INFO - TEST-INFO | started process 3081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5bPNj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:12 INFO - PROCESS | 3081 | RSS: Main: 185655296 09:25:12 INFO - PROCESS | 3081 | 09:25:15 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:16 INFO - PROCESS | 3081 | RSS: Main: 190238720 09:25:16 INFO - PROCESS | 3081 | 09:25:19 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-dft) 09:25:19 INFO - PROCESS | 3081 | RSS: Main: 189513728 09:25:19 INFO - PROCESS | 3081 | 09:25:22 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-fft) 09:25:23 INFO - PROCESS | 3081 | RSS: Main: 185421824 09:25:23 INFO - PROCESS | 3081 | 09:25:25 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-oscillator) 09:25:26 INFO - PROCESS | 3081 | RSS: Main: 186085376 09:25:26 INFO - PROCESS | 3081 | 09:25:28 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:29 INFO - PROCESS | 3081 | RSS: Main: 185901056 09:25:29 INFO - PROCESS | 3081 | 09:25:32 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:32 INFO - PROCESS | 3081 | RSS: Main: 186601472 09:25:32 INFO - PROCESS | 3081 | 09:25:36 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:37 INFO - PROCESS | 3081 | RSS: Main: 183734272 09:25:37 INFO - PROCESS | 3081 | 09:25:40 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48266/tests/kraken/driver.html?testName=json-parse-financial) 09:25:40 INFO - PROCESS | 3081 | RSS: Main: 185409536 09:25:40 INFO - PROCESS | 3081 | 09:25:42 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:43 INFO - PROCESS | 3081 | RSS: Main: 186204160 09:25:43 INFO - PROCESS | 3081 | 09:25:44 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:45 INFO - PROCESS | 3081 | RSS: Main: 185630720 09:25:45 INFO - PROCESS | 3081 | 09:25:47 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:48 INFO - PROCESS | 3081 | RSS: Main: 186298368 09:25:48 INFO - PROCESS | 3081 | 09:25:51 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:52 INFO - PROCESS | 3081 | RSS: Main: 185962496 09:25:52 INFO - PROCESS | 3081 | 09:25:54 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:55 INFO - PROCESS | 3081 | RSS: Main: 185757696 09:25:55 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48266/tests/kraken/driver.html?testName=ai-astar) 09:25:57 INFO - PROCESS | 3081 | RSS: Main: 186679296 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | __start_tp_report 09:25:57 INFO - PROCESS | 3081 | _x_x_mozilla_page_load 09:25:57 INFO - PROCESS | 3081 | _x_x_mozilla_page_load_details 09:25:57 INFO - PROCESS | 3081 | |i|pagename|runs| 09:25:57 INFO - PROCESS | 3081 | |0;ai-astar;115;110;115;115;115;114;115;116;114;116 09:25:57 INFO - PROCESS | 3081 | |1;audio-beat-detection;157;132;178;189;140;168;171;133;180;136 09:25:57 INFO - PROCESS | 3081 | |2;audio-dft;162;167;169;170;163;162;163;163;163;164 09:25:57 INFO - PROCESS | 3081 | |3;audio-fft;77;76;85;178;77;75;77;76;170;78 09:25:57 INFO - PROCESS | 3081 | |4;audio-oscillator;86;87;149;88;85;88;150;87;88;145 09:25:57 INFO - PROCESS | 3081 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;119;119 09:25:57 INFO - PROCESS | 3081 | |6;imaging-darkroom;149;147;148;148;149;148;150;147;147;147 09:25:57 INFO - PROCESS | 3081 | |7;imaging-desaturate;95;95;96;96;96;97;95;96;95;96 09:25:57 INFO - PROCESS | 3081 | |8;json-parse-financial;64;65;65;65;65;64;70;63;63;64 09:25:57 INFO - PROCESS | 3081 | |9;json-stringify-tinderbox;66;65;69;64;65;64;64;65;69;66 09:25:57 INFO - PROCESS | 3081 | |10;stanford-crypto-aes;84;90;84;91;87;86;84;86;121;86 09:25:57 INFO - PROCESS | 3081 | |11;stanford-crypto-ccm;138;137;142;148;146;134;132;135;143;135 09:25:57 INFO - PROCESS | 3081 | |12;stanford-crypto-pbkdf2;172;166;175;168;171;168;169;166;168;168 09:25:57 INFO - PROCESS | 3081 | |13;stanford-crypto-sha256-iterative;66;69;67;67;70;69;71;69;67;69 09:25:57 INFO - PROCESS | 3081 | __end_tp_report 09:25:57 INFO - PROCESS | 3081 | __start_cc_report 09:25:57 INFO - PROCESS | 3081 | _x_x_mozilla_cycle_collect,963 09:25:57 INFO - PROCESS | 3081 | __end_cc_report 09:25:57 INFO - PROCESS | 3081 | __startTimestamp1465489557575__endTimestamp 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | ------- Summary: start ------- 09:25:57 INFO - PROCESS | 3081 | Number of tests: 14 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 09:25:57 INFO - PROCESS | 3081 | Values: 115.0 110.0 115.0 115.0 115.0 114.0 115.0 116.0 114.0 116.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#1] audio-beat-detection Cycles:10 Average:158.40 Median:169.50 stddev:21.66 (12.8%) stddev-sans-first:22.97 09:25:57 INFO - PROCESS | 3081 | Values: 157.0 132.0 178.0 189.0 140.0 168.0 171.0 133.0 180.0 136.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:2.95 (1.8%) stddev-sans-first:2.98 09:25:57 INFO - PROCESS | 3081 | Values: 162.0 167.0 169.0 170.0 163.0 162.0 163.0 163.0 163.0 164.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#3] audio-fft Cycles:10 Average:96.90 Median:77.00 stddev:40.77 (53.0%) stddev-sans-first:42.60 09:25:57 INFO - PROCESS | 3081 | Values: 77.0 76.0 85.0 178.0 77.0 75.0 77.0 76.0 170.0 78.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:87.00 stddev:29.51 (33.9%) stddev-sans-first:30.46 09:25:57 INFO - PROCESS | 3081 | Values: 86.0 87.0 149.0 88.0 85.0 88.0 150.0 87.0 88.0 145.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 09:25:57 INFO - PROCESS | 3081 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 119.0 119.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:25:57 INFO - PROCESS | 3081 | Values: 149.0 147.0 148.0 148.0 149.0 148.0 150.0 147.0 147.0 147.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:25:57 INFO - PROCESS | 3081 | Values: 95.0 95.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 96.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.99 (3.1%) stddev-sans-first:2.09 09:25:57 INFO - PROCESS | 3081 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 70.0 63.0 63.0 64.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.89 (2.9%) stddev-sans-first:2.00 09:25:57 INFO - PROCESS | 3081 | Values: 66.0 65.0 69.0 64.0 65.0 64.0 64.0 65.0 69.0 66.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:86.00 stddev:11.19 (13.0%) stddev-sans-first:11.66 09:25:57 INFO - PROCESS | 3081 | Values: 84.0 90.0 84.0 91.0 87.0 86.0 84.0 86.0 121.0 86.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:140.00 stddev:5.44 (3.9%) stddev-sans-first:5.75 09:25:57 INFO - PROCESS | 3081 | Values: 138.0 137.0 142.0 148.0 146.0 134.0 132.0 135.0 143.0 135.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:168.50 stddev:2.81 (1.7%) stddev-sans-first:2.77 09:25:57 INFO - PROCESS | 3081 | Values: 172.0 166.0 175.0 168.0 171.0 168.0 169.0 166.0 168.0 168.0 09:25:57 INFO - PROCESS | 3081 | 09:25:57 INFO - PROCESS | 3081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.41 09:25:57 INFO - PROCESS | 3081 | Values: 66.0 69.0 67.0 67.0 70.0 69.0 71.0 69.0 67.0 69.0 09:25:57 INFO - PROCESS | 3081 | -------- Summary: end -------- 09:25:57 INFO - PROCESS | 3081 | 09:25:58 INFO - TEST-INFO | 3081: exit 0 09:25:58 INFO - TEST-OK | kraken | took 64159ms 09:25:58 INFO - SUITE-END | took 1179s 09:25:58 INFO - Completed test suite (00:19:39) 09:25:58 INFO - javascript benchmark 09:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6370.678073453799, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.5640241159, 2644.8942042318304, 2656.3890305229806, 2658.8670566471674, 2669.012465387807, 4662.230731929232, 4695.553922377378, 4730.858074257773, 4781.258904869742, 4825.396825396825, 4540.772961351928, 4707.082118986799, 4720.480747117823, 4744.0, 4783.258594917794, 4299.505556860962, 4364.585364390377, 4410.470743510783, 4415.2494076007, 4418.80115394808, 491.034166048672, 4260.97869510652, 4306.590873866978, 4312.676549258803, 4349.565043495657, 4367.323064924942, 4402.911941761179, 4403.053343531156, 4405.140997505488, 4432.867013989553, 4363.410939523187, 4407.713498622579, 4411.933820992687, 4419.381286619876, 4448.5551444855255, 4344.565543445662, 4423.159599676052, 4447.866564003085, 4448.5551444855255, 4452.3989261449615, 4840.104580652591, 4843.612510999147, 4865.148598995162, 4875.8781030474165, 4876.414830220361, 4875.731834749087, 5085.949140508585, 5198.0, 5202.791888324463, 5255.0278198533015, 5146.202338637517, 5150.613703972217, 5179.04187725272, 5188.481151884819, 5219.869503262411, 4813.15769740294, 4813.3983252093485, 4813.638977076734, 4815.807367705253, 4861.416630004422, 5221.530062294336, 5253.185756207794, 5262.02652509287, 5262.210668399694, 5278.841634750964, 5051.949480505148, 5055.797768089309, 5058.924116138261, 5069.7465126744255, 5106.565941894906, 5168.586513078944, 5169.276301317818, 5170.1469257572835, 5170.327857378592, 5172.922406163911, 4880.536349046835, 5022.497750225021, 5045.899082018339, 5062.012907483079, 5087.949120508748, 4971.229459433794, 5028.296038554606, 5031.4465408805, 5043.36957880265, 5104.668196567211, 4122.113745544722, 4221.430106935524, 4223.556526564728, 4237.6821738369745, 4268.210381079511, 3573.12458447682, 3702.3520883845217, 3728.8694895678523, 3737.71967102463, 3754.981225093857, 4460.86617401472, 4471.418715566955, 4475.552444755498, 4526.841560545365, 4552.521985191574, 5027.3464449621315, 5138.254953031789, 5144.819931302386, 5149.9742501287255, 5153.948460515422, 4432.0, 4448.955510444919, 4486.035502366942, 4487.259602165672, 4488.528704486047, 4545.613622842029, 4554.954450455453, 4555.681102322872, 4573.679842411066, 4592.2193227151465, 4745.335653008513, 4767.499412561631, 4794.376731024944, 4830.106430310404, 4834.951650483591, 5028.120078986236, 5035.597152227886, 5037.596992240685, 5044.8234311798915, 5064.164412871834, 4807.471178170328, 4815.566599006106, 4836.008618233183, 4844.709317440965, 4860.3681521401995, 4984.302197692398, 4999.325091112799, 5018.974905125597, 5019.0, 5025.070361983045, 4850.296706977539, 5024.397072351341, 5055.974720126376, 5085.160948443613, 5139.254808052737, 4939.407271127488, 4939.506049395175, 4944.431390390151, 4964.255361695775, 4988.825391111293, 4941.925871112008, 4954.900901982012, 4956.835143741146, 4968.726720030289, 5008.649394542347, 4703.952960470351, 4885.804567817389, 4910.21436570147, 4915.729634870117, 4926.926096108633, 5025.095482813129, 5053.267276244997, 5065.265536497113, 5067.037262920034, 5107.208382700687, 4655.697379670446, 4950.727709975986, 4956.330895329084, 4959.652824302264, 5000.7999680013845], "value": 4653.606720485439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.322401506185, 563.1861959468567, 588.7438964050637, 591.7159763313609, 597.3130899465611, 35271.470927936105, 39393.40909886351, 39427.80286098573, 39451.802740986255, 39575.60424395763, 40177.39733903994, 40766.18467630645, 40912.0, 41019.38470922939, 41089.56186533472, 7709.267619576131, 7795.532268063906, 7849.45053846231, 7850.371970242395, 7870.842583148334, 7680.807979800522, 7721.343685786715, 7813.101493328255, 7834.177411371809, 7868.095169055546, 7898.091719452251, 7915.089764677049, 7922.920770792305, 7932.563708996003, 7939.5633240171765, 7832.56920869352, 7853.175416581234, 7856.410769192334, 7870.212978702112, 7870.527768333918, 7776.105747839014, 7805.258500442449, 7824.217578242187, 7825.765227043198, 7844.882326765103, 37968.24063518714, 38021.23957520834, 38238.42642360367, 38275.617243827764, 38385.23229535422, 2083.489470134156, 2702.540568103427, 2716.9456610867674, 2790.734880186379, 2833.6457942757156, 26964.865175673996, 29177.56233656497, 29578.0, 30005.549916751264, 30365.392692146255, 2961.9111426657237, 2977.4640564698348, 3020.909372718822, 3021.3504096619113, 3025.3344264261827, 266142.0, 266636.0, 267568.0, 267615.0, 268361.6581917097, 54934.0, 55469.0, 55607.443925561034, 55909.720451398294, 56017.719911401, 33550.664493355245, 34612.30775384478, 58531.41468585259, 58612.41387586155, 58638.0, 15710.450134245475, 15713.292901819446, 15717.371305147895, 15720.29258683362, 15830.683386332208, 11815.995640370493, 12020.519179232908, 12028.218165819193, 12051.276923384625, 12076.154669173073, 18375.356862509747, 18471.076446177638, 18553.35063272806, 18570.628587428175, 18646.0, 6851.383375496229, 7015.193252775996, 7076.115485564304, 7078.186008608973, 7212.206657267697, 774.728844904279, 930.930180236485, 958.7842735384482, 964.5659453246068, 1031.5615863258085, 28041.859790700917, 28497.287567810556, 28737.0, 28886.133415997552, 28984.855075724907, 935.4480856294683, 950.7147855643279, 965.9227261819037, 1018.3228153278135, 1057.5188289328337, 15315.540533784004, 15372.692546149237, 15383.08060654416, 15419.306131224123, 15507.612309692347, 384715.0, 387443.0, 388539.0, 389132.0, 390239.0, 50588.0, 50851.0, 50890.74554627203, 50914.236286455736, 51404.0, 1147.6098126636984, 1157.6411312492985, 1159.4956194055612, 1170.126880027113, 1198.0714945916984, 26987.865060674572, 27363.79062395777, 27848.443031139668, 28121.43757124805, 28354.574681380207, 43967.0, 47684.0, 49482.25776613426, 49518.257226140915, 53312.0, 342788.0, 346116.0, 347320.0, 350740.0, 351634.0, 39911.800440997606, 40064.0, 40264.0, 40467.3929891046, 40520.594794051685, 43582.56417435912, 43850.342244865715, 44005.0, 44670.0, 44840.55159448364, 36186.8190659045, 37648.24703505969, 37659.0, 37920.62079379281, 38035.42946855855, 35632.0, 35869.46195807117, 35882.0, 36417.453738194476, 36446.63553364432, 36659.81670091632, 36755.63244367629, 36914.63085369219, 37403.25193496169, 37412.0, 31777.20556986094, 32936.0, 33042.834785825915, 33675.0, 33768.1557961053, 25441.236762897144, 25538.872305638353, 25648.358791030372, 25749.613755793303, 25934.22197334083], "value": 17955.57428832569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7180054654364, 345.14748571029554, 350.82984752395083, 360.4989065199372, 368.5890232390883, 15866.0, 16126.435574754885, 16988.49034528963, 17007.65984680307, 17029.148542572882, 16035.919820400912, 16695.66608667826, 17017.064061476613, 17048.147592620382, 17150.113487516363, 4741.478437371887, 5108.2848401223855, 5148.3564554430695, 5171.715555644457, 5179.352580927384, 5036.7481625918745, 5059.822906198284, 5081.7459127043685, 5094.974525127369, 5098.643094983353, 4787.928181077286, 5017.49825017499, 5031.6729412588065, 5051.595872330223, 5055.368078990126, 4973.204287314031, 4985.277134815431, 4993.575546078588, 5002.449730529639, 5016.046951079302, 4301.204277208726, 4482.708623939434, 4513.142502924434, 4527.479339875924, 4559.931601025987, 19230.423087307405, 19417.417477475698, 19697.704534431996, 19999.500012499804, 20195.596088078157, 1886.6321916610484, 1906.6949288113835, 2010.9698354524694, 2029.2998915374171, 2249.752527222004, 12834.101612887102, 13163.0, 13210.141340812816, 13290.401931912991, 13436.731265374736, 1494.6338147153908, 1512.705022520609, 1538.7768773527887, 1865.6268746250805, 2105.189502041725, 83369.58315208445, 83377.0, 84784.99999999939, 84821.0, 88619.55690221571, 15613.68772624541, 15682.451114210948, 16134.677306453805, 16737.33050677959, 16983.91508042452, 29938.101856944326, 30002.399952001273, 30307.848460757996, 30362.089137325915, 30396.392072158433, 8950.23922966555, 9384.137837959352, 9430.0, 9670.274729395183, 9735.902640973642, 8033.277005069572, 8091.514509129471, 8126.471779334324, 8223.753287401387, 8226.917730822615, 8031.357491400674, 8302.584870756438, 8306.70926517569, 8322.019008066385, 8408.873866892001, 3236.0098539398573, 3346.1300061983575, 3444.8277586120594, 3452.5684289463816, 3486.3567571886933, 367.5772861209577, 369.2356821379718, 384.45407521319794, 808.5270116981632, 918.4764684130115, 10747.0, 10846.891531084588, 10977.615783447542, 10983.945080274707, 10997.450127493594, 387.7324645994311, 398.21750260737787, 405.4728852491749, 407.1064014488229, 416.510600044946, 9497.952510237543, 10262.409326554396, 10494.632687856041, 10500.789984200273, 10524.842127368096, 410838.0, 414239.0, 416617.0, 420799.0, 421371.0, 83850.0, 85363.57318213493, 86567.56716216379, 87053.56473217593, 87440.0, 905.9570668143294, 933.3513208320152, 966.1546147121269, 966.7389804752818, 967.5210770668424, 15673.529794106194, 15727.05637661744, 15778.36886524572, 15864.76202856935, 15905.125218113115, 36344.81827590845, 36645.816770915975, 36819.63180368162, 38099.61900380961, 39285.41071883981, 49733.75133124456, 52497.47502524926, 52577.21134183067, 53296.2005569909, 53879.73060134831, 7671.808204794925, 7858.764237072897, 7914.2085791420395, 7971.441999060242, 7980.401469889665, 8771.692990745294, 11668.368510275259, 11786.11604129711, 11934.880651193724, 12132.75734485323, 10132.594696212363, 10200.489975501047, 10254.794904102026, 10342.482875856327, 10732.248742588255, 10154.898451015692, 10501.842472362769, 10579.94710026445, 10733.409662468326, 10748.516316765608, 10312.742181445525, 10460.476976151314, 10549.789004220027, 10577.259591828499, 10712.089472394622, 7792.064952205772, 7862.646180921986, 7979.680812767424, 7986.2013798622, 8087.353011758927, 7957.403194760532, 9235.815283694154, 10458.26792124544, 10544.78910421772, 10600.681979540626], "value": 8624.709187279543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.9062065655405, 1386.5008596905113, 1457.4097490516338, 1601.4635097242424, 1648.6290584618462, 6593.241777195612, 7293.562386256828, 7445.218252083534, 7775.300222979938, 7789.376849852012, 7512.286332798375, 7739.303462688357, 7742.612869356538, 7776.416768742352, 7797.53214807112, 2160.114353115227, 2191.7698641642637, 2191.9780802191935, 2194.308792730285, 2198.351486311542, 2139.379579921821, 2172.6089303925287, 2187.890605469728, 2190.299104286629, 2193.8025577698004, 2082.2920207129573, 2083.8853863037525, 2086.926957556478, 2093.528955984899, 2206.6579680149603, 2090.049027692404, 2102.190656597206, 2102.2536999365157, 2111.6515774897125, 2118.5127420693175, 2067.286786058807, 2072.958540829175, 2094.413564202026, 2096.8217701495237, 2101.569178318441, 7748.147703752583, 7786.377089832799, 7838.960805195938, 7844.4901081429525, 7910.129885712567, 4524.819007239739, 4599.954000459986, 4623.42207224097, 4636.652251081183, 4644.117617652635, 2730.167298973812, 2800.8879644814183, 2827.123591686584, 2835.815671981335, 2855.971440285612, 841.494165249516, 886.9201771840566, 891.8617614269799, 910.7267819654078, 1551.9767203491956, 9547.331686781929, 9848.162906152986, 9886.604535818558, 9977.0, 9982.351147175483, 3773.1699026214187, 3888.8055597220027, 3919.412088186738, 3919.4904662393706, 3942.605739426092, 7889.566073865993, 7910.446268761131, 7936.4047696423, 7945.48354356965, 7958.323542498837, 4406.757628330409, 4425.645948324126, 4430.556944305544, 4443.688941774045, 4446.9777651111535, 3445.7243420526297, 3938.3501722215515, 3962.980185099056, 3963.5441924178513, 4072.1244932339096, 3372.274960883422, 3379.3579219948133, 3410.079278594815, 3435.2957643682985, 3437.5187473753695, 974.2449601558849, 994.5077186792439, 997.5411310796969, 1002.8646132772128, 1006.0291818395284, 662.9668516574152, 677.1704661789269, 727.4326025699962, 784.9646765895549, 834.6744769539885, 4965.652404331734, 5067.113255180328, 5134.614903882224, 5189.351331083614, 5222.508275101146, 398.08043419700005, 405.561993047508, 408.24270977337204, 411.0873860030727, 411.3356928560413, 3521.7886926784477, 3537.6285490023693, 3566.625504322061, 3586.1931065510053, 3596.7662101963288, 8830.690925817566, 9018.503982280907, 9056.320775941831, 9142.177204051668, 9144.497052662035, 8973.775655608662, 8996.190342869042, 8997.145271199226, 9016.098390161063, 9129.589168487433, 6884.862302754017, 6959.860802783916, 7129.750458734024, 7130.964345178345, 7140.464465165133, 4856.077345304522, 4864.075825593126, 4868.853934381974, 4902.8774280643265, 4926.113299605962, 8324.375671824759, 8507.95746021266, 8533.487990720576, 8538.10349913275, 8549.487030778173, 8544.871826922477, 8634.266087382643, 8672.0, 8707.172818582225, 8708.04211536743, 5732.582709339801, 5861.1501332307425, 5877.941220587911, 5884.852878677896, 5898.3216930053595, 6897.689603967934, 6913.308669133247, 6966.616836073862, 6970.79087627372, 7009.1589009319205, 6212.099245609452, 6386.233651961795, 6408.647524386203, 6427.485801135805, 6594.274629790623, 6061.0, 6076.756929722938, 6097.451229389376, 6111.5110791137495, 6366.808995730135, 5692.971535142297, 5762.740676669476, 5781.248437703071, 5788.855278618068, 5795.420457954171, 4065.6950728694874, 4108.979455102705, 4189.0574620710095, 4200.1179752252365, 4247.936280955726, 4231.724937879028, 4240.766757828349, 4487.08014856947, 4550.635949124128, 4583.954160458353], "value": 3859.752548993367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.93351062500307, 288.9266375415333, 290.2699710228775, 292.7219141815275, 293.69015688448707, 5056.241563765432, 5070.797168113276, 5074.391073071228, 5089.9491005089985, 5117.130087885059, 5044.495550444954, 5047.596192304616, 5050.6969581825115, 5056.519630635084, 5070.163423035195, 3686.225892562565, 3766.924661506768, 3886.8250928708135, 3890.435886796413, 3892.6691231245236, 3880.72834901557, 3906.121122747373, 3912.902177445558, 3913.8043097845134, 3927.9018024549473, 3879.7478163919395, 3908.863189788358, 3930.1943101664233, 3935.685145188378, 3942.4086387041884, 3781.773093614392, 3838.596947320547, 3867.9226415471812, 3875.767453952772, 3882.864099756523, 3350.564426624523, 3397.3545026444895, 3400.2179498715436, 3403.6936675699308, 3406.608240052401, 4879.926801097987, 4881.219004959225, 4882.951170488285, 4920.458749537548, 4943.604511639061, 4391.824327026915, 4433.645308375322, 4440.844570440051, 4463.620592249663, 4499.955000449986, 5137.869668672886, 5140.280360749498, 5146.459621739738, 5171.379434467888, 5185.55922746567, 3640.3083414151492, 3688.5942546320152, 3711.2391959648476, 3718.1076541629814, 3722.181120153562, 5513.558915286768, 5517.97917385285, 5520.861978450531, 5525.972370138124, 5545.889082218373, 3665.596784353719, 3765.134019175605, 3799.677027452642, 3800.809959502014, 3807.9428808567895, 3837.1750073733724, 3838.405047217686, 3841.961580384216, 3866.0721426857913, 3869.3228684980018, 4368.672349573794, 4388.5830846069575, 4444.488883778342, 4450.265706158512, 4467.441569803775, 5116.9744151279, 5154.407243167084, 5192.870178245574, 5228.0, 5329.507737833413, 1330.7138965122545, 1340.3432318164225, 1352.939117739704, 1353.15427857589, 1364.6179069860455, 812.6586833529932, 838.8382090804158, 847.9062010007021, 874.8993865705398, 877.8551538996122, 4560.8141883109965, 4715.834945776881, 4732.716037037789, 4747.7626118693925, 4751.524847515221, 5488.1493368527945, 5525.171224316305, 5527.972360138254, 5542.75057622408, 5542.806001789999, 4474.217012022883, 4719.480857105716, 4725.416985309959, 4759.262314341283, 4774.212254977959, 2872.4255148970287, 2902.956455653167, 2936.9559456608167, 2938.7363433723704, 2942.823430594171, 5104.744762761847, 5105.157648987875, 5149.682642810675, 5203.713795741271, 5237.240600112962, 5367.275417818622, 5474.260974768435, 5545.473180047889, 5562.610617256834, 5566.582506312043, 5100.5718398848385, 5133.435322114565, 5166.870828229249, 5176.98097741881, 5184.222366645109, 5485.670859748428, 5488.615796894339, 5504.366997795145, 5520.309961254843, 5526.392096869261, 5041.630433696157, 5283.286756287852, 5352.357717073976, 5382.815780528277, 5384.9730751346, 5218.634695571425, 5230.241614965885, 5233.555147812479, 5250.976059668328, 5254.6847189168775, 3689.870854520079, 3712.8886133414962, 3734.0104872208344, 3739.439084137401, 3748.194138260287, 5216.139337009503, 5505.532029777513, 5519.254900588369, 5529.695866727207, 5568.805091821767, 5332.9733351333, 5358.919616205682, 5369.899170669925, 5392.406835248041, 5395.730213489388, 5177.948220517746, 5285.814996475105, 5321.255024296524, 5349.438308977657, 5390.568754499553, 5256.39551451588, 5259.763955470538, 5285.68285902847, 5287.709175995357, 5292.179712144623, 5132.9743351283005, 5208.713520756395, 5387.033732687619, 5395.163749618815, 5405.6756094755465, 5288.0, 5289.836236028068, 5299.443558426464, 5307.681539107666, 5326.307580014573], "value": 3964.656829589283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.475967350364, 588.3234280577338, 600.8648054187809, 614.4408588184752, 625.199744327261, 10967.780644387107, 11366.090712742982, 11561.07511399088, 11598.0, 11845.170838041318, 14102.78845817311, 14375.209363485004, 14854.108753474799, 14884.702305953875, 14909.40362385506, 615.2278889993053, 759.9012128423298, 766.4826242286463, 773.5436092705303, 778.1090651204368, 780.1223623423648, 785.8467598818232, 787.7518581646791, 790.7509134622604, 792.3621484704811, 822.5599304372162, 823.1562648285525, 825.8141918068417, 826.6362800367849, 827.1645637905698, 811.9147489513634, 813.32494029955, 814.8411059843303, 817.8364327134567, 820.827626198499, 599.7151353107283, 601.1163589523394, 603.0562170203617, 604.0064094564417, 604.3895665377956, 11796.705082372924, 11926.344051077187, 11964.70088247792, 11970.162088653798, 12030.4586293617, 12613.810792838114, 12871.648476909882, 13054.804177937338, 13121.934390328082, 13130.0, 10130.64542741008, 10284.228682848741, 10309.123724483354, 10484.161267098614, 10605.310654807412, 3295.489199174108, 3338.165458635341, 3358.84885180165, 3372.4266874631126, 3465.8267086645565, 63477.36522634761, 63624.363756362305, 63718.36281637217, 63876.68061659662, 64646.67676661586, 10094.949525252327, 10147.69556913279, 10189.286749927434, 10196.3372380795, 10243.07812296897, 17670.293188272582, 17879.37422190217, 17914.91042544805, 17958.640827183382, 18090.27638894456, 6144.600600961013, 6149.877002459926, 6277.686115694197, 6361.586496877688, 6368.77709280173, 3396.133985833646, 3484.337975784593, 3638.0, 3647.1429214134655, 3649.0512466758832, 2562.0, 2655.4025344297766, 2690.0, 2761.351082495612, 2777.5000499909806, 451.5236425571054, 453.29286313351275, 454.1099445087599, 455.70606958511576, 464.2015732939339, 460.80646128626057, 467.4250671673792, 488.9193283108247, 512.034814374906, 525.3249574297087, 6721.0, 6794.694238759268, 6884.759033433806, 6903.516753827284, 6918.37734603878, 454.9294859296748, 504.6870940017213, 512.9358830146232, 520.1443625236465, 537.9515843574019, 3303.223742420529, 3355.748318876094, 3386.153461634591, 3447.67247111524, 3471.7743346682387, 87689.56155219184, 90093.54953225191, 91683.54158229165, 96960.0, 98579.0, 50161.24758128631, 61246.693766531775, 68983.31016689769, 75608.62195689096, 81643.0, 45964.77017614958, 51189.232161517604, 75294.62352688311, 75988.62005689937, 76357.23642763612, 7305.780826575211, 7436.73971410998, 7447.99452073963, 7451.739189128354, 7532.924670753222, 42224.78887605665, 43055.569444305154, 43329.350059748496, 43805.56194438015, 44421.77789111034, 59014.0, 59870.70064649649, 60288.69855650693, 61225.693871530355, 62117.0, 9795.314327996972, 9889.703308900744, 9923.206143508358, 10039.949800250952, 10130.29087963865, 10696.197785165989, 11012.889871101186, 11157.832632510357, 11236.550537978716, 11325.433728313716, 9600.375975561845, 9604.903950960681, 9628.47043412619, 9883.752906177404, 10119.848202277119, 9639.18066964316, 9658.0, 10086.0, 10307.278490505592, 10341.84487232677, 9469.337146399961, 9699.321047526606, 9729.659461918798, 9779.706608801464, 9929.602815887572, 7899.447038707235, 8746.125387461203, 9076.591553379982, 9078.863817042618, 9173.587188576397, 8380.24577788002, 8417.452865563719, 8500.659973600987, 8660.350473714623, 8747.16901894319], "value": 6061.260069176284, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 115.0, 115.0, 115.0, 114.0, 115.0, 116.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 178.0, 189.0, 140.0, 168.0, 171.0, 133.0, 180.0, 136.0], "value": 158.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 169.0, 170.0, 163.0, 162.0, 163.0, 163.0, 163.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 85.0, 178.0, 77.0, 75.0, 77.0, 76.0, 170.0, 78.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 149.0, 88.0, 85.0, 88.0, 150.0, 87.0, 88.0, 145.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 150.0, 147.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 70.0, 63.0, 63.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 69.0, 64.0, 65.0, 64.0, 64.0, 65.0, 69.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 84.0, 91.0, 87.0, 86.0, 84.0, 86.0, 121.0, 86.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 142.0, 148.0, 146.0, 134.0, 132.0, 135.0, 143.0, 135.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 175.0, 168.0, 171.0, 168.0, 169.0, 166.0, 168.0, 168.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 67.0, 70.0, 69.0, 71.0, 69.0, 67.0, 69.0], "value": 68.4, "unit": "score"}]}]} 09:25:58 INFO - Return code: 0 09:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:58 ERROR - # TBPL SUCCESS # 09:25:58 INFO - Running post-action listener: _resource_record_post_action 09:25:58 INFO - ##### 09:25:58 INFO - ##### Finished run-tests step (success) 09:25:58 INFO - ##### 09:25:58 INFO - Running post-run listener: _resource_record_post_run 09:25:58 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 524361728; Read time: 280; Write time: 410888 09:25:58 INFO - TinderboxPrint: CPU usage
13.4% 09:25:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 280 09:25:58 INFO - TinderboxPrint: I/O write bytes / time
524,361,728 / 410,888 09:25:58 INFO - TinderboxPrint: CPU idle
8,259.4 (86.6%) 09:25:58 INFO - TinderboxPrint: CPU user
1,227.5 (12.9%) 09:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 238256128; Read time: 184; Write time: 238824 09:25:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286105600; Read time: 96; Write time: 172064 09:25:59 INFO - Running post-run listener: _upload_blobber_files 09:25:59 INFO - Blob upload gear active. 09:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:59 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:25:59 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:25:59 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:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:00 INFO - (blobuploader) - INFO - Done attempting. 09:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:04 INFO - (blobuploader) - INFO - Done attempting. 09:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:05 INFO - (blobuploader) - INFO - Done attempting. 09:26:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:05 INFO - Return code: 0 09:26:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd8e99c43963e2819d62c2fe46abb7f3abb77ffca7865ed0aca2239c9b5bc1b49e05c876ac593848c35d5dc198223f926bdd40bd649edf11d20d2ff41de5ae97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec6dae74322d7c0f4aa03922a5088b352b5986b6e756df9fea69c7ca7780ea0ca454612b27d514d764898483a03292af5b98733bef08385c023c37d3f2671fc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/427c7d3a887464517f445bc42039fb991b8210ff63cd13891e04f35fc201df4dbbeb709f76d87d7b68739a0f8481cc9af6edde510397ce0d206efc8e05f8e995"} 09:26:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:05 INFO - Contents: 09:26:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd8e99c43963e2819d62c2fe46abb7f3abb77ffca7865ed0aca2239c9b5bc1b49e05c876ac593848c35d5dc198223f926bdd40bd649edf11d20d2ff41de5ae97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec6dae74322d7c0f4aa03922a5088b352b5986b6e756df9fea69c7ca7780ea0ca454612b27d514d764898483a03292af5b98733bef08385c023c37d3f2671fc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/427c7d3a887464517f445bc42039fb991b8210ff63cd13891e04f35fc201df4dbbeb709f76d87d7b68739a0f8481cc9af6edde510397ce0d206efc8e05f8e995"} 09:26:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:05 INFO - Copying logs to upload dir... 09:26:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.227637 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-09 09:26:05.185822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:05.188907) ========= 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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 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/fd8e99c43963e2819d62c2fe46abb7f3abb77ffca7865ed0aca2239c9b5bc1b49e05c876ac593848c35d5dc198223f926bdd40bd649edf11d20d2ff41de5ae97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec6dae74322d7c0f4aa03922a5088b352b5986b6e756df9fea69c7ca7780ea0ca454612b27d514d764898483a03292af5b98733bef08385c023c37d3f2671fc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/427c7d3a887464517f445bc42039fb991b8210ff63cd13891e04f35fc201df4dbbeb709f76d87d7b68739a0f8481cc9af6edde510397ce0d206efc8e05f8e995"} build_url:https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.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/fd8e99c43963e2819d62c2fe46abb7f3abb77ffca7865ed0aca2239c9b5bc1b49e05c876ac593848c35d5dc198223f926bdd40bd649edf11d20d2ff41de5ae97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec6dae74322d7c0f4aa03922a5088b352b5986b6e756df9fea69c7ca7780ea0ca454612b27d514d764898483a03292af5b98733bef08385c023c37d3f2671fc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/427c7d3a887464517f445bc42039fb991b8210ff63cd13891e04f35fc201df4dbbeb709f76d87d7b68739a0f8481cc9af6edde510397ce0d206efc8e05f8e995"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:05.214378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:05.214759) ========= 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=923d835db2ba3686ebe126b700000192-1465488290.45609-1596841980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:05.297654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:26:05.297960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:26:05.298245) ========= ========= Total master_lag: 0.16 =========