builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1466241604.55 results: success (0) buildid: 20160617233003 builduid: 1c2b73f4bc20486abc510eb2e476775b revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.563290) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.563916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.564211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.599823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.600307) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 02:20:04-- 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% 110M=0s 2016-06-18 02:20:04 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.730830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.731157) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014896 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.801251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.801577) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 02:20:05,095 truncating revision to first 12 chars 2016-06-18 02:20:05,095 Setting DEBUG logging. 2016-06-18 02:20:05,095 attempt 1/10 2016-06-18 02:20:05,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 02:20:05,640 unpacking tar archive at: fx-team-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:05.713849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:05.714180) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:05.714655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:05.714947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:05.725259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-18 02:20:05.725688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:06 INFO - MultiFileLogger online at 20160618 02:20:06 in /builds/slave/test 02:20:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:20:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:06 INFO - {'append_to_log': False, 02:20:06 INFO - 'base_work_dir': '/builds/slave/test', 02:20:06 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:06 INFO - 'branch': 'Fx-Team', 02:20:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:06 INFO - 'config_files': ('talos/linux_config.py',), 02:20:06 INFO - 'default_actions': ('clobber', 02:20:06 INFO - 'read-buildbot-config', 02:20:06 INFO - 'download-and-extract', 02:20:06 INFO - 'populate-webroot', 02:20:06 INFO - 'create-virtualenv', 02:20:06 INFO - 'install', 02:20:06 INFO - 'run-tests'), 02:20:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:06 INFO - 'download_minidump_stackwalk': True, 02:20:06 INFO - 'download_symbols': 'ondemand', 02:20:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:06 INFO - 'installer_path': 'installer.exe', 02:20:06 INFO - 'log_level': 'info', 02:20:06 INFO - 'log_name': 'talos', 02:20:06 INFO - 'log_to_console': True, 02:20:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:06 INFO - 'opt_config_files': (), 02:20:06 INFO - 'pip_index': False, 02:20:06 INFO - 'sps_profile': False, 02:20:06 INFO - 'sps_profile_interval': 0, 02:20:06 INFO - 'suite': 'dromaeojs', 02:20:06 INFO - 'system_bits': '32', 02:20:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:06 INFO - 'title': 'talos-linux64-ix-014', 02:20:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:06 INFO - 'use_talos_json': True, 02:20:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:06 INFO - 'work_dir': 'build'} 02:20:06 INFO - ##### 02:20:06 INFO - ##### Running clobber step. 02:20:06 INFO - ##### 02:20:06 INFO - Running pre-action listener: _resource_record_pre_action 02:20:06 INFO - Running main action method: clobber 02:20:06 INFO - rmtree: /builds/slave/test/build 02:20:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:06 INFO - Running post-action listener: _resource_record_post_action 02:20:06 INFO - ##### 02:20:06 INFO - ##### Finished clobber step (success) 02:20:06 INFO - ##### 02:20:06 INFO - ##### 02:20:06 INFO - ##### Running read-buildbot-config step. 02:20:06 INFO - ##### 02:20:06 INFO - Running pre-action listener: _resource_record_pre_action 02:20:06 INFO - Running main action method: read_buildbot_config 02:20:06 INFO - Using buildbot properties: 02:20:06 INFO - { 02:20:06 INFO - "project": "", 02:20:06 INFO - "product": "firefox", 02:20:06 INFO - "script_repo_revision": "production", 02:20:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:20:06 INFO - "repository": "", 02:20:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:20:06 INFO - "buildid": "20160617233003", 02:20:06 INFO - "pgo_build": "True", 02:20:06 INFO - "basedir": "/builds/slave/test", 02:20:06 INFO - "buildnumber": 813, 02:20:06 INFO - "slavename": "talos-linux64-ix-014", 02:20:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:20:06 INFO - "platform": "ubuntu64_hw", 02:20:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:20:06 INFO - "branch": "fx-team", 02:20:06 INFO - "repo_path": "integration/fx-team", 02:20:06 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 02:20:06 INFO - "stage_platform": "linux64-pgo", 02:20:06 INFO - "builduid": "1c2b73f4bc20486abc510eb2e476775b", 02:20:06 INFO - "slavebuilddir": "test" 02:20:06 INFO - } 02:20:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:20:06 INFO - Running post-action listener: _resource_record_post_action 02:20:06 INFO - ##### 02:20:06 INFO - ##### Finished read-buildbot-config step (success) 02:20:06 INFO - ##### 02:20:06 INFO - ##### 02:20:06 INFO - ##### Running download-and-extract step. 02:20:06 INFO - ##### 02:20:06 INFO - Running pre-action listener: _resource_record_pre_action 02:20:06 INFO - Running main action method: download_and_extract 02:20:06 INFO - mkdir: /builds/slave/test/build/tests 02:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:06 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:13 INFO - Downloaded 1361 bytes. 02:20:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:13 INFO - Using the following test package requirements: 02:20:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'jsshell-linux-x86_64.zip'], 02:20:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:13 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')]} 02:20:13 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:14 INFO - Downloaded 24221020 bytes. 02:20:14 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'] 02:20:14 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 02:20:15 INFO - Return code: 0 02:20:15 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 02:20:15 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')]} 02:20:15 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:22 INFO - Downloaded 24221020 bytes. 02:20:22 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'] 02:20:22 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 02:20:23 INFO - Return code: 0 02:20: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')]} 02:20:23 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:24 INFO - Downloaded 14405384 bytes. 02:20:24 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'] 02:20:24 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 02:20:25 INFO - Return code: 0 02:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:25 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:26 INFO - Downloaded 60128862 bytes. 02:20:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:26 INFO - mkdir: /builds/slave/test/properties 02:20:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:26 INFO - Contents: 02:20:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:27 INFO - Running post-action listener: _resource_record_post_action 02:20:27 INFO - Running post-action listener: set_extra_try_arguments 02:20:27 INFO - ##### 02:20:27 INFO - ##### Finished download-and-extract step (success) 02:20:27 INFO - ##### 02:20:27 INFO - ##### 02:20:27 INFO - ##### Running populate-webroot step. 02:20:27 INFO - ##### 02:20:27 INFO - Running pre-action listener: _resource_record_pre_action 02:20:27 INFO - Running main action method: populate_webroot 02:20:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:27 INFO - '--tppagecycles', 02:20:27 INFO - '7'], 02:20:27 INFO - 'tests': ['tsvgm']}}, 02:20:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['damp', 'tps']}, 02:20:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'tests': ['damp', 'tps']}, 02:20:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['dromaeo_dom']}, 02:20:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['basic_compositor_video']}, 02:20:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['a11yr', 02:20:27 INFO - 'ts_paint', 02:20:27 INFO - 'tpaint', 02:20:27 INFO - 'sessionrestore', 02:20:27 INFO - 'sessionrestore_no_auto_restore', 02:20:27 INFO - 'tabpaint']}, 02:20:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['tsvgx', 02:20:27 INFO - 'tsvgr_opacity', 02:20:27 INFO - 'tart', 02:20:27 INFO - 'tscrollx', 02:20:27 INFO - 'cart']}, 02:20:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:27 INFO - 'tsvgr_opacity', 02:20:27 INFO - 'tart', 02:20:27 INFO - 'tscrollx', 02:20:27 INFO - 'cart']}, 02:20:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'talos_options': ['--disable-e10s'], 02:20:27 INFO - 'tests': ['tp5o']}, 02:20:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'tests': ['tp5o']}, 02:20:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'talos_options': ['--disable-e10s', 02:20:27 INFO - '--xperf_path', 02:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:27 INFO - 'tests': ['tp5n']}, 02:20:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:27 INFO - 'talos_options': ['--xperf_path', 02:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:27 INFO - 'tests': ['tp5n']}}, 02:20:27 INFO - 'talos.zip': {'path': '', 02:20:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:27 INFO - Running post-action listener: _resource_record_post_action 02:20:27 INFO - ##### 02:20:27 INFO - ##### Finished populate-webroot step (success) 02:20:27 INFO - ##### 02:20:27 INFO - ##### 02:20:27 INFO - ##### Running create-virtualenv step. 02:20:27 INFO - ##### 02:20:27 INFO - Running pre-action listener: _resource_record_pre_action 02:20:27 INFO - Running main action method: create_virtualenv 02:20:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:27 INFO - Using real prefix '/usr' 02:20:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:29 INFO - Installing pip.................done. 02:20:29 INFO - Return code: 0 02:20:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:29 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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:29 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 02:20:29 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 02:20:29 INFO - Using env: {'DISPLAY': ':0', 02:20:29 INFO - 'HOME': '/home/cltbld', 02:20:29 INFO - 'LANG': 'en_US.UTF-8', 02:20:29 INFO - 'LANGUAGE': 'en_US:en', 02:20:29 INFO - 'LOGNAME': 'cltbld', 02:20:29 INFO - 'MAIL': '/var/mail/cltbld', 02:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:29 INFO - 'MOZ_NO_REMOTE': '1', 02:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:29 INFO - 'NO_EM_RESTART': '1', 02:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:29 INFO - 'PWD': '/builds/slave/test', 02:20:29 INFO - 'SHELL': '/bin/bash', 02:20:29 INFO - 'SHLVL': '1', 02:20:29 INFO - 'TERM': 'linux', 02:20:29 INFO - 'TMOUT': '86400', 02:20:29 INFO - 'USER': 'cltbld', 02:20:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:29 INFO - '_': '/tools/buildbot/bin/python'} 02:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:30 INFO - Cleaning up... 02:20:30 INFO - Return code: 0 02:20:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:30 INFO - Using env: {'DISPLAY': ':0', 02:20:30 INFO - 'HOME': '/home/cltbld', 02:20:30 INFO - 'LANG': 'en_US.UTF-8', 02:20:30 INFO - 'LANGUAGE': 'en_US:en', 02:20:30 INFO - 'LOGNAME': 'cltbld', 02:20:30 INFO - 'MAIL': '/var/mail/cltbld', 02:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:30 INFO - 'MOZ_NO_REMOTE': '1', 02:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:30 INFO - 'NO_EM_RESTART': '1', 02:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:30 INFO - 'PWD': '/builds/slave/test', 02:20:30 INFO - 'SHELL': '/bin/bash', 02:20:30 INFO - 'SHLVL': '1', 02:20:30 INFO - 'TERM': 'linux', 02:20:30 INFO - 'TMOUT': '86400', 02:20:30 INFO - 'USER': 'cltbld', 02:20:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:30 INFO - '_': '/tools/buildbot/bin/python'} 02:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:30 INFO - Downloading/unpacking psutil>=3.1.1 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:32 INFO - Installing collected packages: psutil 02:20:32 INFO - Running setup.py install for psutil 02:20:32 INFO - building 'psutil._psutil_linux' extension 02:20:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:32 INFO - building 'psutil._psutil_posix' extension 02:20:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:32 INFO - Successfully installed psutil 02:20:32 INFO - Cleaning up... 02:20:32 INFO - Return code: 0 02:20:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:32 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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:32 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 02:20:32 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 02:20:32 INFO - Using env: {'DISPLAY': ':0', 02:20:32 INFO - 'HOME': '/home/cltbld', 02:20:32 INFO - 'LANG': 'en_US.UTF-8', 02:20:32 INFO - 'LANGUAGE': 'en_US:en', 02:20:32 INFO - 'LOGNAME': 'cltbld', 02:20:32 INFO - 'MAIL': '/var/mail/cltbld', 02:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:32 INFO - 'MOZ_NO_REMOTE': '1', 02:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:32 INFO - 'NO_EM_RESTART': '1', 02:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:32 INFO - 'PWD': '/builds/slave/test', 02:20:32 INFO - 'SHELL': '/bin/bash', 02:20:32 INFO - 'SHLVL': '1', 02:20:32 INFO - 'TERM': 'linux', 02:20:32 INFO - 'TMOUT': '86400', 02:20:32 INFO - 'USER': 'cltbld', 02:20:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:32 INFO - '_': '/tools/buildbot/bin/python'} 02:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:34 INFO - Installing collected packages: mozsystemmonitor 02:20:34 INFO - Running setup.py install for mozsystemmonitor 02:20:35 INFO - Successfully installed mozsystemmonitor 02:20:35 INFO - Cleaning up... 02:20:35 INFO - Return code: 0 02:20:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:20:35 INFO - Using env: {'DISPLAY': ':0', 02:20:35 INFO - 'HOME': '/home/cltbld', 02:20:35 INFO - 'LANG': 'en_US.UTF-8', 02:20:35 INFO - 'LANGUAGE': 'en_US:en', 02:20:35 INFO - 'LOGNAME': 'cltbld', 02:20:35 INFO - 'MAIL': '/var/mail/cltbld', 02:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:35 INFO - 'MOZ_NO_REMOTE': '1', 02:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:35 INFO - 'NO_EM_RESTART': '1', 02:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:35 INFO - 'PWD': '/builds/slave/test', 02:20:35 INFO - 'SHELL': '/bin/bash', 02:20:35 INFO - 'SHLVL': '1', 02:20:35 INFO - 'TERM': 'linux', 02:20:35 INFO - 'TMOUT': '86400', 02:20:35 INFO - 'USER': 'cltbld', 02:20:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:35 INFO - '_': '/tools/buildbot/bin/python'} 02:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:37 INFO - warning: no files found matching '*.txt' 02:20:37 INFO - no previously-included directories found matching 'build' 02:20:37 INFO - no previously-included directories found matching 'dist' 02:20:37 INFO - no previously-included directories found matching '.git*' 02:20:37 INFO - Installing collected packages: jsonschema, functools32 02:20:37 INFO - Running setup.py install for functools32 02:20:37 INFO - warning: no files found matching '*.txt' 02:20:37 INFO - no previously-included directories found matching 'build' 02:20:37 INFO - no previously-included directories found matching 'dist' 02:20:37 INFO - no previously-included directories found matching '.git*' 02:20:37 INFO - Successfully installed jsonschema functools32 02:20:37 INFO - Cleaning up... 02:20:37 INFO - Return code: 0 02:20:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:37 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 02:20:37 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 02:20:37 INFO - Using env: {'DISPLAY': ':0', 02:20:37 INFO - 'HOME': '/home/cltbld', 02:20:37 INFO - 'LANG': 'en_US.UTF-8', 02:20:37 INFO - 'LANGUAGE': 'en_US:en', 02:20:37 INFO - 'LOGNAME': 'cltbld', 02:20:37 INFO - 'MAIL': '/var/mail/cltbld', 02:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:37 INFO - 'MOZ_NO_REMOTE': '1', 02:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:37 INFO - 'NO_EM_RESTART': '1', 02:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:37 INFO - 'PWD': '/builds/slave/test', 02:20:37 INFO - 'SHELL': '/bin/bash', 02:20:37 INFO - 'SHLVL': '1', 02:20:37 INFO - 'TERM': 'linux', 02:20:37 INFO - 'TMOUT': '86400', 02:20:37 INFO - 'USER': 'cltbld', 02:20:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:37 INFO - '_': '/tools/buildbot/bin/python'} 02:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:40 INFO - Downloading docopt-0.6.1.tar.gz 02:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:40 INFO - Running setup.py install for blobuploader 02:20:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:40 INFO - Running setup.py install for requests 02:20:41 INFO - Running setup.py install for docopt 02:20:41 INFO - Successfully installed blobuploader requests docopt 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:41 INFO - Using env: {'DISPLAY': ':0', 02:20:41 INFO - 'HOME': '/home/cltbld', 02:20:41 INFO - 'LANG': 'en_US.UTF-8', 02:20:41 INFO - 'LANGUAGE': 'en_US:en', 02:20:41 INFO - 'LOGNAME': 'cltbld', 02:20:41 INFO - 'MAIL': '/var/mail/cltbld', 02:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:41 INFO - 'MOZ_NO_REMOTE': '1', 02:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:41 INFO - 'NO_EM_RESTART': '1', 02:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:41 INFO - 'PWD': '/builds/slave/test', 02:20:41 INFO - 'SHELL': '/bin/bash', 02:20:41 INFO - 'SHLVL': '1', 02:20:41 INFO - 'TERM': 'linux', 02:20:41 INFO - 'TMOUT': '86400', 02:20:41 INFO - 'USER': 'cltbld', 02:20:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:41 INFO - '_': '/tools/buildbot/bin/python'} 02:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:41 INFO - Running setup.py (path:/tmp/pip-P2b1iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:41 INFO - Running setup.py (path:/tmp/pip-BtZ03r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:41 INFO - Running setup.py (path:/tmp/pip-sp5XZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:41 INFO - Running setup.py (path:/tmp/pip-6y25Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:41 INFO - Running setup.py (path:/tmp/pip-lslNKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:41 INFO - Running setup.py (path:/tmp/pip-imE8Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:41 INFO - Running setup.py (path:/tmp/pip-Zo4eZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:41 INFO - Running setup.py (path:/tmp/pip-dWShOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:41 INFO - Running setup.py (path:/tmp/pip-YumuKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:42 INFO - Running setup.py (path:/tmp/pip-y1w28P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:42 INFO - Running setup.py (path:/tmp/pip-Sn9Yhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:42 INFO - Running setup.py (path:/tmp/pip-eUM4Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:42 INFO - Running setup.py (path:/tmp/pip-ZGscPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:42 INFO - Running setup.py (path:/tmp/pip-OA5BXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:42 INFO - Running setup.py (path:/tmp/pip-nOfqE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:42 INFO - Running setup.py (path:/tmp/pip-TB0LTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:42 INFO - Running setup.py (path:/tmp/pip-x77xJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:42 INFO - Running setup.py install for manifestparser 02:20:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:42 INFO - Running setup.py install for mozcrash 02:20:42 INFO - Running setup.py install for mozdebug 02:20:42 INFO - Running setup.py install for mozdevice 02:20:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozfile 02:20:43 INFO - Running setup.py install for mozhttpd 02:20:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozinfo 02:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozInstall 02:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozleak 02:20:43 INFO - Running setup.py install for mozlog 02:20:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for moznetwork 02:20:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozprocess 02:20:43 INFO - Running setup.py install for mozprofile 02:20:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:43 INFO - Running setup.py install for mozrunner 02:20:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:44 INFO - Running setup.py install for mozscreenshot 02:20:44 INFO - Running setup.py install for moztest 02:20:44 INFO - Running setup.py install for mozversion 02:20:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:44 INFO - Cleaning up... 02:20:44 INFO - Return code: 0 02:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:44 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')]} 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:44 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')]} 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:44 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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:44 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 02:20:44 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 02:20:44 INFO - Using env: {'DISPLAY': ':0', 02:20:44 INFO - 'HOME': '/home/cltbld', 02:20:44 INFO - 'LANG': 'en_US.UTF-8', 02:20:44 INFO - 'LANGUAGE': 'en_US:en', 02:20:44 INFO - 'LOGNAME': 'cltbld', 02:20:44 INFO - 'MAIL': '/var/mail/cltbld', 02:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:44 INFO - 'MOZ_NO_REMOTE': '1', 02:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:44 INFO - 'NO_EM_RESTART': '1', 02:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:44 INFO - 'PWD': '/builds/slave/test', 02:20:44 INFO - 'SHELL': '/bin/bash', 02:20:44 INFO - 'SHLVL': '1', 02:20:44 INFO - 'TERM': 'linux', 02:20:44 INFO - 'TMOUT': '86400', 02:20:44 INFO - 'USER': 'cltbld', 02:20:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:44 INFO - '_': '/tools/buildbot/bin/python'} 02:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:44 INFO - Running setup.py (path:/tmp/pip-3I3fTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:44 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)) 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:44 INFO - Running setup.py (path:/tmp/pip-jfn8SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:44 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)) 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:44 INFO - Running setup.py (path:/tmp/pip-wtxrjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:44 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)) 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:44 INFO - Running setup.py (path:/tmp/pip-STv_VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:44 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)) 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:44 INFO - Running setup.py (path:/tmp/pip-xpd_1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:44 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)) 02:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:44 INFO - Running setup.py (path:/tmp/pip-dwQlbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:45 INFO - Running setup.py (path:/tmp/pip-UvH6Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:45 INFO - Running setup.py (path:/tmp/pip-IRZ1TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:45 INFO - Running setup.py (path:/tmp/pip-RgmICg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:45 INFO - Running setup.py (path:/tmp/pip-T3tt_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:45 INFO - Running setup.py (path:/tmp/pip-7hAvbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:45 INFO - Running setup.py (path:/tmp/pip-DYEV3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:45 INFO - Running setup.py (path:/tmp/pip-g7JtMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:45 INFO - Running setup.py (path:/tmp/pip-Defd09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:45 INFO - Running setup.py (path:/tmp/pip-cr6Zj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:45 INFO - Running setup.py (path:/tmp/pip-UDqjwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:45 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)) 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:45 INFO - Running setup.py (path:/tmp/pip-p27BIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:45 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)) 02:20:45 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)) 02:20:45 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)) 02:20:45 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)) 02:20:45 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)) 02:20:45 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)) 02:20:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:47 INFO - Downloading blessings-1.6.tar.gz 02:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:47 INFO - Installing collected packages: blessings 02:20:47 INFO - Running setup.py install for blessings 02:20:47 INFO - Successfully installed blessings 02:20:47 INFO - Cleaning up... 02:20:47 INFO - Return code: 0 02:20:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:48 INFO - Reading from file tmpfile_stdout 02:20:48 INFO - Current package versions: 02:20:48 INFO - argparse == 1.2.1 02:20:48 INFO - blessings == 1.6 02:20:48 INFO - blobuploader == 1.2.4 02:20:48 INFO - docopt == 0.6.1 02:20:48 INFO - functools32 == 3.2.3-2 02:20:48 INFO - jsonschema == 2.5.1 02:20:48 INFO - manifestparser == 1.1 02:20:48 INFO - mozInstall == 1.12 02:20:48 INFO - mozcrash == 0.17 02:20:48 INFO - mozdebug == 0.1 02:20:48 INFO - mozdevice == 0.48 02:20:48 INFO - mozfile == 1.2 02:20:48 INFO - mozhttpd == 0.7 02:20:48 INFO - mozinfo == 0.9 02:20:48 INFO - mozleak == 0.1 02:20:48 INFO - mozlog == 3.2 02:20:48 INFO - moznetwork == 0.27 02:20:48 INFO - mozprocess == 0.22 02:20:48 INFO - mozprofile == 0.28 02:20:48 INFO - mozrunner == 6.11 02:20:48 INFO - mozscreenshot == 0.1 02:20:48 INFO - mozsystemmonitor == 0.3 02:20:48 INFO - moztest == 0.7 02:20:48 INFO - mozversion == 1.4 02:20:48 INFO - psutil == 3.1.1 02:20:48 INFO - requests == 1.2.3 02:20:48 INFO - wsgiref == 0.1.2 02:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 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 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:48 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 02:20:48 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 02:20:48 INFO - Using env: {'DISPLAY': ':0', 02:20:48 INFO - 'HOME': '/home/cltbld', 02:20:48 INFO - 'LANG': 'en_US.UTF-8', 02:20:48 INFO - 'LANGUAGE': 'en_US:en', 02:20:48 INFO - 'LOGNAME': 'cltbld', 02:20:48 INFO - 'MAIL': '/var/mail/cltbld', 02:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:48 INFO - 'MOZ_NO_REMOTE': '1', 02:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:48 INFO - 'NO_EM_RESTART': '1', 02:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:48 INFO - 'PWD': '/builds/slave/test', 02:20:48 INFO - 'SHELL': '/bin/bash', 02:20:48 INFO - 'SHLVL': '1', 02:20:48 INFO - 'TERM': 'linux', 02:20:48 INFO - 'TMOUT': '86400', 02:20:48 INFO - 'USER': 'cltbld', 02:20:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:48 INFO - '_': '/tools/buildbot/bin/python'} 02:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 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)) 02:20:48 INFO - Cleaning up... 02:20:48 INFO - Return code: 0 02:20:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:48 INFO - Using env: {'DISPLAY': ':0', 02:20:48 INFO - 'HOME': '/home/cltbld', 02:20:48 INFO - 'LANG': 'en_US.UTF-8', 02:20:48 INFO - 'LANGUAGE': 'en_US:en', 02:20:48 INFO - 'LOGNAME': 'cltbld', 02:20:48 INFO - 'MAIL': '/var/mail/cltbld', 02:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:48 INFO - 'MOZ_NO_REMOTE': '1', 02:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:48 INFO - 'NO_EM_RESTART': '1', 02:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:48 INFO - 'PWD': '/builds/slave/test', 02:20:48 INFO - 'SHELL': '/bin/bash', 02:20:48 INFO - 'SHLVL': '1', 02:20:48 INFO - 'TERM': 'linux', 02:20:48 INFO - 'TMOUT': '86400', 02:20:48 INFO - 'USER': 'cltbld', 02:20:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:48 INFO - '_': '/tools/buildbot/bin/python'} 02:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:48 INFO - Cleaning up... 02:20:48 INFO - Return code: 0 02:20:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff97f698f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, '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': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', '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 02:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:20:48 INFO - Using env: {'DISPLAY': ':0', 02:20:48 INFO - 'HOME': '/home/cltbld', 02:20:48 INFO - 'LANG': 'en_US.UTF-8', 02:20:48 INFO - 'LANGUAGE': 'en_US:en', 02:20:48 INFO - 'LOGNAME': 'cltbld', 02:20:48 INFO - 'MAIL': '/var/mail/cltbld', 02:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:48 INFO - 'MOZ_NO_REMOTE': '1', 02:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:48 INFO - 'NO_EM_RESTART': '1', 02:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:48 INFO - 'PWD': '/builds/slave/test', 02:20:48 INFO - 'SHELL': '/bin/bash', 02:20:48 INFO - 'SHLVL': '1', 02:20:48 INFO - 'TERM': 'linux', 02:20:48 INFO - 'TMOUT': '86400', 02:20:48 INFO - 'USER': 'cltbld', 02:20:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:48 INFO - '_': '/tools/buildbot/bin/python'} 02:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:48 INFO - Downloading/unpacking flake8 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:51 INFO - no previously-included directories found matching 'docs/_build' 02:20:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:51 INFO - Running setup.py install for pep8 02:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:51 INFO - no previously-included directories found matching 'docs/_build' 02:20:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:51 INFO - Cleaning up... 02:20:51 INFO - Return code: 0 02:20:51 INFO - Running post-action listener: _resource_record_post_action 02:20:51 INFO - Running post-action listener: _start_resource_monitoring 02:20:51 INFO - Starting resource monitoring. 02:20:51 INFO - ##### 02:20:51 INFO - ##### Finished create-virtualenv step (success) 02:20:51 INFO - ##### 02:20:51 INFO - ##### 02:20:51 INFO - ##### Running install step. 02:20:51 INFO - ##### 02:20:51 INFO - Running pre-action listener: _resource_record_pre_action 02:20:51 INFO - Running main action method: install 02:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:51 INFO - Reading from file tmpfile_stdout 02:20:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:52 INFO - Reading from file tmpfile_stdout 02:20:52 INFO - Output received: 02:20:52 INFO - Usage: mozinstall [options] installer 02:20:52 INFO - Options: 02:20:52 INFO - -h, --help show this help message and exit 02:20:52 INFO - -d DEST, --destination=DEST 02:20:52 INFO - Directory to install application into. [default: 02:20:52 INFO - "/builds/slave/test"] 02:20:52 INFO - --app=APP Application being installed. [default: firefox] 02:20:52 INFO - mkdir: /builds/slave/test/build/application 02:20:52 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'] 02:20:52 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 02:21:09 INFO - Reading from file tmpfile_stdout 02:21:09 INFO - Output received: 02:21:09 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:09 INFO - Running post-action listener: _resource_record_post_action 02:21:09 INFO - ##### 02:21:09 INFO - ##### Finished install step (success) 02:21:09 INFO - ##### 02:21:09 INFO - ##### 02:21:09 INFO - ##### Running run-tests step. 02:21:09 INFO - ##### 02:21:09 INFO - Running pre-action listener: _resource_record_pre_action 02:21:09 INFO - Running main action method: run_tests 02:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:09 INFO - Python 2.7.3 02:21:09 INFO - Return code: 0 02:21:09 INFO - grabbing minidump binary from tooltool 02:21:09 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')]} 02:21:09 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 0x2c3b1c0>, '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 0x2c3c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:09 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 02:21:09 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 02:21:09 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 02:21:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:09 INFO - Return code: 0 02:21:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:21:10 INFO - Return code: 0 02:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:21:10 INFO - Using env: {'DISPLAY': ':0', 02:21:10 INFO - 'HOME': '/home/cltbld', 02:21:10 INFO - 'LANG': 'en_US.UTF-8', 02:21:10 INFO - 'LANGUAGE': 'en_US:en', 02:21:10 INFO - 'LOGNAME': 'cltbld', 02:21:10 INFO - 'MAIL': '/var/mail/cltbld', 02:21:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:10 INFO - 'MOZ_NO_REMOTE': '1', 02:21:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:10 INFO - 'NO_EM_RESTART': '1', 02:21:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:10 INFO - 'PWD': '/builds/slave/test', 02:21:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:10 INFO - 'SHELL': '/bin/bash', 02:21:10 INFO - 'SHLVL': '1', 02:21:10 INFO - 'TERM': 'linux', 02:21:10 INFO - 'TMOUT': '86400', 02:21:10 INFO - 'USER': 'cltbld', 02:21:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746', 02:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:10 INFO - '_': '/tools/buildbot/bin/python'} 02:21:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:21:10 INFO - mozversion application_buildid: 20160617233003 02:21:10 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:21:10 INFO - mozversion application_display_name: Nightly 02:21:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:10 INFO - mozversion application_name: Firefox 02:21:10 INFO - mozversion application_remotingname: firefox 02:21:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:10 INFO - mozversion application_vendor: Mozilla 02:21:10 INFO - mozversion application_version: 50.0a1 02:21:10 INFO - mozversion platform_buildid: 20160617233003 02:21:10 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:21:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:10 INFO - mozversion platform_version: 50.0a1 02:21:10 INFO - using testdate: 1466241670 02:21:10 INFO - actual date: 1466241670 02:21:10 INFO - starting webserver on 'localhost:57681' 02:21:10 INFO - SUITE-START | Running 2 tests 02:21:10 INFO - TEST-START | dromaeo_css 02:21:10 INFO - operating with platform_type : linux_ 02:21:10 INFO - Initialising browser for dromaeo_css test... 02:21:10 INFO - TEST-INFO | started process 4078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu3vU2D/profile http://localhost:57681/getInfo.html) 02:21:14 INFO - PROCESS | 4078 | __metrics Screen width/height:1600/1200 02:21:14 INFO - PROCESS | 4078 | colorDepth:24 02:21:14 INFO - PROCESS | 4078 | Browser inner width/height: 1024/697 02:21:14 INFO - PROCESS | 4078 | __metrics 02:21:15 INFO - PROCESS | 4078 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:16 INFO - TEST-INFO | 4078: exit 0 02:21:16 INFO - Browser initialized. 02:21:16 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:16 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu3vU2D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:28 INFO - PROCESS | 4159 | RSS: Main: 174198784 02:21:28 INFO - PROCESS | 4159 | 02:22:19 INFO - PROCESS | 4159 | 1466241739374 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] 02:24:28 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57681/tests/dromaeo/cssquery-ext.html) 02:24:29 INFO - PROCESS | 4159 | RSS: Main: 247513088 02:24:29 INFO - PROCESS | 4159 | 02:27:31 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-ext.html (next: http://localhost:57681/tests/dromaeo/cssquery-jquery.html) 02:27:32 INFO - PROCESS | 4159 | RSS: Main: 254812160 02:27:32 INFO - PROCESS | 4159 | 02:30:34 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57681/tests/dromaeo/cssquery-mootools.html) 02:30:34 INFO - PROCESS | 4159 | RSS: Main: 260661248 02:30:34 INFO - PROCESS | 4159 | 02:33:37 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57681/tests/dromaeo/cssquery-prototype.html) 02:33:37 INFO - PROCESS | 4159 | RSS: Main: 266604544 02:33:37 INFO - PROCESS | 4159 | 02:36:40 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57681/tests/dromaeo/cssquery-yui.html) 02:36:40 INFO - PROCESS | 4159 | RSS: Main: 228958208 02:36:40 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:57681/tests/dromaeo/cssquery-yui.html (next: http://localhost:57681/tests/dromaeo/cssquery-dojo.html) 02:39:43 INFO - PROCESS | 4159 | RSS: Main: 291446784 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | __start_tp_report 02:39:43 INFO - PROCESS | 4159 | _x_x_mozilla_page_load 02:39:43 INFO - PROCESS | 4159 | _x_x_mozilla_page_load_details 02:39:43 INFO - PROCESS | 4159 | |i|pagename|runs| 02:39:43 INFO - PROCESS | 4159 | |0;dojo.html;3108.5492603572484;3113.7508999280058;3139.2779660678043;3149.3228955774534;3165.240342317843;5334.413214546396;5397.568194544437;5400.513953744162;5465.91801122983;5486.423925487821;5421.21392398102;5445.754941027653;5457.972710136443;5491.066518691822;5501.697406642633;4881.4630390657085;4965.950340496603;4991.201407774757;5021.372328458942;5166.044281807877;5085.262636917645;5134.537891589756;5136.768845401966;5160.277561141444;5161.27742116104;4878.756062196876;4901.779419926112;4937.259411088329;4982.651214414992;5023.0707319145895;4947.6289278304275;4960.454350021495;4967.056259310755;5027.547520723152;5060.367454068241;4988.152014157566;4989.451160372356;4998.525140111684;5004.9499505005215;5054.772535235923;5342.358916929955;5349.224362467459;5424.1321388578035;5544.22380866679;5555.805546805843;5764.452377024218;5802.216700745387;5809.448102430262;5818.767249310023;5821.708914554255;5864.266966629171;5910.940890591082;5928.40715928408;5931.051031834886;5933.703314834241;5340.225667278223;5365.543928766059;5403.459654034565;5409.377921538995;5480.890382192334;5991.460768530853;6054.788082417094;6059.848503787441;6060.909086363708;6064.787732429344;5753.367129615739;5796.536277097822;5807;5808.215890854765;5812.9709351452975;5647.407022262603;5759.366469688331;5803.622764520293;5807.216025836543;5835.416458354131;5772.509336706343;5776.046952252916;5786.826395208151;5796.304443466811;5798.304203495523;5565.30433695788;5782.3639399666;5810.389909059572;5826.533877289807;5826.796062137805;4352.434183556117;4384.123175364876;4393.1872603568445;4430.8449204277695;4438.334249862546;3927.3323534999117;3934.9803250984132;3952.1898010907694;3958.980205099014;3976.9602303977167;5354.143337066051;5458.617896747269;5534.1145416733125;5539.19681646159;5542.722863856871;5827.708614569339;5863.589548731547;5894.557908156906;5895.616784908967;5913.970430147821;5541.418151094158;5559.471850174227;5561.138023606348;5562.554995600423;5568.832935011957;4641.071785642885;4690.413698287714;4759.357486739315;4796.25658023007;4846.297286893451;5980.162777211194;5985.9401405986255;5988.131720900532;5988.999999999913;6030.879382412415;5823.7379317929945;5833.883322333614;5835.56233282514;5836.941630583639;5861.853453663693;5848.210491583582;5910.734016969161;5956.463918247378;5977.462028417463;5999.400059993965;5771.595988280948;5774.931637647049;5775.711214439345;5782.306123265235;5785.942140578709;5805.303363596396;5810.94189058104;5835.124731290341;5864.44287792659;5867.237259156283;5489.121740521658;5579.358373786904;5622.690752008679;5639.436056394327;5666.744996475086;5664.603477756682;5674.035413979551;5674.205611214351;5678.4605462480995;5678.801241956512;5477.4248703887115;5577.832665020056;5594.13290939905;5594.9720251398485;5598.356189038313;5516.724163791875;5564.972175139098;5667.036603777286;5748.6838223898085;5758.337791154071;5425.647332923348;5439.6464229826515;5491.588130890279;5494.917576236439;5495.972520137374 02:39:43 INFO - PROCESS | 4159 | |1;ext.html;570.6347937320115;599.9130126131711;620.857202843346;623.7473823101643;640.4780104215067;29862.40275194495;30586.694133058663;33020.33959320812;33122;33147.50278745821;34228;42481.787591062;43202.78398608002;43228.78385608076;47022.52977470224;8879.334049946263;8994.370394072417;9002.909970900273;9014.414063085878;9020.729378118667;8616.956915215447;8697.956510217471;8698.826023479527;8708.259797917184;8711.128887111301;8926.687565935194;8985.460872347647;8991.550422478882;8992.145746154138;8998.415103018315;8972.820543589125;8995.41529800564;9003.189712925836;9013.549322533847;9020.954895225548;8794.12058794122;8867.379283450162;8872.512011839346;8873.378863479495;8874.068222836639;42112;42484.15031699379;42499.787501062296;42506.57493425057;42540.57459425428;3603.765755225902;3668.8899333020054;3903.6291552302487;4043.1711499142607;4147.149834283965;31493.842530787428;32089.51865722016;32595;33747.32505349879;33824.154396140046;4091.774952377618;4112.588741125894;4193.643540299078;4200.201961627281;4224.894377640553;347143;347557;349016;349529;350905;58059;58066;58484.41515584875;58531.12203316954;58531.41468585345;52545.47454525482;52549.2117618236;52621.473785262424;52708.73645631747;54354;13294.734105317839;13798.034137610272;13799.724005520035;14130.50543230982;14140.717185656229;9887.45618990948;9920.40477571348;9934.50327483623;9937.254705897087;9939.105480506789;16003.839961600468;17587;17735.73396399055;18241.17914693842;18366.540836479195;6556.114924485229;6677.3656502632175;6725.831854203586;6761.290064543152;6781.287964763727;922.4050487435567;1044.33162775822;1060.4538662588773;1172.8592568891618;1189.7858385490522;30705.435502257285;32208.19479512984;32288;32400.351992960008;32574.348513029607;1071.0574694268994;1088.118623914616;1106.3804269608884;1173.3546549397797;1195.7429152732204;16733.66532669364;17139.91430042842;17157;17209.483715488554;17557.507611853136;509198;513580;513984;514747;525810;57185.71407142938;57345.13982290269;57363.71318143383;57411.42588574061;57431.42568574261;1259.5402678022456;1281.7756892543769;1327.9933600332129;1330.700592366729;1339.71196192819;30554.694453056076;31375.21561960969;31671.84164079165;31797;32231.516527251642;50666.493335066174;51127.2330915044;51151.74424127855;51176.74411627918;51180;408068;414204;415603;416989;417455;35266.11834704153;35775.64224357723;37257;42258;42767.572324276356;37594.24811503809;40788.59211407966;41230.1753964925;44805.32792008188;46536.767316163205;36266.63733362738;40017;41153.79423102865;41838.79080604699;42534.361984570874;38282.80858595689;40204.59795402126;40472.79763601163;43231.35152972771;44328.778356108014;39445.60554394419;39572;39893.40159897662;40271.79864100661;41281.58718412898;34288.0855127317;36206.818965905004;36880.44679329758;36929.63070369262;36975.44536832003;25778.871105644354;25801.870990644926;25811.225663230132;26393.340166495993;26509.734902650725 02:39:43 INFO - PROCESS | 4159 | |2;jquery.html;362.18146987807546;378.782200234865;379.9445002536278;385.70878986365295;403.82635466749304;15501.457448989288;17188.226529806157;18531.351402700926;18941.715874261896;19621.215151393964;17312.56718582036;17312.653746925054;17514.649707005854;17592.648147037053;17720.64558708825;5390.380106287788;5638.267025286707;5664.886702265952;5684.630499017571;5685.744141513621;5285.841424757245;5611.354694210157;5614.466625670575;5629.4652008059165;5630.662160270376;5563.276774019372;5564;5566.109422492402;5566.8608284793;5569.997400467914;5323.9467605324035;5533.723313834333;5550.72246387681;5551.139573366135;5552.056150454412;4855.975720121412;4939.654224204307;4953.752312384402;4962.925556116661;4963.379577552806;21377.03803328854;22148;22244;22316.107355705753;22538.09847606094;2329.801966832821;2444.5355382477273;2749.6801535263185;2750.2161883863005;2933.0467598030727;14102.224377659224;14373.065750726273;14410.855891441057;14497.202653854034;14747.336369863382;1945.9902700486548;1964.430315208588;1972.30969160794;1977.4364306172815;2026.5440275937945;78257.21742782556;78492.60753696252;80477.59761201215;80867.59566202131;81495.59252203761;10134.290599658101;10240.743981400525;10309.432981185957;10711.196660250513;10720.73198170052;14158.64603384903;14208.360623771749;14310.49913253052;14316.28418579067;14341.498047568284;7158.2841715828;7197.316254955771;7208.531445456028;7215.603141827145;7275;6650.70071846768;6703.430208432241;6787.21946976104;6825.249222585511;6831.351021652935;6299.5275354348605;6468.094466774655;6474.546781725328;6611.900821487681;6674.933250667528;1794.5154808201712;1870.8316251537426;1881.2098918454283;1890.3383815664683;1891.3285783546644;850.2050582705191;936.2182577547824;950.95720692569;987.3532835992437;1082.9187810914214;17890.463286101436;18628.627427451647;18642.720359194624;19083.332083377016;19473.31843385503;959.8944116147218;969.4667932637021;1008.4000019988096;1010.282699283517;1022.9181665466745;10244.590216391261;10893.673189804318;10985.560577576967;10995.285306455055;11123.110151187886;474785;485546;486282;486550;490005;82373;82823.5858820714;85104.57447712721;85137;85424.57287713522;989.4409658543044;993.0863605482973;1035.963741269052;1057.7197042783669;1064.3454275620438;16749.91625041867;16911.408100716417;17149.657006859543;17245.741313880553;17538.123093845003;32267.677323227406;35626;38816.447342106;39530.802345988086;40348;51434;52828.20757688561;53126.4687353137;53519.19721204263;54141.18788218101;7284.854302914018;7519.548827070394;7822.217778222132;8407.663693452194;8468.534230617375;12809.359532023547;13172.143810652276;13386.129901556367;13575.38910748999;13668.179909205479;11134;11294.717632059264;11391.088712903114;11779;11929.582464613697;10900.509477073709;11101.67344688322;11305.71735706614;11432.428378581204;11741.354225517336;11647.76704465923;11752.58865939688;11786.46960886745;12022.75954480888;12045.75908481843;7772.417068719756;7962.442629015914;8016.7194148204535;8022.398320125897;8036.276735093869;11083.445827708743;11315.038221751243;11458.4270786462;11681.182317237712;11731.23746956445 02:39:43 INFO - PROCESS | 4159 | |3;mootools.html;1273.4524154613523;1434.8708616224537;1450.7896355028522;1576.858082772551;1735.4359833054261;8358.247757701805;8745.825083498334;8757.956210218948;9002.099790021011;9004.639814407416;8696.39125261232;8839.734807955756;8858.069902660209;8859.20267175954;8875.91124088759;2025.5442525431733;2274.1471948019494;2324.872132032746;2341.941451463714;2382.249591378719;2313.178821518362;2319.4433335999324;2325.6046472099783;2330.137848995874;2339.3800642829665;2281.0875649740155;2286.8170546356337;2303.1823702585593;2311.295055008222;2312.919047833326;1994.1923520974028;2053.1068984991575;2217.789310015546;2227.4765430123907;2274.6701728249313;2330.5804955108074;2337.053493335202;2343.6367363058753;2348.5302939412013;2356.5640356534095;9020.548972551345;9085.81828363429;9087.545622718837;9091.31815113869;9091.954540227323;5232.476752324737;5363.758630861621;5369.114096174166;5375.704336261504;5376.11294136467;3080.383923215366;3205.6954589313978;3256.739460843127;3260.983695081533;3263.1026467721567;1111.5053801058452;1117.3463523838564;1150.9942450287779;1154.6766905266538;1162.1690491298677;12930.09489335747;12945.741085178244;12958.416871240817;12962.157459765085;12999.350032498338;4783.641226907996;4793.592544633675;4883.780229889663;4895.118878601815;4904.215325547966;10562.31344962575;10569.101626361846;10592;10592.682219533426;10682.78634427307;5093.388793344749;5161.535461808456;5354.839354819362;5355.303810504687;5362.973185134049;4293.184294983943;4752.976235118802;4898.510148985144;4909.140900342497;4969.204927211629;3747.9437808432895;3843.2505661396317;3883.30100581898;3923.9803800980812;3941.5467221269346;1251.4305990774176;1266.4174479739238;1271.9364031798373;1272.2875189893505;1290.9031822613154;866.7573079537614;873.5282947208436;982.3909176310733;991.0683957080322;998.9001099889953;5991.712009664347;6069.180660610849;6100.0849872519475;6180.876382472416;6233.283172435228;433.20939285803536;434.4894748670363;440.6584896705015;441.0473377504575;455.83817744700815;4252.91494170121;4338.045629961466;4381.496127945327;4386.276264416336;4454.198244316054;10840.837387439195;11149.16381271408;11209.439528023566;11239;11252.043576295942;11056.557737690402;11114.888851111547;11182.16133789969;11357.886421135849;11362.545498180145;8093.069297030799;8220.424570280142;8243.917560824435;8260.380471464545;8352.958235208785;6151.477124444473;6205.906911396423;6228;6291.213598300213;6353.872922541431;10365.274430789772;10373.481325933824;10379.06588407047;10533.10468610146;10537.315074520131;9914.752131196488;10316.793664126826;10326.225533084898;10568.260221784401;10585.417802020962;7146.9285307146265;7319.121705395387;7351.632418378953;7989.600519974094;8149.225823546753;8220.917790822254;8406.537640429835;8701.738947831574;8710.041895391376;8963.282937364866;7648.120466146242;7797.103333116765;7808.219178082147;7815.570143642154;8145.307648849915;7915.1293357729455;7991.200879911962;8023.518588884685;8066.314363279187;8126.796830079295;7217.06178196831;7303.561786292839;7393.334599886036;7394.075740532434;7396.667149978156;5387.272718182995;5482.945170548243;5506.091494903296;5602.411746766694;5633.436656334334;5249.868753281198;5343.946560534345;5444.700541470257;5461.262729531462;5532.1425179097305 02:39:43 INFO - PROCESS | 4159 | |4;prototype.html;323.5357262328559;327.7984039815513;332.72550146129447;332.7920049968769;333.66966702964055;5409.7827988702575;5446.455354464551;5463.480969307914;5484.670919744808;5504.311961004874;5304.681719096857;5313.149896016638;5392.514673679368;5400.675959442427;5412.565670097418;4150;4214.47131720968;4232.76719780412;4245.617894389505;4256.723312984646;4182.5190103138075;4210.3894935234375;4229.746215227081;4251.659867210616;4279.037216626265;4207.368894665809;4224.936625950613;4230.851920182794;4237.724547904377;4248.9575104249025;4037.2329257440992;4039.2123535910364;4154.774341569214;4183.163367326547;4225.281702110648;3676.8417948346455;3684.889453316405;3684.9631503684886;3695.334839728848;3720.776753394778;5194.142966410538;5198.610104242159;5223.895522089575;5230.712310822903;5258.894822103574;4517.9774101129615;4522.29904364824;4660.578523550315;4673.766311684436;4729.148753224418;5479.369872464677;5501.449855014506;5511.255980442629;5519.889602207973;5532.944670553324;4013.9197216055513;4015.297322968498;4034.132661477767;4052.371882358239;4063.6545893599077;5520.309961254843;5667.263255776764;5779;5808.448197421239;5828.591998560145;4083.816228269735;4091.5703851095204;4098.856540021085;4117.97941010293;4151.398047283127;4179.561146079618;4185.183889141588;4189.4344263524645;4190.350495673115;4193.706440549132;4664.207084795593;4722.456917454468;4727.834525791581;4728.030753695484;4739.170645137087;5568.749406276727;5573.637713548606;5612.326520817528;5683.232763576947;5687.317521897398;1413.861841217809;1419.9077059991068;1428.728541577097;1441.2865631512468;1443.2134486704772;920.6869664314165;926.6756635177634;956.6269155029544;970.8834939807127;973.2700474644017;5322.33470816148;5340.973295133577;5344.545713614386;5353.785848566014;5365.704886231295;5621.550275977994;5640.615630621594;5693.715314234271;5703.315602127771;5741.282339707536;5177.870553236199;5256.8697729988235;5348.732563371894;5428.9185662215095;5461.836144915659;2981.6123903892353;3020.3808219314988;3046.45163870501;3065.834982706557;3075.4925437302595;5869.853253668693;5932;5936.703164841827;5949.791757288474;5960.970195149083;5581.962583657018;5770.221020162308;5850.882982340329;5853.1220316952795;5897.587168898136;5885.116762636001;5900.321463031721;5939.792107276225;5944.8811023780145;5955.672438015864;5469.206964989975;5674.460926212003;5712.80005199816;5796.913046304393;5797.130430435468;5663;5692.943070569241;5715.114157305624;5725.856853578527;5759.308882934075;5897.41025897424;5960.523158147251;5974.402559744165;5995.670238136944;6014.789482368096;3986.262541429845;4048.676105911461;4067.7355971861734;4090.9795451022555;4095.24238015968;5737.91393129095;5762.394948530344;5781.94218057814;5786.392428794916;5816.970915145397;5467.507924286833;5662.7734890603915;5678.659280443187;5687.800926967702;5730.194988578751;5626.2967129108865;5650.491455768836;5659.801906933238;5662.858428539154;5688.288963879515;5579.609427340048;5585.799053203581;5597.44025597437;5619.775208991595;5625.015622266169;5437.673739575638;5672.14917762339;5683.72116273835;5694.743736531783;5706.400827913009;5532.529734972572;5575.4424557543925;5579.832605021694;5581.358143813513;5583.4416558345465 02:39:43 INFO - PROCESS | 4159 | |5;yui.html;612.4855121697774;616.685490399896;668.8628831089624;678.1861765880944;708.9432845372371;13509.256990865499;14620.707585848277;14656.120632762028;14671.55985320442;14705.117692938431;13047.543335983242;13321.933390333035;13481.460741570325;13652.726945461085;13676.111052781562;774.0247288416607;781.2773184804062;782.1513657681422;782.6869252299069;782.7847341980972;653.8169312592458;745.6868115391521;773.941954353423;777.3237283563308;781.5662307419379;812.3460614205562;816.3265306122443;817.0073360866546;817.3502065857657;817.5585184000662;673.1518286958419;808.0707186735272;808.6037841457702;809.4455298120777;809.4617079642061;573.4294377094776;587.2189987316858;591.5474661883662;593.2288025566746;593.6200831467821;13090.214587124708;13100.148490348098;13123.868761312455;13185.406656700376;13222.801657975138;12215.083868709882;12268.938655306756;12322.199057061262;12412.255264684149;13480.797788033187;10767.206929931184;12317.56888508907;12433.618849011837;12575.559855405018;12772.61682149537;3431.571053618298;3437.106352348407;3445.7243420526297;3466.9826650866835;3595.6224596417524;76891.23108768897;77408.61295693486;79034.60482697606;79941;80241.99999999942;9309.301802364715;9492.525373731423;9504;9592.424454532751;9864.309498335191;16728.832711672727;18870.90564547196;19428;19502.414927552196;19503;8046.557439340775;8056.113827478973;8104.0680321762575;8369.121242269473;8369.246767790928;4316.201502722007;4425.601695847389;4474.463064432289;4660.347551342815;4758.833440829623;3334.233126380946;3417.4019546579248;3443.1220038889924;3454.9309013820084;3455.2398472336045;625.3402660193449;630.1209812311799;646.1696719715144;649.795314475948;650.2392201124695;586.4985437450918;615.9137720719103;677.3497442455298;680.1124532485154;682.74738346812;8285.337173026144;8458.957705211435;8469.957650211709;8642.22220000203;8734.257588105082;486.9756512174377;492.34763937782583;651.3291309950758;658.3350815676201;679.0154276299386;3951.269015232191;4181.372794080912;4217;4289.7640629765665;4328.588784065509;114994;115957.42021289839;116698.41650791692;116922;119346;95778.52110739402;96223.6699348531;97449.15271152233;98107;99290.5035474818;71698.28301717021;72986.27013729795;82929.17070829336;84175.579122104;85203;8433.86142870729;8503.914960850312;8864.645414183618;8969.282457403522;9261.490618016074;45255;46753.06493870036;47217.527824721314;47690.423218258074;49452.50547494623;61452.69273653603;71130;72442.63778681283;74072.62963685147;76005.61997189978;11135.276207046516;11146.275492093313;11187.10503159729;11818.822717659414;11865.762684746429;12177.208481448677;12570.748585028432;12609.30648814324;12756.681082973;12770.42533086032;11793.174477786473;11857.110716696456;11858.466369013588;12610.117291789487;12625.431855566705;11532.25040372373;11999.460024298753;12062.095342849147;12314.797764384206;12447.626571202878;11503.367314797766;11593.82609260845;11815.40922953866;11839;12085.75828483443;9586.185174260267;9587.17178432378;9721.31950763468;9763.51182440861;9777.706668799947;9839.754006149904;10125.392476451436;10361.119304859172;10414.375137491776;10424.478776061318 02:39:43 INFO - PROCESS | 4159 | __end_tp_report 02:39:43 INFO - PROCESS | 4159 | __start_cc_report 02:39:43 INFO - PROCESS | 4159 | _x_x_mozilla_cycle_collect,1050 02:39:43 INFO - PROCESS | 4159 | __end_cc_report 02:39:43 INFO - PROCESS | 4159 | __startTimestamp1466242783841__endTimestamp 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | ------- Summary: start ------- 02:39:43 INFO - PROCESS | 4159 | Number of tests: 6 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#0] dojo.html Cycles:165 Average:5399.73 Median:5564.97 stddev:618.79 (11.1%) stddev-sans-first:594.01 02:39:43 INFO - PROCESS | 4159 | Values: 3108.5 3113.8 3139.3 3149.3 3165.2 5334.4 5397.6 5400.5 5465.9 5486.4 5421.2 5445.8 5458.0 5491.1 5501.7 4881.5 4966.0 4991.2 5021.4 5166.0 5085.3 5134.5 5136.8 5160.3 5161.3 4878.8 4901.8 4937.3 4982.7 5023.1 4947.6 4960.5 4967.1 5027.5 5060.4 4988.2 4989.5 4998.5 5004.9 5054.8 5342.4 5349.2 5424.1 5544.2 5555.8 5764.5 5802.2 5809.4 5818.8 5821.7 5864.3 5910.9 5928.4 5931.1 5933.7 5340.2 5365.5 5403.5 5409.4 5480.9 5991.5 6054.8 6059.8 6060.9 6064.8 5753.4 5796.5 5807.0 5808.2 5813.0 5647.4 5759.4 5803.6 5807.2 5835.4 5772.5 5776.0 5786.8 5796.3 5798.3 5565.3 5782.4 5810.4 5826.5 5826.8 4352.4 4384.1 4393.2 4430.8 4438.3 3927.3 3935.0 3952.2 3959.0 3977.0 5354.1 5458.6 5534.1 5539.2 5542.7 5827.7 5863.6 5894.6 5895.6 5914.0 5541.4 5559.5 5561.1 5562.6 5568.8 4641.1 4690.4 4759.4 4796.3 4846.3 5980.2 5985.9 5988.1 5989.0 6030.9 5823.7 5833.9 5835.6 5836.9 5861.9 5848.2 5910.7 5956.5 5977.5 5999.4 5771.6 5774.9 5775.7 5782.3 5785.9 5805.3 5810.9 5835.1 5864.4 5867.2 5489.1 5579.4 5622.7 5639.4 5666.7 5664.6 5674.0 5674.2 5678.5 5678.8 5477.4 5577.8 5594.1 5595.0 5598.4 5516.7 5565.0 5667.0 5748.7 5758.3 5425.6 5439.6 5491.6 5494.9 5496.0 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#1] ext.html Cycles:180 Average:58277.13 Median:209875.07 stddev:114380.29 (54.5%) stddev-sans-first:114619.09 02:39:43 INFO - PROCESS | 4159 | Values: 570.6 599.9 620.9 623.7 640.5 29862.4 30586.7 33020.3 33122.0 33147.5 34228.0 42481.8 43202.8 43228.8 47022.5 8879.3 8994.4 9002.9 9014.4 9020.7 8617.0 8698.0 8698.8 8708.3 8711.1 8926.7 8985.5 8991.6 8992.1 8998.4 8972.8 8995.4 9003.2 9013.5 9021.0 8794.1 8867.4 8872.5 8873.4 8874.1 42112.0 42484.2 42499.8 42506.6 42540.6 3603.8 3668.9 3903.6 4043.2 4147.1 31493.8 32089.5 32595.0 33747.3 33824.2 4091.8 4112.6 4193.6 4200.2 4224.9 347143.0 347557.0 349016.0 349529.0 350905.0 58059.0 58066.0 58484.4 58531.1 58531.4 52545.5 52549.2 52621.5 52708.7 54354.0 13294.7 13798.0 13799.7 14130.5 14140.7 9887.5 9920.4 9934.5 9937.3 9939.1 16003.8 17587.0 17735.7 18241.2 18366.5 6556.1 6677.4 6725.8 6761.3 6781.3 922.4 1044.3 1060.5 1172.9 1189.8 30705.4 32208.2 32288.0 32400.4 32574.3 1071.1 1088.1 1106.4 1173.4 1195.7 16733.7 17139.9 17157.0 17209.5 17557.5 509198.0 513580.0 513984.0 514747.0 525810.0 57185.7 57345.1 57363.7 57411.4 57431.4 1259.5 1281.8 1328.0 1330.7 1339.7 30554.7 31375.2 31671.8 31797.0 32231.5 50666.5 51127.2 51151.7 51176.7 51180.0 408068.0 414204.0 415603.0 416989.0 417455.0 35266.1 35775.6 37257.0 42258.0 42767.6 37594.2 40788.6 41230.2 44805.3 46536.8 36266.6 40017.0 41153.8 41838.8 42534.4 38282.8 40204.6 40472.8 43231.4 44328.8 39445.6 39572.0 39893.4 40271.8 41281.6 34288.1 36206.8 36880.4 36929.6 36975.4 25778.9 25801.9 25811.2 26393.3 26509.7 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#2] jquery.html Cycles:180 Average:28201.13 Median:2841.63 stddev:79716.21 (2805.3%) stddev-sans-first:79912.43 02:39:43 INFO - PROCESS | 4159 | Values: 362.2 378.8 379.9 385.7 403.8 15501.5 17188.2 18531.4 18941.7 19621.2 17312.6 17312.7 17514.6 17592.6 17720.6 5390.4 5638.3 5664.9 5684.6 5685.7 5285.8 5611.4 5614.5 5629.5 5630.7 5563.3 5564.0 5566.1 5566.9 5570.0 5323.9 5533.7 5550.7 5551.1 5552.1 4856.0 4939.7 4953.8 4962.9 4963.4 21377.0 22148.0 22244.0 22316.1 22538.1 2329.8 2444.5 2749.7 2750.2 2933.0 14102.2 14373.1 14410.9 14497.2 14747.3 1946.0 1964.4 1972.3 1977.4 2026.5 78257.2 78492.6 80477.6 80867.6 81495.6 10134.3 10240.7 10309.4 10711.2 10720.7 14158.6 14208.4 14310.5 14316.3 14341.5 7158.3 7197.3 7208.5 7215.6 7275.0 6650.7 6703.4 6787.2 6825.2 6831.4 6299.5 6468.1 6474.5 6611.9 6674.9 1794.5 1870.8 1881.2 1890.3 1891.3 850.2 936.2 951.0 987.4 1082.9 17890.5 18628.6 18642.7 19083.3 19473.3 959.9 969.5 1008.4 1010.3 1022.9 10244.6 10893.7 10985.6 10995.3 11123.1 474785.0 485546.0 486282.0 486550.0 490005.0 82373.0 82823.6 85104.6 85137.0 85424.6 989.4 993.1 1036.0 1057.7 1064.3 16749.9 16911.4 17149.7 17245.7 17538.1 32267.7 35626.0 38816.4 39530.8 40348.0 51434.0 52828.2 53126.5 53519.2 54141.2 7284.9 7519.5 7822.2 8407.7 8468.5 12809.4 13172.1 13386.1 13575.4 13668.2 11134.0 11294.7 11391.1 11779.0 11929.6 10900.5 11101.7 11305.7 11432.4 11741.4 11647.8 11752.6 11786.5 12022.8 12045.8 7772.4 7962.4 8016.7 8022.4 8036.3 11083.4 11315.0 11458.4 11681.2 11731.2 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#3] mootools.html Cycles:180 Average:5906.66 Median:4768.31 stddev:3434.41 (72.0%) stddev-sans-first:3426.39 02:39:43 INFO - PROCESS | 4159 | Values: 1273.5 1434.9 1450.8 1576.9 1735.4 8358.2 8745.8 8758.0 9002.1 9004.6 8696.4 8839.7 8858.1 8859.2 8875.9 2025.5 2274.1 2324.9 2341.9 2382.2 2313.2 2319.4 2325.6 2330.1 2339.4 2281.1 2286.8 2303.2 2311.3 2312.9 1994.2 2053.1 2217.8 2227.5 2274.7 2330.6 2337.1 2343.6 2348.5 2356.6 9020.5 9085.8 9087.5 9091.3 9092.0 5232.5 5363.8 5369.1 5375.7 5376.1 3080.4 3205.7 3256.7 3261.0 3263.1 1111.5 1117.3 1151.0 1154.7 1162.2 12930.1 12945.7 12958.4 12962.2 12999.4 4783.6 4793.6 4883.8 4895.1 4904.2 10562.3 10569.1 10592.0 10592.7 10682.8 5093.4 5161.5 5354.8 5355.3 5363.0 4293.2 4753.0 4898.5 4909.1 4969.2 3747.9 3843.3 3883.3 3924.0 3941.5 1251.4 1266.4 1271.9 1272.3 1290.9 866.8 873.5 982.4 991.1 998.9 5991.7 6069.2 6100.1 6180.9 6233.3 433.2 434.5 440.7 441.0 455.8 4252.9 4338.0 4381.5 4386.3 4454.2 10840.8 11149.2 11209.4 11239.0 11252.0 11056.6 11114.9 11182.2 11357.9 11362.5 8093.1 8220.4 8243.9 8260.4 8353.0 6151.5 6205.9 6228.0 6291.2 6353.9 10365.3 10373.5 10379.1 10533.1 10537.3 9914.8 10316.8 10326.2 10568.3 10585.4 7146.9 7319.1 7351.6 7989.6 8149.2 8220.9 8406.5 8701.7 8710.0 8963.3 7648.1 7797.1 7808.2 7815.6 8145.3 7915.1 7991.2 8023.5 8066.3 8126.8 7217.1 7303.6 7393.3 7394.1 7396.7 5387.3 5482.9 5506.1 5602.4 5633.4 5249.9 5343.9 5444.7 5461.3 5532.1 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#4] prototype.html Cycles:180 Average:4726.25 Median:5442.06 stddev:1388.83 (25.5%) stddev-sans-first:1352.84 02:39:43 INFO - PROCESS | 4159 | Values: 323.5 327.8 332.7 332.8 333.7 5409.8 5446.5 5463.5 5484.7 5504.3 5304.7 5313.1 5392.5 5400.7 5412.6 4150.0 4214.5 4232.8 4245.6 4256.7 4182.5 4210.4 4229.7 4251.7 4279.0 4207.4 4224.9 4230.9 4237.7 4249.0 4037.2 4039.2 4154.8 4183.2 4225.3 3676.8 3684.9 3685.0 3695.3 3720.8 5194.1 5198.6 5223.9 5230.7 5258.9 4518.0 4522.3 4660.6 4673.8 4729.1 5479.4 5501.4 5511.3 5519.9 5532.9 4013.9 4015.3 4034.1 4052.4 4063.7 5520.3 5667.3 5779.0 5808.4 5828.6 4083.8 4091.6 4098.9 4118.0 4151.4 4179.6 4185.2 4189.4 4190.4 4193.7 4664.2 4722.5 4727.8 4728.0 4739.2 5568.7 5573.6 5612.3 5683.2 5687.3 1413.9 1419.9 1428.7 1441.3 1443.2 920.7 926.7 956.6 970.9 973.3 5322.3 5341.0 5344.5 5353.8 5365.7 5621.6 5640.6 5693.7 5703.3 5741.3 5177.9 5256.9 5348.7 5428.9 5461.8 2981.6 3020.4 3046.5 3065.8 3075.5 5869.9 5932.0 5936.7 5949.8 5961.0 5582.0 5770.2 5850.9 5853.1 5897.6 5885.1 5900.3 5939.8 5944.9 5955.7 5469.2 5674.5 5712.8 5796.9 5797.1 5663.0 5692.9 5715.1 5725.9 5759.3 5897.4 5960.5 5974.4 5995.7 6014.8 3986.3 4048.7 4067.7 4091.0 4095.2 5737.9 5762.4 5781.9 5786.4 5817.0 5467.5 5662.8 5678.7 5687.8 5730.2 5626.3 5650.5 5659.8 5662.9 5688.3 5579.6 5585.8 5597.4 5619.8 5625.0 5437.7 5672.1 5683.7 5694.7 5706.4 5532.5 5575.4 5579.8 5581.4 5583.4 02:39:43 INFO - PROCESS | 4159 | 02:39:43 INFO - PROCESS | 4159 | [#5] yui.html Cycles:180 Average:19775.93 Median:25012.97 stddev:29616.50 (118.4%) stddev-sans-first:29664.63 02:39:43 INFO - PROCESS | 4159 | Values: 612.5 616.7 668.9 678.2 708.9 13509.3 14620.7 14656.1 14671.6 14705.1 13047.5 13321.9 13481.5 13652.7 13676.1 774.0 781.3 782.2 782.7 782.8 653.8 745.7 773.9 777.3 781.6 812.3 816.3 817.0 817.4 817.6 673.2 808.1 808.6 809.4 809.5 573.4 587.2 591.5 593.2 593.6 13090.2 13100.1 13123.9 13185.4 13222.8 12215.1 12268.9 12322.2 12412.3 13480.8 10767.2 12317.6 12433.6 12575.6 12772.6 3431.6 3437.1 3445.7 3467.0 3595.6 76891.2 77408.6 79034.6 79941.0 80242.0 9309.3 9492.5 9504.0 9592.4 9864.3 16728.8 18870.9 19428.0 19502.4 19503.0 8046.6 8056.1 8104.1 8369.1 8369.2 4316.2 4425.6 4474.5 4660.3 4758.8 3334.2 3417.4 3443.1 3454.9 3455.2 625.3 630.1 646.2 649.8 650.2 586.5 615.9 677.3 680.1 682.7 8285.3 8459.0 8470.0 8642.2 8734.3 487.0 492.3 651.3 658.3 679.0 3951.3 4181.4 4217.0 4289.8 4328.6 114994.0 115957.4 116698.4 116922.0 119346.0 95778.5 96223.7 97449.2 98107.0 99290.5 71698.3 72986.3 82929.2 84175.6 85203.0 8433.9 8503.9 8864.6 8969.3 9261.5 45255.0 46753.1 47217.5 47690.4 49452.5 61452.7 71130.0 72442.6 74072.6 76005.6 11135.3 11146.3 11187.1 11818.8 11865.8 12177.2 12570.7 12609.3 12756.7 12770.4 11793.2 11857.1 11858.5 12610.1 12625.4 11532.3 11999.5 12062.1 12314.8 12447.6 11503.4 11593.8 11815.4 11839.0 12085.8 9586.2 9587.2 9721.3 9763.5 9777.7 9839.8 10125.4 10361.1 10414.4 10424.5 02:39:43 INFO - PROCESS | 4159 | -------- Summary: end -------- 02:39:43 INFO - PROCESS | 4159 | 02:39:44 INFO - TEST-INFO | 4159: exit 0 02:39:44 INFO - TEST-OK | dromaeo_css | took 1114236ms 02:39:44 INFO - TEST-START | kraken 02:39:44 INFO - operating with platform_type : linux_ 02:39:44 INFO - Initialising browser for kraken test... 02:39:44 INFO - TEST-INFO | started process 4349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLu4Ul/profile http://localhost:57681/getInfo.html) 02:39:48 INFO - PROCESS | 4349 | __metrics Screen width/height:1600/1200 02:39:48 INFO - PROCESS | 4349 | colorDepth:24 02:39:48 INFO - PROCESS | 4349 | Browser inner width/height: 1024/697 02:39:48 INFO - PROCESS | 4349 | __metrics 02:39:49 INFO - PROCESS | 4349 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:50 INFO - TEST-INFO | 4349: exit 0 02:39:50 INFO - Browser initialized. 02:39:50 INFO - Running cycle 1/1 for kraken test... 02:39:50 INFO - TEST-INFO | started process 4431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnLu4Ul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:02 INFO - PROCESS | 4431 | RSS: Main: 174231552 02:40:02 INFO - PROCESS | 4431 | 02:40:05 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57681/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:06 INFO - PROCESS | 4431 | RSS: Main: 232869888 02:40:06 INFO - PROCESS | 4431 | 02:40:08 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57681/tests/kraken/driver.html?testName=audio-dft) 02:40:09 INFO - PROCESS | 4431 | RSS: Main: 220532736 02:40:09 INFO - PROCESS | 4431 | 02:40:12 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57681/tests/kraken/driver.html?testName=audio-fft) 02:40:13 INFO - PROCESS | 4431 | RSS: Main: 287109120 02:40:13 INFO - PROCESS | 4431 | 02:40:15 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57681/tests/kraken/driver.html?testName=audio-oscillator) 02:40:15 INFO - PROCESS | 4431 | RSS: Main: 198414336 02:40:15 INFO - PROCESS | 4431 | 02:40:17 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:18 INFO - PROCESS | 4431 | RSS: Main: 202612736 02:40:18 INFO - PROCESS | 4431 | 02:40:21 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57681/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:22 INFO - PROCESS | 4431 | RSS: Main: 238301184 02:40:22 INFO - PROCESS | 4431 | 02:40:25 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57681/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:26 INFO - PROCESS | 4431 | RSS: Main: 238907392 02:40:26 INFO - PROCESS | 4431 | 02:40:28 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57681/tests/kraken/driver.html?testName=json-parse-financial) 02:40:29 INFO - PROCESS | 4431 | RSS: Main: 238698496 02:40:29 INFO - PROCESS | 4431 | 02:40:31 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:31 INFO - PROCESS | 4431 | RSS: Main: 228597760 02:40:31 INFO - PROCESS | 4431 | 02:40:33 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:34 INFO - PROCESS | 4431 | RSS: Main: 229953536 02:40:34 INFO - PROCESS | 4431 | 02:40:36 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:36 INFO - PROCESS | 4431 | RSS: Main: 238080000 02:40:36 INFO - PROCESS | 4431 | 02:40:39 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:39 INFO - PROCESS | 4431 | RSS: Main: 239165440 02:40:39 INFO - PROCESS | 4431 | 02:40:42 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:43 INFO - PROCESS | 4431 | RSS: Main: 240390144 02:40:43 INFO - PROCESS | 4431 | 02:40:44 INFO - PROCESS | 4431 | Cycle 1(1): loaded http://localhost:57681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57681/tests/kraken/driver.html?testName=ai-astar) 02:40:45 INFO - PROCESS | 4431 | RSS: Main: 283508736 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | __start_tp_report 02:40:45 INFO - PROCESS | 4431 | _x_x_mozilla_page_load 02:40:45 INFO - PROCESS | 4431 | _x_x_mozilla_page_load_details 02:40:45 INFO - PROCESS | 4431 | |i|pagename|runs| 02:40:45 INFO - PROCESS | 4431 | |0;ai-astar;110;107;110;111;111;111;112;110;110;109 02:40:45 INFO - PROCESS | 4431 | |1;audio-beat-detection;146;132;127;176;128;157;153;127;178;133 02:40:45 INFO - PROCESS | 4431 | |2;audio-dft;160;160;160;159;159;159;163;160;160;159 02:40:45 INFO - PROCESS | 4431 | |3;audio-fft;74;78;75;126;75;76;75;79;97;74 02:40:45 INFO - PROCESS | 4431 | |4;audio-oscillator;85;85;109;85;86;87;128;84;85;134 02:40:45 INFO - PROCESS | 4431 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;116 02:40:45 INFO - PROCESS | 4431 | |6;imaging-darkroom;147;147;146;146;146;146;146;147;147;146 02:40:45 INFO - PROCESS | 4431 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 02:40:45 INFO - PROCESS | 4431 | |8;json-parse-financial;54;55;55;55;54;55;55;55;56;54 02:40:45 INFO - PROCESS | 4431 | |9;json-stringify-tinderbox;61;61;61;61;62;61;62;60;61;61 02:40:45 INFO - PROCESS | 4431 | |10;stanford-crypto-aes;80;79;79;79;81;79;79;86;116;82 02:40:45 INFO - PROCESS | 4431 | |11;stanford-crypto-ccm;121;139;127;130;120;121;126;121;134;131 02:40:45 INFO - PROCESS | 4431 | |12;stanford-crypto-pbkdf2;160;156;157;160;162;154;159;162;159;157 02:40:45 INFO - PROCESS | 4431 | |13;stanford-crypto-sha256-iterative;63;61;63;62;61;64;62;64;65;60 02:40:45 INFO - PROCESS | 4431 | __end_tp_report 02:40:45 INFO - PROCESS | 4431 | __start_cc_report 02:40:45 INFO - PROCESS | 4431 | _x_x_mozilla_cycle_collect,1615 02:40:45 INFO - PROCESS | 4431 | __end_cc_report 02:40:45 INFO - PROCESS | 4431 | __startTimestamp1466242845168__endTimestamp 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | ------- Summary: start ------- 02:40:45 INFO - PROCESS | 4431 | Number of tests: 14 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.37 (1.2%) stddev-sans-first:1.45 02:40:45 INFO - PROCESS | 4431 | Values: 110.0 107.0 110.0 111.0 111.0 111.0 112.0 110.0 110.0 109.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:149.50 stddev:19.73 (13.2%) stddev-sans-first:20.93 02:40:45 INFO - PROCESS | 4431 | Values: 146.0 132.0 127.0 176.0 128.0 157.0 153.0 127.0 178.0 133.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 02:40:45 INFO - PROCESS | 4431 | Values: 160.0 160.0 160.0 159.0 159.0 159.0 163.0 160.0 160.0 159.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:16.63 (22.0%) stddev-sans-first:17.32 02:40:45 INFO - PROCESS | 4431 | Values: 74.0 78.0 75.0 126.0 75.0 76.0 75.0 79.0 97.0 74.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:85.00 stddev:19.55 (23.0%) stddev-sans-first:20.26 02:40:45 INFO - PROCESS | 4431 | Values: 85.0 85.0 109.0 85.0 86.0 87.0 128.0 84.0 85.0 134.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:40:45 INFO - PROCESS | 4431 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:40:45 INFO - PROCESS | 4431 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:40:45 INFO - PROCESS | 4431 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 02:40:45 INFO - PROCESS | 4431 | Values: 54.0 55.0 55.0 55.0 54.0 55.0 55.0 55.0 56.0 54.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:40:45 INFO - PROCESS | 4431 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 62.0 60.0 61.0 61.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:79.50 stddev:11.46 (14.4%) stddev-sans-first:12.06 02:40:45 INFO - PROCESS | 4431 | Values: 80.0 79.0 79.0 79.0 81.0 79.0 79.0 86.0 116.0 82.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.50 stddev:6.46 (5.0%) stddev-sans-first:6.48 02:40:45 INFO - PROCESS | 4431 | Values: 121.0 139.0 127.0 130.0 120.0 121.0 126.0 121.0 134.0 131.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.50 stddev:2.59 (1.6%) stddev-sans-first:2.70 02:40:45 INFO - PROCESS | 4431 | Values: 160.0 156.0 157.0 160.0 162.0 154.0 159.0 162.0 159.0 157.0 02:40:45 INFO - PROCESS | 4431 | 02:40:45 INFO - PROCESS | 4431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 02:40:45 INFO - PROCESS | 4431 | Values: 63.0 61.0 63.0 62.0 61.0 64.0 62.0 64.0 65.0 60.0 02:40:45 INFO - PROCESS | 4431 | -------- Summary: end -------- 02:40:45 INFO - PROCESS | 4431 | 02:40:46 INFO - TEST-INFO | 4431: exit 0 02:40:46 INFO - TEST-OK | kraken | took 61654ms 02:40:46 INFO - SUITE-END | took 1175s 02:40:46 INFO - Completed test suite (00:19:36) 02:40:46 INFO - javascript benchmark 02:40:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.5492603572484, 3113.7508999280058, 3139.2779660678043, 3149.3228955774534, 3165.240342317843, 5334.413214546396, 5397.568194544437, 5400.513953744162, 5465.91801122983, 5486.423925487821, 5421.21392398102, 5445.754941027653, 5457.972710136443, 5491.066518691822, 5501.697406642633, 4881.4630390657085, 4965.950340496603, 4991.201407774757, 5021.372328458942, 5166.044281807877, 5085.262636917645, 5134.537891589756, 5136.768845401966, 5160.277561141444, 5161.27742116104, 4878.756062196876, 4901.779419926112, 4937.259411088329, 4982.651214414992, 5023.0707319145895, 4947.6289278304275, 4960.454350021495, 4967.056259310755, 5027.547520723152, 5060.367454068241, 4988.152014157566, 4989.451160372356, 4998.525140111684, 5004.9499505005215, 5054.772535235923, 5342.358916929955, 5349.224362467459, 5424.1321388578035, 5544.22380866679, 5555.805546805843, 5764.452377024218, 5802.216700745387, 5809.448102430262, 5818.767249310023, 5821.708914554255, 5864.266966629171, 5910.940890591082, 5928.40715928408, 5931.051031834886, 5933.703314834241, 5340.225667278223, 5365.543928766059, 5403.459654034565, 5409.377921538995, 5480.890382192334, 5991.460768530853, 6054.788082417094, 6059.848503787441, 6060.909086363708, 6064.787732429344, 5753.367129615739, 5796.536277097822, 5807.0, 5808.215890854765, 5812.9709351452975, 5647.407022262603, 5759.366469688331, 5803.622764520293, 5807.216025836543, 5835.416458354131, 5772.509336706343, 5776.046952252916, 5786.826395208151, 5796.304443466811, 5798.304203495523, 5565.30433695788, 5782.3639399666, 5810.389909059572, 5826.533877289807, 5826.796062137805, 4352.434183556117, 4384.123175364876, 4393.1872603568445, 4430.8449204277695, 4438.334249862546, 3927.3323534999117, 3934.9803250984132, 3952.1898010907694, 3958.980205099014, 3976.9602303977167, 5354.143337066051, 5458.617896747269, 5534.1145416733125, 5539.19681646159, 5542.722863856871, 5827.708614569339, 5863.589548731547, 5894.557908156906, 5895.616784908967, 5913.970430147821, 5541.418151094158, 5559.471850174227, 5561.138023606348, 5562.554995600423, 5568.832935011957, 4641.071785642885, 4690.413698287714, 4759.357486739315, 4796.25658023007, 4846.297286893451, 5980.162777211194, 5985.9401405986255, 5988.131720900532, 5988.999999999913, 6030.879382412415, 5823.7379317929945, 5833.883322333614, 5835.56233282514, 5836.941630583639, 5861.853453663693, 5848.210491583582, 5910.734016969161, 5956.463918247378, 5977.462028417463, 5999.400059993965, 5771.595988280948, 5774.931637647049, 5775.711214439345, 5782.306123265235, 5785.942140578709, 5805.303363596396, 5810.94189058104, 5835.124731290341, 5864.44287792659, 5867.237259156283, 5489.121740521658, 5579.358373786904, 5622.690752008679, 5639.436056394327, 5666.744996475086, 5664.603477756682, 5674.035413979551, 5674.205611214351, 5678.4605462480995, 5678.801241956512, 5477.4248703887115, 5577.832665020056, 5594.13290939905, 5594.9720251398485, 5598.356189038313, 5516.724163791875, 5564.972175139098, 5667.036603777286, 5748.6838223898085, 5758.337791154071, 5425.647332923348, 5439.6464229826515, 5491.588130890279, 5494.917576236439, 5495.972520137374], "value": 5357.46659914088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6347937320115, 599.9130126131711, 620.857202843346, 623.7473823101643, 640.4780104215067, 29862.40275194495, 30586.694133058663, 33020.33959320812, 33122.0, 33147.50278745821, 34228.0, 42481.787591062, 43202.78398608002, 43228.78385608076, 47022.52977470224, 8879.334049946263, 8994.370394072417, 9002.909970900273, 9014.414063085878, 9020.729378118667, 8616.956915215447, 8697.956510217471, 8698.826023479527, 8708.259797917184, 8711.128887111301, 8926.687565935194, 8985.460872347647, 8991.550422478882, 8992.145746154138, 8998.415103018315, 8972.820543589125, 8995.41529800564, 9003.189712925836, 9013.549322533847, 9020.954895225548, 8794.12058794122, 8867.379283450162, 8872.512011839346, 8873.378863479495, 8874.068222836639, 42112.0, 42484.15031699379, 42499.787501062296, 42506.57493425057, 42540.57459425428, 3603.765755225902, 3668.8899333020054, 3903.6291552302487, 4043.1711499142607, 4147.149834283965, 31493.842530787428, 32089.51865722016, 32595.0, 33747.32505349879, 33824.154396140046, 4091.774952377618, 4112.588741125894, 4193.643540299078, 4200.201961627281, 4224.894377640553, 347143.0, 347557.0, 349016.0, 349529.0, 350905.0, 58059.0, 58066.0, 58484.41515584875, 58531.12203316954, 58531.41468585345, 52545.47454525482, 52549.2117618236, 52621.473785262424, 52708.73645631747, 54354.0, 13294.734105317839, 13798.034137610272, 13799.724005520035, 14130.50543230982, 14140.717185656229, 9887.45618990948, 9920.40477571348, 9934.50327483623, 9937.254705897087, 9939.105480506789, 16003.839961600468, 17587.0, 17735.73396399055, 18241.17914693842, 18366.540836479195, 6556.114924485229, 6677.3656502632175, 6725.831854203586, 6761.290064543152, 6781.287964763727, 922.4050487435567, 1044.33162775822, 1060.4538662588773, 1172.8592568891618, 1189.7858385490522, 30705.435502257285, 32208.19479512984, 32288.0, 32400.351992960008, 32574.348513029607, 1071.0574694268994, 1088.118623914616, 1106.3804269608884, 1173.3546549397797, 1195.7429152732204, 16733.66532669364, 17139.91430042842, 17157.0, 17209.483715488554, 17557.507611853136, 509198.0, 513580.0, 513984.0, 514747.0, 525810.0, 57185.71407142938, 57345.13982290269, 57363.71318143383, 57411.42588574061, 57431.42568574261, 1259.5402678022456, 1281.7756892543769, 1327.9933600332129, 1330.700592366729, 1339.71196192819, 30554.694453056076, 31375.21561960969, 31671.84164079165, 31797.0, 32231.516527251642, 50666.493335066174, 51127.2330915044, 51151.74424127855, 51176.74411627918, 51180.0, 408068.0, 414204.0, 415603.0, 416989.0, 417455.0, 35266.11834704153, 35775.64224357723, 37257.0, 42258.0, 42767.572324276356, 37594.24811503809, 40788.59211407966, 41230.1753964925, 44805.32792008188, 46536.767316163205, 36266.63733362738, 40017.0, 41153.79423102865, 41838.79080604699, 42534.361984570874, 38282.80858595689, 40204.59795402126, 40472.79763601163, 43231.35152972771, 44328.778356108014, 39445.60554394419, 39572.0, 39893.40159897662, 40271.79864100661, 41281.58718412898, 34288.0855127317, 36206.818965905004, 36880.44679329758, 36929.63070369262, 36975.44536832003, 25778.871105644354, 25801.870990644926, 25811.225663230132, 26393.340166495993, 26509.734902650725], "value": 19578.409893513704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.18146987807546, 378.782200234865, 379.9445002536278, 385.70878986365295, 403.82635466749304, 15501.457448989288, 17188.226529806157, 18531.351402700926, 18941.715874261896, 19621.215151393964, 17312.56718582036, 17312.653746925054, 17514.649707005854, 17592.648147037053, 17720.64558708825, 5390.380106287788, 5638.267025286707, 5664.886702265952, 5684.630499017571, 5685.744141513621, 5285.841424757245, 5611.354694210157, 5614.466625670575, 5629.4652008059165, 5630.662160270376, 5563.276774019372, 5564.0, 5566.109422492402, 5566.8608284793, 5569.997400467914, 5323.9467605324035, 5533.723313834333, 5550.72246387681, 5551.139573366135, 5552.056150454412, 4855.975720121412, 4939.654224204307, 4953.752312384402, 4962.925556116661, 4963.379577552806, 21377.03803328854, 22148.0, 22244.0, 22316.107355705753, 22538.09847606094, 2329.801966832821, 2444.5355382477273, 2749.6801535263185, 2750.2161883863005, 2933.0467598030727, 14102.224377659224, 14373.065750726273, 14410.855891441057, 14497.202653854034, 14747.336369863382, 1945.9902700486548, 1964.430315208588, 1972.30969160794, 1977.4364306172815, 2026.5440275937945, 78257.21742782556, 78492.60753696252, 80477.59761201215, 80867.59566202131, 81495.59252203761, 10134.290599658101, 10240.743981400525, 10309.432981185957, 10711.196660250513, 10720.73198170052, 14158.64603384903, 14208.360623771749, 14310.49913253052, 14316.28418579067, 14341.498047568284, 7158.2841715828, 7197.316254955771, 7208.531445456028, 7215.603141827145, 7275.0, 6650.70071846768, 6703.430208432241, 6787.21946976104, 6825.249222585511, 6831.351021652935, 6299.5275354348605, 6468.094466774655, 6474.546781725328, 6611.900821487681, 6674.933250667528, 1794.5154808201712, 1870.8316251537426, 1881.2098918454283, 1890.3383815664683, 1891.3285783546644, 850.2050582705191, 936.2182577547824, 950.95720692569, 987.3532835992437, 1082.9187810914214, 17890.463286101436, 18628.627427451647, 18642.720359194624, 19083.332083377016, 19473.31843385503, 959.8944116147218, 969.4667932637021, 1008.4000019988096, 1010.282699283517, 1022.9181665466745, 10244.590216391261, 10893.673189804318, 10985.560577576967, 10995.285306455055, 11123.110151187886, 474785.0, 485546.0, 486282.0, 486550.0, 490005.0, 82373.0, 82823.5858820714, 85104.57447712721, 85137.0, 85424.57287713522, 989.4409658543044, 993.0863605482973, 1035.963741269052, 1057.7197042783669, 1064.3454275620438, 16749.91625041867, 16911.408100716417, 17149.657006859543, 17245.741313880553, 17538.123093845003, 32267.677323227406, 35626.0, 38816.447342106, 39530.802345988086, 40348.0, 51434.0, 52828.20757688561, 53126.4687353137, 53519.19721204263, 54141.18788218101, 7284.854302914018, 7519.548827070394, 7822.217778222132, 8407.663693452194, 8468.534230617375, 12809.359532023547, 13172.143810652276, 13386.129901556367, 13575.38910748999, 13668.179909205479, 11134.0, 11294.717632059264, 11391.088712903114, 11779.0, 11929.582464613697, 10900.509477073709, 11101.67344688322, 11305.71735706614, 11432.428378581204, 11741.354225517336, 11647.76704465923, 11752.58865939688, 11786.46960886745, 12022.75954480888, 12045.75908481843, 7772.417068719756, 7962.442629015914, 8016.7194148204535, 8022.398320125897, 8036.276735093869, 11083.445827708743, 11315.038221751243, 11458.4270786462, 11681.182317237712, 11731.23746956445], "value": 9047.332352012974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.4524154613523, 1434.8708616224537, 1450.7896355028522, 1576.858082772551, 1735.4359833054261, 8358.247757701805, 8745.825083498334, 8757.956210218948, 9002.099790021011, 9004.639814407416, 8696.39125261232, 8839.734807955756, 8858.069902660209, 8859.20267175954, 8875.91124088759, 2025.5442525431733, 2274.1471948019494, 2324.872132032746, 2341.941451463714, 2382.249591378719, 2313.178821518362, 2319.4433335999324, 2325.6046472099783, 2330.137848995874, 2339.3800642829665, 2281.0875649740155, 2286.8170546356337, 2303.1823702585593, 2311.295055008222, 2312.919047833326, 1994.1923520974028, 2053.1068984991575, 2217.789310015546, 2227.4765430123907, 2274.6701728249313, 2330.5804955108074, 2337.053493335202, 2343.6367363058753, 2348.5302939412013, 2356.5640356534095, 9020.548972551345, 9085.81828363429, 9087.545622718837, 9091.31815113869, 9091.954540227323, 5232.476752324737, 5363.758630861621, 5369.114096174166, 5375.704336261504, 5376.11294136467, 3080.383923215366, 3205.6954589313978, 3256.739460843127, 3260.983695081533, 3263.1026467721567, 1111.5053801058452, 1117.3463523838564, 1150.9942450287779, 1154.6766905266538, 1162.1690491298677, 12930.09489335747, 12945.741085178244, 12958.416871240817, 12962.157459765085, 12999.350032498338, 4783.641226907996, 4793.592544633675, 4883.780229889663, 4895.118878601815, 4904.215325547966, 10562.31344962575, 10569.101626361846, 10592.0, 10592.682219533426, 10682.78634427307, 5093.388793344749, 5161.535461808456, 5354.839354819362, 5355.303810504687, 5362.973185134049, 4293.184294983943, 4752.976235118802, 4898.510148985144, 4909.140900342497, 4969.204927211629, 3747.9437808432895, 3843.2505661396317, 3883.30100581898, 3923.9803800980812, 3941.5467221269346, 1251.4305990774176, 1266.4174479739238, 1271.9364031798373, 1272.2875189893505, 1290.9031822613154, 866.7573079537614, 873.5282947208436, 982.3909176310733, 991.0683957080322, 998.9001099889953, 5991.712009664347, 6069.180660610849, 6100.0849872519475, 6180.876382472416, 6233.283172435228, 433.20939285803536, 434.4894748670363, 440.6584896705015, 441.0473377504575, 455.83817744700815, 4252.91494170121, 4338.045629961466, 4381.496127945327, 4386.276264416336, 4454.198244316054, 10840.837387439195, 11149.16381271408, 11209.439528023566, 11239.0, 11252.043576295942, 11056.557737690402, 11114.888851111547, 11182.16133789969, 11357.886421135849, 11362.545498180145, 8093.069297030799, 8220.424570280142, 8243.917560824435, 8260.380471464545, 8352.958235208785, 6151.477124444473, 6205.906911396423, 6228.0, 6291.213598300213, 6353.872922541431, 10365.274430789772, 10373.481325933824, 10379.06588407047, 10533.10468610146, 10537.315074520131, 9914.752131196488, 10316.793664126826, 10326.225533084898, 10568.260221784401, 10585.417802020962, 7146.9285307146265, 7319.121705395387, 7351.632418378953, 7989.600519974094, 8149.225823546753, 8220.917790822254, 8406.537640429835, 8701.738947831574, 8710.041895391376, 8963.282937364866, 7648.120466146242, 7797.103333116765, 7808.219178082147, 7815.570143642154, 8145.307648849915, 7915.1293357729455, 7991.200879911962, 8023.518588884685, 8066.314363279187, 8126.796830079295, 7217.06178196831, 7303.561786292839, 7393.334599886036, 7394.075740532434, 7396.667149978156, 5387.272718182995, 5482.945170548243, 5506.091494903296, 5602.411746766694, 5633.436656334334, 5249.868753281198, 5343.946560534345, 5444.700541470257, 5461.262729531462, 5532.1425179097305], "value": 4599.23242005107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5357262328559, 327.7984039815513, 332.72550146129447, 332.7920049968769, 333.66966702964055, 5409.7827988702575, 5446.455354464551, 5463.480969307914, 5484.670919744808, 5504.311961004874, 5304.681719096857, 5313.149896016638, 5392.514673679368, 5400.675959442427, 5412.565670097418, 4150.0, 4214.47131720968, 4232.76719780412, 4245.617894389505, 4256.723312984646, 4182.5190103138075, 4210.3894935234375, 4229.746215227081, 4251.659867210616, 4279.037216626265, 4207.368894665809, 4224.936625950613, 4230.851920182794, 4237.724547904377, 4248.9575104249025, 4037.2329257440992, 4039.2123535910364, 4154.774341569214, 4183.163367326547, 4225.281702110648, 3676.8417948346455, 3684.889453316405, 3684.9631503684886, 3695.334839728848, 3720.776753394778, 5194.142966410538, 5198.610104242159, 5223.895522089575, 5230.712310822903, 5258.894822103574, 4517.9774101129615, 4522.29904364824, 4660.578523550315, 4673.766311684436, 4729.148753224418, 5479.369872464677, 5501.449855014506, 5511.255980442629, 5519.889602207973, 5532.944670553324, 4013.9197216055513, 4015.297322968498, 4034.132661477767, 4052.371882358239, 4063.6545893599077, 5520.309961254843, 5667.263255776764, 5779.0, 5808.448197421239, 5828.591998560145, 4083.816228269735, 4091.5703851095204, 4098.856540021085, 4117.97941010293, 4151.398047283127, 4179.561146079618, 4185.183889141588, 4189.4344263524645, 4190.350495673115, 4193.706440549132, 4664.207084795593, 4722.456917454468, 4727.834525791581, 4728.030753695484, 4739.170645137087, 5568.749406276727, 5573.637713548606, 5612.326520817528, 5683.232763576947, 5687.317521897398, 1413.861841217809, 1419.9077059991068, 1428.728541577097, 1441.2865631512468, 1443.2134486704772, 920.6869664314165, 926.6756635177634, 956.6269155029544, 970.8834939807127, 973.2700474644017, 5322.33470816148, 5340.973295133577, 5344.545713614386, 5353.785848566014, 5365.704886231295, 5621.550275977994, 5640.615630621594, 5693.715314234271, 5703.315602127771, 5741.282339707536, 5177.870553236199, 5256.8697729988235, 5348.732563371894, 5428.9185662215095, 5461.836144915659, 2981.6123903892353, 3020.3808219314988, 3046.45163870501, 3065.834982706557, 3075.4925437302595, 5869.853253668693, 5932.0, 5936.703164841827, 5949.791757288474, 5960.970195149083, 5581.962583657018, 5770.221020162308, 5850.882982340329, 5853.1220316952795, 5897.587168898136, 5885.116762636001, 5900.321463031721, 5939.792107276225, 5944.8811023780145, 5955.672438015864, 5469.206964989975, 5674.460926212003, 5712.80005199816, 5796.913046304393, 5797.130430435468, 5663.0, 5692.943070569241, 5715.114157305624, 5725.856853578527, 5759.308882934075, 5897.41025897424, 5960.523158147251, 5974.402559744165, 5995.670238136944, 6014.789482368096, 3986.262541429845, 4048.676105911461, 4067.7355971861734, 4090.9795451022555, 4095.24238015968, 5737.91393129095, 5762.394948530344, 5781.94218057814, 5786.392428794916, 5816.970915145397, 5467.507924286833, 5662.7734890603915, 5678.659280443187, 5687.800926967702, 5730.194988578751, 5626.2967129108865, 5650.491455768836, 5659.801906933238, 5662.858428539154, 5688.288963879515, 5579.609427340048, 5585.799053203581, 5597.44025597437, 5619.775208991595, 5625.015622266169, 5437.673739575638, 5672.14917762339, 5683.72116273835, 5694.743736531783, 5706.400827913009, 5532.529734972572, 5575.4424557543925, 5579.832605021694, 5581.358143813513, 5583.4416558345465], "value": 4280.827603627978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.4855121697774, 616.685490399896, 668.8628831089624, 678.1861765880944, 708.9432845372371, 13509.256990865499, 14620.707585848277, 14656.120632762028, 14671.55985320442, 14705.117692938431, 13047.543335983242, 13321.933390333035, 13481.460741570325, 13652.726945461085, 13676.111052781562, 774.0247288416607, 781.2773184804062, 782.1513657681422, 782.6869252299069, 782.7847341980972, 653.8169312592458, 745.6868115391521, 773.941954353423, 777.3237283563308, 781.5662307419379, 812.3460614205562, 816.3265306122443, 817.0073360866546, 817.3502065857657, 817.5585184000662, 673.1518286958419, 808.0707186735272, 808.6037841457702, 809.4455298120777, 809.4617079642061, 573.4294377094776, 587.2189987316858, 591.5474661883662, 593.2288025566746, 593.6200831467821, 13090.214587124708, 13100.148490348098, 13123.868761312455, 13185.406656700376, 13222.801657975138, 12215.083868709882, 12268.938655306756, 12322.199057061262, 12412.255264684149, 13480.797788033187, 10767.206929931184, 12317.56888508907, 12433.618849011837, 12575.559855405018, 12772.61682149537, 3431.571053618298, 3437.106352348407, 3445.7243420526297, 3466.9826650866835, 3595.6224596417524, 76891.23108768897, 77408.61295693486, 79034.60482697606, 79941.0, 80241.99999999942, 9309.301802364715, 9492.525373731423, 9504.0, 9592.424454532751, 9864.309498335191, 16728.832711672727, 18870.90564547196, 19428.0, 19502.414927552196, 19503.0, 8046.557439340775, 8056.113827478973, 8104.0680321762575, 8369.121242269473, 8369.246767790928, 4316.201502722007, 4425.601695847389, 4474.463064432289, 4660.347551342815, 4758.833440829623, 3334.233126380946, 3417.4019546579248, 3443.1220038889924, 3454.9309013820084, 3455.2398472336045, 625.3402660193449, 630.1209812311799, 646.1696719715144, 649.795314475948, 650.2392201124695, 586.4985437450918, 615.9137720719103, 677.3497442455298, 680.1124532485154, 682.74738346812, 8285.337173026144, 8458.957705211435, 8469.957650211709, 8642.22220000203, 8734.257588105082, 486.9756512174377, 492.34763937782583, 651.3291309950758, 658.3350815676201, 679.0154276299386, 3951.269015232191, 4181.372794080912, 4217.0, 4289.7640629765665, 4328.588784065509, 114994.0, 115957.42021289839, 116698.41650791692, 116922.0, 119346.0, 95778.52110739402, 96223.6699348531, 97449.15271152233, 98107.0, 99290.5035474818, 71698.28301717021, 72986.27013729795, 82929.17070829336, 84175.579122104, 85203.0, 8433.86142870729, 8503.914960850312, 8864.645414183618, 8969.282457403522, 9261.490618016074, 45255.0, 46753.06493870036, 47217.527824721314, 47690.423218258074, 49452.50547494623, 61452.69273653603, 71130.0, 72442.63778681283, 74072.62963685147, 76005.61997189978, 11135.276207046516, 11146.275492093313, 11187.10503159729, 11818.822717659414, 11865.762684746429, 12177.208481448677, 12570.748585028432, 12609.30648814324, 12756.681082973, 12770.42533086032, 11793.174477786473, 11857.110716696456, 11858.466369013588, 12610.117291789487, 12625.431855566705, 11532.25040372373, 11999.460024298753, 12062.095342849147, 12314.797764384206, 12447.626571202878, 11503.367314797766, 11593.82609260845, 11815.40922953866, 11839.0, 12085.75828483443, 9586.185174260267, 9587.17178432378, 9721.31950763468, 9763.51182440861, 9777.706668799947, 9839.754006149904, 10125.392476451436, 10361.119304859172, 10414.375137491776, 10424.478776061318], "value": 6948.625073137512, "unit": "score"}], "name": "dromaeo_css", "value": 7115.9923604138685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 132.0, 127.0, 176.0, 128.0, 157.0, 153.0, 127.0, 178.0, 133.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 159.0, 159.0, 163.0, 160.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 126.0, 75.0, 76.0, 75.0, 79.0, 97.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 85.0, 86.0, 87.0, 128.0, 84.0, 85.0, 134.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 56.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 81.0, 79.0, 79.0, 86.0, 116.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 139.0, 127.0, 130.0, 120.0, 121.0, 126.0, 121.0, 134.0, 131.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 157.0, 160.0, 162.0, 154.0, 159.0, 162.0, 159.0, 157.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 61.0, 64.0, 62.0, 64.0, 65.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1501.2999999999997, "alertThreshold": 2.0}]} 02:40:46 INFO - Return code: 0 02:40:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:46 INFO - # TBPL SUCCESS # 02:40:46 INFO - Running post-action listener: _resource_record_post_action 02:40:46 INFO - ##### 02:40:46 INFO - ##### Finished run-tests step (success) 02:40:46 INFO - ##### 02:40:46 INFO - Running post-run listener: _resource_record_post_run 02:40:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 421888; Write bytes: 293474304; Read time: 36; Write time: 176384 02:40:46 INFO - TinderboxPrint: CPU usage
13.1% 02:40:46 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 36 02:40:46 INFO - TinderboxPrint: I/O write bytes / time
293,474,304 / 176,384 02:40:46 INFO - TinderboxPrint: CPU idle
8,274.8 (86.8%) 02:40:46 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 02:40:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1232896; Read time: 0; Write time: 52 02:40:46 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 421888; Write bytes: 292241408; Read time: 36; Write time: 176332 02:40:47 INFO - Running post-run listener: _upload_blobber_files 02:40:47 INFO - Blob upload gear active. 02:40:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:47 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 02:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:48 INFO - (blobuploader) - INFO - Done attempting. 02:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:51 INFO - (blobuploader) - INFO - Done attempting. 02:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:52 INFO - (blobuploader) - INFO - Done attempting. 02:40:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:52 INFO - Return code: 0 02:40:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa14e7c5c6240886cbddb19a16a680d0745e149bef948e9d4cbba9e508cd018b97382ba6d56584ca26a3409485a86421bf1cd64c5c15f393cd99a06acde2e2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29ad1e74a3203d08def39ec563e6abd205b59c11c74770d55e795597b5e5fba764ded405a092653882fb4bcb3323d06f80a07983b4b7befefa260247dfce7c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee0283baa15d75d255c8989d4ad1f93168f52827c6f24e37b105522c908281b65f7f2887a307bac10fc7184b3ab0ac69f05ff771dd8eb1102ecfe17d4a589ae"} 02:40:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:52 INFO - Contents: 02:40:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa14e7c5c6240886cbddb19a16a680d0745e149bef948e9d4cbba9e508cd018b97382ba6d56584ca26a3409485a86421bf1cd64c5c15f393cd99a06acde2e2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29ad1e74a3203d08def39ec563e6abd205b59c11c74770d55e795597b5e5fba764ded405a092653882fb4bcb3323d06f80a07983b4b7befefa260247dfce7c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee0283baa15d75d255c8989d4ad1f93168f52827c6f24e37b105522c908281b65f7f2887a307bac10fc7184b3ab0ac69f05ff771dd8eb1102ecfe17d4a589ae"} 02:40:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:52 INFO - Copying logs to upload dir... 02:40:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.433980 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-18 02:40:52.176219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:40:52.179638) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa14e7c5c6240886cbddb19a16a680d0745e149bef948e9d4cbba9e508cd018b97382ba6d56584ca26a3409485a86421bf1cd64c5c15f393cd99a06acde2e2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29ad1e74a3203d08def39ec563e6abd205b59c11c74770d55e795597b5e5fba764ded405a092653882fb4bcb3323d06f80a07983b4b7befefa260247dfce7c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee0283baa15d75d255c8989d4ad1f93168f52827c6f24e37b105522c908281b65f7f2887a307bac10fc7184b3ab0ac69f05ff771dd8eb1102ecfe17d4a589ae"} build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa14e7c5c6240886cbddb19a16a680d0745e149bef948e9d4cbba9e508cd018b97382ba6d56584ca26a3409485a86421bf1cd64c5c15f393cd99a06acde2e2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29ad1e74a3203d08def39ec563e6abd205b59c11c74770d55e795597b5e5fba764ded405a092653882fb4bcb3323d06f80a07983b4b7befefa260247dfce7c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee0283baa15d75d255c8989d4ad1f93168f52827c6f24e37b105522c908281b65f7f2887a307bac10fc7184b3ab0ac69f05ff771dd8eb1102ecfe17d4a589ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:40:52.205231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:40:52.205582) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466238595.848069-884168746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:40:52.288525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:40:52.288838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:40:52.289125) ========= ========= Total master_lag: 0.21 =========