builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1451512709.4 results: success (0) buildid: 20151230113009 builduid: ba78263a176c451bad6721243b59eb91 revision: 63227efdffeffc2b8dc6f0fc999c13809b753a43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.398878) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.399652) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.400156) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006501 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.473574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.474064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.569892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.570315) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.628195) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.628691) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.629265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.629748) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 13:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2015-12-30 13:58:30 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.778292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.778581) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.831336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:29.831653) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63227efdffeffc2b8dc6f0fc999c13809b753a43 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 63227efdffeffc2b8dc6f0fc999c13809b753a43 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 13:58:30,584 truncating revision to first 12 chars 2015-12-30 13:58:30,584 Setting DEBUG logging. 2015-12-30 13:58:30,584 attempt 1/10 2015-12-30 13:58:30,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63227efdffef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 13:58:30,830 unpacking tar archive at: fx-team-63227efdffef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:30.368862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:30.369144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:30.381340) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:30.381598) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 13:58:30.381990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-30 13:58:30.382311) ========= /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-pgo/. (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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:31 INFO - MultiFileLogger online at 20151230 13:58:31 in /builds/slave/test-pgo 13:58:31 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 13:58:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:58:31 INFO - {'append_to_log': False, 13:58:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:58:31 INFO - 'blob_upload_branch': 'Fx-Team', 13:58:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:58:31 INFO - 'branch': 'Fx-Team', 13:58:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:31 INFO - 'config_files': ('talos/linux_config.py',), 13:58:31 INFO - 'default_actions': ('clobber', 13:58:31 INFO - 'read-buildbot-config', 13:58:31 INFO - 'download-and-extract', 13:58:31 INFO - 'populate-webroot', 13:58:31 INFO - 'create-virtualenv', 13:58:31 INFO - 'install', 13:58:31 INFO - 'run-tests'), 13:58:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:31 INFO - 'download_minidump_stackwalk': True, 13:58:31 INFO - 'download_symbols': 'ondemand', 13:58:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:31 INFO - 'installer_path': 'installer.exe', 13:58:31 INFO - 'log_level': 'info', 13:58:31 INFO - 'log_name': 'talos', 13:58:31 INFO - 'log_to_console': True, 13:58:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:31 INFO - 'opt_config_files': (), 13:58:31 INFO - 'pip_index': False, 13:58:31 INFO - 'sps_profile': False, 13:58:31 INFO - 'sps_profile_interval': 0, 13:58:31 INFO - 'suite': 'dromaeojs', 13:58:31 INFO - 'system_bits': '32', 13:58:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:31 INFO - 'title': 'talos-linux64-ix-059', 13:58:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:31 INFO - 'use_talos_json': True, 13:58:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:58:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:31 INFO - 'work_dir': 'build'} 13:58:31 INFO - ##### 13:58:31 INFO - ##### Running clobber step. 13:58:31 INFO - ##### 13:58:31 INFO - Running pre-action listener: _resource_record_pre_action 13:58:31 INFO - Running main action method: clobber 13:58:31 INFO - rmtree: /builds/slave/test-pgo/build 13:58:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:58:32 INFO - Running post-action listener: _resource_record_post_action 13:58:32 INFO - ##### 13:58:32 INFO - ##### Running read-buildbot-config step. 13:58:32 INFO - ##### 13:58:32 INFO - Running pre-action listener: _resource_record_pre_action 13:58:32 INFO - Running main action method: read_buildbot_config 13:58:32 INFO - Using buildbot properties: 13:58:32 INFO - { 13:58:32 INFO - "project": "", 13:58:32 INFO - "product": "firefox", 13:58:32 INFO - "script_repo_revision": "production", 13:58:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:58:32 INFO - "repository": "", 13:58:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:58:32 INFO - "buildid": "20151230113009", 13:58:32 INFO - "pgo_build": "True", 13:58:32 INFO - "basedir": "/builds/slave/test-pgo", 13:58:32 INFO - "buildnumber": 391, 13:58:32 INFO - "slavename": "talos-linux64-ix-059", 13:58:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:58:32 INFO - "platform": "ubuntu64_hw", 13:58:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:58:32 INFO - "branch": "fx-team", 13:58:32 INFO - "repo_path": "integration/fx-team", 13:58:32 INFO - "revision": "63227efdffeffc2b8dc6f0fc999c13809b753a43", 13:58:32 INFO - "stage_platform": "linux64-pgo", 13:58:32 INFO - "builduid": "ba78263a176c451bad6721243b59eb91", 13:58:32 INFO - "slavebuilddir": "test" 13:58:32 INFO - } 13:58:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:58:32 INFO - Running post-action listener: _resource_record_post_action 13:58:32 INFO - ##### 13:58:32 INFO - ##### Running download-and-extract step. 13:58:32 INFO - ##### 13:58:32 INFO - Running pre-action listener: _resource_record_pre_action 13:58:32 INFO - Running main action method: download_and_extract 13:58:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:58: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')]} 13:58:32 INFO - https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/test_packages.json 13:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/test_packages.json 13:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:58:37 INFO - Downloaded 1302 bytes. 13:58:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:58:37 INFO - Using the following test package requirements: 13:58:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'jsshell-linux-x86_64.zip'], 13:58:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58: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')]} 13:58:37 INFO - https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:58:47 INFO - Downloaded 23202480 bytes. 13:58:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:58:48 INFO - Return code: 0 13:58:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:58: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')]} 13:58:48 INFO - https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:58:49 INFO - Downloaded 23202480 bytes. 13:58:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:58:50 INFO - Return code: 0 13:58:50 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')]} 13:58:50 INFO - https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:58:51 INFO - Downloaded 11132285 bytes. 13:58:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:58:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:58:52 INFO - Return code: 0 13:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:52 INFO - https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:58:54 INFO - Downloaded 54942323 bytes. 13:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:54 INFO - mkdir: /builds/slave/test-pgo/properties 13:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:58:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:58:54 INFO - Contents: 13:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:58:54 INFO - Running post-action listener: _resource_record_post_action 13:58:54 INFO - Running post-action listener: set_extra_try_arguments 13:58:54 INFO - ##### 13:58:54 INFO - ##### Running populate-webroot step. 13:58:54 INFO - ##### 13:58:54 INFO - Running pre-action listener: _resource_record_pre_action 13:58:54 INFO - Running main action method: populate_webroot 13:58:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:54 INFO - '--tppagecycles', 13:58:54 INFO - '7'], 13:58:54 INFO - 'tests': ['tsvgm']}}, 13:58:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:58:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:58:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:58:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'tests': ['damp', 'tps']}, 13:58:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['damp', 'tps']}, 13:58:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:54 INFO - 'other': {'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'other_l64': {'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'other_nol64': {'tests': ['a11yr', 13:58:54 INFO - 'ts_paint', 13:58:54 INFO - 'tpaint', 13:58:54 INFO - 'sessionrestore', 13:58:54 INFO - 'sessionrestore_no_auto_restore']}, 13:58:54 INFO - 'svgr': {'tests': ['tsvgx', 13:58:54 INFO - 'tsvgr_opacity', 13:58:54 INFO - 'tart', 13:58:54 INFO - 'tscrollx', 13:58:54 INFO - 'cart']}, 13:58:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['tsvgx', 13:58:54 INFO - 'tsvgr_opacity', 13:58:54 INFO - 'tart', 13:58:54 INFO - 'tscrollx', 13:58:54 INFO - 'cart']}, 13:58:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'tests': ['tp5o']}, 13:58:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'talos_options': ['--e10s'], 13:58:54 INFO - 'tests': ['tp5o']}, 13:58:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'talos_options': ['--xperf_path', 13:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:54 INFO - 'tests': ['tp5n']}, 13:58:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:54 INFO - 'talos_options': ['--e10s', 13:58:54 INFO - '--xperf_path', 13:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:54 INFO - 'tests': ['tp5n']}}, 13:58:54 INFO - 'talos.zip': {'path': '', 13:58:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:54 INFO - Running post-action listener: _resource_record_post_action 13:58:54 INFO - ##### 13:58:54 INFO - ##### Running create-virtualenv step. 13:58:54 INFO - ##### 13:58:54 INFO - Running pre-action listener: _resource_record_pre_action 13:58:54 INFO - Running main action method: create_virtualenv 13:58:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:58:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:58:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:54 INFO - Using real prefix '/usr' 13:58:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:56 INFO - Installing pip.................done. 13:58:56 INFO - Return code: 0 13:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:58:56 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')]} 13:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:56 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')]} 13:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 13:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:58:56 INFO - Using env: {'DISPLAY': ':0', 13:58:56 INFO - 'HOME': '/home/cltbld', 13:58:56 INFO - 'LANG': 'en_US.UTF-8', 13:58:56 INFO - 'LANGUAGE': 'en_US:en', 13:58:56 INFO - 'LOGNAME': 'cltbld', 13:58:56 INFO - 'MAIL': '/var/mail/cltbld', 13:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:56 INFO - 'MOZ_NO_REMOTE': '1', 13:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:56 INFO - 'NO_EM_RESTART': '1', 13:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:56 INFO - 'SHELL': '/bin/bash', 13:58:56 INFO - 'SHLVL': '1', 13:58:56 INFO - 'TERM': 'linux', 13:58:56 INFO - 'TMOUT': '86400', 13:58:56 INFO - 'USER': 'cltbld', 13:58:56 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:56 INFO - '_': '/tools/buildbot/bin/python'} 13:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:57 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 13:58:57 INFO - Cleaning up... 13:58:57 INFO - Return code: 0 13:58:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:58:57 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')]} 13:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 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')]} 13:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:58:57 INFO - Using env: {'DISPLAY': ':0', 13:58:57 INFO - 'HOME': '/home/cltbld', 13:58:57 INFO - 'LANG': 'en_US.UTF-8', 13:58:57 INFO - 'LANGUAGE': 'en_US:en', 13:58:57 INFO - 'LOGNAME': 'cltbld', 13:58:57 INFO - 'MAIL': '/var/mail/cltbld', 13:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:57 INFO - 'MOZ_NO_REMOTE': '1', 13:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:57 INFO - 'NO_EM_RESTART': '1', 13:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:57 INFO - 'SHELL': '/bin/bash', 13:58:57 INFO - 'SHLVL': '1', 13:58:57 INFO - 'TERM': 'linux', 13:58:57 INFO - 'TMOUT': '86400', 13:58:57 INFO - 'USER': 'cltbld', 13:58:57 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:57 INFO - '_': '/tools/buildbot/bin/python'} 13:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:57 INFO - Downloading/unpacking psutil>=0.7.1 13:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:59 INFO - Installing collected packages: psutil 13:58:59 INFO - Running setup.py install for psutil 13:58:59 INFO - building 'psutil._psutil_linux' extension 13:58:59 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 13:58:59 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 13:58:59 INFO - building 'psutil._psutil_posix' extension 13:58:59 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 13:58:59 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 13:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:59 INFO - Successfully installed psutil 13:58:59 INFO - Cleaning up... 13:58:59 INFO - Return code: 0 13:58:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:58:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:58:59 INFO - Using env: {'DISPLAY': ':0', 13:58:59 INFO - 'HOME': '/home/cltbld', 13:58:59 INFO - 'LANG': 'en_US.UTF-8', 13:58:59 INFO - 'LANGUAGE': 'en_US:en', 13:58:59 INFO - 'LOGNAME': 'cltbld', 13:58:59 INFO - 'MAIL': '/var/mail/cltbld', 13:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:59 INFO - 'MOZ_NO_REMOTE': '1', 13:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:59 INFO - 'NO_EM_RESTART': '1', 13:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:59 INFO - 'SHELL': '/bin/bash', 13:58:59 INFO - 'SHLVL': '1', 13:58:59 INFO - 'TERM': 'linux', 13:58:59 INFO - 'TMOUT': '86400', 13:58:59 INFO - 'USER': 'cltbld', 13:58:59 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:59 INFO - '_': '/tools/buildbot/bin/python'} 13:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:59:01 INFO - Installing collected packages: mozsystemmonitor 13:59:01 INFO - Running setup.py install for mozsystemmonitor 13:59:01 INFO - Successfully installed mozsystemmonitor 13:59:01 INFO - Cleaning up... 13:59:01 INFO - Return code: 0 13:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:59:01 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')]} 13:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:01 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')]} 13:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 13:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:59:01 INFO - Using env: {'DISPLAY': ':0', 13:59:01 INFO - 'HOME': '/home/cltbld', 13:59:01 INFO - 'LANG': 'en_US.UTF-8', 13:59:01 INFO - 'LANGUAGE': 'en_US:en', 13:59:01 INFO - 'LOGNAME': 'cltbld', 13:59:01 INFO - 'MAIL': '/var/mail/cltbld', 13:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:01 INFO - 'MOZ_NO_REMOTE': '1', 13:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:01 INFO - 'NO_EM_RESTART': '1', 13:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:01 INFO - 'SHELL': '/bin/bash', 13:59:01 INFO - 'SHLVL': '1', 13:59:01 INFO - 'TERM': 'linux', 13:59:01 INFO - 'TMOUT': '86400', 13:59:01 INFO - 'USER': 'cltbld', 13:59:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:01 INFO - '_': '/tools/buildbot/bin/python'} 13:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:59:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:03 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 13:59:03 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 13:59:03 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 13:59:03 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 13:59:03 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 13:59:03 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 13:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:59:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:04 INFO - Downloading docopt-0.6.1.tar.gz 13:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:04 INFO - Running setup.py install for blobuploader 13:59:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:59:04 INFO - Running setup.py install for requests 13:59:04 INFO - Running setup.py install for docopt 13:59:05 INFO - Successfully installed blobuploader requests docopt 13:59:05 INFO - Cleaning up... 13:59:05 INFO - Return code: 0 13:59:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:05 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')]} 13:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:05 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')]} 13:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 13:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:59:05 INFO - Using env: {'DISPLAY': ':0', 13:59:05 INFO - 'HOME': '/home/cltbld', 13:59:05 INFO - 'LANG': 'en_US.UTF-8', 13:59:05 INFO - 'LANGUAGE': 'en_US:en', 13:59:05 INFO - 'LOGNAME': 'cltbld', 13:59:05 INFO - 'MAIL': '/var/mail/cltbld', 13:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:05 INFO - 'MOZ_NO_REMOTE': '1', 13:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:05 INFO - 'NO_EM_RESTART': '1', 13:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:05 INFO - 'SHELL': '/bin/bash', 13:59:05 INFO - 'SHLVL': '1', 13:59:05 INFO - 'TERM': 'linux', 13:59:05 INFO - 'TMOUT': '86400', 13:59:05 INFO - 'USER': 'cltbld', 13:59:05 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:05 INFO - '_': '/tools/buildbot/bin/python'} 13:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:05 INFO - Running setup.py (path:/tmp/pip-kidOAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:05 INFO - Running setup.py (path:/tmp/pip-IMBP2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:05 INFO - Running setup.py (path:/tmp/pip-6TJwVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:05 INFO - Running setup.py (path:/tmp/pip-8MfaZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:05 INFO - Running setup.py (path:/tmp/pip-ffnJ8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:05 INFO - Running setup.py (path:/tmp/pip-J1Y8kw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:05 INFO - Running setup.py (path:/tmp/pip-sVyPNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:05 INFO - Running setup.py (path:/tmp/pip-Fn3LS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:05 INFO - Running setup.py (path:/tmp/pip-cHI6f_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:05 INFO - Running setup.py (path:/tmp/pip-jCG8l_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:06 INFO - Running setup.py (path:/tmp/pip-JdXXDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:06 INFO - Running setup.py (path:/tmp/pip-gouzLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:06 INFO - Running setup.py (path:/tmp/pip-bFpMFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:06 INFO - Running setup.py (path:/tmp/pip-I4mCj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:06 INFO - Running setup.py (path:/tmp/pip-4LVDSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:06 INFO - Running setup.py (path:/tmp/pip-GMuyEa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:06 INFO - Running setup.py (path:/tmp/pip-wrsQy9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:06 INFO - Running setup.py install for manifestparser 13:59:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:59:06 INFO - Running setup.py install for mozcrash 13:59:06 INFO - Running setup.py install for mozdebug 13:59:06 INFO - Running setup.py install for mozdevice 13:59:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:59:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:59:06 INFO - Running setup.py install for mozfile 13:59:07 INFO - Running setup.py install for mozhttpd 13:59:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozinfo 13:59:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozInstall 13:59:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozleak 13:59:07 INFO - Running setup.py install for mozlog 13:59:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for moznetwork 13:59:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozprocess 13:59:07 INFO - Running setup.py install for mozprofile 13:59:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozrunner 13:59:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:59:07 INFO - Running setup.py install for mozscreenshot 13:59:08 INFO - Running setup.py install for moztest 13:59:08 INFO - Running setup.py install for mozversion 13:59:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:59:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:08 INFO - Cleaning up... 13:59:08 INFO - Return code: 0 13:59:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:08 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')]} 13:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:08 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')]} 13:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 13:59:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:59:08 INFO - Using env: {'DISPLAY': ':0', 13:59:08 INFO - 'HOME': '/home/cltbld', 13:59:08 INFO - 'LANG': 'en_US.UTF-8', 13:59:08 INFO - 'LANGUAGE': 'en_US:en', 13:59:08 INFO - 'LOGNAME': 'cltbld', 13:59:08 INFO - 'MAIL': '/var/mail/cltbld', 13:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:08 INFO - 'MOZ_NO_REMOTE': '1', 13:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:08 INFO - 'NO_EM_RESTART': '1', 13:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:08 INFO - 'SHELL': '/bin/bash', 13:59:08 INFO - 'SHLVL': '1', 13:59:08 INFO - 'TERM': 'linux', 13:59:08 INFO - 'TMOUT': '86400', 13:59:08 INFO - 'USER': 'cltbld', 13:59:08 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:08 INFO - '_': '/tools/buildbot/bin/python'} 13:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:08 INFO - Running setup.py (path:/tmp/pip-9ocKsI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:08 INFO - Running setup.py (path:/tmp/pip-Dz05BB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:08 INFO - Running setup.py (path:/tmp/pip-Y_FczO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:08 INFO - Running setup.py (path:/tmp/pip-DJ5N_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:08 INFO - Running setup.py (path:/tmp/pip-6tb0uu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:08 INFO - Running setup.py (path:/tmp/pip-AK_vXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:08 INFO - Running setup.py (path:/tmp/pip-hMvoCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:09 INFO - Running setup.py (path:/tmp/pip-2eHaOE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:09 INFO - Running setup.py (path:/tmp/pip-ZUGsGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:09 INFO - Running setup.py (path:/tmp/pip-pTeYKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:09 INFO - Running setup.py (path:/tmp/pip-DNZA1O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:09 INFO - Running setup.py (path:/tmp/pip-M782Ni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:09 INFO - Running setup.py (path:/tmp/pip-1eyAZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:09 INFO - Running setup.py (path:/tmp/pip-0Q91ph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:09 INFO - Running setup.py (path:/tmp/pip-Daut8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:09 INFO - Running setup.py (path:/tmp/pip-W0YUhm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:09 INFO - Running setup.py (path:/tmp/pip-Kuhb0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:59:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:09 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 13:59:09 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 13:59:09 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 13:59:09 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 13:59:09 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 13:59:09 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 13:59:11 INFO - Downloading blessings-1.5.1.tar.gz 13:59:11 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:11 INFO - Installing collected packages: blessings 13:59:11 INFO - Running setup.py install for blessings 13:59:11 INFO - Successfully installed blessings 13:59:11 INFO - Cleaning up... 13:59:11 INFO - Return code: 0 13:59:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:59:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:11 INFO - Reading from file tmpfile_stdout 13:59:11 INFO - Current package versions: 13:59:11 INFO - argparse == 1.2.1 13:59:11 INFO - blessings == 1.5.1 13:59:11 INFO - blobuploader == 1.2.4 13:59:11 INFO - docopt == 0.6.1 13:59:11 INFO - manifestparser == 1.1 13:59:11 INFO - mozInstall == 1.12 13:59:11 INFO - mozcrash == 0.16 13:59:11 INFO - mozdebug == 0.1 13:59:11 INFO - mozdevice == 0.47 13:59:11 INFO - mozfile == 1.2 13:59:11 INFO - mozhttpd == 0.7 13:59:11 INFO - mozinfo == 0.9 13:59:11 INFO - mozleak == 0.1 13:59:11 INFO - mozlog == 3.1 13:59:11 INFO - moznetwork == 0.27 13:59:11 INFO - mozprocess == 0.22 13:59:11 INFO - mozprofile == 0.28 13:59:11 INFO - mozrunner == 6.11 13:59:11 INFO - mozscreenshot == 0.1 13:59:11 INFO - mozsystemmonitor == 0.0 13:59:11 INFO - moztest == 0.7 13:59:11 INFO - mozversion == 1.4 13:59:11 INFO - psutil == 3.1.1 13:59:11 INFO - requests == 1.2.3 13:59:11 INFO - wsgiref == 0.1.2 13:59:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 13:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:59:11 INFO - Using env: {'DISPLAY': ':0', 13:59:11 INFO - 'HOME': '/home/cltbld', 13:59:11 INFO - 'LANG': 'en_US.UTF-8', 13:59:11 INFO - 'LANGUAGE': 'en_US:en', 13:59:11 INFO - 'LOGNAME': 'cltbld', 13:59:11 INFO - 'MAIL': '/var/mail/cltbld', 13:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:11 INFO - 'MOZ_NO_REMOTE': '1', 13:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:11 INFO - 'NO_EM_RESTART': '1', 13:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:11 INFO - 'SHELL': '/bin/bash', 13:59:11 INFO - 'SHLVL': '1', 13:59:11 INFO - 'TERM': 'linux', 13:59:11 INFO - 'TMOUT': '86400', 13:59:11 INFO - 'USER': 'cltbld', 13:59:11 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:11 INFO - '_': '/tools/buildbot/bin/python'} 13:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:59:12 INFO - Cleaning up... 13:59:12 INFO - Return code: 0 13:59:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 13:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:59:12 INFO - Using env: {'DISPLAY': ':0', 13:59:12 INFO - 'HOME': '/home/cltbld', 13:59:12 INFO - 'LANG': 'en_US.UTF-8', 13:59:12 INFO - 'LANGUAGE': 'en_US:en', 13:59:12 INFO - 'LOGNAME': 'cltbld', 13:59:12 INFO - 'MAIL': '/var/mail/cltbld', 13:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:12 INFO - 'MOZ_NO_REMOTE': '1', 13:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:12 INFO - 'NO_EM_RESTART': '1', 13:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:12 INFO - 'SHELL': '/bin/bash', 13:59:12 INFO - 'SHLVL': '1', 13:59:12 INFO - 'TERM': 'linux', 13:59:12 INFO - 'TMOUT': '86400', 13:59:12 INFO - 'USER': 'cltbld', 13:59:12 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:12 INFO - '_': '/tools/buildbot/bin/python'} 13:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:12 INFO - Downloading/unpacking jsonschema 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:59:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:14 INFO - warning: no files found matching '*.txt' 13:59:14 INFO - no previously-included directories found matching 'build' 13:59:14 INFO - no previously-included directories found matching 'dist' 13:59:14 INFO - no previously-included directories found matching '.git*' 13:59:14 INFO - Installing collected packages: jsonschema, functools32 13:59:14 INFO - Running setup.py install for functools32 13:59:14 INFO - warning: no files found matching '*.txt' 13:59:14 INFO - no previously-included directories found matching 'build' 13:59:14 INFO - no previously-included directories found matching 'dist' 13:59:14 INFO - no previously-included directories found matching '.git*' 13:59:14 INFO - Successfully installed jsonschema functools32 13:59:14 INFO - Cleaning up... 13:59:14 INFO - Return code: 0 13:59:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:59:14 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')]} 13:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:14 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')]} 13:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f6e0d926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:59:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 13:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 13:59:14 INFO - Using env: {'DISPLAY': ':0', 13:59:14 INFO - 'HOME': '/home/cltbld', 13:59:14 INFO - 'LANG': 'en_US.UTF-8', 13:59:14 INFO - 'LANGUAGE': 'en_US:en', 13:59:14 INFO - 'LOGNAME': 'cltbld', 13:59:14 INFO - 'MAIL': '/var/mail/cltbld', 13:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:14 INFO - 'MOZ_NO_REMOTE': '1', 13:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:14 INFO - 'NO_EM_RESTART': '1', 13:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:14 INFO - 'SHELL': '/bin/bash', 13:59:14 INFO - 'SHLVL': '1', 13:59:14 INFO - 'TERM': 'linux', 13:59:14 INFO - 'TMOUT': '86400', 13:59:14 INFO - 'USER': 'cltbld', 13:59:14 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:14 INFO - '_': '/tools/buildbot/bin/python'} 13:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:14 INFO - Downloading/unpacking flake8 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:59:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:59:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:59:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:59:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:59:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 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 13:59:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:59:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:59:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:16 INFO - no previously-included directories found matching 'docs/_build' 13:59:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:59:17 INFO - Running setup.py install for pep8 13:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:17 INFO - no previously-included directories found matching 'docs/_build' 13:59:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:59:17 INFO - Cleaning up... 13:59:17 INFO - Return code: 0 13:59:17 INFO - Running post-action listener: _resource_record_post_action 13:59:17 INFO - Running post-action listener: _start_resource_monitoring 13:59:17 INFO - Starting resource monitoring. 13:59:17 INFO - ##### 13:59:17 INFO - ##### Running install step. 13:59:17 INFO - ##### 13:59:17 INFO - Running pre-action listener: _resource_record_pre_action 13:59:17 INFO - Running main action method: install 13:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:17 INFO - Reading from file tmpfile_stdout 13:59:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:59:17 INFO - Reading from file tmpfile_stdout 13:59:17 INFO - Output received: 13:59:17 INFO - Usage: mozinstall [options] installer 13:59:17 INFO - Options: 13:59:17 INFO - -h, --help show this help message and exit 13:59:17 INFO - -d DEST, --destination=DEST 13:59:17 INFO - Directory to install application into. [default: 13:59:17 INFO - "/builds/slave/test-pgo"] 13:59:17 INFO - --app=APP Application being installed. [default: firefox] 13:59:17 INFO - mkdir: /builds/slave/test-pgo/build/application 13:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:59:33 INFO - Reading from file tmpfile_stdout 13:59:33 INFO - Output received: 13:59:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:59:33 INFO - Running post-action listener: _resource_record_post_action 13:59:33 INFO - ##### 13:59:33 INFO - ##### Running run-tests step. 13:59:33 INFO - ##### 13:59:33 INFO - Running pre-action listener: _resource_record_pre_action 13:59:33 INFO - Running main action method: run_tests 13:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:59:33 INFO - Python 2.7.3 13:59:33 INFO - Return code: 0 13:59:33 INFO - grabbing minidump binary from tooltool 13:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:33 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf840>, '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 0x1a3c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:59:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:59:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:59:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:33 INFO - Return code: 0 13:59:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:59:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:59:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:59:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:59:34 INFO - Return code: 0 13:59:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:59:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:59:34 INFO - Using env: {'DISPLAY': ':0', 13:59:34 INFO - 'HOME': '/home/cltbld', 13:59:34 INFO - 'LANG': 'en_US.UTF-8', 13:59:34 INFO - 'LANGUAGE': 'en_US:en', 13:59:34 INFO - 'LOGNAME': 'cltbld', 13:59:34 INFO - 'MAIL': '/var/mail/cltbld', 13:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:34 INFO - 'MOZ_NO_REMOTE': '1', 13:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:34 INFO - 'NO_EM_RESTART': '1', 13:59:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:34 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:59:34 INFO - 'SHELL': '/bin/bash', 13:59:34 INFO - 'SHLVL': '1', 13:59:34 INFO - 'TERM': 'linux', 13:59:34 INFO - 'TMOUT': '86400', 13:59:34 INFO - 'USER': 'cltbld', 13:59:34 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891', 13:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:34 INFO - '_': '/tools/buildbot/bin/python'} 13:59:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:59:34 INFO - mozversion application_buildid: 20151230113009 13:59:34 INFO - mozversion application_changeset: 63227efdffeffc2b8dc6f0fc999c13809b753a43 13:59:34 INFO - mozversion application_display_name: Nightly 13:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:34 INFO - mozversion application_name: Firefox 13:59:34 INFO - mozversion application_remotingname: firefox 13:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:59:34 INFO - mozversion application_vendor: Mozilla 13:59:34 INFO - mozversion application_version: 46.0a1 13:59:34 INFO - mozversion platform_buildid: 20151230113009 13:59:34 INFO - mozversion platform_changeset: 63227efdffeffc2b8dc6f0fc999c13809b753a43 13:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:59:34 INFO - mozversion platform_version: 46.0a1 13:59:34 INFO - using testdate: 1451512774 13:59:34 INFO - actual date: 1451512774 13:59:34 INFO - starting webserver on 'localhost:35669' 13:59:34 INFO - SUITE-START | Running 3 tests 13:59:34 INFO - TEST-START | dromaeo_css 13:59:34 INFO - operating with platform_type : linux_ 13:59:34 INFO - Initialising browser for dromaeo_css test... 13:59:34 INFO - TEST-INFO | started process 26237 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4eYhsa/profile http://localhost:35669/getInfo.html) 13:59:38 INFO - PROCESS | 26237 | __metrics Screen width/height:1600/1200 13:59:38 INFO - PROCESS | 26237 | colorDepth:24 13:59:38 INFO - PROCESS | 26237 | Browser inner width/height: 1024/697 13:59:38 INFO - PROCESS | 26237 | __metrics 13:59:38 INFO - PROCESS | 26237 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:59:38 INFO - PROCESS | 26237 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:39 INFO - TEST-INFO | 26237: exit 0 13:59:39 INFO - Browser initialized. 13:59:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:39 INFO - TEST-INFO | started process 26330 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4eYhsa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:51 INFO - PROCESS | 26330 | RSS: Main: 149237760 13:59:51 INFO - PROCESS | 26330 | 14:00:42 INFO - PROCESS | 26330 | 1451512842205 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] 14:02:51 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35669/tests/dromaeo/cssquery-ext.html) 14:02:52 INFO - PROCESS | 26330 | RSS: Main: 255291392 14:02:52 INFO - PROCESS | 26330 | 14:05:55 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-ext.html (next: http://localhost:35669/tests/dromaeo/cssquery-jquery.html) 14:05:55 INFO - PROCESS | 26330 | RSS: Main: 240054272 14:05:55 INFO - PROCESS | 26330 | 14:08:57 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35669/tests/dromaeo/cssquery-mootools.html) 14:08:58 INFO - PROCESS | 26330 | RSS: Main: 228651008 14:08:58 INFO - PROCESS | 26330 | 14:12:00 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35669/tests/dromaeo/cssquery-prototype.html) 14:12:00 INFO - PROCESS | 26330 | RSS: Main: 220930048 14:12:00 INFO - PROCESS | 26330 | 14:15:03 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35669/tests/dromaeo/cssquery-yui.html) 14:15:04 INFO - PROCESS | 26330 | RSS: Main: 218025984 14:15:04 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | Cycle 1(1): loaded http://localhost:35669/tests/dromaeo/cssquery-yui.html (next: http://localhost:35669/tests/dromaeo/cssquery-dojo.html) 14:18:06 INFO - PROCESS | 26330 | RSS: Main: 291782656 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | __start_tp_report 14:18:06 INFO - PROCESS | 26330 | _x_x_mozilla_page_load 14:18:06 INFO - PROCESS | 26330 | _x_x_mozilla_page_load_details 14:18:06 INFO - PROCESS | 26330 | |i|pagename|runs| 14:18:06 INFO - PROCESS | 26330 | |0;dojo.html;3123.7032481914216;3202.343519578487;3243.8540265688043;3244.8053116812994;3261.9673803261967;5210.478952104797;5320.281761962134;5333.919991200135;5353.03645343838;5409.161579955104;5314.176302673091;5327;5347.438518955512;5422.48486393793;5443.292371991635;4813.374261346029;4870.756462176894;4885.364902562662;4935.679180853251;4991.850244492671;4917.950820491785;4955.08330958772;4996.700197988114;5002.224655178435;5029.1953287473825;4841.394825646794;4938.9012219755405;4945.23348880924;4961.603071754251;4983.352164218646;4777.498362671939;4876;4877.439094504142;4883.902321953541;4891.6820406673805;4827.831025914076;4833.275008748716;4840.927386089212;4852.927206091911;4865.537773911473;5091.516305950929;5139.229115632647;5149.382074151088;5185.0148471790235;5208.192730126836;5784.334801497797;5787.1608616750755;5792.8841423171725;5803.303603567557;5804.564657650693;5807.245058142456;5816.418358164192;5826.533877289849;5834.708264586754;5837.9124313135335;5324.707141107198;5335.493128152819;5411.675299482044;5438.265834112423;5439.292891924064;5878.676672783038;5883.411658834082;5892.911606325909;5901.970490147608;5938.673372964528;5666.065099258659;5668.149777533321;5668.801591944262;5672.801451949162;5729.28383952006;5604.60767746262;5656.6888821115235;5708.686022268732;5754.4533269339345;5786.508146807484;5678.886422271531;5719.970405326998;5722.17028530869;5724.79963201286;5730.570207234474;5709.314882214161;5749.568782341341;5749.626274292157;5750.30996280449;5762.30852297727;4228.344606585984;4285.849995250152;4297.205017071852;4327.502337231196;4370.453693288339;3852.152526444178;3890.7665540067687;3894.1043559980794;3921.784301863425;3937.5668676445566;5372.409035006146;5381.919271210935;5397.10947693634;5401.378841433207;5404;5638.436156384329;5689.630174038757;5748.425157484218;5751.827445176651;5786.623869448473;5333.413324534298;5343.412224655285;5346.304980352529;5349.411564727877;5389.0299746046085;4978.452370239271;5003.524665156804;5008.4240312364545;5014.323066385991;5055.87360315995;5776.740046697909;5842.824715258549;5878.647281163144;5911.881762364728;5922.674252916131;5712.942870571241;5777.971110144423;5780.971095144498;5821.330546987151;5824.912626310694;5884.235049443545;5906;5910.261217347832;5913.763449461973;5917.201177840936;5460.453954604508;5666.17840413146;5723.255976723;5724.227229323988;5724.313082430135;5709.800156994485;5731.799387021434;5767.048437007847;5804.65172089676;5854.560907931837;5617.241672374341;5632.957902787997;5639.548836093185;5646.802361917313;5648.915266271091;5588.916166257591;5617.8033768817895;5622.072358060874;5630.493255607015;5630.718464076862;5274.841754747364;5330.493603107699;5396.460353964572;5410.269613602113;5522.972385138049;5679.119736440858;5688.601797874109;5720;5720.599558030898;5725.19847221381;5600.187972743848;5605.019121653776;5605.887882242414;5609.074502707008;5617.662940223599 14:18:06 INFO - PROCESS | 26330 | |1;ext.html;530.6179550723479;533.0964015992892;534.3027349309152;552.6463063639271;558.391353424767;25007;27824.3043923902;27912.162635120952;28021.719782802167;35048.12379690503;38743.225135497276;38942.22115557687;39139;39174.80412597933;39214.80392598033;8231.506109633427;8533.317334613215;8546.914530854674;8548.40161188717;8551.914480855205;7421.406287496988;7594.962025189894;7598.620068996555;8331.375146863978;10018.098371146596;9895.653652122177;9988;10014.699559013241;10024.949875250613;10032.89967100327;9846.606135754633;9862.408255504657;9868.506574671237;9947.5026248688;9958.253131015166;7461.776146715607;7630.046244219473;7633.847323053508;10025.097741203326;10304.948475257575;35852.10369740751;36305.45541816875;36413.271734565424;36433;36460.0884977875;2980.0761763853275;2982.7464665503458;3035.9544606830914;3071.523913793343;3077.1999280187088;27302;27883.16350509488;28493;28670.13989580316;28883.133505994643;3987.535834475882;4004.899877503057;4064.959350406488;4128.236276288866;4249.893752656178;266617;270293;273714;274296;275339.6233018842;43058.04832444246;43742.12515749667;59924;60094.69952650296;60356.39643603595;56116;56179.157312640345;56544.71727641336;56546.15180772292;56642.45108970106;13196;13416.798748018788;13418.060735748599;13434.596962090958;13451.12567683117;9645.08371704687;9760.804783904283;9761.707148785548;9763.560639771227;9764.121229089416;19813.801861981196;20368.69446958297;20437;20444.080016399297;20547.38357849267;7850.607469626496;8093.878591821127;8130.59347032646;8171.5505647189975;8178.591070446454;826.6073615032811;863.4560227056913;908.3323757038571;1052.5325636544492;1053.805046066465;28486;28596;28611;28761.856190718914;28808.711912881023;938.174406522256;989.7575094101848;1063.8882917293727;1123.9771807655159;1129.093337053803;14825.184614846072;14879.33043013067;15052;15102.773458398133;15195;337506;343649;344882;345122;345827;52719;53076.20385694218;53100;53134.20298695523;53145.46854531483;1304.9478020879249;1311.6458556189775;1318.7494376068516;1325.5161865919063;1334.8665133486768;27534.173974780788;28497;28725.85637071801;28759.856200718863;29000.7099928998;40576.59423405728;41214;46313.53686463092;47471.76264118657;47548.52451475441;240782;241268;244579;245445;245918;26883.327916801452;27371.178864634094;31722.20694482564;32092.19769505781;32127.51808722918;36687.449688254164;38698.03254918649;43112.78443607762;45254;47052;33087.338253235284;33239;33816.32367352688;38347.42478862875;40075.398869016404;33878;37804.81097594494;39294.21411571695;39884.2023159541;40453.79773101116;33710;33901.83049084838;37942.2411551773;38820;38941;28979.42041159123;30532.694673052985;31139.37721245608;31161.37677246397;31192.376152477278;23458.76541234566;23796.762032379454;23862.15994723091;23912;24183.516329672955 14:18:06 INFO - PROCESS | 26330 | |2;jquery.html;338.45677687311866;341.92477654915916;353.06085811740775;354.33915747131607;354.8757934722847;14092.64768380791;14483;16413.179341032945;16978.575535611617;18176.18207180677;14647.707045859077;14665.413383464649;14939.850601493981;14992.550223493285;15010.399584016626;4980.203167493201;4987.152184128707;4994.126027945095;5035.446100928895;5240.056789777848;3938.72428929975;4047.8583249586272;5385.030694474993;5751.367349591563;5990.101484777275;5871.9412805871825;5915.9704201478935;5916.585838991272;5937.88124237515;5942.078977758454;5720.628159169662;5886.528367908023;5888.911666325009;5889;5893.675847828367;5147.536721695028;5181.715005674687;5187.273781670569;5195.038917800219;5204.8959020819375;15216.923915380352;15225.543233703007;17744.37894673693;18657;19303.613927721366;1943.3004118517322;1955.3840540229783;1996.690512970492;2087.1547023455523;2139.465133716571;9692.017222261082;9765.853512197322;9879.604815807359;11823.626343537317;12581.433835477334;1652.115380808139;1735.2104792319465;1762.5946032412617;1808.7558179645712;1848.2052717331542;57606.423935760526;59458.702706487056;61068.69465652643;61160;61805.38194618086;9847.606095756233;9878.209743220525;9954.601815927283;10078.949605251926;10265.133564462654;12932.741345173044;12942.935285323512;13005.869941300465;13022.674433139247;13081.41133648988;7162.319579639926;7191.676374563157;7195.028671129435;7208.459365547605;7235.819104522429;6914.308569143146;6934;6939.653017349112;6963.1296087989;6985.301469853076;4239.724417912826;4274.615284624399;4286.249906266453;4286.678499112579;4314;1666.983330166707;1736.1753167245458;1739.7390391441131;1790.5255107396551;1805.4132406967788;401.5783427401217;817.7955511122219;863.3768515191525;1023.8310678738073;1048.3552615141632;9634.699315592445;10481.580736770597;10912.236143469881;10935.343879367105;11311.264767790068;442.263631054291;455.26247479083435;865.1348651348651;904.213334399077;933.2021121940778;8830.514321712239;9740.75648108803;10075.445850478294;10234.59061637541;10297.17622590191;497023;504101;506017;513873;596296.2412201773;77366;79438.6028069856;79812;80909.19090809135;81185;1112.3103675720943;1124.2299025167622;1125.6791814332876;1131.1007748839693;1147.0422197465043;15588.766168507254;15726.606834829221;15734.13462259541;15840.683186335978;15952.122633255283;32911;34896.65103348934;34931.301373972885;35220.295594088486;35895;43104;43307.35038974481;43592.12815743604;45670.771646141555;46327.30509042434;9306.767330816512;9503.477308747808;9608.75978100525;9616.9038309616;9619.903800961902;11402.600908968147;13686.657833553843;13780.724385512032;16553.25510352013;17586.736198957282;10989.835152472559;11937.343446110548;13681.657958551115;14119.152850828983;14264.286785660468;14016.78974815399;14056.859431405555;14329.928350358181;14564.19896905638;14628.12231266085;14274.429022838971;14332.993380926888;14334.928325358724;14722.337494812973;14857.108573485626;9126.17864392208;9170.495622740813;9465.432074075577;9467.337286389886;9566.617335306788;9838.293789602158;12906.612801615967;14438.639034024234;14642.85357146415;14643.19462429534 14:18:06 INFO - PROCESS | 26330 | |3;mootools.html;1111.4276147783887;1419.503173889139;1424.7506686329893;1552.200616682408;1736.331512367738;6157.445829875311;6715.328467153282;6787.219469760979;6818.352256535633;6824.146981627297;6744;6896.413804826596;6903.344182302686;6912.481563882704;6915.308469153095;1921.7117432385114;1950.775660799005;1951.9024048797573;2182.5962196993605;2217.6784366266884;2163.1131236193164;2192.210804110519;2192.4080498265457;2193.747719012318;2196.758356580775;2107.1466056247245;2125.0543508138885;2161.492049368397;2161.5352699169675;2162.6215412302786;2117.851750377474;2126.2770657976284;2140.2081229944943;2148.34475484977;2196.7254093238184;2189.4854709143337;2220.6335954567476;2222.4443889027743;2222.944426389337;2223.132978138527;6909.930900691029;7001.719931202746;7020.508564400494;7029.648517574101;7053.823654408629;4174.436451079096;4176;4239.830406783725;4241;4246.363045543162;2830.5471124620167;2852.0588205892213;2915.2274647218505;2920.7225313595172;2946.6464024317006;913.1279627955287;916.8074704312103;937.8452555328363;957.262907561181;969.1181025267043;9406.153446189875;9410.811783764355;9415.340926135174;9419.623215071457;9441.055894410641;3978.701597380208;4002.739821911625;4051.7366371186367;4054.1891621675195;4058.553559108496;8201.179882011751;8213.38399620019;8217.260446559838;8221.424500285042;8221.958890205511;4168.083021735213;4202.054537728986;4202.138561594866;4223.345381465816;4233.597808208216;3835.7698538087247;3843.0584506796013;3847.3844184930276;3848.0956975110826;3854.9807250963568;3118.3295591447495;3149.6692847251165;3357.6138744044747;3419.965800341965;3447.7069449096607;1123.634818683931;1124.5614210457927;1126.0428635659787;1126.1947707389256;1135.3755434510986;967.0184762466102;967.0377973915998;1025.0006243912126;1065.4512925843042;1285.3059347952187;6471.158749362553;6536.967315163393;6538.084668146464;6542.051402546699;6543;1062.9202809789297;1072.646026811166;1092.3118435385657;1098.3464838421128;1126.7126882644873;5223.660462070029;5298.364196296469;5393.83818485446;5405.270288511001;5405.702686352289;8128.959355203305;8462.492250464991;8471.237588617054;8478.025027121837;8478.152184781473;7952.483088599338;8325.500469971821;8345.207205315486;8352.874706879402;8367.539785311745;6589.86820263592;6754.054432379471;6757.256701762803;6759.5606285591275;6760.695768690421;6471.255805582418;6549.836254093686;6600.735970561123;6617.404433600999;6624.370684784938;7291.489595728248;7362.300581444754;7431.962840185764;7541.585212813348;7552.358049565849;7544.886826697713;7677.232276772278;7861.764147075597;7871.488353257249;7881.763547093597;6280.623162610258;6342.651154186379;6360.650164240826;6440.098386225838;6483.837904052248;5769.105788602773;5859.20900678403;5863.677497737665;5876.236089308362;6884.311568843075;5949.851253718519;6056.818295451144;6296.118543404019;6387.616742995435;6405.903911441239;6040.577159598786;6201.627902325875;6214.161088253209;6266.968665156645;6359.427651511386;6271.122042914087;6307.400796924285;6309.873802523832;6311.526635502264;6321.905171422341;5880.647161170344;5915.645061296336;5917.260342457193;6026.126211699367;6038.63768173911;5907.734151963258;6082.9695851520455;6083.726232319645;6084;6112.510999119971 14:18:06 INFO - PROCESS | 26330 | |4;prototype.html;332.5958959863765;337.2563497488039;339.95240666306705;344.6037057384009;347.8695489191555;6022.397760223976;6031.939680603193;6078.300995385521;6087.7260523276445;6091.025435930252;5742.827715168552;5755.453231942969;5814.098814683731;5885.32318783339;5950.821475355746;4565.132624801294;4570.680052396334;4590;4590.472095708986;4605.700629459091;4413.249747542909;4594.632429405639;4599.149157405874;4602.194615942213;4614.8154073837;4454.13144436835;4461.018575913294;4555.658325625592;4559.635229181657;4560.3843481130125;4518.774061296955;4528.230200865861;4546.204414227497;4546.704464209833;4554.476235232957;4014.3978403239457;4039.0508230565792;4054.8175332110127;4057;4067.959320406788;5562.443755624446;5677.630953987978;5679.488846003838;5690.487856092972;5701.2018317435595;5246.554042906358;5254.133068043769;5255.08036093682;5258.684478931238;5307.814226502092;6373.9681301593655;6376.936230637681;6377.362263773632;6384.968075159641;6386.744530218785;4378.934315985262;4399.428074350314;4402.3396490526675;4403.207422663919;4418.867433976986;6499.740010399579;6582.769603063918;6592.80221593353;6629.171353580802;6656.700448479782;4650.95349046512;4655.231886738718;4655.95344046562;4655.976720116378;4663.790129444184;4721.055788842176;4721.15019296523;4725.763711814396;4730.645201609893;4732.834350797705;5379.865503362447;5385.219143224289;5389.218563308298;5392.056390131711;5404.513593776579;6255.155554000243;6423.903641445382;6433.131527243856;6434.067060276234;6438.678066096676;1650.6616143690514;1671.4484220207546;1672.7909011373579;1673.2470388325303;1673.7656728058082;1127.312339472921;1133.8072527670315;1137.9829302560468;1155.5435602936961;1167.795635763738;6004.789832355934;6010.308814486302;6011.879762404727;6014.578979471483;6014.969925150346;6413.102165696806;6572.474202063823;6577.868442631217;6585.341465853377;6594.637294948824;5892.175095486636;5958.510372406899;5981.730822113015;5983.970080149571;6030.698465076729;3543.681068703829;3572.2498275361945;3576.2476386570916;3588.6770190682964;3590.7845529267806;6581.736730530821;6806.217285012188;6809.080774095532;6813.727450902007;6815.42068924147;6815.488838337144;6822.4200942919415;6828.624425656537;6831.6242606657115;6837.521373503906;6782.694778734969;6798.286179951034;6798.93201067983;6800.4219641330055;6802.14973128359;6411.96794016027;6623.470122390101;6629.237637671729;6630.801075967729;6634.03806448072;6522.510811689237;6582.440492558187;6590.143281373583;6593.208814942238;6599.901001485077;6826.522143449911;6834.589924604539;6837.1111755471475;6845.520813543004;6851.794446166623;4494.101179763995;4559.156556037011;4566.109608626286;4566.725996440225;4568.771561421982;6426;6570.047343135314;6574.276829548841;6627.304133065959;6681.064650948774;6487.902681459687;6488.091667166695;6494.740210391531;6495.610263384212;6503.382178693017;6240.375962403723;6464.5798023128345;6464.935350646433;6485.578437401554;6487.091807147098;6286.491242101954;6323.557350985387;6330.746770129143;6338.746450141943;6339.683015849281;6402.423781859468;6433.388828061326;6487.513436492188;6488.675566221765;6498.935010649833;6159.5072394209255;6301.590396624205;6321.11504389395;6349.49204063683;6354 14:18:06 INFO - PROCESS | 26330 | |5;yui.html;731.9377852882504;835.8787975743518;842.9789255268614;854.0989256334568;862.168007872403;12822.48710051598;12993.74012519749;13013.804792928113;13018.153820001706;13043;12653.240805551673;12784.169029013108;12886;12887.033472489577;13014.804777928315;825.347975099672;841.0706169682504;841.4026041510505;841.6002398860553;842.3976856547567;828.772087675888;850.196564246787;850.3834719828137;850.587465079436;850.7873031742065;874.5889431966965;886.9068747781487;886.9822603547925;887.4808237181225;888.2938064238913;876.5836227791812;883.0463099852176;883.7039591736776;883.7613844262013;883.8276536075468;642.6979319719725;646.9708863101125;648.0538413915689;648.5200951296055;648.9578177418452;12502.187357821804;12511.687207819787;12583.245005299712;12648.114631975764;12674.112812103156;10177;10284;10807.621733239299;10899.782004359948;11096.944515277453;9981.251406144569;10005.29962902597;10073.49632518371;10110.443925584164;10275.177985761122;3603.765755225928;3627.6009638939695;3674.2467794102145;3686.1337585667347;3745.6441638044344;34309.92415501864;41190.38214426786;44463.77768111171;45411.31883021758;45806.08387832258;10167.7458063549;10191;10385.63650272237;10424.583016679248;10619.09737672291;17882;17999.460016199537;18084.27662893496;18098.276068957093;18147.276008779147;7406.925930740731;7436.367908727819;7502.962485187648;7657.578833164118;7663.157052724196;4216.64158546527;4269.210196113729;4283.1005488847695;4323.221820072355;4360.716553424018;2946.2634341414646;2981.7316441520366;2985.7462115719973;2993.2816124130054;2998.8800447981835;505.84824552634063;505.9595232381401;509.23868816120137;513.8895137545371;521.7321907764094;504.71483611759237;552.8175702018405;603.7826382502295;619.7582942652369;623.4575918950542;7715.729949451742;7773.883391749016;7819.296263336327;8154.103048664642;8254;539.4201233673816;589.2634207240949;596.7225240263299;684.4832151725416;690.9827254318682;3718.7396882218527;3749.1564398010228;3762.3415902217002;3856.3444214483607;3873.65137137659;53207;53992;54061.05328413871;57993;58330.4166958325;41930.37104443375;47518.287225691645;47637;48062.279065814044;49545.99999999928;43603.34594981078;44092.118157636665;44491.55508444939;44913;46197.53802462067;7363.705451782083;8225.40241573447;8383.245507904317;8536.146385361662;8634.740957771277;29533.26166845846;33664.831675841466;34007;36162.8191859039;37107.6289237115;42919.7854010728;43435.34846977235;43502.782486087366;43538.56461435472;43956.34065489084;10422.687319380431;10433.165346772392;10554.472276386303;10719.249652524248;10731.463426828783;11056.336619802838;11063.889361106287;11156.721081973015;11544.076473881902;11637.370768092644;10291.742706432398;10370.701427684668;10469.371837689763;10556.89443105559;10619.36283822973;10500;10543.472826358498;10787.137029037502;10967.890321096687;11335.546578136782;10591.841122383325;11086.501107450023;11179.329240245612;11500.654980350602;11535.942320288344;8621.458955112648;8696.645622122094;8730.912690873263;8819.559022048743;9038.728838134866;8114.43198976066;8301.958490207511;8414.663413463637;8580.742577722678;8695.52174630376 14:18:06 INFO - PROCESS | 26330 | __end_tp_report 14:18:06 INFO - PROCESS | 26330 | __start_cc_report 14:18:06 INFO - PROCESS | 26330 | _x_x_mozilla_cycle_collect,863 14:18:06 INFO - PROCESS | 26330 | __end_cc_report 14:18:06 INFO - PROCESS | 26330 | __startTimestamp1451513886837__endTimestamp 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | ------- Summary: start ------- 14:18:06 INFO - PROCESS | 26330 | Number of tests: 6 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#0] dojo.html Cycles:165 Average:5332.19 Median:5600.19 stddev:598.52 (10.7%) stddev-sans-first:574.74 14:18:06 INFO - PROCESS | 26330 | Values: 3123.7 3202.3 3243.9 3244.8 3262.0 5210.5 5320.3 5333.9 5353.0 5409.2 5314.2 5327.0 5347.4 5422.5 5443.3 4813.4 4870.8 4885.4 4935.7 4991.9 4918.0 4955.1 4996.7 5002.2 5029.2 4841.4 4938.9 4945.2 4961.6 4983.4 4777.5 4876.0 4877.4 4883.9 4891.7 4827.8 4833.3 4840.9 4852.9 4865.5 5091.5 5139.2 5149.4 5185.0 5208.2 5784.3 5787.2 5792.9 5803.3 5804.6 5807.2 5816.4 5826.5 5834.7 5837.9 5324.7 5335.5 5411.7 5438.3 5439.3 5878.7 5883.4 5892.9 5902.0 5938.7 5666.1 5668.1 5668.8 5672.8 5729.3 5604.6 5656.7 5708.7 5754.5 5786.5 5678.9 5720.0 5722.2 5724.8 5730.6 5709.3 5749.6 5749.6 5750.3 5762.3 4228.3 4285.8 4297.2 4327.5 4370.5 3852.2 3890.8 3894.1 3921.8 3937.6 5372.4 5381.9 5397.1 5401.4 5404.0 5638.4 5689.6 5748.4 5751.8 5786.6 5333.4 5343.4 5346.3 5349.4 5389.0 4978.5 5003.5 5008.4 5014.3 5055.9 5776.7 5842.8 5878.6 5911.9 5922.7 5712.9 5778.0 5781.0 5821.3 5824.9 5884.2 5906.0 5910.3 5913.8 5917.2 5460.5 5666.2 5723.3 5724.2 5724.3 5709.8 5731.8 5767.0 5804.7 5854.6 5617.2 5633.0 5639.5 5646.8 5648.9 5588.9 5617.8 5622.1 5630.5 5630.7 5274.8 5330.5 5396.5 5410.3 5523.0 5679.1 5688.6 5720.0 5720.6 5725.2 5600.2 5605.0 5605.9 5609.1 5617.7 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#1] ext.html Cycles:180 Average:44889.28 Median:190437.56 stddev:75767.43 (39.8%) stddev-sans-first:75906.78 14:18:06 INFO - PROCESS | 26330 | Values: 530.6 533.1 534.3 552.6 558.4 25007.0 27824.3 27912.2 28021.7 35048.1 38743.2 38942.2 39139.0 39174.8 39214.8 8231.5 8533.3 8546.9 8548.4 8551.9 7421.4 7595.0 7598.6 8331.4 10018.1 9895.7 9988.0 10014.7 10024.9 10032.9 9846.6 9862.4 9868.5 9947.5 9958.3 7461.8 7630.0 7633.8 10025.1 10304.9 35852.1 36305.5 36413.3 36433.0 36460.1 2980.1 2982.7 3036.0 3071.5 3077.2 27302.0 27883.2 28493.0 28670.1 28883.1 3987.5 4004.9 4065.0 4128.2 4249.9 266617.0 270293.0 273714.0 274296.0 275339.6 43058.0 43742.1 59924.0 60094.7 60356.4 56116.0 56179.2 56544.7 56546.2 56642.5 13196.0 13416.8 13418.1 13434.6 13451.1 9645.1 9760.8 9761.7 9763.6 9764.1 19813.8 20368.7 20437.0 20444.1 20547.4 7850.6 8093.9 8130.6 8171.6 8178.6 826.6 863.5 908.3 1052.5 1053.8 28486.0 28596.0 28611.0 28761.9 28808.7 938.2 989.8 1063.9 1124.0 1129.1 14825.2 14879.3 15052.0 15102.8 15195.0 337506.0 343649.0 344882.0 345122.0 345827.0 52719.0 53076.2 53100.0 53134.2 53145.5 1304.9 1311.6 1318.7 1325.5 1334.9 27534.2 28497.0 28725.9 28759.9 29000.7 40576.6 41214.0 46313.5 47471.8 47548.5 240782.0 241268.0 244579.0 245445.0 245918.0 26883.3 27371.2 31722.2 32092.2 32127.5 36687.4 38698.0 43112.8 45254.0 47052.0 33087.3 33239.0 33816.3 38347.4 40075.4 33878.0 37804.8 39294.2 39884.2 40453.8 33710.0 33901.8 37942.2 38820.0 38941.0 28979.4 30532.7 31139.4 31161.4 31192.4 23458.8 23796.8 23862.2 23912.0 24183.5 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#2] jquery.html Cycles:180 Average:27870.44 Median:18124.94 stddev:85815.81 (473.5%) stddev-sans-first:86031.64 14:18:06 INFO - PROCESS | 26330 | Values: 338.5 341.9 353.1 354.3 354.9 14092.6 14483.0 16413.2 16978.6 18176.2 14647.7 14665.4 14939.9 14992.6 15010.4 4980.2 4987.2 4994.1 5035.4 5240.1 3938.7 4047.9 5385.0 5751.4 5990.1 5871.9 5916.0 5916.6 5937.9 5942.1 5720.6 5886.5 5888.9 5889.0 5893.7 5147.5 5181.7 5187.3 5195.0 5204.9 15216.9 15225.5 17744.4 18657.0 19303.6 1943.3 1955.4 1996.7 2087.2 2139.5 9692.0 9765.9 9879.6 11823.6 12581.4 1652.1 1735.2 1762.6 1808.8 1848.2 57606.4 59458.7 61068.7 61160.0 61805.4 9847.6 9878.2 9954.6 10078.9 10265.1 12932.7 12942.9 13005.9 13022.7 13081.4 7162.3 7191.7 7195.0 7208.5 7235.8 6914.3 6934.0 6939.7 6963.1 6985.3 4239.7 4274.6 4286.2 4286.7 4314.0 1667.0 1736.2 1739.7 1790.5 1805.4 401.6 817.8 863.4 1023.8 1048.4 9634.7 10481.6 10912.2 10935.3 11311.3 442.3 455.3 865.1 904.2 933.2 8830.5 9740.8 10075.4 10234.6 10297.2 497023.0 504101.0 506017.0 513873.0 596296.2 77366.0 79438.6 79812.0 80909.2 81185.0 1112.3 1124.2 1125.7 1131.1 1147.0 15588.8 15726.6 15734.1 15840.7 15952.1 32911.0 34896.7 34931.3 35220.3 35895.0 43104.0 43307.4 43592.1 45670.8 46327.3 9306.8 9503.5 9608.8 9616.9 9619.9 11402.6 13686.7 13780.7 16553.3 17586.7 10989.8 11937.3 13681.7 14119.2 14264.3 14016.8 14056.9 14329.9 14564.2 14628.1 14274.4 14333.0 14334.9 14722.3 14857.1 9126.2 9170.5 9465.4 9467.3 9566.6 9838.3 12906.6 14438.6 14642.9 14643.2 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#3] mootools.html Cycles:180 Average:4924.76 Median:6069.89 stddev:2480.88 (40.9%) stddev-sans-first:2471.28 14:18:06 INFO - PROCESS | 26330 | Values: 1111.4 1419.5 1424.8 1552.2 1736.3 6157.4 6715.3 6787.2 6818.4 6824.1 6744.0 6896.4 6903.3 6912.5 6915.3 1921.7 1950.8 1951.9 2182.6 2217.7 2163.1 2192.2 2192.4 2193.7 2196.8 2107.1 2125.1 2161.5 2161.5 2162.6 2117.9 2126.3 2140.2 2148.3 2196.7 2189.5 2220.6 2222.4 2222.9 2223.1 6909.9 7001.7 7020.5 7029.6 7053.8 4174.4 4176.0 4239.8 4241.0 4246.4 2830.5 2852.1 2915.2 2920.7 2946.6 913.1 916.8 937.8 957.3 969.1 9406.2 9410.8 9415.3 9419.6 9441.1 3978.7 4002.7 4051.7 4054.2 4058.6 8201.2 8213.4 8217.3 8221.4 8222.0 4168.1 4202.1 4202.1 4223.3 4233.6 3835.8 3843.1 3847.4 3848.1 3855.0 3118.3 3149.7 3357.6 3420.0 3447.7 1123.6 1124.6 1126.0 1126.2 1135.4 967.0 967.0 1025.0 1065.5 1285.3 6471.2 6537.0 6538.1 6542.1 6543.0 1062.9 1072.6 1092.3 1098.3 1126.7 5223.7 5298.4 5393.8 5405.3 5405.7 8129.0 8462.5 8471.2 8478.0 8478.2 7952.5 8325.5 8345.2 8352.9 8367.5 6589.9 6754.1 6757.3 6759.6 6760.7 6471.3 6549.8 6600.7 6617.4 6624.4 7291.5 7362.3 7432.0 7541.6 7552.4 7544.9 7677.2 7861.8 7871.5 7881.8 6280.6 6342.7 6360.7 6440.1 6483.8 5769.1 5859.2 5863.7 5876.2 6884.3 5949.9 6056.8 6296.1 6387.6 6405.9 6040.6 6201.6 6214.2 6267.0 6359.4 6271.1 6307.4 6309.9 6311.5 6321.9 5880.6 5915.6 5917.3 6026.1 6038.6 5907.7 6083.0 6083.7 6084.0 6112.5 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#4] prototype.html Cycles:180 Average:5344.31 Median:6011.09 stddev:1599.69 (26.6%) stddev-sans-first:1559.32 14:18:06 INFO - PROCESS | 26330 | Values: 332.6 337.3 340.0 344.6 347.9 6022.4 6031.9 6078.3 6087.7 6091.0 5742.8 5755.5 5814.1 5885.3 5950.8 4565.1 4570.7 4590.0 4590.5 4605.7 4413.2 4594.6 4599.1 4602.2 4614.8 4454.1 4461.0 4555.7 4559.6 4560.4 4518.8 4528.2 4546.2 4546.7 4554.5 4014.4 4039.1 4054.8 4057.0 4068.0 5562.4 5677.6 5679.5 5690.5 5701.2 5246.6 5254.1 5255.1 5258.7 5307.8 6374.0 6376.9 6377.4 6385.0 6386.7 4378.9 4399.4 4402.3 4403.2 4418.9 6499.7 6582.8 6592.8 6629.2 6656.7 4651.0 4655.2 4656.0 4656.0 4663.8 4721.1 4721.2 4725.8 4730.6 4732.8 5379.9 5385.2 5389.2 5392.1 5404.5 6255.2 6423.9 6433.1 6434.1 6438.7 1650.7 1671.4 1672.8 1673.2 1673.8 1127.3 1133.8 1138.0 1155.5 1167.8 6004.8 6010.3 6011.9 6014.6 6015.0 6413.1 6572.5 6577.9 6585.3 6594.6 5892.2 5958.5 5981.7 5984.0 6030.7 3543.7 3572.2 3576.2 3588.7 3590.8 6581.7 6806.2 6809.1 6813.7 6815.4 6815.5 6822.4 6828.6 6831.6 6837.5 6782.7 6798.3 6798.9 6800.4 6802.1 6412.0 6623.5 6629.2 6630.8 6634.0 6522.5 6582.4 6590.1 6593.2 6599.9 6826.5 6834.6 6837.1 6845.5 6851.8 4494.1 4559.2 4566.1 4566.7 4568.8 6426.0 6570.0 6574.3 6627.3 6681.1 6487.9 6488.1 6494.7 6495.6 6503.4 6240.4 6464.6 6464.9 6485.6 6487.1 6286.5 6323.6 6330.7 6338.7 6339.7 6402.4 6433.4 6487.5 6488.7 6498.9 6159.5 6301.6 6321.1 6349.5 6354.0 14:18:06 INFO - PROCESS | 26330 | 14:18:06 INFO - PROCESS | 26330 | [#5] yui.html Cycles:180 Average:13085.37 Median:23982.03 stddev:15057.42 (62.8%) stddev-sans-first:15071.09 14:18:06 INFO - PROCESS | 26330 | Values: 731.9 835.9 843.0 854.1 862.2 12822.5 12993.7 13013.8 13018.2 13043.0 12653.2 12784.2 12886.0 12887.0 13014.8 825.3 841.1 841.4 841.6 842.4 828.8 850.2 850.4 850.6 850.8 874.6 886.9 887.0 887.5 888.3 876.6 883.0 883.7 883.8 883.8 642.7 647.0 648.1 648.5 649.0 12502.2 12511.7 12583.2 12648.1 12674.1 10177.0 10284.0 10807.6 10899.8 11096.9 9981.3 10005.3 10073.5 10110.4 10275.2 3603.8 3627.6 3674.2 3686.1 3745.6 34309.9 41190.4 44463.8 45411.3 45806.1 10167.7 10191.0 10385.6 10424.6 10619.1 17882.0 17999.5 18084.3 18098.3 18147.3 7406.9 7436.4 7503.0 7657.6 7663.2 4216.6 4269.2 4283.1 4323.2 4360.7 2946.3 2981.7 2985.7 2993.3 2998.9 505.8 506.0 509.2 513.9 521.7 504.7 552.8 603.8 619.8 623.5 7715.7 7773.9 7819.3 8154.1 8254.0 539.4 589.3 596.7 684.5 691.0 3718.7 3749.2 3762.3 3856.3 3873.7 53207.0 53992.0 54061.1 57993.0 58330.4 41930.4 47518.3 47637.0 48062.3 49546.0 43603.3 44092.1 44491.6 44913.0 46197.5 7363.7 8225.4 8383.2 8536.1 8634.7 29533.3 33664.8 34007.0 36162.8 37107.6 42919.8 43435.3 43502.8 43538.6 43956.3 10422.7 10433.2 10554.5 10719.2 10731.5 11056.3 11063.9 11156.7 11544.1 11637.4 10291.7 10370.7 10469.4 10556.9 10619.4 10500.0 10543.5 10787.1 10967.9 11335.5 10591.8 11086.5 11179.3 11500.7 11535.9 8621.5 8696.6 8730.9 8819.6 9038.7 8114.4 8302.0 8414.7 8580.7 8695.5 14:18:06 INFO - PROCESS | 26330 | -------- Summary: end -------- 14:18:06 INFO - PROCESS | 26330 | 14:18:07 INFO - TEST-INFO | 26330: exit 0 14:18:07 INFO - TEST-OK | dromaeo_css | took 1112997ms 14:18:07 INFO - TEST-START | kraken 14:18:07 INFO - operating with platform_type : linux_ 14:18:07 INFO - Initialising browser for kraken test... 14:18:07 INFO - TEST-INFO | started process 26522 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYGpIde/profile http://localhost:35669/getInfo.html) 14:18:11 INFO - PROCESS | 26522 | __metrics Screen width/height:1600/1200 14:18:11 INFO - PROCESS | 26522 | colorDepth:24 14:18:11 INFO - PROCESS | 26522 | Browser inner width/height: 1024/697 14:18:11 INFO - PROCESS | 26522 | __metrics 14:18:11 INFO - PROCESS | 26522 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:18:11 INFO - PROCESS | 26522 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:12 INFO - TEST-INFO | 26522: exit 0 14:18:12 INFO - Browser initialized. 14:18:12 INFO - Running cycle 1/1 for kraken test... 14:18:12 INFO - TEST-INFO | started process 26604 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYGpIde/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:24 INFO - PROCESS | 26604 | RSS: Main: 148332544 14:18:24 INFO - PROCESS | 26604 | 14:18:26 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35669/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:27 INFO - PROCESS | 26604 | RSS: Main: 183218176 14:18:27 INFO - PROCESS | 26604 | 14:18:30 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35669/tests/kraken/driver.html?testName=audio-dft) 14:18:30 INFO - PROCESS | 26604 | RSS: Main: 173576192 14:18:30 INFO - PROCESS | 26604 | 14:18:33 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35669/tests/kraken/driver.html?testName=audio-fft) 14:18:34 INFO - PROCESS | 26604 | RSS: Main: 160264192 14:18:34 INFO - PROCESS | 26604 | 14:18:36 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35669/tests/kraken/driver.html?testName=audio-oscillator) 14:18:36 INFO - PROCESS | 26604 | RSS: Main: 161742848 14:18:36 INFO - PROCESS | 26604 | 14:18:38 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:39 INFO - PROCESS | 26604 | RSS: Main: 164659200 14:18:39 INFO - PROCESS | 26604 | 14:18:42 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35669/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:42 INFO - PROCESS | 26604 | RSS: Main: 164237312 14:18:42 INFO - PROCESS | 26604 | 14:18:46 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35669/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:46 INFO - PROCESS | 26604 | RSS: Main: 165957632 14:18:46 INFO - PROCESS | 26604 | 14:18:49 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35669/tests/kraken/driver.html?testName=json-parse-financial) 14:18:50 INFO - PROCESS | 26604 | RSS: Main: 165539840 14:18:50 INFO - PROCESS | 26604 | 14:18:51 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:52 INFO - PROCESS | 26604 | RSS: Main: 176914432 14:18:52 INFO - PROCESS | 26604 | 14:18:54 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:54 INFO - PROCESS | 26604 | RSS: Main: 174948352 14:18:54 INFO - PROCESS | 26604 | 14:18:56 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:57 INFO - PROCESS | 26604 | RSS: Main: 180604928 14:18:57 INFO - PROCESS | 26604 | 14:18:59 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:00 INFO - PROCESS | 26604 | RSS: Main: 189149184 14:19:00 INFO - PROCESS | 26604 | 14:19:03 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:03 INFO - PROCESS | 26604 | RSS: Main: 184516608 14:19:03 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | Cycle 1(1): loaded http://localhost:35669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35669/tests/kraken/driver.html?testName=ai-astar) 14:19:05 INFO - PROCESS | 26604 | RSS: Main: 242286592 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | __start_tp_report 14:19:05 INFO - PROCESS | 26604 | _x_x_mozilla_page_load 14:19:05 INFO - PROCESS | 26604 | _x_x_mozilla_page_load_details 14:19:05 INFO - PROCESS | 26604 | |i|pagename|runs| 14:19:05 INFO - PROCESS | 26604 | |0;ai-astar;112;113;106;111;112;111;101;113;112;105 14:19:05 INFO - PROCESS | 26604 | |1;audio-beat-detection;160;128;154;169;129;150;155;124;166;124 14:19:05 INFO - PROCESS | 26604 | |2;audio-dft;161;161;162;161;164;163;161;159;162;163 14:19:05 INFO - PROCESS | 26604 | |3;audio-fft;72;75;87;91;72;75;72;129;91;73 14:19:05 INFO - PROCESS | 26604 | |4;audio-oscillator;97;97;142;96;96;96;144;96;97;139 14:19:05 INFO - PROCESS | 26604 | |5;imaging-gaussian-blur;108;109;109;109;109;109;110;109;109;110 14:19:05 INFO - PROCESS | 26604 | |6;imaging-darkroom;146;146;145;145;145;146;145;145;146;147 14:19:05 INFO - PROCESS | 26604 | |7;imaging-desaturate;95;96;96;96;96;95;96;96;96;95 14:19:05 INFO - PROCESS | 26604 | |8;json-parse-financial;60;60;58;58;58;59;58;68;57;57 14:19:05 INFO - PROCESS | 26604 | |9;json-stringify-tinderbox;69;68;69;68;69;69;70;69;70;69 14:19:05 INFO - PROCESS | 26604 | |10;stanford-crypto-aes;87;88;88;87;87;89;89;91;90;87 14:19:05 INFO - PROCESS | 26604 | |11;stanford-crypto-ccm;119;117;127;123;115;126;118;122;128;120 14:19:05 INFO - PROCESS | 26604 | |12;stanford-crypto-pbkdf2;160;158;155;155;154;149;156;157;163;154 14:19:05 INFO - PROCESS | 26604 | |13;stanford-crypto-sha256-iterative;68;71;68;70;68;68;67;68;69;69 14:19:05 INFO - PROCESS | 26604 | __end_tp_report 14:19:05 INFO - PROCESS | 26604 | __start_cc_report 14:19:05 INFO - PROCESS | 26604 | _x_x_mozilla_cycle_collect,941 14:19:05 INFO - PROCESS | 26604 | __end_cc_report 14:19:05 INFO - PROCESS | 26604 | __startTimestamp1451513945565__endTimestamp 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | ------- Summary: start ------- 14:19:05 INFO - PROCESS | 26604 | Number of tests: 14 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.27 14:19:05 INFO - PROCESS | 26604 | Values: 112.0 113.0 106.0 111.0 112.0 111.0 101.0 113.0 112.0 105.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.50 stddev:17.85 (11.6%) stddev-sans-first:18.19 14:19:05 INFO - PROCESS | 26604 | Values: 160.0 128.0 154.0 169.0 129.0 150.0 155.0 124.0 166.0 124.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 14:19:05 INFO - PROCESS | 26604 | Values: 161.0 161.0 162.0 161.0 164.0 163.0 161.0 159.0 162.0 163.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.00 stddev:17.78 (23.7%) stddev-sans-first:18.35 14:19:05 INFO - PROCESS | 26604 | Values: 72.0 75.0 87.0 91.0 72.0 75.0 72.0 129.0 91.0 73.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:21.89 (22.8%) stddev-sans-first:22.71 14:19:05 INFO - PROCESS | 26604 | Values: 97.0 97.0 142.0 96.0 96.0 96.0 144.0 96.0 97.0 139.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 14:19:05 INFO - PROCESS | 26604 | Values: 108.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:19:05 INFO - PROCESS | 26604 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 147.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:19:05 INFO - PROCESS | 26604 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.50 stddev:3.23 (5.5%) stddev-sans-first:3.42 14:19:05 INFO - PROCESS | 26604 | Values: 60.0 60.0 58.0 58.0 58.0 59.0 58.0 68.0 57.0 57.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:19:05 INFO - PROCESS | 26604 | Values: 69.0 68.0 69.0 68.0 69.0 69.0 70.0 69.0 70.0 69.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.50 stddev:1.42 (1.6%) stddev-sans-first:1.42 14:19:05 INFO - PROCESS | 26604 | Values: 87.0 88.0 88.0 87.0 87.0 89.0 89.0 91.0 90.0 87.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:4.45 (3.6%) stddev-sans-first:4.63 14:19:05 INFO - PROCESS | 26604 | Values: 119.0 117.0 127.0 123.0 115.0 126.0 118.0 122.0 128.0 120.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.50 stddev:3.78 (2.4%) stddev-sans-first:3.74 14:19:05 INFO - PROCESS | 26604 | Values: 160.0 158.0 155.0 155.0 154.0 149.0 156.0 157.0 163.0 154.0 14:19:05 INFO - PROCESS | 26604 | 14:19:05 INFO - PROCESS | 26604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 14:19:05 INFO - PROCESS | 26604 | Values: 68.0 71.0 68.0 70.0 68.0 68.0 67.0 68.0 69.0 69.0 14:19:05 INFO - PROCESS | 26604 | -------- Summary: end -------- 14:19:05 INFO - PROCESS | 26604 | 14:19:06 INFO - TEST-INFO | 26604: exit 0 14:19:06 INFO - TEST-OK | kraken | took 58966ms 14:19:06 INFO - TEST-START | v8_7 14:19:06 INFO - operating with platform_type : linux_ 14:19:06 INFO - Initialising browser for v8_7 test... 14:19:06 INFO - TEST-INFO | started process 26851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60tb1_/profile http://localhost:35669/getInfo.html) 14:19:10 INFO - PROCESS | 26851 | __metrics Screen width/height:1600/1200 14:19:10 INFO - PROCESS | 26851 | colorDepth:24 14:19:10 INFO - PROCESS | 26851 | Browser inner width/height: 1024/697 14:19:10 INFO - PROCESS | 26851 | __metrics 14:19:10 INFO - PROCESS | 26851 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:19:10 INFO - PROCESS | 26851 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:11 INFO - TEST-INFO | 26851: exit 0 14:19:11 INFO - Browser initialized. 14:19:11 INFO - Running cycle 1/1 for v8_7 test... 14:19:11 INFO - TEST-INFO | started process 26935 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60tb1_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:23 INFO - PROCESS | 26935 | RSS: Main: 149901312 14:19:23 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | Cycle 1(1): loaded http://localhost:35669/tests/v8_7/run.html (next: http://localhost:35669/tests/v8_7/run.html) 14:19:44 INFO - PROCESS | 26935 | RSS: Main: 583372800 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | __start_tp_report 14:19:44 INFO - PROCESS | 26935 | _x_x_mozilla_page_load 14:19:44 INFO - PROCESS | 26935 | _x_x_mozilla_page_load_details 14:19:44 INFO - PROCESS | 26935 | |i|pagename|runs| 14:19:44 INFO - PROCESS | 26935 | |0;Richards;169.63528413910095 14:19:44 INFO - PROCESS | 26935 | |1;DeltaBlue;191.20458891013385 14:19:44 INFO - PROCESS | 26935 | |2;Encrypt;280.97780275358247 14:19:44 INFO - PROCESS | 26935 | |3;Decrypt;5263.1578947368425 14:19:44 INFO - PROCESS | 26935 | |4;RayTrace;1990.0596421471173 14:19:44 INFO - PROCESS | 26935 | |5;Earley;799.3605115907275 14:19:44 INFO - PROCESS | 26935 | |6;Boyer;12382.716049382716 14:19:44 INFO - PROCESS | 26935 | |7;RegExp;25974.358974358973 14:19:44 INFO - PROCESS | 26935 | |8;Splay;648.0881399870383 14:19:44 INFO - PROCESS | 26935 | |9;NavierStokes;4822.115384615385 14:19:44 INFO - PROCESS | 26935 | __end_tp_report 14:19:44 INFO - PROCESS | 26935 | __startTimestamp1451513984842__endTimestamp 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | ------- Summary: start ------- 14:19:44 INFO - PROCESS | 26935 | Number of tests: 10 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#0] Richards Cycles:1 Average:169.64 Median:169.64 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 169.6 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 191.2 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 281.0 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 5263.2 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 1990.1 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 799.4 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 12382.7 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 25974.4 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#8] Splay Cycles:1 Average:648.09 Median:648.09 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 648.1 14:19:44 INFO - PROCESS | 26935 | 14:19:44 INFO - PROCESS | 26935 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:19:44 INFO - PROCESS | 26935 | Values: 4822.1 14:19:44 INFO - PROCESS | 26935 | -------- Summary: end -------- 14:19:44 INFO - PROCESS | 26935 | 14:19:45 INFO - TEST-INFO | 26935: exit 0 14:19:45 INFO - TEST-OK | v8_7 | took 39190ms 14:19:45 INFO - SUITE-END | took 1211s 14:19:45 INFO - Completed test suite (00:20:11) 14:19:45 INFO - Working with test: dromaeo_css 14:19:45 INFO - Generating results file: dromaeo_css 14:19:45 INFO - Working with test: kraken 14:19:45 INFO - Generating results file: kraken 14:19:45 INFO - javascript benchmark 14:19:45 INFO - Working with test: v8_7 14:19:45 INFO - Generating results file: v8_7 14:19:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:19:45 INFO - process_Request line: dromaeo_css 6769.91 graph.html#tests=[[72,64,35]] 14:19:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:45 INFO - process_Request line: kraken 1524.10 graph.html#tests=[[232,64,35]] 14:19:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:46 INFO - process_Request line: v8_7 19540.70 graph.html#tests=[[230,64,35]] 14:19:46 INFO - RETURN: dromaeo_css: 6769.91 14:19:46 INFO - RETURN: kraken: 1524.10 14:19:46 INFO - RETURN: v8_7: 19540.70 14:19:46 INFO - javascript benchmark 14:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3123.7032481914216, 3202.343519578487, 3243.8540265688043, 3244.8053116812994, 3261.9673803261967, 5210.478952104797, 5320.281761962134, 5333.919991200135, 5353.03645343838, 5409.161579955104, 5314.176302673091, 5327.0, 5347.438518955512, 5422.48486393793, 5443.292371991635, 4813.374261346029, 4870.756462176894, 4885.364902562662, 4935.679180853251, 4991.850244492671, 4917.950820491785, 4955.08330958772, 4996.700197988114, 5002.224655178435, 5029.1953287473825, 4841.394825646794, 4938.9012219755405, 4945.23348880924, 4961.603071754251, 4983.352164218646, 4777.498362671939, 4876.0, 4877.439094504142, 4883.902321953541, 4891.6820406673805, 4827.831025914076, 4833.275008748716, 4840.927386089212, 4852.927206091911, 4865.537773911473, 5091.516305950929, 5139.229115632647, 5149.382074151088, 5185.0148471790235, 5208.192730126836, 5784.334801497797, 5787.1608616750755, 5792.8841423171725, 5803.303603567557, 5804.564657650693, 5807.245058142456, 5816.418358164192, 5826.533877289849, 5834.708264586754, 5837.9124313135335, 5324.707141107198, 5335.493128152819, 5411.675299482044, 5438.265834112423, 5439.292891924064, 5878.676672783038, 5883.411658834082, 5892.911606325909, 5901.970490147608, 5938.673372964528, 5666.065099258659, 5668.149777533321, 5668.801591944262, 5672.801451949162, 5729.28383952006, 5604.60767746262, 5656.6888821115235, 5708.686022268732, 5754.4533269339345, 5786.508146807484, 5678.886422271531, 5719.970405326998, 5722.17028530869, 5724.79963201286, 5730.570207234474, 5709.314882214161, 5749.568782341341, 5749.626274292157, 5750.30996280449, 5762.30852297727, 4228.344606585984, 4285.849995250152, 4297.205017071852, 4327.502337231196, 4370.453693288339, 3852.152526444178, 3890.7665540067687, 3894.1043559980794, 3921.784301863425, 3937.5668676445566, 5372.409035006146, 5381.919271210935, 5397.10947693634, 5401.378841433207, 5404.0, 5638.436156384329, 5689.630174038757, 5748.425157484218, 5751.827445176651, 5786.623869448473, 5333.413324534298, 5343.412224655285, 5346.304980352529, 5349.411564727877, 5389.0299746046085, 4978.452370239271, 5003.524665156804, 5008.4240312364545, 5014.323066385991, 5055.87360315995, 5776.740046697909, 5842.824715258549, 5878.647281163144, 5911.881762364728, 5922.674252916131, 5712.942870571241, 5777.971110144423, 5780.971095144498, 5821.330546987151, 5824.912626310694, 5884.235049443545, 5906.0, 5910.261217347832, 5913.763449461973, 5917.201177840936, 5460.453954604508, 5666.17840413146, 5723.255976723, 5724.227229323988, 5724.313082430135, 5709.800156994485, 5731.799387021434, 5767.048437007847, 5804.65172089676, 5854.560907931837, 5617.241672374341, 5632.957902787997, 5639.548836093185, 5646.802361917313, 5648.915266271091, 5588.916166257591, 5617.8033768817895, 5622.072358060874, 5630.493255607015, 5630.718464076862, 5274.841754747364, 5330.493603107699, 5396.460353964572, 5410.269613602113, 5522.972385138049, 5679.119736440858, 5688.601797874109, 5720.0, 5720.599558030898, 5725.19847221381, 5600.187972743848, 5605.019121653776, 5605.887882242414, 5609.074502707008, 5617.662940223599], "unit": "score", "name": "dojo.html", "value": 5292.791651854928}, {"lowerIsBetter": false, "replicates": [530.6179550723479, 533.0964015992892, 534.3027349309152, 552.6463063639271, 558.391353424767, 25007.0, 27824.3043923902, 27912.162635120952, 28021.719782802167, 35048.12379690503, 38743.225135497276, 38942.22115557687, 39139.0, 39174.80412597933, 39214.80392598033, 8231.506109633427, 8533.317334613215, 8546.914530854674, 8548.40161188717, 8551.914480855205, 7421.406287496988, 7594.962025189894, 7598.620068996555, 8331.375146863978, 10018.098371146596, 9895.653652122177, 9988.0, 10014.699559013241, 10024.949875250613, 10032.89967100327, 9846.606135754633, 9862.408255504657, 9868.506574671237, 9947.5026248688, 9958.253131015166, 7461.776146715607, 7630.046244219473, 7633.847323053508, 10025.097741203326, 10304.948475257575, 35852.10369740751, 36305.45541816875, 36413.271734565424, 36433.0, 36460.0884977875, 2980.0761763853275, 2982.7464665503458, 3035.9544606830914, 3071.523913793343, 3077.1999280187088, 27302.0, 27883.16350509488, 28493.0, 28670.13989580316, 28883.133505994643, 3987.535834475882, 4004.899877503057, 4064.959350406488, 4128.236276288866, 4249.893752656178, 266617.0, 270293.0, 273714.0, 274296.0, 275339.6233018842, 43058.04832444246, 43742.12515749667, 59924.0, 60094.69952650296, 60356.39643603595, 56116.0, 56179.157312640345, 56544.71727641336, 56546.15180772292, 56642.45108970106, 13196.0, 13416.798748018788, 13418.060735748599, 13434.596962090958, 13451.12567683117, 9645.08371704687, 9760.804783904283, 9761.707148785548, 9763.560639771227, 9764.121229089416, 19813.801861981196, 20368.69446958297, 20437.0, 20444.080016399297, 20547.38357849267, 7850.607469626496, 8093.878591821127, 8130.59347032646, 8171.5505647189975, 8178.591070446454, 826.6073615032811, 863.4560227056913, 908.3323757038571, 1052.5325636544492, 1053.805046066465, 28486.0, 28596.0, 28611.0, 28761.856190718914, 28808.711912881023, 938.174406522256, 989.7575094101848, 1063.8882917293727, 1123.9771807655159, 1129.093337053803, 14825.184614846072, 14879.33043013067, 15052.0, 15102.773458398133, 15195.0, 337506.0, 343649.0, 344882.0, 345122.0, 345827.0, 52719.0, 53076.20385694218, 53100.0, 53134.20298695523, 53145.46854531483, 1304.9478020879249, 1311.6458556189775, 1318.7494376068516, 1325.5161865919063, 1334.8665133486768, 27534.173974780788, 28497.0, 28725.85637071801, 28759.856200718863, 29000.7099928998, 40576.59423405728, 41214.0, 46313.53686463092, 47471.76264118657, 47548.52451475441, 240782.0, 241268.0, 244579.0, 245445.0, 245918.0, 26883.327916801452, 27371.178864634094, 31722.20694482564, 32092.19769505781, 32127.51808722918, 36687.449688254164, 38698.03254918649, 43112.78443607762, 45254.0, 47052.0, 33087.338253235284, 33239.0, 33816.32367352688, 38347.42478862875, 40075.398869016404, 33878.0, 37804.81097594494, 39294.21411571695, 39884.2023159541, 40453.79773101116, 33710.0, 33901.83049084838, 37942.2411551773, 38820.0, 38941.0, 28979.42041159123, 30532.694673052985, 31139.37721245608, 31161.37677246397, 31192.376152477278, 23458.76541234566, 23796.762032379454, 23862.15994723091, 23912.0, 24183.516329672955], "unit": "score", "name": "ext.html", "value": 17864.524254981803}, {"lowerIsBetter": false, "replicates": [338.45677687311866, 341.92477654915916, 353.06085811740775, 354.33915747131607, 354.8757934722847, 14092.64768380791, 14483.0, 16413.179341032945, 16978.575535611617, 18176.18207180677, 14647.707045859077, 14665.413383464649, 14939.850601493981, 14992.550223493285, 15010.399584016626, 4980.203167493201, 4987.152184128707, 4994.126027945095, 5035.446100928895, 5240.056789777848, 3938.72428929975, 4047.8583249586272, 5385.030694474993, 5751.367349591563, 5990.101484777275, 5871.9412805871825, 5915.9704201478935, 5916.585838991272, 5937.88124237515, 5942.078977758454, 5720.628159169662, 5886.528367908023, 5888.911666325009, 5889.0, 5893.675847828367, 5147.536721695028, 5181.715005674687, 5187.273781670569, 5195.038917800219, 5204.8959020819375, 15216.923915380352, 15225.543233703007, 17744.37894673693, 18657.0, 19303.613927721366, 1943.3004118517322, 1955.3840540229783, 1996.690512970492, 2087.1547023455523, 2139.465133716571, 9692.017222261082, 9765.853512197322, 9879.604815807359, 11823.626343537317, 12581.433835477334, 1652.115380808139, 1735.2104792319465, 1762.5946032412617, 1808.7558179645712, 1848.2052717331542, 57606.423935760526, 59458.702706487056, 61068.69465652643, 61160.0, 61805.38194618086, 9847.606095756233, 9878.209743220525, 9954.601815927283, 10078.949605251926, 10265.133564462654, 12932.741345173044, 12942.935285323512, 13005.869941300465, 13022.674433139247, 13081.41133648988, 7162.319579639926, 7191.676374563157, 7195.028671129435, 7208.459365547605, 7235.819104522429, 6914.308569143146, 6934.0, 6939.653017349112, 6963.1296087989, 6985.301469853076, 4239.724417912826, 4274.615284624399, 4286.249906266453, 4286.678499112579, 4314.0, 1666.983330166707, 1736.1753167245458, 1739.7390391441131, 1790.5255107396551, 1805.4132406967788, 401.5783427401217, 817.7955511122219, 863.3768515191525, 1023.8310678738073, 1048.3552615141632, 9634.699315592445, 10481.580736770597, 10912.236143469881, 10935.343879367105, 11311.264767790068, 442.263631054291, 455.26247479083435, 865.1348651348651, 904.213334399077, 933.2021121940778, 8830.514321712239, 9740.75648108803, 10075.445850478294, 10234.59061637541, 10297.17622590191, 497023.0, 504101.0, 506017.0, 513873.0, 596296.2412201773, 77366.0, 79438.6028069856, 79812.0, 80909.19090809135, 81185.0, 1112.3103675720943, 1124.2299025167622, 1125.6791814332876, 1131.1007748839693, 1147.0422197465043, 15588.766168507254, 15726.606834829221, 15734.13462259541, 15840.683186335978, 15952.122633255283, 32911.0, 34896.65103348934, 34931.301373972885, 35220.295594088486, 35895.0, 43104.0, 43307.35038974481, 43592.12815743604, 45670.771646141555, 46327.30509042434, 9306.767330816512, 9503.477308747808, 9608.75978100525, 9616.9038309616, 9619.903800961902, 11402.600908968147, 13686.657833553843, 13780.724385512032, 16553.25510352013, 17586.736198957282, 10989.835152472559, 11937.343446110548, 13681.657958551115, 14119.152850828983, 14264.286785660468, 14016.78974815399, 14056.859431405555, 14329.928350358181, 14564.19896905638, 14628.12231266085, 14274.429022838971, 14332.993380926888, 14334.928325358724, 14722.337494812973, 14857.108573485626, 9126.17864392208, 9170.495622740813, 9465.432074075577, 9467.337286389886, 9566.617335306788, 9838.293789602158, 12906.612801615967, 14438.639034024234, 14642.85357146415, 14643.19462429534], "unit": "score", "name": "jquery.html", "value": 8464.130285353795}, {"lowerIsBetter": false, "replicates": [1111.4276147783887, 1419.503173889139, 1424.7506686329893, 1552.200616682408, 1736.331512367738, 6157.445829875311, 6715.328467153282, 6787.219469760979, 6818.352256535633, 6824.146981627297, 6744.0, 6896.413804826596, 6903.344182302686, 6912.481563882704, 6915.308469153095, 1921.7117432385114, 1950.775660799005, 1951.9024048797573, 2182.5962196993605, 2217.6784366266884, 2163.1131236193164, 2192.210804110519, 2192.4080498265457, 2193.747719012318, 2196.758356580775, 2107.1466056247245, 2125.0543508138885, 2161.492049368397, 2161.5352699169675, 2162.6215412302786, 2117.851750377474, 2126.2770657976284, 2140.2081229944943, 2148.34475484977, 2196.7254093238184, 2189.4854709143337, 2220.6335954567476, 2222.4443889027743, 2222.944426389337, 2223.132978138527, 6909.930900691029, 7001.719931202746, 7020.508564400494, 7029.648517574101, 7053.823654408629, 4174.436451079096, 4176.0, 4239.830406783725, 4241.0, 4246.363045543162, 2830.5471124620167, 2852.0588205892213, 2915.2274647218505, 2920.7225313595172, 2946.6464024317006, 913.1279627955287, 916.8074704312103, 937.8452555328363, 957.262907561181, 969.1181025267043, 9406.153446189875, 9410.811783764355, 9415.340926135174, 9419.623215071457, 9441.055894410641, 3978.701597380208, 4002.739821911625, 4051.7366371186367, 4054.1891621675195, 4058.553559108496, 8201.179882011751, 8213.38399620019, 8217.260446559838, 8221.424500285042, 8221.958890205511, 4168.083021735213, 4202.054537728986, 4202.138561594866, 4223.345381465816, 4233.597808208216, 3835.7698538087247, 3843.0584506796013, 3847.3844184930276, 3848.0956975110826, 3854.9807250963568, 3118.3295591447495, 3149.6692847251165, 3357.6138744044747, 3419.965800341965, 3447.7069449096607, 1123.634818683931, 1124.5614210457927, 1126.0428635659787, 1126.1947707389256, 1135.3755434510986, 967.0184762466102, 967.0377973915998, 1025.0006243912126, 1065.4512925843042, 1285.3059347952187, 6471.158749362553, 6536.967315163393, 6538.084668146464, 6542.051402546699, 6543.0, 1062.9202809789297, 1072.646026811166, 1092.3118435385657, 1098.3464838421128, 1126.7126882644873, 5223.660462070029, 5298.364196296469, 5393.83818485446, 5405.270288511001, 5405.702686352289, 8128.959355203305, 8462.492250464991, 8471.237588617054, 8478.025027121837, 8478.152184781473, 7952.483088599338, 8325.500469971821, 8345.207205315486, 8352.874706879402, 8367.539785311745, 6589.86820263592, 6754.054432379471, 6757.256701762803, 6759.5606285591275, 6760.695768690421, 6471.255805582418, 6549.836254093686, 6600.735970561123, 6617.404433600999, 6624.370684784938, 7291.489595728248, 7362.300581444754, 7431.962840185764, 7541.585212813348, 7552.358049565849, 7544.886826697713, 7677.232276772278, 7861.764147075597, 7871.488353257249, 7881.763547093597, 6280.623162610258, 6342.651154186379, 6360.650164240826, 6440.098386225838, 6483.837904052248, 5769.105788602773, 5859.20900678403, 5863.677497737665, 5876.236089308362, 6884.311568843075, 5949.851253718519, 6056.818295451144, 6296.118543404019, 6387.616742995435, 6405.903911441239, 6040.577159598786, 6201.627902325875, 6214.161088253209, 6266.968665156645, 6359.427651511386, 6271.122042914087, 6307.400796924285, 6309.873802523832, 6311.526635502264, 6321.905171422341, 5880.647161170344, 5915.645061296336, 5917.260342457193, 6026.126211699367, 6038.63768173911, 5907.734151963258, 6082.9695851520455, 6083.726232319645, 6084.0, 6112.510999119971], "unit": "score", "name": "mootools.html", "value": 4095.969912818259}, {"lowerIsBetter": false, "replicates": [332.5958959863765, 337.2563497488039, 339.95240666306705, 344.6037057384009, 347.8695489191555, 6022.397760223976, 6031.939680603193, 6078.300995385521, 6087.7260523276445, 6091.025435930252, 5742.827715168552, 5755.453231942969, 5814.098814683731, 5885.32318783339, 5950.821475355746, 4565.132624801294, 4570.680052396334, 4590.0, 4590.472095708986, 4605.700629459091, 4413.249747542909, 4594.632429405639, 4599.149157405874, 4602.194615942213, 4614.8154073837, 4454.13144436835, 4461.018575913294, 4555.658325625592, 4559.635229181657, 4560.3843481130125, 4518.774061296955, 4528.230200865861, 4546.204414227497, 4546.704464209833, 4554.476235232957, 4014.3978403239457, 4039.0508230565792, 4054.8175332110127, 4057.0, 4067.959320406788, 5562.443755624446, 5677.630953987978, 5679.488846003838, 5690.487856092972, 5701.2018317435595, 5246.554042906358, 5254.133068043769, 5255.08036093682, 5258.684478931238, 5307.814226502092, 6373.9681301593655, 6376.936230637681, 6377.362263773632, 6384.968075159641, 6386.744530218785, 4378.934315985262, 4399.428074350314, 4402.3396490526675, 4403.207422663919, 4418.867433976986, 6499.740010399579, 6582.769603063918, 6592.80221593353, 6629.171353580802, 6656.700448479782, 4650.95349046512, 4655.231886738718, 4655.95344046562, 4655.976720116378, 4663.790129444184, 4721.055788842176, 4721.15019296523, 4725.763711814396, 4730.645201609893, 4732.834350797705, 5379.865503362447, 5385.219143224289, 5389.218563308298, 5392.056390131711, 5404.513593776579, 6255.155554000243, 6423.903641445382, 6433.131527243856, 6434.067060276234, 6438.678066096676, 1650.6616143690514, 1671.4484220207546, 1672.7909011373579, 1673.2470388325303, 1673.7656728058082, 1127.312339472921, 1133.8072527670315, 1137.9829302560468, 1155.5435602936961, 1167.795635763738, 6004.789832355934, 6010.308814486302, 6011.879762404727, 6014.578979471483, 6014.969925150346, 6413.102165696806, 6572.474202063823, 6577.868442631217, 6585.341465853377, 6594.637294948824, 5892.175095486636, 5958.510372406899, 5981.730822113015, 5983.970080149571, 6030.698465076729, 3543.681068703829, 3572.2498275361945, 3576.2476386570916, 3588.6770190682964, 3590.7845529267806, 6581.736730530821, 6806.217285012188, 6809.080774095532, 6813.727450902007, 6815.42068924147, 6815.488838337144, 6822.4200942919415, 6828.624425656537, 6831.6242606657115, 6837.521373503906, 6782.694778734969, 6798.286179951034, 6798.93201067983, 6800.4219641330055, 6802.14973128359, 6411.96794016027, 6623.470122390101, 6629.237637671729, 6630.801075967729, 6634.03806448072, 6522.510811689237, 6582.440492558187, 6590.143281373583, 6593.208814942238, 6599.901001485077, 6826.522143449911, 6834.589924604539, 6837.1111755471475, 6845.520813543004, 6851.794446166623, 4494.101179763995, 4559.156556037011, 4566.109608626286, 4566.725996440225, 4568.771561421982, 6426.0, 6570.047343135314, 6574.276829548841, 6627.304133065959, 6681.064650948774, 6487.902681459687, 6488.091667166695, 6494.740210391531, 6495.610263384212, 6503.382178693017, 6240.375962403723, 6464.5798023128345, 6464.935350646433, 6485.578437401554, 6487.091807147098, 6286.491242101954, 6323.557350985387, 6330.746770129143, 6338.746450141943, 6339.683015849281, 6402.423781859468, 6433.388828061326, 6487.513436492188, 6488.675566221765, 6498.935010649833, 6159.5072394209255, 6301.590396624205, 6321.11504389395, 6349.49204063683, 6354.0], "unit": "score", "name": "prototype.html", "value": 4830.582367200905}, {"lowerIsBetter": false, "replicates": [731.9377852882504, 835.8787975743518, 842.9789255268614, 854.0989256334568, 862.168007872403, 12822.48710051598, 12993.74012519749, 13013.804792928113, 13018.153820001706, 13043.0, 12653.240805551673, 12784.169029013108, 12886.0, 12887.033472489577, 13014.804777928315, 825.347975099672, 841.0706169682504, 841.4026041510505, 841.6002398860553, 842.3976856547567, 828.772087675888, 850.196564246787, 850.3834719828137, 850.587465079436, 850.7873031742065, 874.5889431966965, 886.9068747781487, 886.9822603547925, 887.4808237181225, 888.2938064238913, 876.5836227791812, 883.0463099852176, 883.7039591736776, 883.7613844262013, 883.8276536075468, 642.6979319719725, 646.9708863101125, 648.0538413915689, 648.5200951296055, 648.9578177418452, 12502.187357821804, 12511.687207819787, 12583.245005299712, 12648.114631975764, 12674.112812103156, 10177.0, 10284.0, 10807.621733239299, 10899.782004359948, 11096.944515277453, 9981.251406144569, 10005.29962902597, 10073.49632518371, 10110.443925584164, 10275.177985761122, 3603.765755225928, 3627.6009638939695, 3674.2467794102145, 3686.1337585667347, 3745.6441638044344, 34309.92415501864, 41190.38214426786, 44463.77768111171, 45411.31883021758, 45806.08387832258, 10167.7458063549, 10191.0, 10385.63650272237, 10424.583016679248, 10619.09737672291, 17882.0, 17999.460016199537, 18084.27662893496, 18098.276068957093, 18147.276008779147, 7406.925930740731, 7436.367908727819, 7502.962485187648, 7657.578833164118, 7663.157052724196, 4216.64158546527, 4269.210196113729, 4283.1005488847695, 4323.221820072355, 4360.716553424018, 2946.2634341414646, 2981.7316441520366, 2985.7462115719973, 2993.2816124130054, 2998.8800447981835, 505.84824552634063, 505.9595232381401, 509.23868816120137, 513.8895137545371, 521.7321907764094, 504.71483611759237, 552.8175702018405, 603.7826382502295, 619.7582942652369, 623.4575918950542, 7715.729949451742, 7773.883391749016, 7819.296263336327, 8154.103048664642, 8254.0, 539.4201233673816, 589.2634207240949, 596.7225240263299, 684.4832151725416, 690.9827254318682, 3718.7396882218527, 3749.1564398010228, 3762.3415902217002, 3856.3444214483607, 3873.65137137659, 53207.0, 53992.0, 54061.05328413871, 57993.0, 58330.4166958325, 41930.37104443375, 47518.287225691645, 47637.0, 48062.279065814044, 49545.99999999928, 43603.34594981078, 44092.118157636665, 44491.55508444939, 44913.0, 46197.53802462067, 7363.705451782083, 8225.40241573447, 8383.245507904317, 8536.146385361662, 8634.740957771277, 29533.26166845846, 33664.831675841466, 34007.0, 36162.8191859039, 37107.6289237115, 42919.7854010728, 43435.34846977235, 43502.782486087366, 43538.56461435472, 43956.34065489084, 10422.687319380431, 10433.165346772392, 10554.472276386303, 10719.249652524248, 10731.463426828783, 11056.336619802838, 11063.889361106287, 11156.721081973015, 11544.076473881902, 11637.370768092644, 10291.742706432398, 10370.701427684668, 10469.371837689763, 10556.89443105559, 10619.36283822973, 10500.0, 10543.472826358498, 10787.137029037502, 10967.890321096687, 11335.546578136782, 10591.841122383325, 11086.501107450023, 11179.329240245612, 11500.654980350602, 11535.942320288344, 8621.458955112648, 8696.645622122094, 8730.912690873263, 8819.559022048743, 9038.728838134866, 8114.43198976066, 8301.958490207511, 8414.663413463637, 8580.742577722678, 8695.52174630376], "unit": "score", "name": "yui.html", "value": 6079.155788212631}], "name": "dromaeo_css", "value": 6769.912283655725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 111.0, 112.0, 111.0, 101.0, 113.0, 112.0, 105.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 154.0, 169.0, 129.0, 150.0, 155.0, 124.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 164.0, 163.0, 161.0, 159.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 87.0, 91.0, 72.0, 75.0, 72.0, 129.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 96.0, 96.0, 96.0, 144.0, 96.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 58.0, 58.0, 58.0, 59.0, 58.0, 68.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 88.0, 87.0, 87.0, 89.0, 89.0, 91.0, 90.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 127.0, 123.0, 115.0, 126.0, 118.0, 122.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [160.0, 158.0, 155.0, 155.0, 154.0, 149.0, 156.0, 157.0, 163.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.1}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 70.0, 68.0, 68.0, 67.0, 68.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1524.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.63528413910095], "unit": "score", "name": "Richards", "value": 208.10529000000002}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [648.0881399870383], "unit": "score", "name": "Splay", "value": 125.74061300000001}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19540.69924913992}]} 14:19:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19540.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1524.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6769.91"}}} 14:19:46 INFO - Return code: 0 14:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:19:46 INFO - # TBPL SUCCESS # 14:19:46 INFO - Running post-action listener: _resource_record_post_action 14:19:46 INFO - Running post-run listener: _resource_record_post_run 14:19:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543817728; Read time: 12; Write time: 355192 14:19:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235155456; Read time: 0; Write time: 194856 14:19:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308662272; Read time: 12; Write time: 160336 14:19:47 INFO - Running post-run listener: _upload_blobber_files 14:19:47 INFO - Blob upload gear active. 14:19:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:19:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:19:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:19:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:48 INFO - (blobuploader) - INFO - Done attempting. 14:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:49 INFO - (blobuploader) - INFO - Done attempting. 14:19:49 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:49 INFO - Return code: 0 14:19:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:19:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87c490cf9ca549a899274578d448dbe2d6c37f8097d6ed443b914109e9d5ac8bc4a3dc8e249a8db284340aec8da6e34da858e00967d8c649e82a93ac2d4b73bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acdb05f94c0be38f84bede0ea7acd4bfe7c3c4c04fd49d1a4addcf49daa8b5ba140cd7cfe567a446315c8637b91205b2f133a3f4be4662cca7134f4097d31ba"} 14:19:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:19:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:19:49 INFO - Contents: 14:19:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87c490cf9ca549a899274578d448dbe2d6c37f8097d6ed443b914109e9d5ac8bc4a3dc8e249a8db284340aec8da6e34da858e00967d8c649e82a93ac2d4b73bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acdb05f94c0be38f84bede0ea7acd4bfe7c3c4c04fd49d1a4addcf49daa8b5ba140cd7cfe567a446315c8637b91205b2f133a3f4be4662cca7134f4097d31ba"} 14:19:49 INFO - Copying logs to upload dir... 14:19:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.326233 ========= master_lag: 1.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-30 14:19:50.557731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 14:19:50.566026) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 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/87c490cf9ca549a899274578d448dbe2d6c37f8097d6ed443b914109e9d5ac8bc4a3dc8e249a8db284340aec8da6e34da858e00967d8c649e82a93ac2d4b73bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acdb05f94c0be38f84bede0ea7acd4bfe7c3c4c04fd49d1a4addcf49daa8b5ba140cd7cfe567a446315c8637b91205b2f133a3f4be4662cca7134f4097d31ba"} build_url:https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/Dwt0GJRuTiCsI9P1UKT6JQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87c490cf9ca549a899274578d448dbe2d6c37f8097d6ed443b914109e9d5ac8bc4a3dc8e249a8db284340aec8da6e34da858e00967d8c649e82a93ac2d4b73bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5acdb05f94c0be38f84bede0ea7acd4bfe7c3c4c04fd49d1a4addcf49daa8b5ba140cd7cfe567a446315c8637b91205b2f133a3f4be4662cca7134f4097d31ba"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 14:19:50.604334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 14:19:50.605113) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451510521.460566-1299973891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 14:19:50.980062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 14:19:50.983473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 14:19:50.983918) ========= ========= Total master_lag: 2.43 =========