builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1451706674.59 results: success (0) buildid: 20160101173004 builduid: 8363781bf1b84107ad43bc71660b056c revision: 1f682dc05790a8ab1cdda60dad61e511ba611629 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.586794) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.587388) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.587682) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006314 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.610764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.611082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.624707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.625264) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.691092) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.691563) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.692103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.692573) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 19:51:14-- 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% 43.8M=0s 2016-01-01 19:51:15 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.868179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.868470) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019125 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.933595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:14.934115) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f682dc05790a8ab1cdda60dad61e511ba611629 --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 1f682dc05790a8ab1cdda60dad61e511ba611629 --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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 19:51:15,186 truncating revision to first 12 chars 2016-01-01 19:51:15,186 Setting DEBUG logging. 2016-01-01 19:51:15,186 attempt 1/10 2016-01-01 19:51:15,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f682dc05790?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 19:51:15,768 unpacking tar archive at: fx-team-1f682dc05790/testing/mozharness/ program finished with exit code 0 elapsedTime=0.870547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:15.819441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:15.819775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:15.829722) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:15.830329) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:15.831071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-01 19:51:15.831605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:16 INFO - MultiFileLogger online at 20160101 19:51:16 in /builds/slave/test-pgo 19:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:51:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:16 INFO - {'append_to_log': False, 19:51:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:16 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:16 INFO - 'branch': 'Fx-Team', 19:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:16 INFO - 'config_files': ('talos/linux_config.py',), 19:51:16 INFO - 'default_actions': ('clobber', 19:51:16 INFO - 'read-buildbot-config', 19:51:16 INFO - 'download-and-extract', 19:51:16 INFO - 'populate-webroot', 19:51:16 INFO - 'create-virtualenv', 19:51:16 INFO - 'install', 19:51:16 INFO - 'run-tests'), 19:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:16 INFO - 'download_minidump_stackwalk': True, 19:51:16 INFO - 'download_symbols': 'ondemand', 19:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:16 INFO - 'installer_path': 'installer.exe', 19:51:16 INFO - 'log_level': 'info', 19:51:16 INFO - 'log_name': 'talos', 19:51:16 INFO - 'log_to_console': True, 19:51:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:16 INFO - 'opt_config_files': (), 19:51:16 INFO - 'pip_index': False, 19:51:16 INFO - 'sps_profile': False, 19:51:16 INFO - 'sps_profile_interval': 0, 19:51:16 INFO - 'suite': 'dromaeojs-e10s', 19:51:16 INFO - 'system_bits': '32', 19:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:16 INFO - 'title': 'talos-linux64-ix-015', 19:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:16 INFO - 'use_talos_json': True, 19:51:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:16 INFO - 'work_dir': 'build'} 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running clobber step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: clobber 19:51:16 INFO - rmtree: /builds/slave/test-pgo/build 19:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:16 INFO - Running post-action listener: _resource_record_post_action 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running read-buildbot-config step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: read_buildbot_config 19:51:16 INFO - Using buildbot properties: 19:51:16 INFO - { 19:51:16 INFO - "project": "", 19:51:16 INFO - "product": "firefox", 19:51:16 INFO - "script_repo_revision": "production", 19:51:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:51:16 INFO - "repository": "", 19:51:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:51:16 INFO - "buildid": "20160101173004", 19:51:16 INFO - "pgo_build": "True", 19:51:16 INFO - "basedir": "/builds/slave/test-pgo", 19:51:16 INFO - "buildnumber": 171, 19:51:16 INFO - "slavename": "talos-linux64-ix-015", 19:51:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:51:16 INFO - "platform": "ubuntu64_hw", 19:51:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:16 INFO - "branch": "fx-team", 19:51:16 INFO - "repo_path": "integration/fx-team", 19:51:16 INFO - "revision": "1f682dc05790a8ab1cdda60dad61e511ba611629", 19:51:16 INFO - "stage_platform": "linux64-pgo", 19:51:16 INFO - "builduid": "8363781bf1b84107ad43bc71660b056c", 19:51:16 INFO - "slavebuilddir": "test" 19:51:16 INFO - } 19:51:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:51:16 INFO - Running post-action listener: _resource_record_post_action 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running download-and-extract step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: download_and_extract 19:51:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51:16 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')]} 19:51:16 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json 19:51:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json 19:51:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:23 INFO - Downloaded 1302 bytes. 19:51:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:23 INFO - Using the following test package requirements: 19:51:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'jsshell-linux-x86_64.zip'], 19:51:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:23 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:26 INFO - Downloaded 23198211 bytes. 19:51:26 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 19:51:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:26 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 19:51:28 INFO - Return code: 0 19:51:28 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 19:51:28 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')]} 19:51:28 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:35 INFO - Downloaded 23198211 bytes. 19:51:35 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 19:51:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:35 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 19:51:36 INFO - Return code: 0 19:51:36 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')]} 19:51:36 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:38 INFO - Downloaded 11132285 bytes. 19:51:38 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 19:51:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:38 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 19:51:38 INFO - Return code: 0 19:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:38 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:39 INFO - Downloaded 54982849 bytes. 19:51:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:39 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:39 INFO - Contents: 19:51:39 INFO - build_url:https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:39 INFO - Running post-action listener: _resource_record_post_action 19:51:39 INFO - Running post-action listener: set_extra_try_arguments 19:51:39 INFO - ##### 19:51:39 INFO - ##### Running populate-webroot step. 19:51:39 INFO - ##### 19:51:39 INFO - Running pre-action listener: _resource_record_pre_action 19:51:39 INFO - Running main action method: populate_webroot 19:51:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:39 INFO - '--tppagecycles', 19:51:39 INFO - '7'], 19:51:39 INFO - 'tests': ['tsvgm']}}, 19:51:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'tests': ['damp', 'tps']}, 19:51:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['damp', 'tps']}, 19:51:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:39 INFO - 'other': {'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'other_l64': {'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:39 INFO - 'ts_paint', 19:51:39 INFO - 'tpaint', 19:51:39 INFO - 'sessionrestore', 19:51:39 INFO - 'sessionrestore_no_auto_restore']}, 19:51:39 INFO - 'svgr': {'tests': ['tsvgx', 19:51:39 INFO - 'tsvgr_opacity', 19:51:39 INFO - 'tart', 19:51:39 INFO - 'tscrollx', 19:51:39 INFO - 'cart']}, 19:51:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['tsvgx', 19:51:39 INFO - 'tsvgr_opacity', 19:51:39 INFO - 'tart', 19:51:39 INFO - 'tscrollx', 19:51:39 INFO - 'cart']}, 19:51:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'tests': ['tp5o']}, 19:51:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'talos_options': ['--e10s'], 19:51:39 INFO - 'tests': ['tp5o']}, 19:51:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'talos_options': ['--xperf_path', 19:51:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:39 INFO - 'tests': ['tp5n']}, 19:51:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:39 INFO - 'talos_options': ['--e10s', 19:51:39 INFO - '--xperf_path', 19:51:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:39 INFO - 'tests': ['tp5n']}}, 19:51:39 INFO - 'talos.zip': {'path': '', 19:51:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:39 INFO - Running post-action listener: _resource_record_post_action 19:51:39 INFO - ##### 19:51:39 INFO - ##### Running create-virtualenv step. 19:51:39 INFO - ##### 19:51:39 INFO - Running pre-action listener: _resource_record_pre_action 19:51:39 INFO - Running main action method: create_virtualenv 19:51:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:39 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 19:51:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:39 INFO - Using real prefix '/usr' 19:51:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:42 INFO - Installing pip.................done. 19:51:42 INFO - Return code: 0 19:51:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:42 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 19:51:42 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 19:51:42 INFO - Using env: {'DISPLAY': ':0', 19:51:42 INFO - 'HOME': '/home/cltbld', 19:51:42 INFO - 'LANG': 'en_US.UTF-8', 19:51:42 INFO - 'LANGUAGE': 'en_US:en', 19:51:42 INFO - 'LOGNAME': 'cltbld', 19:51:42 INFO - 'MAIL': '/var/mail/cltbld', 19:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:42 INFO - 'MOZ_NO_REMOTE': '1', 19:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:42 INFO - 'NO_EM_RESTART': '1', 19:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:42 INFO - 'SHELL': '/bin/bash', 19:51:42 INFO - 'SHLVL': '1', 19:51:42 INFO - 'TERM': 'linux', 19:51:42 INFO - 'TMOUT': '86400', 19:51:42 INFO - 'USER': 'cltbld', 19:51:42 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:42 INFO - '_': '/tools/buildbot/bin/python'} 19:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:42 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 19:51:42 INFO - Cleaning up... 19:51:42 INFO - Return code: 0 19:51:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:42 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 19:51:42 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 19:51:42 INFO - Using env: {'DISPLAY': ':0', 19:51:42 INFO - 'HOME': '/home/cltbld', 19:51:42 INFO - 'LANG': 'en_US.UTF-8', 19:51:42 INFO - 'LANGUAGE': 'en_US:en', 19:51:42 INFO - 'LOGNAME': 'cltbld', 19:51:42 INFO - 'MAIL': '/var/mail/cltbld', 19:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:42 INFO - 'MOZ_NO_REMOTE': '1', 19:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:42 INFO - 'NO_EM_RESTART': '1', 19:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:42 INFO - 'SHELL': '/bin/bash', 19:51:42 INFO - 'SHLVL': '1', 19:51:42 INFO - 'TERM': 'linux', 19:51:42 INFO - 'TMOUT': '86400', 19:51:42 INFO - 'USER': 'cltbld', 19:51:42 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:42 INFO - '_': '/tools/buildbot/bin/python'} 19:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:42 INFO - Downloading/unpacking psutil>=0.7.1 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:51:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:44 INFO - Installing collected packages: psutil 19:51:44 INFO - Running setup.py install for psutil 19:51:44 INFO - building 'psutil._psutil_linux' extension 19:51:44 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 19:51:44 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 19:51:44 INFO - building 'psutil._psutil_posix' extension 19:51:44 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 19:51:44 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 19:51:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:45 INFO - Successfully installed psutil 19:51:45 INFO - Cleaning up... 19:51:45 INFO - Return code: 0 19:51:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:45 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:45 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 19:51:45 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 19:51:45 INFO - Using env: {'DISPLAY': ':0', 19:51:45 INFO - 'HOME': '/home/cltbld', 19:51:45 INFO - 'LANG': 'en_US.UTF-8', 19:51:45 INFO - 'LANGUAGE': 'en_US:en', 19:51:45 INFO - 'LOGNAME': 'cltbld', 19:51:45 INFO - 'MAIL': '/var/mail/cltbld', 19:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:45 INFO - 'MOZ_NO_REMOTE': '1', 19:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:45 INFO - 'NO_EM_RESTART': '1', 19:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:45 INFO - 'SHELL': '/bin/bash', 19:51:45 INFO - 'SHLVL': '1', 19:51:45 INFO - 'TERM': 'linux', 19:51:45 INFO - 'TMOUT': '86400', 19:51:45 INFO - 'USER': 'cltbld', 19:51:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:45 INFO - '_': '/tools/buildbot/bin/python'} 19:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:51:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:47 INFO - Installing collected packages: mozsystemmonitor 19:51:47 INFO - Running setup.py install for mozsystemmonitor 19:51:47 INFO - Successfully installed mozsystemmonitor 19:51:47 INFO - Cleaning up... 19:51:47 INFO - Return code: 0 19:51:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:47 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 19:51:47 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 19:51:47 INFO - Using env: {'DISPLAY': ':0', 19:51:47 INFO - 'HOME': '/home/cltbld', 19:51:47 INFO - 'LANG': 'en_US.UTF-8', 19:51:47 INFO - 'LANGUAGE': 'en_US:en', 19:51:47 INFO - 'LOGNAME': 'cltbld', 19:51:47 INFO - 'MAIL': '/var/mail/cltbld', 19:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:47 INFO - 'MOZ_NO_REMOTE': '1', 19:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:47 INFO - 'NO_EM_RESTART': '1', 19:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:47 INFO - 'SHELL': '/bin/bash', 19:51:47 INFO - 'SHLVL': '1', 19:51:47 INFO - 'TERM': 'linux', 19:51:47 INFO - 'TMOUT': '86400', 19:51:47 INFO - 'USER': 'cltbld', 19:51:47 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:47 INFO - '_': '/tools/buildbot/bin/python'} 19:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - Downloading docopt-0.6.1.tar.gz 19:51:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:49 INFO - Running setup.py install for blobuploader 19:51:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:50 INFO - Running setup.py install for requests 19:51:50 INFO - Running setup.py install for docopt 19:51:50 INFO - Successfully installed blobuploader requests docopt 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'DISPLAY': ':0', 19:51:50 INFO - 'HOME': '/home/cltbld', 19:51:50 INFO - 'LANG': 'en_US.UTF-8', 19:51:50 INFO - 'LANGUAGE': 'en_US:en', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MAIL': '/var/mail/cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SHLVL': '1', 19:51:50 INFO - 'TERM': 'linux', 19:51:50 INFO - 'TMOUT': '86400', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:50 INFO - Running setup.py (path:/tmp/pip-jMQbEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:50 INFO - Running setup.py (path:/tmp/pip-uv4cuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:50 INFO - Running setup.py (path:/tmp/pip-bMcnGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:50 INFO - Running setup.py (path:/tmp/pip-WEKeLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:51 INFO - Running setup.py (path:/tmp/pip-rGQioF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:51 INFO - Running setup.py (path:/tmp/pip-MoVGB9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:51 INFO - Running setup.py (path:/tmp/pip-LBlnTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:51 INFO - Running setup.py (path:/tmp/pip-K_jVCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:51 INFO - Running setup.py (path:/tmp/pip-MzYt1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:51 INFO - Running setup.py (path:/tmp/pip-UY3UJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:51 INFO - Running setup.py (path:/tmp/pip-eDjbwz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:51 INFO - Running setup.py (path:/tmp/pip-Y9pebr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:51 INFO - Running setup.py (path:/tmp/pip-lUvPZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:51 INFO - Running setup.py (path:/tmp/pip-9izNiG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:51 INFO - Running setup.py (path:/tmp/pip-TDAn4h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:51 INFO - Running setup.py (path:/tmp/pip-pmk7GX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:51 INFO - Running setup.py (path:/tmp/pip-mqm7mg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:51 INFO - Running setup.py install for manifestparser 19:51:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozcrash 19:51:52 INFO - Running setup.py install for mozdebug 19:51:52 INFO - Running setup.py install for mozdevice 19:51:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozfile 19:51:52 INFO - Running setup.py install for mozhttpd 19:51:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozinfo 19:51:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozInstall 19:51:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozleak 19:51:52 INFO - Running setup.py install for mozlog 19:51:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Running setup.py install for moznetwork 19:51:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Running setup.py install for mozprocess 19:51:53 INFO - Running setup.py install for mozprofile 19:51:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Running setup.py install for mozrunner 19:51:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Running setup.py install for mozscreenshot 19:51:53 INFO - Running setup.py install for moztest 19:51:53 INFO - Running setup.py install for mozversion 19:51:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:53 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')]} 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 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')]} 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:53 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 19:51:53 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 19:51:53 INFO - Using env: {'DISPLAY': ':0', 19:51:53 INFO - 'HOME': '/home/cltbld', 19:51:53 INFO - 'LANG': 'en_US.UTF-8', 19:51:53 INFO - 'LANGUAGE': 'en_US:en', 19:51:53 INFO - 'LOGNAME': 'cltbld', 19:51:53 INFO - 'MAIL': '/var/mail/cltbld', 19:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:53 INFO - 'MOZ_NO_REMOTE': '1', 19:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:53 INFO - 'NO_EM_RESTART': '1', 19:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:53 INFO - 'SHELL': '/bin/bash', 19:51:53 INFO - 'SHLVL': '1', 19:51:53 INFO - 'TERM': 'linux', 19:51:53 INFO - 'TMOUT': '86400', 19:51:53 INFO - 'USER': 'cltbld', 19:51:53 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:53 INFO - '_': '/tools/buildbot/bin/python'} 19:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:53 INFO - Running setup.py (path:/tmp/pip-5OMIrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:54 INFO - Running setup.py (path:/tmp/pip-zD0Riu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:54 INFO - Running setup.py (path:/tmp/pip-L7IZWe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:54 INFO - Running setup.py (path:/tmp/pip-EmyTQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:54 INFO - Running setup.py (path:/tmp/pip-8T752C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:54 INFO - Running setup.py (path:/tmp/pip-FPN4pU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:54 INFO - Running setup.py (path:/tmp/pip-v_wmU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:54 INFO - Running setup.py (path:/tmp/pip-j9W__d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:54 INFO - Running setup.py (path:/tmp/pip-GwK6n4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:54 INFO - Running setup.py (path:/tmp/pip-6njQqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:54 INFO - Running setup.py (path:/tmp/pip-PSW8NV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 INFO - Running setup.py (path:/tmp/pip-LMM4yE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 INFO - Running setup.py (path:/tmp/pip-vskjQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 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)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:54 INFO - Running setup.py (path:/tmp/pip-rErdKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:55 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)) 19:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:55 INFO - Running setup.py (path:/tmp/pip-wO4e0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:55 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)) 19:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:55 INFO - Running setup.py (path:/tmp/pip-u1ZmVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:55 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)) 19:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:55 INFO - Running setup.py (path:/tmp/pip-YhxAee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:55 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)) 19:51:55 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)) 19:51:55 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)) 19:51:55 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)) 19:51:55 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)) 19:51:55 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)) 19:51:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 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 19:51:56 INFO - Downloading blessings-1.5.1.tar.gz 19:51:56 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 19:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:57 INFO - Installing collected packages: blessings 19:51:57 INFO - Running setup.py install for blessings 19:51:57 INFO - Successfully installed blessings 19:51:57 INFO - Cleaning up... 19:51:57 INFO - Return code: 0 19:51:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:51:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:57 INFO - Reading from file tmpfile_stdout 19:51:57 INFO - Current package versions: 19:51:57 INFO - argparse == 1.2.1 19:51:57 INFO - blessings == 1.5.1 19:51:57 INFO - blobuploader == 1.2.4 19:51:57 INFO - docopt == 0.6.1 19:51:57 INFO - manifestparser == 1.1 19:51:57 INFO - mozInstall == 1.12 19:51:57 INFO - mozcrash == 0.16 19:51:57 INFO - mozdebug == 0.1 19:51:57 INFO - mozdevice == 0.47 19:51:57 INFO - mozfile == 1.2 19:51:57 INFO - mozhttpd == 0.7 19:51:57 INFO - mozinfo == 0.9 19:51:57 INFO - mozleak == 0.1 19:51:57 INFO - mozlog == 3.1 19:51:57 INFO - moznetwork == 0.27 19:51:57 INFO - mozprocess == 0.22 19:51:57 INFO - mozprofile == 0.28 19:51:57 INFO - mozrunner == 6.11 19:51:57 INFO - mozscreenshot == 0.1 19:51:57 INFO - mozsystemmonitor == 0.0 19:51:57 INFO - moztest == 0.7 19:51:57 INFO - mozversion == 1.4 19:51:57 INFO - psutil == 3.1.1 19:51:57 INFO - requests == 1.2.3 19:51:57 INFO - wsgiref == 0.1.2 19:51:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', '-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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51:57 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 19:51:57 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 19:51:57 INFO - Using env: {'DISPLAY': ':0', 19:51:57 INFO - 'HOME': '/home/cltbld', 19:51:57 INFO - 'LANG': 'en_US.UTF-8', 19:51:57 INFO - 'LANGUAGE': 'en_US:en', 19:51:57 INFO - 'LOGNAME': 'cltbld', 19:51:57 INFO - 'MAIL': '/var/mail/cltbld', 19:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:57 INFO - 'MOZ_NO_REMOTE': '1', 19:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:57 INFO - 'NO_EM_RESTART': '1', 19:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:57 INFO - 'SHELL': '/bin/bash', 19:51:57 INFO - 'SHLVL': '1', 19:51:57 INFO - 'TERM': 'linux', 19:51:57 INFO - 'TMOUT': '86400', 19:51:57 INFO - 'USER': 'cltbld', 19:51:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:57 INFO - '_': '/tools/buildbot/bin/python'} 19:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 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)) 19:51:57 INFO - Cleaning up... 19:51:57 INFO - Return code: 0 19:51:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:51: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', 'jsonschema'] in /builds/slave/test-pgo/build 19:51: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 jsonschema 19:51:57 INFO - Using env: {'DISPLAY': ':0', 19:51:57 INFO - 'HOME': '/home/cltbld', 19:51:57 INFO - 'LANG': 'en_US.UTF-8', 19:51:57 INFO - 'LANGUAGE': 'en_US:en', 19:51:57 INFO - 'LOGNAME': 'cltbld', 19:51:57 INFO - 'MAIL': '/var/mail/cltbld', 19:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:57 INFO - 'MOZ_NO_REMOTE': '1', 19:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:57 INFO - 'NO_EM_RESTART': '1', 19:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:57 INFO - 'SHELL': '/bin/bash', 19:51:57 INFO - 'SHLVL': '1', 19:51:57 INFO - 'TERM': 'linux', 19:51:57 INFO - 'TMOUT': '86400', 19:51:57 INFO - 'USER': 'cltbld', 19:51:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:57 INFO - '_': '/tools/buildbot/bin/python'} 19:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:57 INFO - Downloading/unpacking jsonschema 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:59 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 19:51:59 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:59 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:51:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:59 INFO - warning: no files found matching '*.txt' 19:51:59 INFO - no previously-included directories found matching 'build' 19:51:59 INFO - no previously-included directories found matching 'dist' 19:51:59 INFO - no previously-included directories found matching '.git*' 19:51:59 INFO - Installing collected packages: jsonschema, functools32 19:51:59 INFO - Running setup.py install for functools32 19:51:59 INFO - warning: no files found matching '*.txt' 19:51:59 INFO - no previously-included directories found matching 'build' 19:51:59 INFO - no previously-included directories found matching 'dist' 19:51:59 INFO - no previously-included directories found matching '.git*' 19:51:59 INFO - Successfully installed jsonschema functools32 19:51:59 INFO - Cleaning up... 19:52:00 INFO - Return code: 0 19:52:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:52:00 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')]} 19:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:00 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')]} 19:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:00 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 0x7fd8084cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, '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': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', '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 19:52:00 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 19:52:00 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 19:52:00 INFO - Using env: {'DISPLAY': ':0', 19:52:00 INFO - 'HOME': '/home/cltbld', 19:52:00 INFO - 'LANG': 'en_US.UTF-8', 19:52:00 INFO - 'LANGUAGE': 'en_US:en', 19:52:00 INFO - 'LOGNAME': 'cltbld', 19:52:00 INFO - 'MAIL': '/var/mail/cltbld', 19:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:00 INFO - 'MOZ_NO_REMOTE': '1', 19:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:00 INFO - 'NO_EM_RESTART': '1', 19:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:00 INFO - 'SHELL': '/bin/bash', 19:52:00 INFO - 'SHLVL': '1', 19:52:00 INFO - 'TERM': 'linux', 19:52:00 INFO - 'TMOUT': '86400', 19:52:00 INFO - 'USER': 'cltbld', 19:52:00 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:00 INFO - '_': '/tools/buildbot/bin/python'} 19:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:00 INFO - Downloading/unpacking flake8 19:52:00 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 19:52:00 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 19:52:00 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 19:52:00 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 19:52:00 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 19:52:00 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 19:52:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:52:01 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 19:52:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:52:02 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 19:52:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:02 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 19:52:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:02 INFO - no previously-included directories found matching 'docs/_build' 19:52:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:52:02 INFO - Running setup.py install for pep8 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:02 INFO - no previously-included directories found matching 'docs/_build' 19:52:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:52:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:52:02 INFO - Cleaning up... 19:52:02 INFO - Return code: 0 19:52:02 INFO - Running post-action listener: _resource_record_post_action 19:52:02 INFO - Running post-action listener: _start_resource_monitoring 19:52:02 INFO - Starting resource monitoring. 19:52:02 INFO - ##### 19:52:02 INFO - ##### Running install step. 19:52:02 INFO - ##### 19:52:02 INFO - Running pre-action listener: _resource_record_pre_action 19:52:02 INFO - Running main action method: install 19:52:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:52:03 INFO - Reading from file tmpfile_stdout 19:52:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:52:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:52:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:52:03 INFO - Reading from file tmpfile_stdout 19:52:03 INFO - Output received: 19:52:03 INFO - Usage: mozinstall [options] installer 19:52:03 INFO - Options: 19:52:03 INFO - -h, --help show this help message and exit 19:52:03 INFO - -d DEST, --destination=DEST 19:52:03 INFO - Directory to install application into. [default: 19:52:03 INFO - "/builds/slave/test-pgo"] 19:52:03 INFO - --app=APP Application being installed. [default: firefox] 19:52:03 INFO - mkdir: /builds/slave/test-pgo/build/application 19:52:03 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'] 19:52:03 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 19:52:18 INFO - Reading from file tmpfile_stdout 19:52:18 INFO - Output received: 19:52:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:18 INFO - Running post-action listener: _resource_record_post_action 19:52:18 INFO - ##### 19:52:18 INFO - ##### Running run-tests step. 19:52:18 INFO - ##### 19:52:18 INFO - Running pre-action listener: _resource_record_pre_action 19:52:18 INFO - Running main action method: run_tests 19:52:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:18 INFO - Python 2.7.3 19:52:18 INFO - Return code: 0 19:52:18 INFO - grabbing minidump binary from tooltool 19:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:52:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-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 0xe73540>, '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 0xe74440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe748f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:52:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:52:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:19 INFO - Return code: 0 19:52:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:19 INFO - Return code: 0 19:52:19 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:52:19 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:52:19 INFO - Using env: {'DISPLAY': ':0', 19:52:19 INFO - 'HOME': '/home/cltbld', 19:52:19 INFO - 'LANG': 'en_US.UTF-8', 19:52:19 INFO - 'LANGUAGE': 'en_US:en', 19:52:19 INFO - 'LOGNAME': 'cltbld', 19:52:19 INFO - 'MAIL': '/var/mail/cltbld', 19:52:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:19 INFO - 'MOZ_NO_REMOTE': '1', 19:52:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:19 INFO - 'NO_EM_RESTART': '1', 19:52:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:19 INFO - 'SHELL': '/bin/bash', 19:52:19 INFO - 'SHLVL': '1', 19:52:19 INFO - 'TERM': 'linux', 19:52:19 INFO - 'TMOUT': '86400', 19:52:19 INFO - 'USER': 'cltbld', 19:52:19 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219', 19:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:19 INFO - '_': '/tools/buildbot/bin/python'} 19:52:19 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:52:20 INFO - mozversion application_buildid: 20160101173004 19:52:20 INFO - mozversion application_changeset: 1f682dc05790a8ab1cdda60dad61e511ba611629 19:52:20 INFO - mozversion application_display_name: Nightly 19:52:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:20 INFO - mozversion application_name: Firefox 19:52:20 INFO - mozversion application_remotingname: firefox 19:52:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:20 INFO - mozversion application_vendor: Mozilla 19:52:20 INFO - mozversion application_version: 46.0a1 19:52:20 INFO - mozversion platform_buildid: 20160101173004 19:52:20 INFO - mozversion platform_changeset: 1f682dc05790a8ab1cdda60dad61e511ba611629 19:52:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:20 INFO - mozversion platform_version: 46.0a1 19:52:20 INFO - using testdate: 1451706740 19:52:20 INFO - actual date: 1451706740 19:52:20 INFO - starting webserver on 'localhost:45568' 19:52:20 INFO - SUITE-START | Running 3 tests 19:52:20 INFO - TEST-START | dromaeo_css 19:52:20 INFO - operating with platform_type : linux_ 19:52:20 INFO - Initialising browser for dromaeo_css test... 19:52:20 INFO - TEST-INFO | started process 689 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Aft7s/profile http://localhost:45568/getInfo.html) 19:52:24 INFO - PROCESS | 689 | __metrics Screen width/height:1600/1200 19:52:24 INFO - PROCESS | 689 | colorDepth:24 19:52:24 INFO - PROCESS | 689 | Browser inner width/height: 1024/697 19:52:24 INFO - PROCESS | 689 | __metrics 19:52:25 INFO - PROCESS | 689 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:52:25 INFO - PROCESS | 689 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:52:26 INFO - TEST-INFO | 689: exit 0 19:52:26 INFO - Browser initialized. 19:52:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:26 INFO - TEST-INFO | started process 827 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Aft7s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:37 INFO - PROCESS | 827 | RSS: Main: 150609920 19:52:37 INFO - PROCESS | 827 | 19:53:27 INFO - PROCESS | 827 | 1451706807422 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] 19:55:36 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45568/tests/dromaeo/cssquery-ext.html) 19:55:37 INFO - PROCESS | 827 | RSS: Main: 157933568 19:55:37 INFO - PROCESS | 827 | 19:58:39 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-ext.html (next: http://localhost:45568/tests/dromaeo/cssquery-jquery.html) 19:58:40 INFO - PROCESS | 827 | RSS: Main: 151855104 19:58:40 INFO - PROCESS | 827 | 20:01:41 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45568/tests/dromaeo/cssquery-mootools.html) 20:01:42 INFO - PROCESS | 827 | RSS: Main: 153198592 20:01:42 INFO - PROCESS | 827 | 20:04:44 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45568/tests/dromaeo/cssquery-prototype.html) 20:04:44 INFO - PROCESS | 827 | RSS: Main: 152477696 20:04:44 INFO - PROCESS | 827 | 20:07:47 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45568/tests/dromaeo/cssquery-yui.html) 20:07:47 INFO - PROCESS | 827 | RSS: Main: 152875008 20:07:47 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:45568/tests/dromaeo/cssquery-yui.html (next: http://localhost:45568/tests/dromaeo/cssquery-dojo.html) 20:10:50 INFO - PROCESS | 827 | RSS: Main: 154931200 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | __start_tp_report 20:10:50 INFO - PROCESS | 827 | _x_x_mozilla_page_load 20:10:50 INFO - PROCESS | 827 | _x_x_mozilla_page_load_details 20:10:50 INFO - PROCESS | 827 | |i|pagename|runs| 20:10:50 INFO - PROCESS | 827 | |0;dojo.html;3128.5932828732266;3169.477036289011;3203.519472079189;3211.8233497157653;3212.5984251968503;5146.871328216796;5278.709670968095;5303.390110137336;5354.946450535494;5362.919556206655;5282.418933917275;5299;5335;5450.04624190767;5461.453854614537;4825.855224343267;4916.188828843255;4972.676776009566;4997.950020499803;5005.1491246488;4876.146674331995;4933.33399991002;4968.031233909389;5029.1199040168;5041.344625198719;4793.233082706785;4916.754162291871;4952.653314268003;4953.578945789613;5067.797288108472;4818.975905120487;4945.109880221558;4950.603951683856;4960.355153829979;4970.353853998957;4800.975995120002;4856.538628830255;4860.076585448789;4860.295257187688;4867.853964381075;5055.51972562606;5123.1546794778815;5147.922781158286;5183.481651834786;5184.948150518522;5642;5664.54683625309;5670.319561652628;5737.254156959569;5868.295804503487;5799.072148456226;5816.360200377955;5824.592278540504;5828.970855145697;5842;5400.027994960906;5419.268398766116;5424.593155513352;5428.647137936061;5437.075697131458;5783.450572195635;5897.469227769521;5948.940510594925;6027.336992930862;6067.089936509471;5588.105903055492;5634.070378387521;5663.292088488939;5673.858153546112;5687.431256874363;5593.216949627055;5669.773209071591;5705.857353566111;5712.171735098387;5731.197632331477;5664.433556644302;5673.234113394639;5764.250647415809;5781.768729250783;5829.970850145722;5791.652500849962;5812.186293918855;5813.040848260074;5823.4467725566;5833.38749431312;4367.956320436755;4396.956030439718;4476.910461790746;4500.347449619852;4539.568740969603;3909.706771992055;3930.744501607386;3932.8426862925735;3973.5033120859894;3991.2815693174925;5326.973365133227;5377.5429088527135;5384.9730751346;5393.352797664305;5406.91889621656;5609.607327487037;5643.125315576092;5715.399883012307;5718;5744.080947048536;5409.972950135303;5434.347878254555;5438.864028399243;5439.238506609078;5457.263269458652;4941.308216849644;4946.4064312282035;4949.356583644103;4950.158473059589;4993.575546078551;5852.385499522489;5932.762689492458;5967.5524335675;5974.910376344358;6035.305939816977;5787.276590426197;5811.651300921958;5812.128180772918;5813.738381772746;5815.447532484407;5955.255593050869;5994.850128746816;6003.5797494174985;6013.789517366871;6016.157737916607;5519.475649813261;5555.8888822222525;5612.887742245214;5674.460926212003;5735.426457354231;5753.280839895013;5757.165211044459;5763.250777398911;5766.135079738073;5774.682392468287;5619.8595035124445;5630.0991841305195;5631.099024156116;5642.5485961122195;5644.153376993319;5580.135079062752;5594.300712410949;5624.353199382123;5643.576731745054;5694.715264236689;5479.726013699379;5481.725913704219;5500.174973753808;5533.087040638249;5537.584681148849;5622.269105016322;5647.124695672177;5651.8304450866535;5658.179563963285;5660.179274005329;5415.729213539386;5452.291202143696;5500.559955203654;5586.52514536269;5606.523445507178 20:10:50 INFO - PROCESS | 827 | |1;ext.html;502.8843366025814;515.5257163409664;524.874030232744;539.4012645962978;541.972961238453;35369.64630353696;36335.09162270944;36449;36476.27047459049;36571.451428228596;39195;39811.20377592446;39896.202075958536;39900.600993990054;39984.40023399644;8488.108748581388;8575.185357391068;8614.310855131574;8635.69775057873;8649.913500865005;8377.036640786297;8417.95791021044;8421.747347579583;8439.113893041234;8495.938007749031;8552.401331906769;8662.566871656423;8667.95666021669;8671.43635663683;8690.348223883202;8474.067852536216;8611.397202195818;8626.741197764077;8630.482171069756;8636.956815215946;8485;8599.914000860037;8615.741527754115;8615.784605384853;8621.870671939925;39265.60734392648;39941.60058399408;40094;40168.196636067114;40213.39679904804;3076.215565030925;3090.2892334762905;3098.055093196574;3232.305054413289;3483.773554718935;29306.120816375544;30652.233694157603;30662;31383.686163138304;31972.360552788814;3442.5723139466504;3453.2920751245933;3475.113845969287;3549.2014296783277;3600.3339382214112;255966;260766.69616651986;263186;263335;264940;54859.72570137124;55916;59714;60713.69643151756;62490.375096249365;67357;68006.65996669985;68270.65864670744;68745.65627171833;68818.65590672015;16085.034897906164;16183.595410114605;16319.59201019984;16321.755173672404;16326.673466530603;12130.090243231793;12195.14633975631;12196.634100976986;12207.633770986884;12246.693832654255;21236;21537.56924861494;21551.67672484914;21574.89212553927;21625.134994600354;8670.132986701405;8691.391602587759;8721.476711397336;8857.158569935975;8906.242969347548;983.8130755156641;1038.600138946511;1055.730788648905;1072.7747173093737;1107.8393632923342;28676.856615717206;30453.39093218123;32869.17827054295;33669.15827104293;33864.32271354559;975;978.7308490165261;997.2122023601273;1028.4395004722444;1153.907687385024;14222.359993800097;14691.853081469262;14752.704945901236;14875.5537333878;14895.180765058027;386720;389822;390693;395537.06694399606;395714;50638.74680626647;51055.23417148746;51158;51208.23187652188;51250.74374628103;1341.7920222365549;1347.4610155937703;1355.4374934402113;1355.8372995240436;1356.959291221265;26695.798689059426;27819.879626482143;27871.303217419725;27891.581626276027;28028.85985570059;44166.33750493809;45016;45055.32417013813;45140.09719805651;45142.548574515145;242287;243622;244569;244697;246284;31910.840445798553;45503.772481137385;45937;46352.53647463482;46365.30452043154;42288.577114228465;42400.5759942409;42619.36070959;42781.57218427776;42834.785826071915;35168.472472912414;35437.29125417529;35750.28499430049;35978.8201058993;36267.45598815967;35351.64648353484;36595.085122872144;36636.084097897765;37685.2462950734;38595;32495.18762030968;33093.503597445575;33123;33536.329273414885;33710.83144584261;30068.54897176588;32040;32498.83750581232;32646.51030234501;32782.34435311328;24651.260462186165;25267.241982740547;25355.746442536078;25384.74615253824;25634.615480768178 20:10:50 INFO - PROCESS | 827 | |2;jquery.html;342.4520766773163;348.53122550170013;351.2781234562972;360.0817914318488;361.26482607892945;14044.64888377791;14511.854881451209;16370.427035053775;16637.916810415947;17286.740698889495;15331.156786376772;15970.201489925486;16471;16477.423290184845;16577.254023568938;5162.664426812264;5411.864703382407;5412.9458705412835;5417.64785288957;5423.810166644168;5030.6730062546;5173.042987047389;5194.506521880416;5202.193659982709;5348.465153484659;5112.335396398482;5148.716820574867;5159.432462429129;5179.870503237412;5464.4262352453015;5404.675719456825;5423.810166644149;5437.891242175174;5443.646162999412;5446.428125046892;5096.668716533451;5198.9480105198845;5212.58299336056;5235.319408476912;5242.501962313612;12179.208351457128;12353.135280530367;12575.119741618091;12605;12633.49466021358;1988.5923385705896;2025.0785892418915;2088.3004193595166;2169.349195241421;2509.146890057371;8786.341024423129;8873.29013678904;9044.321675874337;9088.863667045;9154.67958621445;1607.8311777263336;1634.0849124490205;1638.7214173590519;1640.2454870759345;1689.4340395967365;59240.107015932525;62360.37639623591;62757.37242627561;62759;62854.371456285306;9705.320627556004;9716.562754676057;9732.854007189897;9742.512874356255;9743.512824358753;12523.373831308398;12579.874201258053;12589.622311330675;12645.557405490763;12654.240745555297;7044.506884518035;7314.158871729819;7347.8163045924275;7392.260773922565;7415.369693576106;7027.262137475594;7038.436925045984;7048.400885924754;7173.175084865307;7201.819954501179;3944.171723938005;4057.330540460791;4335.458067741532;4381.38660587518;4394.406755088086;1706.9146542672818;1791.7760279965005;1793.157216108453;1802.486291406969;1805.2959345855127;910.7768596693852;931.5807886451124;942.7468350641972;999.2455695949511;1071.8499410082595;15799.447019354267;16805.32778688839;16818.663626727397;16905.49283521496;17395.82604173942;835.2482765510968;928.4429342394509;942.5381563034064;948.0330063335497;954.9474778887089;8848.716936044366;9301.767455813659;9585.472798996123;10549.683509494727;10591.258611897094;367620;483508;488253;496824;506304;67160.32839671541;67280.66359668269;70342;70537;71800.64099679573;1093.8742044664966;1118.7370967822555;1121.332806979862;1122.37147197568;1129.8418221449003;14838.703225935205;14852.034617749812;15361;15495.302711378241;15857.920710396374;33178;34168;34456.827715862266;35036.299274013865;35550;43740.56259437365;44550.3317450232;45053.32420013768;45677;48694.26958595553;9203.815923681355;9344.579493922654;9604.615815367308;9631.325807193429;9641;12646.494140234288;16399.590010249838;16697.582560436087;16790.496285111465;17460.12699365052;13342.06605537603;13472.86527134716;13498.730025399633;13590.660233494242;13925.164490130624;13486.86513134856;13610.115342503103;13886.652833679238;14006.719865602427;14210.28948552589;13053.28206948627;13544.864551354754;13587.45650173982;13776.724465510833;13816.240106794223;9088.818223635622;9147;9289.071092890657;9327.953360233427;9355.25157987373;8809.911900880908;10319.535620897228;13182.077254592086;13412.664683382993;13588.25264610456 20:10:50 INFO - PROCESS | 827 | |3;mootools.html;1471.9484818031372;1484.050207866965;1657.9668406631868;1770.610465697546;1814.8275913788193;6553.148090748196;6602;7303.926960730391;7393.03890494235;7400.074990626172;6885.070515480409;6982.546134501254;6988.440924726023;7001.824954376143;7023.61370124643;2105.473631592102;2131.9893400532974;2144.8820314882673;2161.5676864627058;2161.945951351213;2152.4403655049723;2181.0512427094186;2235.284708893155;2243.9439014024697;2244.7979681828633;2161;2193.2433310507927;2202.119152339061;2203.3720389688942;2243.9663405048937;2182.4980254541465;2199.274239500961;2202.5044365017825;2203.2288698955235;2212.7344718633785;2188.3544354415485;2216;2219.1789038055863;2221.2114699281683;2229.1640634761966;7192.64036798158;7250.601216933067;7255.600941948191;7271.127464704269;7291.08861392326;4428.247197976351;4488.910221795579;4499.055198408339;4501.27979523278;4502.842400515966;2798.202512283989;2826.1662809471254;2880.9135725928254;2885.552739325408;2895.420915816824;926.6293482606944;949.3070058857004;958.3148049144895;958.8897276813186;969.2439896880445;9863.852042219372;9889.357191782512;9893.159081478083;9918.950405247928;9941.204703623693;3927.9214415711526;4017.276890159799;4042.555318914917;4043.4137050127565;4052.8986775330854;8660.8700869487;8667.78330541729;8674.132586741276;8675.045744968049;8679.956600217085;4490.57339552742;4495.955040449619;4505.36924830524;4509.346144808985;4519.457665080211;4030.5163380393956;4081.9182916527143;4127;4132.111596006813;4138.358554424009;3349.7487688423466;3400.0309911675054;3405.0976491229844;3410.9658903411146;3429.9657003429647;1044.2324891204958;1045.7385653586603;1048.6801525534786;1062.0229388962173;1062.3307316390624;1271.2944315904763;1275.67470295076;1295.740851829638;1305.9804102938463;1306.2815451501635;6870.45036397087;6988.650567471606;7022.438204943593;7082.964585177041;7111;1013.8327176015874;1064.2709743825503;1136.8635763708407;1137.391495549877;1152.4065106470175;5362.2224777407055;5366.597505187126;5392.867497825422;5401.2168235606405;5419.891602168013;8271.255586997198;8409.789755256168;8496;8698.913010869937;8818.426802257833;8587.87118193215;8609.397342185986;8632.611532481053;8735.912640873637;8736.344774141964;6902;6949.30506949301;7041.753538626123;7052.554226383681;7110.217876033632;6807.965960170168;6828.2830302819475;6831.931680683129;6836.760713375008;6858.622775747382;7732.8453430932195;7812.609369531387;7898.921010789819;7989.7203597873795;8115.959420202861;7980.4812687175145;8062.355011599176;8184.468009579358;8187.345012398875;8198.385121115822;6085.817425477243;6146.6004709693725;6152.477039451696;6217.658028808459;6251.624902505864;7033.085698859116;7079.362857342864;7124.608146551989;7143.107111611049;7186.24544422849;6306.369363063657;6417.582857114273;6426.389492998158;6445.774397896239;6662.367075127855;6269.7178626962805;6333.524985626189;6458.773942911976;6467.579607325697;6522.934770652422;6025.728842202024;6070.484008859296;6077.453029227391;6108.358622344767;6108.969455152695;5684.573656975661;5722.284714410699;5724;5754.136879468113;5786.363500014911;5851.912221316598;5893.086571581412;5902.852428689317;5909.349971503045;5910.497607703393 20:10:50 INFO - PROCESS | 827 | |4;prototype.html;314.45913029589104;325.45648766559844;328.8421557652325;329.6736231131181;338.0939083256872;6150.907736383958;6187.9999999999945;6212.440880320776;6226.626402415858;6264.812055638338;6050.273967123941;6072.7874524391655;6094.14681944527;6128.509719222463;6184.783532576361;4695.906081878369;4697.13103075932;4707.435107787071;4712.90574188516;4715.339852420664;4705.576498115169;4716.221823399135;4718.103560323545;4719.669623126382;4721.858344249661;4482.798274077674;4494.9325760113625;4637.768111594423;4657.673962822604;4668.323093151491;4609.792559334838;4628.305754136873;4629.722216667011;4634.606058485033;4641.350210970467;4014.979925100385;4020.9396859047138;4022.8591999279884;4028.8388464461386;4031.637152656275;5837.474627283565;5893.970530147365;5897.852553686193;5906.468417842415;5929.792457264019;5225.425203227642;5315;5397.568194544427;5418.106012507931;5440.211169380457;6502.414782669583;6515.283318834924;6521;6522.445592124675;6527.281998980108;4439.689221754478;4439.955600444019;4448.888777780549;4453.599176074169;4462.3975763271865;6732.697028633675;6768.56004359715;6800;6841.828954276133;6856.485763567753;4498.235299999008;4552.11233809404;4552.88617784558;4559.293309537027;4566.452025756864;4608.147492713859;4612.423447069116;4613.561711637389;4620.768961551909;4621.399218101693;5384.111621582395;5385.461453854583;5393.191021346751;5399.704071023005;5413.9729301353245;6367.299597044322;6533.346665333429;6548.345165483413;6637.900431493532;6638.402543771083;1605.414023881275;1618.34457044897;1620.0441739373825;1625.9349626014828;1631.3882294139698;1056.6196169379018;1083.268793564341;1090.013537748339;1096.7751610919743;1099.6481126039591;6242.531810114259;6269.868244796791;6275.874482510324;6278.811635650938;6285.654289014056;6733.225679046972;6761.154855643044;6780.762673306411;6783.152105986752;6794.796156115324;6136.662483563447;6242.438180563771;6256.6871656417;6264.060390941395;6269.937300627026;3656.945145822815;3663.8900832975055;3682.834272457746;3689.6125906779403;3690.8708195213576;7082.504224704324;7083.574985500886;7088.751893683696;7103.89344159838;7104.893426598605;6909.136357955255;6924.93075069253;6989.825254368681;7008.299170083053;7053.647317634098;6928.44572434204;6931.722731090801;6959.860802783916;6978.057962175244;6984.476164287597;6811.727530898708;6822.147231596051;6835.282295358916;6837.3162683731225;6843.589384636938;6493.707783149675;6716.126903502513;6730.360615741497;6800.31996800316;6806.319368063154;7046.084009078787;7128.964355178191;7131.85736285261;7135.001099845922;7136.785896423115;4527.253003254426;4592.977035114803;4594.425696787902;4602.826279298892;4620.768961551977;6688.197416310074;6876.828079298058;6877.071595334766;6889;6900.723971041102;6647.501437392311;6648.268690444144;6661.367170118831;6662.333766623299;6663.36698013688;6640.169978752656;6659.2008958925235;6678.499112566674;6679.131712877295;6681.365270299314;6406.071119687526;6522.315156908646;6543.672816359258;6544.214694236722;6561.278259391559;6644.302348253364;6645.966770166118;6674.332566743481;6691.431228345645;6698.2631910488835;6497.480201583768;6525.771597994048;6530.608163510205;6534.934650653433;6547.410733034049 20:10:50 INFO - PROCESS | 827 | |5;yui.html;737.2259127915688;763.461759459581;796.4265728675351;822.5887056471761;826.177952936828;12832.807507887377;12984;13069.346532673364;13073.803892941589;13124.278164700938;11747.060235181187;11854.585089521846;11855;11855.11086668499;13747.93126034371;806.6168569929296;823.3495538524588;823.4277177361736;823.4976664234812;823.6540652925786;813.7029984055836;820.3027426687298;839.5844057191699;842.6839935024366;842.9409941304111;863.818598094401;865.446114486729;869.5261082709939;870.4168207301092;871.7210492642357;849.1466076593047;849.7620666213439;851.6635928808148;856.5160684213399;857.8112815180682;629.4618101523178;630.9621422714652;631.8072987738738;632.6773345593734;633.6989929783316;12700.110992230548;12731.108822382437;12898.613041608673;12918.354082295848;12930.612081637566;10773.192010599236;11044.392558409285;11086.390248536327;11776.411179440993;12317.876821231763;9617.71146865595;9654.517274136266;9694.36986595876;9874.90125098747;9983.550740216708;3378.864845406181;3508.473728940654;3551.7336199784863;3555.8044307563073;3650.3976843821;44252.3362149568;44281.557184428384;44440.777796111135;44645.55354446446;44899.77550112228;8825.911740882637;9054.547272636342;9076.183143517115;9143;9169.495677737788;17863.821361786475;17874.55313617144;17904.194311256026;17906.820931790775;17973;6723.865522689519;6884.380405763505;6891.931080689229;6894.413974812097;7004.334588214111;3896.123372241223;3948.0327319806256;4006.819693113817;4013.1973605279063;4074.7758873262255;3078.476658967936;3078.5074388098246;3096.28785379364;3105.891293804706;3109.30040740836;548.8051741631743;553.079123259776;557.6849080269635;562.0894151474637;574.3280361976498;532.3053415293002;604.8215776345901;614.1340709599443;632.7036141701693;670.8792417364824;7724.961375193088;7769.106552746506;7864.134945156028;8014.79963000918;8115.8782618260775;530.9522143007148;546.3662151903852;558.6370052285301;570.9343425506037;643.5398689936718;3625;3690.1143725505685;3918.0988372673874;3967.722259441869;4114.115465174942;50707;51826.48173518216;53880.46119538833;56681.7165914176;56843;46482.535174648496;48069.75965120222;48254;48469.27296090561;48658.27012594814;44861.327080093826;46654.766726166155;46920.530794691615;47731.28403073887;48472.27291590629;7811.726589569338;7846.450748447553;7931.722389716563;8145.592720363839;8272.17278272168;31104;31108;31590.3671077829;31638.367232655677;32033.67966320307;37343.62656373402;37421.625783741816;37574.43638345372;40544.79727601343;40871.79564102161;9628.855567166358;9941.403515788787;9982.700518984442;10178.829345284976;10439.686809395731;10977.61578344786;11006.559737610405;11497.310161390009;11500.194986351209;11549.769004619693;9671.70984870455;9747.463889486145;9927;9976.700698979042;10023.599056037678;9944.850827237453;10141.442220677933;10282.126019288145;10449.164066874784;10453.84319235197;9730.416175029237;9884.703458896245;9925.503724813587;9958.50207489637;9994.650187243411;8933.46399216049;9002.594883230402;9004.59479323419;9220;9253.768655783659;8345.791355216168;8777.648894044167;8855.690050848447;8870.467771933705;8935.508547029976 20:10:50 INFO - PROCESS | 827 | __end_tp_report 20:10:50 INFO - PROCESS | 827 | __start_cc_report 20:10:50 INFO - PROCESS | 827 | _x_x_mozilla_cycle_collect,315 20:10:50 INFO - PROCESS | 827 | __end_cc_report 20:10:50 INFO - PROCESS | 827 | __startTimestamp1451707850462__endTimestamp 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | ------- Summary: start ------- 20:10:50 INFO - PROCESS | 827 | Number of tests: 6 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#0] dojo.html Cycles:165 Average:5343.32 Median:5533.09 stddev:594.40 (10.7%) stddev-sans-first:570.26 20:10:50 INFO - PROCESS | 827 | Values: 3128.6 3169.5 3203.5 3211.8 3212.6 5146.9 5278.7 5303.4 5354.9 5362.9 5282.4 5299.0 5335.0 5450.0 5461.5 4825.9 4916.2 4972.7 4998.0 5005.1 4876.1 4933.3 4968.0 5029.1 5041.3 4793.2 4916.8 4952.7 4953.6 5067.8 4819.0 4945.1 4950.6 4960.4 4970.4 4801.0 4856.5 4860.1 4860.3 4867.9 5055.5 5123.2 5147.9 5183.5 5184.9 5642.0 5664.5 5670.3 5737.3 5868.3 5799.1 5816.4 5824.6 5829.0 5842.0 5400.0 5419.3 5424.6 5428.6 5437.1 5783.5 5897.5 5948.9 6027.3 6067.1 5588.1 5634.1 5663.3 5673.9 5687.4 5593.2 5669.8 5705.9 5712.2 5731.2 5664.4 5673.2 5764.3 5781.8 5830.0 5791.7 5812.2 5813.0 5823.4 5833.4 4368.0 4397.0 4476.9 4500.3 4539.6 3909.7 3930.7 3932.8 3973.5 3991.3 5327.0 5377.5 5385.0 5393.4 5406.9 5609.6 5643.1 5715.4 5718.0 5744.1 5410.0 5434.3 5438.9 5439.2 5457.3 4941.3 4946.4 4949.4 4950.2 4993.6 5852.4 5932.8 5967.6 5974.9 6035.3 5787.3 5811.7 5812.1 5813.7 5815.4 5955.3 5994.9 6003.6 6013.8 6016.2 5519.5 5555.9 5612.9 5674.5 5735.4 5753.3 5757.2 5763.3 5766.1 5774.7 5619.9 5630.1 5631.1 5642.5 5644.2 5580.1 5594.3 5624.4 5643.6 5694.7 5479.7 5481.7 5500.2 5533.1 5537.6 5622.3 5647.1 5651.8 5658.2 5660.2 5415.7 5452.3 5500.6 5586.5 5606.5 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#1] ext.html Cycles:180 Average:47298.19 Median:36462.64 stddev:80448.74 (220.6%) stddev-sans-first:80597.69 20:10:50 INFO - PROCESS | 827 | Values: 502.9 515.5 524.9 539.4 542.0 35369.6 36335.1 36449.0 36476.3 36571.5 39195.0 39811.2 39896.2 39900.6 39984.4 8488.1 8575.2 8614.3 8635.7 8649.9 8377.0 8418.0 8421.7 8439.1 8495.9 8552.4 8662.6 8668.0 8671.4 8690.3 8474.1 8611.4 8626.7 8630.5 8637.0 8485.0 8599.9 8615.7 8615.8 8621.9 39265.6 39941.6 40094.0 40168.2 40213.4 3076.2 3090.3 3098.1 3232.3 3483.8 29306.1 30652.2 30662.0 31383.7 31972.4 3442.6 3453.3 3475.1 3549.2 3600.3 255966.0 260766.7 263186.0 263335.0 264940.0 54859.7 55916.0 59714.0 60713.7 62490.4 67357.0 68006.7 68270.7 68745.7 68818.7 16085.0 16183.6 16319.6 16321.8 16326.7 12130.1 12195.1 12196.6 12207.6 12246.7 21236.0 21537.6 21551.7 21574.9 21625.1 8670.1 8691.4 8721.5 8857.2 8906.2 983.8 1038.6 1055.7 1072.8 1107.8 28676.9 30453.4 32869.2 33669.2 33864.3 975.0 978.7 997.2 1028.4 1153.9 14222.4 14691.9 14752.7 14875.6 14895.2 386720.0 389822.0 390693.0 395537.1 395714.0 50638.7 51055.2 51158.0 51208.2 51250.7 1341.8 1347.5 1355.4 1355.8 1357.0 26695.8 27819.9 27871.3 27891.6 28028.9 44166.3 45016.0 45055.3 45140.1 45142.5 242287.0 243622.0 244569.0 244697.0 246284.0 31910.8 45503.8 45937.0 46352.5 46365.3 42288.6 42400.6 42619.4 42781.6 42834.8 35168.5 35437.3 35750.3 35978.8 36267.5 35351.6 36595.1 36636.1 37685.2 38595.0 32495.2 33093.5 33123.0 33536.3 33710.8 30068.5 32040.0 32498.8 32646.5 32782.3 24651.3 25267.2 25355.7 25384.7 25634.6 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#2] jquery.html Cycles:180 Average:26082.63 Median:24038.01 stddev:77056.09 (320.6%) stddev-sans-first:77248.01 20:10:50 INFO - PROCESS | 827 | Values: 342.5 348.5 351.3 360.1 361.3 14044.6 14511.9 16370.4 16637.9 17286.7 15331.2 15970.2 16471.0 16477.4 16577.3 5162.7 5411.9 5412.9 5417.6 5423.8 5030.7 5173.0 5194.5 5202.2 5348.5 5112.3 5148.7 5159.4 5179.9 5464.4 5404.7 5423.8 5437.9 5443.6 5446.4 5096.7 5198.9 5212.6 5235.3 5242.5 12179.2 12353.1 12575.1 12605.0 12633.5 1988.6 2025.1 2088.3 2169.3 2509.1 8786.3 8873.3 9044.3 9088.9 9154.7 1607.8 1634.1 1638.7 1640.2 1689.4 59240.1 62360.4 62757.4 62759.0 62854.4 9705.3 9716.6 9732.9 9742.5 9743.5 12523.4 12579.9 12589.6 12645.6 12654.2 7044.5 7314.2 7347.8 7392.3 7415.4 7027.3 7038.4 7048.4 7173.2 7201.8 3944.2 4057.3 4335.5 4381.4 4394.4 1706.9 1791.8 1793.2 1802.5 1805.3 910.8 931.6 942.7 999.2 1071.8 15799.4 16805.3 16818.7 16905.5 17395.8 835.2 928.4 942.5 948.0 954.9 8848.7 9301.8 9585.5 10549.7 10591.3 367620.0 483508.0 488253.0 496824.0 506304.0 67160.3 67280.7 70342.0 70537.0 71800.6 1093.9 1118.7 1121.3 1122.4 1129.8 14838.7 14852.0 15361.0 15495.3 15857.9 33178.0 34168.0 34456.8 35036.3 35550.0 43740.6 44550.3 45053.3 45677.0 48694.3 9203.8 9344.6 9604.6 9631.3 9641.0 12646.5 16399.6 16697.6 16790.5 17460.1 13342.1 13472.9 13498.7 13590.7 13925.2 13486.9 13610.1 13886.7 14006.7 14210.3 13053.3 13544.9 13587.5 13776.7 13816.2 9088.8 9147.0 9289.1 9328.0 9355.3 8809.9 10319.5 13182.1 13412.7 13588.3 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#3] mootools.html Cycles:180 Average:5098.67 Median:6048.11 stddev:2588.44 (42.8%) stddev-sans-first:2581.35 20:10:50 INFO - PROCESS | 827 | Values: 1471.9 1484.1 1658.0 1770.6 1814.8 6553.1 6602.0 7303.9 7393.0 7400.1 6885.1 6982.5 6988.4 7001.8 7023.6 2105.5 2132.0 2144.9 2161.6 2161.9 2152.4 2181.1 2235.3 2243.9 2244.8 2161.0 2193.2 2202.1 2203.4 2244.0 2182.5 2199.3 2202.5 2203.2 2212.7 2188.4 2216.0 2219.2 2221.2 2229.2 7192.6 7250.6 7255.6 7271.1 7291.1 4428.2 4488.9 4499.1 4501.3 4502.8 2798.2 2826.2 2880.9 2885.6 2895.4 926.6 949.3 958.3 958.9 969.2 9863.9 9889.4 9893.2 9919.0 9941.2 3927.9 4017.3 4042.6 4043.4 4052.9 8660.9 8667.8 8674.1 8675.0 8680.0 4490.6 4496.0 4505.4 4509.3 4519.5 4030.5 4081.9 4127.0 4132.1 4138.4 3349.7 3400.0 3405.1 3411.0 3430.0 1044.2 1045.7 1048.7 1062.0 1062.3 1271.3 1275.7 1295.7 1306.0 1306.3 6870.5 6988.7 7022.4 7083.0 7111.0 1013.8 1064.3 1136.9 1137.4 1152.4 5362.2 5366.6 5392.9 5401.2 5419.9 8271.3 8409.8 8496.0 8698.9 8818.4 8587.9 8609.4 8632.6 8735.9 8736.3 6902.0 6949.3 7041.8 7052.6 7110.2 6808.0 6828.3 6831.9 6836.8 6858.6 7732.8 7812.6 7898.9 7989.7 8116.0 7980.5 8062.4 8184.5 8187.3 8198.4 6085.8 6146.6 6152.5 6217.7 6251.6 7033.1 7079.4 7124.6 7143.1 7186.2 6306.4 6417.6 6426.4 6445.8 6662.4 6269.7 6333.5 6458.8 6467.6 6522.9 6025.7 6070.5 6077.5 6108.4 6109.0 5684.6 5722.3 5724.0 5754.1 5786.4 5851.9 5893.1 5902.9 5909.3 5910.5 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#4] prototype.html Cycles:180 Average:5478.78 Median:6242.48 stddev:1684.54 (27.0%) stddev-sans-first:1644.06 20:10:50 INFO - PROCESS | 827 | Values: 314.5 325.5 328.8 329.7 338.1 6150.9 6188.0 6212.4 6226.6 6264.8 6050.3 6072.8 6094.1 6128.5 6184.8 4695.9 4697.1 4707.4 4712.9 4715.3 4705.6 4716.2 4718.1 4719.7 4721.9 4482.8 4494.9 4637.8 4657.7 4668.3 4609.8 4628.3 4629.7 4634.6 4641.4 4015.0 4020.9 4022.9 4028.8 4031.6 5837.5 5894.0 5897.9 5906.5 5929.8 5225.4 5315.0 5397.6 5418.1 5440.2 6502.4 6515.3 6521.0 6522.4 6527.3 4439.7 4440.0 4448.9 4453.6 4462.4 6732.7 6768.6 6800.0 6841.8 6856.5 4498.2 4552.1 4552.9 4559.3 4566.5 4608.1 4612.4 4613.6 4620.8 4621.4 5384.1 5385.5 5393.2 5399.7 5414.0 6367.3 6533.3 6548.3 6637.9 6638.4 1605.4 1618.3 1620.0 1625.9 1631.4 1056.6 1083.3 1090.0 1096.8 1099.6 6242.5 6269.9 6275.9 6278.8 6285.7 6733.2 6761.2 6780.8 6783.2 6794.8 6136.7 6242.4 6256.7 6264.1 6269.9 3656.9 3663.9 3682.8 3689.6 3690.9 7082.5 7083.6 7088.8 7103.9 7104.9 6909.1 6924.9 6989.8 7008.3 7053.6 6928.4 6931.7 6959.9 6978.1 6984.5 6811.7 6822.1 6835.3 6837.3 6843.6 6493.7 6716.1 6730.4 6800.3 6806.3 7046.1 7129.0 7131.9 7135.0 7136.8 4527.3 4593.0 4594.4 4602.8 4620.8 6688.2 6876.8 6877.1 6889.0 6900.7 6647.5 6648.3 6661.4 6662.3 6663.4 6640.2 6659.2 6678.5 6679.1 6681.4 6406.1 6522.3 6543.7 6544.2 6561.3 6644.3 6646.0 6674.3 6691.4 6698.3 6497.5 6525.8 6530.6 6534.9 6547.4 20:10:50 INFO - PROCESS | 827 | 20:10:50 INFO - PROCESS | 827 | [#5] yui.html Cycles:180 Average:12856.39 Median:558.16 stddev:14936.31 (2676.0%) stddev-sans-first:14950.49 20:10:50 INFO - PROCESS | 827 | Values: 737.2 763.5 796.4 822.6 826.2 12832.8 12984.0 13069.3 13073.8 13124.3 11747.1 11854.6 11855.0 11855.1 13747.9 806.6 823.3 823.4 823.5 823.7 813.7 820.3 839.6 842.7 842.9 863.8 865.4 869.5 870.4 871.7 849.1 849.8 851.7 856.5 857.8 629.5 631.0 631.8 632.7 633.7 12700.1 12731.1 12898.6 12918.4 12930.6 10773.2 11044.4 11086.4 11776.4 12317.9 9617.7 9654.5 9694.4 9874.9 9983.6 3378.9 3508.5 3551.7 3555.8 3650.4 44252.3 44281.6 44440.8 44645.6 44899.8 8825.9 9054.5 9076.2 9143.0 9169.5 17863.8 17874.6 17904.2 17906.8 17973.0 6723.9 6884.4 6891.9 6894.4 7004.3 3896.1 3948.0 4006.8 4013.2 4074.8 3078.5 3078.5 3096.3 3105.9 3109.3 548.8 553.1 557.7 562.1 574.3 532.3 604.8 614.1 632.7 670.9 7725.0 7769.1 7864.1 8014.8 8115.9 531.0 546.4 558.6 570.9 643.5 3625.0 3690.1 3918.1 3967.7 4114.1 50707.0 51826.5 53880.5 56681.7 56843.0 46482.5 48069.8 48254.0 48469.3 48658.3 44861.3 46654.8 46920.5 47731.3 48472.3 7811.7 7846.5 7931.7 8145.6 8272.2 31104.0 31108.0 31590.4 31638.4 32033.7 37343.6 37421.6 37574.4 40544.8 40871.8 9628.9 9941.4 9982.7 10178.8 10439.7 10977.6 11006.6 11497.3 11500.2 11549.8 9671.7 9747.5 9927.0 9976.7 10023.6 9944.9 10141.4 10282.1 10449.2 10453.8 9730.4 9884.7 9925.5 9958.5 9994.7 8933.5 9002.6 9004.6 9220.0 9253.8 8345.8 8777.6 8855.7 8870.5 8935.5 20:10:50 INFO - PROCESS | 827 | -------- Summary: end -------- 20:10:50 INFO - PROCESS | 827 | 20:10:51 INFO - TEST-INFO | 827: exit 0 20:10:51 INFO - TEST-OK | dromaeo_css | took 1111025ms 20:10:51 INFO - TEST-START | kraken 20:10:51 INFO - operating with platform_type : linux_ 20:10:51 INFO - Initialising browser for kraken test... 20:10:51 INFO - TEST-INFO | started process 1088 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlKgtx/profile http://localhost:45568/getInfo.html) 20:10:55 INFO - PROCESS | 1088 | __metrics Screen width/height:1600/1200 20:10:55 INFO - PROCESS | 1088 | colorDepth:24 20:10:55 INFO - PROCESS | 1088 | Browser inner width/height: 1024/697 20:10:55 INFO - PROCESS | 1088 | __metrics 20:10:56 INFO - PROCESS | 1088 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:10:56 INFO - TEST-INFO | 1088: exit 0 20:10:56 INFO - Browser initialized. 20:10:56 INFO - Running cycle 1/1 for kraken test... 20:10:56 INFO - TEST-INFO | started process 1280 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlKgtx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:08 INFO - PROCESS | 1280 | RSS: Main: 150548480 20:11:08 INFO - PROCESS | 1280 | 20:11:11 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45568/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:11 INFO - PROCESS | 1280 | RSS: Main: 150896640 20:11:11 INFO - PROCESS | 1280 | 20:11:14 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45568/tests/kraken/driver.html?testName=audio-dft) 20:11:15 INFO - PROCESS | 1280 | RSS: Main: 151474176 20:11:15 INFO - PROCESS | 1280 | 20:11:17 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45568/tests/kraken/driver.html?testName=audio-fft) 20:11:18 INFO - PROCESS | 1280 | RSS: Main: 146300928 20:11:18 INFO - PROCESS | 1280 | 20:11:20 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45568/tests/kraken/driver.html?testName=audio-oscillator) 20:11:21 INFO - PROCESS | 1280 | RSS: Main: 146026496 20:11:21 INFO - PROCESS | 1280 | 20:11:23 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:23 INFO - PROCESS | 1280 | RSS: Main: 146755584 20:11:23 INFO - PROCESS | 1280 | 20:11:26 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45568/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:27 INFO - PROCESS | 1280 | RSS: Main: 146751488 20:11:27 INFO - PROCESS | 1280 | 20:11:30 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45568/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:31 INFO - PROCESS | 1280 | RSS: Main: 148193280 20:11:31 INFO - PROCESS | 1280 | 20:11:34 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45568/tests/kraken/driver.html?testName=json-parse-financial) 20:11:34 INFO - PROCESS | 1280 | RSS: Main: 148492288 20:11:34 INFO - PROCESS | 1280 | 20:11:36 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:36 INFO - PROCESS | 1280 | RSS: Main: 148979712 20:11:36 INFO - PROCESS | 1280 | 20:11:38 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:39 INFO - PROCESS | 1280 | RSS: Main: 148901888 20:11:39 INFO - PROCESS | 1280 | 20:11:41 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:42 INFO - PROCESS | 1280 | RSS: Main: 149516288 20:11:42 INFO - PROCESS | 1280 | 20:11:44 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:45 INFO - PROCESS | 1280 | RSS: Main: 149721088 20:11:45 INFO - PROCESS | 1280 | 20:11:47 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:48 INFO - PROCESS | 1280 | RSS: Main: 148303872 20:11:48 INFO - PROCESS | 1280 | 20:11:49 INFO - PROCESS | 1280 | Cycle 1(1): loaded http://localhost:45568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45568/tests/kraken/driver.html?testName=ai-astar) 20:11:50 INFO - PROCESS | 1280 | RSS: Main: 148271104 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | __start_tp_report 20:11:50 INFO - PROCESS | 1280 | _x_x_mozilla_page_load 20:11:50 INFO - PROCESS | 1280 | _x_x_mozilla_page_load_details 20:11:50 INFO - PROCESS | 1280 | |i|pagename|runs| 20:11:50 INFO - PROCESS | 1280 | |0;ai-astar;112;107;110;109;111;121;111;111;111;110 20:11:50 INFO - PROCESS | 1280 | |1;audio-beat-detection;151;130;150;161;130;158;154;133;160;136 20:11:50 INFO - PROCESS | 1280 | |2;audio-dft;162;162;164;162;162;161;163;168;173;165 20:11:50 INFO - PROCESS | 1280 | |3;audio-fft;71;74;74;72;74;73;132;74;72;71 20:11:50 INFO - PROCESS | 1280 | |4;audio-oscillator;96;96;152;96;97;96;143;95;98;140 20:11:50 INFO - PROCESS | 1280 | |5;imaging-gaussian-blur;109;110;109;109;110;109;110;110;109;111 20:11:50 INFO - PROCESS | 1280 | |6;imaging-darkroom;148;147;147;148;147;147;147;147;148;147 20:11:50 INFO - PROCESS | 1280 | |7;imaging-desaturate;95;97;96;97;97;97;96;96;96;96 20:11:50 INFO - PROCESS | 1280 | |8;json-parse-financial;57;57;58;58;60;62;57;58;56;61 20:11:50 INFO - PROCESS | 1280 | |9;json-stringify-tinderbox;67;69;66;67;67;68;67;66;67;67 20:11:50 INFO - PROCESS | 1280 | |10;stanford-crypto-aes;86;88;86;87;85;87;85;94;87;86 20:11:50 INFO - PROCESS | 1280 | |11;stanford-crypto-ccm;126;116;124;118;119;119;121;121;117;124 20:11:50 INFO - PROCESS | 1280 | |12;stanford-crypto-pbkdf2;141;151;157;153;155;148;156;152;156;142 20:11:50 INFO - PROCESS | 1280 | |13;stanford-crypto-sha256-iterative;69;70;68;67;71;68;69;68;70;67 20:11:50 INFO - PROCESS | 1280 | __end_tp_report 20:11:50 INFO - PROCESS | 1280 | __start_cc_report 20:11:50 INFO - PROCESS | 1280 | _x_x_mozilla_cycle_collect,731 20:11:50 INFO - PROCESS | 1280 | __end_cc_report 20:11:50 INFO - PROCESS | 1280 | __startTimestamp1451707910224__endTimestamp 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | ------- Summary: start ------- 20:11:50 INFO - PROCESS | 1280 | Number of tests: 14 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 20:11:50 INFO - PROCESS | 1280 | Values: 112.0 107.0 110.0 109.0 111.0 121.0 111.0 111.0 111.0 110.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:12.69 (8.3%) stddev-sans-first:13.35 20:11:50 INFO - PROCESS | 1280 | Values: 151.0 130.0 150.0 161.0 130.0 158.0 154.0 133.0 160.0 136.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.71 (2.3%) stddev-sans-first:3.84 20:11:50 INFO - PROCESS | 1280 | Values: 162.0 162.0 164.0 162.0 162.0 161.0 163.0 168.0 173.0 165.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#3] audio-fft Cycles:10 Average:78.70 Median:73.50 stddev:18.77 (25.5%) stddev-sans-first:19.70 20:11:50 INFO - PROCESS | 1280 | Values: 71.0 74.0 74.0 72.0 74.0 73.0 132.0 74.0 72.0 71.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:23.73 (24.7%) stddev-sans-first:24.55 20:11:50 INFO - PROCESS | 1280 | Values: 96.0 96.0 152.0 96.0 97.0 96.0 143.0 95.0 98.0 140.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:11:50 INFO - PROCESS | 1280 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 111.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:11:50 INFO - PROCESS | 1280 | Values: 148.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 20:11:50 INFO - PROCESS | 1280 | Values: 95.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:1.96 (3.4%) stddev-sans-first:2.01 20:11:50 INFO - PROCESS | 1280 | Values: 57.0 57.0 58.0 58.0 60.0 62.0 57.0 58.0 56.0 61.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 20:11:50 INFO - PROCESS | 1280 | Values: 67.0 69.0 66.0 67.0 67.0 68.0 67.0 66.0 67.0 67.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.60 (3.0%) stddev-sans-first:2.73 20:11:50 INFO - PROCESS | 1280 | Values: 86.0 88.0 86.0 87.0 85.0 87.0 85.0 94.0 87.0 86.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:3.31 (2.7%) stddev-sans-first:2.85 20:11:50 INFO - PROCESS | 1280 | Values: 126.0 116.0 124.0 118.0 119.0 119.0 121.0 121.0 117.0 124.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:154.00 stddev:5.74 (3.7%) stddev-sans-first:4.79 20:11:50 INFO - PROCESS | 1280 | Values: 141.0 151.0 157.0 153.0 155.0 148.0 156.0 152.0 156.0 142.0 20:11:50 INFO - PROCESS | 1280 | 20:11:50 INFO - PROCESS | 1280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 20:11:50 INFO - PROCESS | 1280 | Values: 69.0 70.0 68.0 67.0 71.0 68.0 69.0 68.0 70.0 67.0 20:11:50 INFO - PROCESS | 1280 | -------- Summary: end -------- 20:11:50 INFO - PROCESS | 1280 | 20:11:51 INFO - TEST-INFO | 1280: exit 0 20:11:51 INFO - TEST-OK | kraken | took 60010ms 20:11:51 INFO - TEST-START | v8_7 20:11:51 INFO - operating with platform_type : linux_ 20:11:51 INFO - Initialising browser for v8_7 test... 20:11:51 INFO - TEST-INFO | started process 1569 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnHOX2G/profile http://localhost:45568/getInfo.html) 20:11:55 INFO - PROCESS | 1569 | __metrics Screen width/height:1600/1200 20:11:55 INFO - PROCESS | 1569 | colorDepth:24 20:11:55 INFO - PROCESS | 1569 | Browser inner width/height: 1024/697 20:11:55 INFO - PROCESS | 1569 | __metrics 20:11:56 INFO - PROCESS | 1569 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:11:57 INFO - TEST-INFO | 1569: exit 0 20:11:57 INFO - Browser initialized. 20:11:57 INFO - Running cycle 1/1 for v8_7 test... 20:11:57 INFO - TEST-INFO | started process 1690 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnHOX2G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:08 INFO - PROCESS | 1690 | RSS: Main: 150413312 20:12:08 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:45568/tests/v8_7/run.html (next: http://localhost:45568/tests/v8_7/run.html) 20:12:30 INFO - PROCESS | 1690 | RSS: Main: 146644992 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | __start_tp_report 20:12:30 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 20:12:30 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 20:12:30 INFO - PROCESS | 1690 | |i|pagename|runs| 20:12:30 INFO - PROCESS | 1690 | |0;Richards;167.8697330871244 20:12:30 INFO - PROCESS | 1690 | |1;DeltaBlue;191.93857965451056 20:12:30 INFO - PROCESS | 1690 | |2;Encrypt;280.2690582959641 20:12:30 INFO - PROCESS | 1690 | |3;Decrypt;5218.75 20:12:30 INFO - PROCESS | 1690 | |4;RayTrace;1074.1138560687432 20:12:30 INFO - PROCESS | 1690 | |5;Earley;704.7216349541931 20:12:30 INFO - PROCESS | 1690 | |6;Boyer;12256.09756097561 20:12:30 INFO - PROCESS | 1690 | |7;RegExp;25225 20:12:30 INFO - PROCESS | 1690 | |8;Splay;705.7163020465773 20:12:30 INFO - PROCESS | 1690 | |9;NavierStokes;4830.917874396136 20:12:30 INFO - PROCESS | 1690 | __end_tp_report 20:12:30 INFO - PROCESS | 1690 | __startTimestamp1451707950564__endTimestamp 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | ------- Summary: start ------- 20:12:30 INFO - PROCESS | 1690 | Number of tests: 10 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 167.9 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 191.9 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 280.3 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 5218.8 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 1074.1 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 704.7 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 12256.1 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 25225.0 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#8] Splay Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 705.7 20:12:30 INFO - PROCESS | 1690 | 20:12:30 INFO - PROCESS | 1690 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:12:30 INFO - PROCESS | 1690 | Values: 4830.9 20:12:30 INFO - PROCESS | 1690 | -------- Summary: end -------- 20:12:30 INFO - PROCESS | 1690 | 20:12:31 INFO - TEST-INFO | 1690: exit 0 20:12:31 INFO - TEST-OK | v8_7 | took 40261ms 20:12:31 INFO - SUITE-END | took 1211s 20:12:31 INFO - Completed test suite (00:20:11) 20:12:31 INFO - Working with test: dromaeo_css 20:12:31 INFO - Generating results file: dromaeo_css 20:12:31 INFO - Working with test: kraken 20:12:31 INFO - Generating results file: kraken 20:12:31 INFO - javascript benchmark 20:12:31 INFO - Working with test: v8_7 20:12:31 INFO - Generating results file: v8_7 20:12:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:12:31 INFO - process_Request line: dromaeo_css 6854.25 graph.html#tests=[[72,64,43]] 20:12:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:31 INFO - process_Request line: kraken 1517.50 graph.html#tests=[[232,64,43]] 20:12:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:31 INFO - process_Request line: v8_7 20987.97 graph.html#tests=[[230,64,43]] 20:12:31 INFO - RETURN: dromaeo_css: 6854.25 20:12:31 INFO - RETURN: kraken: 1517.50 20:12:31 INFO - RETURN: v8_7: 20987.97 20:12:31 INFO - javascript benchmark 20:12:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.5932828732266, 3169.477036289011, 3203.519472079189, 3211.8233497157653, 3212.5984251968503, 5146.871328216796, 5278.709670968095, 5303.390110137336, 5354.946450535494, 5362.919556206655, 5282.418933917275, 5299.0, 5335.0, 5450.04624190767, 5461.453854614537, 4825.855224343267, 4916.188828843255, 4972.676776009566, 4997.950020499803, 5005.1491246488, 4876.146674331995, 4933.33399991002, 4968.031233909389, 5029.1199040168, 5041.344625198719, 4793.233082706785, 4916.754162291871, 4952.653314268003, 4953.578945789613, 5067.797288108472, 4818.975905120487, 4945.109880221558, 4950.603951683856, 4960.355153829979, 4970.353853998957, 4800.975995120002, 4856.538628830255, 4860.076585448789, 4860.295257187688, 4867.853964381075, 5055.51972562606, 5123.1546794778815, 5147.922781158286, 5183.481651834786, 5184.948150518522, 5642.0, 5664.54683625309, 5670.319561652628, 5737.254156959569, 5868.295804503487, 5799.072148456226, 5816.360200377955, 5824.592278540504, 5828.970855145697, 5842.0, 5400.027994960906, 5419.268398766116, 5424.593155513352, 5428.647137936061, 5437.075697131458, 5783.450572195635, 5897.469227769521, 5948.940510594925, 6027.336992930862, 6067.089936509471, 5588.105903055492, 5634.070378387521, 5663.292088488939, 5673.858153546112, 5687.431256874363, 5593.216949627055, 5669.773209071591, 5705.857353566111, 5712.171735098387, 5731.197632331477, 5664.433556644302, 5673.234113394639, 5764.250647415809, 5781.768729250783, 5829.970850145722, 5791.652500849962, 5812.186293918855, 5813.040848260074, 5823.4467725566, 5833.38749431312, 4367.956320436755, 4396.956030439718, 4476.910461790746, 4500.347449619852, 4539.568740969603, 3909.706771992055, 3930.744501607386, 3932.8426862925735, 3973.5033120859894, 3991.2815693174925, 5326.973365133227, 5377.5429088527135, 5384.9730751346, 5393.352797664305, 5406.91889621656, 5609.607327487037, 5643.125315576092, 5715.399883012307, 5718.0, 5744.080947048536, 5409.972950135303, 5434.347878254555, 5438.864028399243, 5439.238506609078, 5457.263269458652, 4941.308216849644, 4946.4064312282035, 4949.356583644103, 4950.158473059589, 4993.575546078551, 5852.385499522489, 5932.762689492458, 5967.5524335675, 5974.910376344358, 6035.305939816977, 5787.276590426197, 5811.651300921958, 5812.128180772918, 5813.738381772746, 5815.447532484407, 5955.255593050869, 5994.850128746816, 6003.5797494174985, 6013.789517366871, 6016.157737916607, 5519.475649813261, 5555.8888822222525, 5612.887742245214, 5674.460926212003, 5735.426457354231, 5753.280839895013, 5757.165211044459, 5763.250777398911, 5766.135079738073, 5774.682392468287, 5619.8595035124445, 5630.0991841305195, 5631.099024156116, 5642.5485961122195, 5644.153376993319, 5580.135079062752, 5594.300712410949, 5624.353199382123, 5643.576731745054, 5694.715264236689, 5479.726013699379, 5481.725913704219, 5500.174973753808, 5533.087040638249, 5537.584681148849, 5622.269105016322, 5647.124695672177, 5651.8304450866535, 5658.179563963285, 5660.179274005329, 5415.729213539386, 5452.291202143696, 5500.559955203654, 5586.52514536269, 5606.523445507178], "unit": "score", "name": "dojo.html", "value": 5304.52676950192}, {"lowerIsBetter": false, "replicates": [502.8843366025814, 515.5257163409664, 524.874030232744, 539.4012645962978, 541.972961238453, 35369.64630353696, 36335.09162270944, 36449.0, 36476.27047459049, 36571.451428228596, 39195.0, 39811.20377592446, 39896.202075958536, 39900.600993990054, 39984.40023399644, 8488.108748581388, 8575.185357391068, 8614.310855131574, 8635.69775057873, 8649.913500865005, 8377.036640786297, 8417.95791021044, 8421.747347579583, 8439.113893041234, 8495.938007749031, 8552.401331906769, 8662.566871656423, 8667.95666021669, 8671.43635663683, 8690.348223883202, 8474.067852536216, 8611.397202195818, 8626.741197764077, 8630.482171069756, 8636.956815215946, 8485.0, 8599.914000860037, 8615.741527754115, 8615.784605384853, 8621.870671939925, 39265.60734392648, 39941.60058399408, 40094.0, 40168.196636067114, 40213.39679904804, 3076.215565030925, 3090.2892334762905, 3098.055093196574, 3232.305054413289, 3483.773554718935, 29306.120816375544, 30652.233694157603, 30662.0, 31383.686163138304, 31972.360552788814, 3442.5723139466504, 3453.2920751245933, 3475.113845969287, 3549.2014296783277, 3600.3339382214112, 255966.0, 260766.69616651986, 263186.0, 263335.0, 264940.0, 54859.72570137124, 55916.0, 59714.0, 60713.69643151756, 62490.375096249365, 67357.0, 68006.65996669985, 68270.65864670744, 68745.65627171833, 68818.65590672015, 16085.034897906164, 16183.595410114605, 16319.59201019984, 16321.755173672404, 16326.673466530603, 12130.090243231793, 12195.14633975631, 12196.634100976986, 12207.633770986884, 12246.693832654255, 21236.0, 21537.56924861494, 21551.67672484914, 21574.89212553927, 21625.134994600354, 8670.132986701405, 8691.391602587759, 8721.476711397336, 8857.158569935975, 8906.242969347548, 983.8130755156641, 1038.600138946511, 1055.730788648905, 1072.7747173093737, 1107.8393632923342, 28676.856615717206, 30453.39093218123, 32869.17827054295, 33669.15827104293, 33864.32271354559, 975.0, 978.7308490165261, 997.2122023601273, 1028.4395004722444, 1153.907687385024, 14222.359993800097, 14691.853081469262, 14752.704945901236, 14875.5537333878, 14895.180765058027, 386720.0, 389822.0, 390693.0, 395537.06694399606, 395714.0, 50638.74680626647, 51055.23417148746, 51158.0, 51208.23187652188, 51250.74374628103, 1341.7920222365549, 1347.4610155937703, 1355.4374934402113, 1355.8372995240436, 1356.959291221265, 26695.798689059426, 27819.879626482143, 27871.303217419725, 27891.581626276027, 28028.85985570059, 44166.33750493809, 45016.0, 45055.32417013813, 45140.09719805651, 45142.548574515145, 242287.0, 243622.0, 244569.0, 244697.0, 246284.0, 31910.840445798553, 45503.772481137385, 45937.0, 46352.53647463482, 46365.30452043154, 42288.577114228465, 42400.5759942409, 42619.36070959, 42781.57218427776, 42834.785826071915, 35168.472472912414, 35437.29125417529, 35750.28499430049, 35978.8201058993, 36267.45598815967, 35351.64648353484, 36595.085122872144, 36636.084097897765, 37685.2462950734, 38595.0, 32495.18762030968, 33093.503597445575, 33123.0, 33536.329273414885, 33710.83144584261, 30068.54897176588, 32040.0, 32498.83750581232, 32646.51030234501, 32782.34435311328, 24651.260462186165, 25267.241982740547, 25355.746442536078, 25384.74615253824, 25634.615480768178], "unit": "score", "name": "ext.html", "value": 18609.5645586649}, {"lowerIsBetter": false, "replicates": [342.4520766773163, 348.53122550170013, 351.2781234562972, 360.0817914318488, 361.26482607892945, 14044.64888377791, 14511.854881451209, 16370.427035053775, 16637.916810415947, 17286.740698889495, 15331.156786376772, 15970.201489925486, 16471.0, 16477.423290184845, 16577.254023568938, 5162.664426812264, 5411.864703382407, 5412.9458705412835, 5417.64785288957, 5423.810166644168, 5030.6730062546, 5173.042987047389, 5194.506521880416, 5202.193659982709, 5348.465153484659, 5112.335396398482, 5148.716820574867, 5159.432462429129, 5179.870503237412, 5464.4262352453015, 5404.675719456825, 5423.810166644149, 5437.891242175174, 5443.646162999412, 5446.428125046892, 5096.668716533451, 5198.9480105198845, 5212.58299336056, 5235.319408476912, 5242.501962313612, 12179.208351457128, 12353.135280530367, 12575.119741618091, 12605.0, 12633.49466021358, 1988.5923385705896, 2025.0785892418915, 2088.3004193595166, 2169.349195241421, 2509.146890057371, 8786.341024423129, 8873.29013678904, 9044.321675874337, 9088.863667045, 9154.67958621445, 1607.8311777263336, 1634.0849124490205, 1638.7214173590519, 1640.2454870759345, 1689.4340395967365, 59240.107015932525, 62360.37639623591, 62757.37242627561, 62759.0, 62854.371456285306, 9705.320627556004, 9716.562754676057, 9732.854007189897, 9742.512874356255, 9743.512824358753, 12523.373831308398, 12579.874201258053, 12589.622311330675, 12645.557405490763, 12654.240745555297, 7044.506884518035, 7314.158871729819, 7347.8163045924275, 7392.260773922565, 7415.369693576106, 7027.262137475594, 7038.436925045984, 7048.400885924754, 7173.175084865307, 7201.819954501179, 3944.171723938005, 4057.330540460791, 4335.458067741532, 4381.38660587518, 4394.406755088086, 1706.9146542672818, 1791.7760279965005, 1793.157216108453, 1802.486291406969, 1805.2959345855127, 910.7768596693852, 931.5807886451124, 942.7468350641972, 999.2455695949511, 1071.8499410082595, 15799.447019354267, 16805.32778688839, 16818.663626727397, 16905.49283521496, 17395.82604173942, 835.2482765510968, 928.4429342394509, 942.5381563034064, 948.0330063335497, 954.9474778887089, 8848.716936044366, 9301.767455813659, 9585.472798996123, 10549.683509494727, 10591.258611897094, 367620.0, 483508.0, 488253.0, 496824.0, 506304.0, 67160.32839671541, 67280.66359668269, 70342.0, 70537.0, 71800.64099679573, 1093.8742044664966, 1118.7370967822555, 1121.332806979862, 1122.37147197568, 1129.8418221449003, 14838.703225935205, 14852.034617749812, 15361.0, 15495.302711378241, 15857.920710396374, 33178.0, 34168.0, 34456.827715862266, 35036.299274013865, 35550.0, 43740.56259437365, 44550.3317450232, 45053.32420013768, 45677.0, 48694.26958595553, 9203.815923681355, 9344.579493922654, 9604.615815367308, 9631.325807193429, 9641.0, 12646.494140234288, 16399.590010249838, 16697.582560436087, 16790.496285111465, 17460.12699365052, 13342.06605537603, 13472.86527134716, 13498.730025399633, 13590.660233494242, 13925.164490130624, 13486.86513134856, 13610.115342503103, 13886.652833679238, 14006.719865602427, 14210.28948552589, 13053.28206948627, 13544.864551354754, 13587.45650173982, 13776.724465510833, 13816.240106794223, 9088.818223635622, 9147.0, 9289.071092890657, 9327.953360233427, 9355.25157987373, 8809.911900880908, 10319.535620897228, 13182.077254592086, 13412.664683382993, 13588.25264610456], "unit": "score", "name": "jquery.html", "value": 8452.897663282994}, {"lowerIsBetter": false, "replicates": [1471.9484818031372, 1484.050207866965, 1657.9668406631868, 1770.610465697546, 1814.8275913788193, 6553.148090748196, 6602.0, 7303.926960730391, 7393.03890494235, 7400.074990626172, 6885.070515480409, 6982.546134501254, 6988.440924726023, 7001.824954376143, 7023.61370124643, 2105.473631592102, 2131.9893400532974, 2144.8820314882673, 2161.5676864627058, 2161.945951351213, 2152.4403655049723, 2181.0512427094186, 2235.284708893155, 2243.9439014024697, 2244.7979681828633, 2161.0, 2193.2433310507927, 2202.119152339061, 2203.3720389688942, 2243.9663405048937, 2182.4980254541465, 2199.274239500961, 2202.5044365017825, 2203.2288698955235, 2212.7344718633785, 2188.3544354415485, 2216.0, 2219.1789038055863, 2221.2114699281683, 2229.1640634761966, 7192.64036798158, 7250.601216933067, 7255.600941948191, 7271.127464704269, 7291.08861392326, 4428.247197976351, 4488.910221795579, 4499.055198408339, 4501.27979523278, 4502.842400515966, 2798.202512283989, 2826.1662809471254, 2880.9135725928254, 2885.552739325408, 2895.420915816824, 926.6293482606944, 949.3070058857004, 958.3148049144895, 958.8897276813186, 969.2439896880445, 9863.852042219372, 9889.357191782512, 9893.159081478083, 9918.950405247928, 9941.204703623693, 3927.9214415711526, 4017.276890159799, 4042.555318914917, 4043.4137050127565, 4052.8986775330854, 8660.8700869487, 8667.78330541729, 8674.132586741276, 8675.045744968049, 8679.956600217085, 4490.57339552742, 4495.955040449619, 4505.36924830524, 4509.346144808985, 4519.457665080211, 4030.5163380393956, 4081.9182916527143, 4127.0, 4132.111596006813, 4138.358554424009, 3349.7487688423466, 3400.0309911675054, 3405.0976491229844, 3410.9658903411146, 3429.9657003429647, 1044.2324891204958, 1045.7385653586603, 1048.6801525534786, 1062.0229388962173, 1062.3307316390624, 1271.2944315904763, 1275.67470295076, 1295.740851829638, 1305.9804102938463, 1306.2815451501635, 6870.45036397087, 6988.650567471606, 7022.438204943593, 7082.964585177041, 7111.0, 1013.8327176015874, 1064.2709743825503, 1136.8635763708407, 1137.391495549877, 1152.4065106470175, 5362.2224777407055, 5366.597505187126, 5392.867497825422, 5401.2168235606405, 5419.891602168013, 8271.255586997198, 8409.789755256168, 8496.0, 8698.913010869937, 8818.426802257833, 8587.87118193215, 8609.397342185986, 8632.611532481053, 8735.912640873637, 8736.344774141964, 6902.0, 6949.30506949301, 7041.753538626123, 7052.554226383681, 7110.217876033632, 6807.965960170168, 6828.2830302819475, 6831.931680683129, 6836.760713375008, 6858.622775747382, 7732.8453430932195, 7812.609369531387, 7898.921010789819, 7989.7203597873795, 8115.959420202861, 7980.4812687175145, 8062.355011599176, 8184.468009579358, 8187.345012398875, 8198.385121115822, 6085.817425477243, 6146.6004709693725, 6152.477039451696, 6217.658028808459, 6251.624902505864, 7033.085698859116, 7079.362857342864, 7124.608146551989, 7143.107111611049, 7186.24544422849, 6306.369363063657, 6417.582857114273, 6426.389492998158, 6445.774397896239, 6662.367075127855, 6269.7178626962805, 6333.524985626189, 6458.773942911976, 6467.579607325697, 6522.934770652422, 6025.728842202024, 6070.484008859296, 6077.453029227391, 6108.358622344767, 6108.969455152695, 5684.573656975661, 5722.284714410699, 5724.0, 5754.136879468113, 5786.363500014911, 5851.912221316598, 5893.086571581412, 5902.852428689317, 5909.349971503045, 5910.497607703393], "unit": "score", "name": "mootools.html", "value": 4237.8609776862595}, {"lowerIsBetter": false, "replicates": [314.45913029589104, 325.45648766559844, 328.8421557652325, 329.6736231131181, 338.0939083256872, 6150.907736383958, 6187.9999999999945, 6212.440880320776, 6226.626402415858, 6264.812055638338, 6050.273967123941, 6072.7874524391655, 6094.14681944527, 6128.509719222463, 6184.783532576361, 4695.906081878369, 4697.13103075932, 4707.435107787071, 4712.90574188516, 4715.339852420664, 4705.576498115169, 4716.221823399135, 4718.103560323545, 4719.669623126382, 4721.858344249661, 4482.798274077674, 4494.9325760113625, 4637.768111594423, 4657.673962822604, 4668.323093151491, 4609.792559334838, 4628.305754136873, 4629.722216667011, 4634.606058485033, 4641.350210970467, 4014.979925100385, 4020.9396859047138, 4022.8591999279884, 4028.8388464461386, 4031.637152656275, 5837.474627283565, 5893.970530147365, 5897.852553686193, 5906.468417842415, 5929.792457264019, 5225.425203227642, 5315.0, 5397.568194544427, 5418.106012507931, 5440.211169380457, 6502.414782669583, 6515.283318834924, 6521.0, 6522.445592124675, 6527.281998980108, 4439.689221754478, 4439.955600444019, 4448.888777780549, 4453.599176074169, 4462.3975763271865, 6732.697028633675, 6768.56004359715, 6800.0, 6841.828954276133, 6856.485763567753, 4498.235299999008, 4552.11233809404, 4552.88617784558, 4559.293309537027, 4566.452025756864, 4608.147492713859, 4612.423447069116, 4613.561711637389, 4620.768961551909, 4621.399218101693, 5384.111621582395, 5385.461453854583, 5393.191021346751, 5399.704071023005, 5413.9729301353245, 6367.299597044322, 6533.346665333429, 6548.345165483413, 6637.900431493532, 6638.402543771083, 1605.414023881275, 1618.34457044897, 1620.0441739373825, 1625.9349626014828, 1631.3882294139698, 1056.6196169379018, 1083.268793564341, 1090.013537748339, 1096.7751610919743, 1099.6481126039591, 6242.531810114259, 6269.868244796791, 6275.874482510324, 6278.811635650938, 6285.654289014056, 6733.225679046972, 6761.154855643044, 6780.762673306411, 6783.152105986752, 6794.796156115324, 6136.662483563447, 6242.438180563771, 6256.6871656417, 6264.060390941395, 6269.937300627026, 3656.945145822815, 3663.8900832975055, 3682.834272457746, 3689.6125906779403, 3690.8708195213576, 7082.504224704324, 7083.574985500886, 7088.751893683696, 7103.89344159838, 7104.893426598605, 6909.136357955255, 6924.93075069253, 6989.825254368681, 7008.299170083053, 7053.647317634098, 6928.44572434204, 6931.722731090801, 6959.860802783916, 6978.057962175244, 6984.476164287597, 6811.727530898708, 6822.147231596051, 6835.282295358916, 6837.3162683731225, 6843.589384636938, 6493.707783149675, 6716.126903502513, 6730.360615741497, 6800.31996800316, 6806.319368063154, 7046.084009078787, 7128.964355178191, 7131.85736285261, 7135.001099845922, 7136.785896423115, 4527.253003254426, 4592.977035114803, 4594.425696787902, 4602.826279298892, 4620.768961551977, 6688.197416310074, 6876.828079298058, 6877.071595334766, 6889.0, 6900.723971041102, 6647.501437392311, 6648.268690444144, 6661.367170118831, 6662.333766623299, 6663.36698013688, 6640.169978752656, 6659.2008958925235, 6678.499112566674, 6679.131712877295, 6681.365270299314, 6406.071119687526, 6522.315156908646, 6543.672816359258, 6544.214694236722, 6561.278259391559, 6644.302348253364, 6645.966770166118, 6674.332566743481, 6691.431228345645, 6698.2631910488835, 6497.480201583768, 6525.771597994048, 6530.608163510205, 6534.934650653433, 6547.410733034049], "unit": "score", "name": "prototype.html", "value": 4922.187241719252}, {"lowerIsBetter": false, "replicates": [737.2259127915688, 763.461759459581, 796.4265728675351, 822.5887056471761, 826.177952936828, 12832.807507887377, 12984.0, 13069.346532673364, 13073.803892941589, 13124.278164700938, 11747.060235181187, 11854.585089521846, 11855.0, 11855.11086668499, 13747.93126034371, 806.6168569929296, 823.3495538524588, 823.4277177361736, 823.4976664234812, 823.6540652925786, 813.7029984055836, 820.3027426687298, 839.5844057191699, 842.6839935024366, 842.9409941304111, 863.818598094401, 865.446114486729, 869.5261082709939, 870.4168207301092, 871.7210492642357, 849.1466076593047, 849.7620666213439, 851.6635928808148, 856.5160684213399, 857.8112815180682, 629.4618101523178, 630.9621422714652, 631.8072987738738, 632.6773345593734, 633.6989929783316, 12700.110992230548, 12731.108822382437, 12898.613041608673, 12918.354082295848, 12930.612081637566, 10773.192010599236, 11044.392558409285, 11086.390248536327, 11776.411179440993, 12317.876821231763, 9617.71146865595, 9654.517274136266, 9694.36986595876, 9874.90125098747, 9983.550740216708, 3378.864845406181, 3508.473728940654, 3551.7336199784863, 3555.8044307563073, 3650.3976843821, 44252.3362149568, 44281.557184428384, 44440.777796111135, 44645.55354446446, 44899.77550112228, 8825.911740882637, 9054.547272636342, 9076.183143517115, 9143.0, 9169.495677737788, 17863.821361786475, 17874.55313617144, 17904.194311256026, 17906.820931790775, 17973.0, 6723.865522689519, 6884.380405763505, 6891.931080689229, 6894.413974812097, 7004.334588214111, 3896.123372241223, 3948.0327319806256, 4006.819693113817, 4013.1973605279063, 4074.7758873262255, 3078.476658967936, 3078.5074388098246, 3096.28785379364, 3105.891293804706, 3109.30040740836, 548.8051741631743, 553.079123259776, 557.6849080269635, 562.0894151474637, 574.3280361976498, 532.3053415293002, 604.8215776345901, 614.1340709599443, 632.7036141701693, 670.8792417364824, 7724.961375193088, 7769.106552746506, 7864.134945156028, 8014.79963000918, 8115.8782618260775, 530.9522143007148, 546.3662151903852, 558.6370052285301, 570.9343425506037, 643.5398689936718, 3625.0, 3690.1143725505685, 3918.0988372673874, 3967.722259441869, 4114.115465174942, 50707.0, 51826.48173518216, 53880.46119538833, 56681.7165914176, 56843.0, 46482.535174648496, 48069.75965120222, 48254.0, 48469.27296090561, 48658.27012594814, 44861.327080093826, 46654.766726166155, 46920.530794691615, 47731.28403073887, 48472.27291590629, 7811.726589569338, 7846.450748447553, 7931.722389716563, 8145.592720363839, 8272.17278272168, 31104.0, 31108.0, 31590.3671077829, 31638.367232655677, 32033.67966320307, 37343.62656373402, 37421.625783741816, 37574.43638345372, 40544.79727601343, 40871.79564102161, 9628.855567166358, 9941.403515788787, 9982.700518984442, 10178.829345284976, 10439.686809395731, 10977.61578344786, 11006.559737610405, 11497.310161390009, 11500.194986351209, 11549.769004619693, 9671.70984870455, 9747.463889486145, 9927.0, 9976.700698979042, 10023.599056037678, 9944.850827237453, 10141.442220677933, 10282.126019288145, 10449.164066874784, 10453.84319235197, 9730.416175029237, 9884.703458896245, 9925.503724813587, 9958.50207489637, 9994.650187243411, 8933.46399216049, 9002.594883230402, 9004.59479323419, 9220.0, 9253.768655783659, 8345.791355216168, 8777.648894044167, 8855.690050848447, 8870.467771933705, 8935.508547029976], "unit": "score", "name": "yui.html", "value": 5956.980762197963}], "name": "dromaeo_css", "value": 6854.249691770383}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 109.0, 111.0, 121.0, 111.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 150.0, 161.0, 130.0, 158.0, 154.0, 133.0, 160.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 163.0, 168.0, 173.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 74.0, 72.0, 74.0, 73.0, 132.0, 74.0, 72.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 152.0, 96.0, 97.0, 96.0, 143.0, 95.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 58.0, 60.0, 62.0, 57.0, 58.0, 56.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 86.0, 87.0, 85.0, 87.0, 85.0, 94.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [126.0, 116.0, 124.0, 118.0, 119.0, 119.0, 121.0, 121.0, 117.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 157.0, 153.0, 155.0, 148.0, 156.0, 152.0, 156.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 67.0, 71.0, 68.0, 69.0, 68.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1517.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Splay", "value": 115.47274699999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20987.969918894505}]} 20:12:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20987.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6854.25"}}} 20:12:31 INFO - Return code: 0 20:12:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:12:31 INFO - # TBPL SUCCESS # 20:12:31 INFO - Running post-action listener: _resource_record_post_action 20:12:31 INFO - Running post-run listener: _resource_record_post_run 20:12:32 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554958848; Read time: 20; Write time: 551896 20:12:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235429888; Read time: 0; Write time: 380824 20:12:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319291392; Read time: 20; Write time: 171072 20:12:32 INFO - Running post-run listener: _upload_blobber_files 20:12:32 INFO - Blob upload gear active. 20:12:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:12:32 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 20:12:32 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'] 20:12:32 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 20:12:33 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:34 INFO - (blobuploader) - INFO - Done attempting. 20:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:35 INFO - (blobuploader) - INFO - Done attempting. 20:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:35 INFO - Return code: 0 20:12:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8f542f1c18365986fbbbcf4b2fcc7e39bf244e922cd29e789ad6ba7913356d92005d24844fbf485f67b1f3a1e9066bb5d189da415cc14c87a5695e7ba3816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4092e497876722aee7c240c071929a35112f809c25da8dd3712f928aaa32d421df48956e91e490a8ad97ee62f195cc917e7fe75888c82a3ac3ad14567d07f4ee"} 20:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:12:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:12:35 INFO - Contents: 20:12:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8f542f1c18365986fbbbcf4b2fcc7e39bf244e922cd29e789ad6ba7913356d92005d24844fbf485f67b1f3a1e9066bb5d189da415cc14c87a5695e7ba3816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4092e497876722aee7c240c071929a35112f809c25da8dd3712f928aaa32d421df48956e91e490a8ad97ee62f195cc917e7fe75888c82a3ac3ad14567d07f4ee"} 20:12:35 INFO - Copying logs to upload dir... 20:12:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.032447 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-01 20:12:34.887007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:34.890851) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8f542f1c18365986fbbbcf4b2fcc7e39bf244e922cd29e789ad6ba7913356d92005d24844fbf485f67b1f3a1e9066bb5d189da415cc14c87a5695e7ba3816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4092e497876722aee7c240c071929a35112f809c25da8dd3712f928aaa32d421df48956e91e490a8ad97ee62f195cc917e7fe75888c82a3ac3ad14567d07f4ee"} build_url:https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8f542f1c18365986fbbbcf4b2fcc7e39bf244e922cd29e789ad6ba7913356d92005d24844fbf485f67b1f3a1e9066bb5d189da415cc14c87a5695e7ba3816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4092e497876722aee7c240c071929a35112f809c25da8dd3712f928aaa32d421df48956e91e490a8ad97ee62f195cc917e7fe75888c82a3ac3ad14567d07f4ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:34.920136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:34.920570) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451706383.983222-8669219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:35.003334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:12:35.003671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:12:35.003971) ========= ========= Total master_lag: 0.27 =========