builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1453344794.34 results: success (0) buildid: 20160120143008 builduid: c293ad26638f43a1b64d311502bb847d revision: ca345be438249e308318379eca7eec7d6013ae93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.340991) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.341446) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.341779) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006610 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.365171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.365462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.393632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.394017) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.441465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.441775) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.442153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.442419) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 18:53: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% 46.3K=0.3s 2016-01-20 18:53:15 (46.3 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.423190 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.877541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.877813) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098963 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.987607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:14.987928) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca345be438249e308318379eca7eec7d6013ae93 --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 ca345be438249e308318379eca7eec7d6013ae93 --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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 18:53:15,257 truncating revision to first 12 chars 2016-01-20 18:53:15,257 Setting DEBUG logging. 2016-01-20 18:53:15,257 attempt 1/10 2016-01-20 18:53:15,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca345be43824?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 18:53:15,503 unpacking tar archive at: fx-team-ca345be43824/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.522396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.522753) ========= echo ca345be438249e308318379eca7eec7d6013ae93 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca345be438249e308318379eca7eec7d6013ae93'] 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ca345be438249e308318379eca7eec7d6013ae93 program finished with exit code 0 elapsedTime=0.003544 script_repo_revision: 'ca345be438249e308318379eca7eec7d6013ae93' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.573187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.573646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.586807) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.587237) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/ca345be438249e308318379eca7eec7d6013ae93 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 18:53:15.587797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-20 18:53:15.588282) ========= /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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:15 INFO - MultiFileLogger online at 20160120 18:53:15 in /builds/slave/test-pgo 18:53:15 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 18:53:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:53:15 INFO - {'append_to_log': False, 18:53:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:53:15 INFO - 'blob_upload_branch': 'Fx-Team', 18:53:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:53:15 INFO - 'branch': 'Fx-Team', 18:53:15 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:15 INFO - 'config_files': ('talos/linux_config.py',), 18:53:15 INFO - 'default_actions': ('clobber', 18:53:15 INFO - 'read-buildbot-config', 18:53:15 INFO - 'download-and-extract', 18:53:15 INFO - 'populate-webroot', 18:53:15 INFO - 'create-virtualenv', 18:53:15 INFO - 'install', 18:53:15 INFO - 'run-tests'), 18:53:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:15 INFO - 'download_minidump_stackwalk': True, 18:53:15 INFO - 'download_symbols': 'ondemand', 18:53:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:15 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:15 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:15 INFO - 'installer_path': 'installer.exe', 18:53:15 INFO - 'log_level': 'info', 18:53:15 INFO - 'log_name': 'talos', 18:53:15 INFO - 'log_to_console': True, 18:53:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:15 INFO - 'opt_config_files': (), 18:53:15 INFO - 'pip_index': False, 18:53:15 INFO - 'sps_profile': False, 18:53:15 INFO - 'sps_profile_interval': 0, 18:53:15 INFO - 'suite': 'dromaeojs-e10s', 18:53:15 INFO - 'system_bits': '32', 18:53:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:15 INFO - 'title': 'talos-linux64-ix-046', 18:53:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:15 INFO - 'use_talos_json': True, 18:53:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:53:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:15 INFO - 'work_dir': 'build'} 18:53:15 INFO - ##### 18:53:15 INFO - ##### Running clobber step. 18:53:15 INFO - ##### 18:53:15 INFO - Running pre-action listener: _resource_record_pre_action 18:53:15 INFO - Running main action method: clobber 18:53:15 INFO - rmtree: /builds/slave/test-pgo/build 18:53:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:53:20 INFO - Running post-action listener: _resource_record_post_action 18:53:20 INFO - ##### 18:53:20 INFO - ##### Running read-buildbot-config step. 18:53:20 INFO - ##### 18:53:20 INFO - Running pre-action listener: _resource_record_pre_action 18:53:20 INFO - Running main action method: read_buildbot_config 18:53:20 INFO - Using buildbot properties: 18:53:20 INFO - { 18:53:20 INFO - "project": "", 18:53:20 INFO - "product": "firefox", 18:53:20 INFO - "script_repo_revision": "production", 18:53:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:53:20 INFO - "repository": "", 18:53:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:53:20 INFO - "buildid": "20160120143008", 18:53:20 INFO - "pgo_build": "True", 18:53:20 INFO - "basedir": "/builds/slave/test-pgo", 18:53:20 INFO - "buildnumber": 228, 18:53:20 INFO - "slavename": "talos-linux64-ix-046", 18:53:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:53:20 INFO - "platform": "ubuntu64_hw", 18:53:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:53:20 INFO - "branch": "fx-team", 18:53:20 INFO - "repo_path": "integration/fx-team", 18:53:20 INFO - "revision": "ca345be438249e308318379eca7eec7d6013ae93", 18:53:20 INFO - "stage_platform": "linux64-pgo", 18:53:20 INFO - "builduid": "c293ad26638f43a1b64d311502bb847d", 18:53:20 INFO - "slavebuilddir": "test" 18:53:20 INFO - } 18:53:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:53:20 INFO - Running post-action listener: _resource_record_post_action 18:53:20 INFO - ##### 18:53:20 INFO - ##### Running download-and-extract step. 18:53:20 INFO - ##### 18:53:20 INFO - Running pre-action listener: _resource_record_pre_action 18:53:20 INFO - Running main action method: download_and_extract 18:53:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:53:20 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')]} 18:53:20 INFO - https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/test_packages.json 18:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/test_packages.json 18:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:53:25 INFO - Downloaded 1448 bytes. 18:53:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:53:25 INFO - Using the following test package requirements: 18:53:25 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:25 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:25 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:25 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'jsshell-linux-x86_64.zip'], 18:53:25 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:25 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:25 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:25 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:25 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:25 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:25 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:25 INFO - https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:32 INFO - Downloaded 22486018 bytes. 18:53:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:33 INFO - Return code: 0 18:53:33 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 18:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:33 INFO - https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:36 INFO - Downloaded 22486018 bytes. 18:53:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:37 INFO - Return code: 0 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:38 INFO - Downloaded 11132144 bytes. 18:53:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:38 INFO - Return code: 0 18:53: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')]} 18:53:38 INFO - https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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 18:53:40 INFO - Downloaded 55942003 bytes. 18:53:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:53:40 INFO - mkdir: /builds/slave/test-pgo/properties 18:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:53:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:53:40 INFO - Contents: 18:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:53:40 INFO - Running post-action listener: _resource_record_post_action 18:53:40 INFO - Running post-action listener: set_extra_try_arguments 18:53:40 INFO - ##### 18:53:40 INFO - ##### Running populate-webroot step. 18:53:40 INFO - ##### 18:53:40 INFO - Running pre-action listener: _resource_record_pre_action 18:53:40 INFO - Running main action method: populate_webroot 18:53:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:40 INFO - '--tppagecycles', 18:53:40 INFO - '7'], 18:53:40 INFO - 'tests': ['tsvgm']}}, 18:53:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:53:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:53:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:53:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['damp', 'tps']}, 18:53:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['damp', 'tps']}, 18:53:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:53:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:40 INFO - 'other': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'other_l64': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'other_nol64': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore']}, 18:53:40 INFO - 'svgr': {'tests': ['tsvgx', 18:53:40 INFO - 'tsvgr_opacity', 18:53:40 INFO - 'tart', 18:53:40 INFO - 'tscrollx', 18:53:40 INFO - 'cart']}, 18:53:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['tsvgx', 18:53:40 INFO - 'tsvgr_opacity', 18:53:40 INFO - 'tart', 18:53:40 INFO - 'tscrollx', 18:53:40 INFO - 'cart']}, 18:53:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['tp5o']}, 18:53:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--e10s'], 18:53:40 INFO - 'tests': ['tp5o']}, 18:53:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--xperf_path', 18:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:40 INFO - 'tests': ['tp5n']}, 18:53:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--e10s', 18:53:40 INFO - '--xperf_path', 18:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:40 INFO - 'tests': ['tp5n']}}, 18:53:40 INFO - 'talos.zip': {'path': '', 18:53:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:40 INFO - Running post-action listener: _resource_record_post_action 18:53:40 INFO - ##### 18:53:40 INFO - ##### Running create-virtualenv step. 18:53:40 INFO - ##### 18:53:40 INFO - Running pre-action listener: _resource_record_pre_action 18:53:40 INFO - Running main action method: create_virtualenv 18:53:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:53:40 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 18:53:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:40 INFO - Using real prefix '/usr' 18:53:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:53:41 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:43 INFO - Installing pip.................done. 18:53:43 INFO - Return code: 0 18:53:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:53:43 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')]} 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 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')]} 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:43 INFO - Using env: {'DISPLAY': ':0', 18:53:43 INFO - 'HOME': '/home/cltbld', 18:53:43 INFO - 'LANG': 'en_US.UTF-8', 18:53:43 INFO - 'LANGUAGE': 'en_US:en', 18:53:43 INFO - 'LOGNAME': 'cltbld', 18:53:43 INFO - 'MAIL': '/var/mail/cltbld', 18:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:43 INFO - 'MOZ_NO_REMOTE': '1', 18:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:43 INFO - 'NO_EM_RESTART': '1', 18:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:43 INFO - 'SHELL': '/bin/bash', 18:53:43 INFO - 'SHLVL': '1', 18:53:43 INFO - 'TERM': 'linux', 18:53:43 INFO - 'TMOUT': '86400', 18:53:43 INFO - 'USER': 'cltbld', 18:53:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:43 INFO - '_': '/tools/buildbot/bin/python'} 18:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:43 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 18:53:43 INFO - Cleaning up... 18:53:43 INFO - Return code: 0 18:53:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:53:43 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')]} 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 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')]} 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:53:43 INFO - Using env: {'DISPLAY': ':0', 18:53:43 INFO - 'HOME': '/home/cltbld', 18:53:43 INFO - 'LANG': 'en_US.UTF-8', 18:53:43 INFO - 'LANGUAGE': 'en_US:en', 18:53:43 INFO - 'LOGNAME': 'cltbld', 18:53:43 INFO - 'MAIL': '/var/mail/cltbld', 18:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:43 INFO - 'MOZ_NO_REMOTE': '1', 18:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:43 INFO - 'NO_EM_RESTART': '1', 18:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:43 INFO - 'SHELL': '/bin/bash', 18:53:43 INFO - 'SHLVL': '1', 18:53:43 INFO - 'TERM': 'linux', 18:53:43 INFO - 'TMOUT': '86400', 18:53:43 INFO - 'USER': 'cltbld', 18:53:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:43 INFO - '_': '/tools/buildbot/bin/python'} 18:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:43 INFO - Downloading/unpacking psutil>=0.7.1 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:45 INFO - Installing collected packages: psutil 18:53:45 INFO - Running setup.py install for psutil 18:53:45 INFO - building 'psutil._psutil_linux' extension 18:53:45 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 18:53:45 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 18:53:45 INFO - building 'psutil._psutil_posix' extension 18:53:45 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 18:53:45 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 18:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:45 INFO - Successfully installed psutil 18:53:45 INFO - Cleaning up... 18:53:45 INFO - Return code: 0 18:53:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:53:45 INFO - Using env: {'DISPLAY': ':0', 18:53:45 INFO - 'HOME': '/home/cltbld', 18:53:45 INFO - 'LANG': 'en_US.UTF-8', 18:53:45 INFO - 'LANGUAGE': 'en_US:en', 18:53:45 INFO - 'LOGNAME': 'cltbld', 18:53:45 INFO - 'MAIL': '/var/mail/cltbld', 18:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:45 INFO - 'MOZ_NO_REMOTE': '1', 18:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:45 INFO - 'NO_EM_RESTART': '1', 18:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:45 INFO - 'SHELL': '/bin/bash', 18:53:45 INFO - 'SHLVL': '1', 18:53:45 INFO - 'TERM': 'linux', 18:53:45 INFO - 'TMOUT': '86400', 18:53:45 INFO - 'USER': 'cltbld', 18:53:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:45 INFO - '_': '/tools/buildbot/bin/python'} 18:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:53:48 INFO - Installing collected packages: mozsystemmonitor 18:53:48 INFO - Running setup.py install for mozsystemmonitor 18:53:48 INFO - Successfully installed mozsystemmonitor 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:53:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Downloading docopt-0.6.1.tar.gz 18:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:51 INFO - Running setup.py install for blobuploader 18:53:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:53:51 INFO - Running setup.py install for requests 18:53:51 INFO - Running setup.py install for docopt 18:53:51 INFO - Successfully installed blobuploader requests docopt 18:53:51 INFO - Cleaning up... 18:53:52 INFO - Return code: 0 18:53:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 18:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 18:53:52 INFO - Using env: {'DISPLAY': ':0', 18:53:52 INFO - 'HOME': '/home/cltbld', 18:53:52 INFO - 'LANG': 'en_US.UTF-8', 18:53:52 INFO - 'LANGUAGE': 'en_US:en', 18:53:52 INFO - 'LOGNAME': 'cltbld', 18:53:52 INFO - 'MAIL': '/var/mail/cltbld', 18:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:52 INFO - 'MOZ_NO_REMOTE': '1', 18:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:52 INFO - 'NO_EM_RESTART': '1', 18:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:52 INFO - 'SHELL': '/bin/bash', 18:53:52 INFO - 'SHLVL': '1', 18:53:52 INFO - 'TERM': 'linux', 18:53:52 INFO - 'TMOUT': '86400', 18:53:52 INFO - 'USER': 'cltbld', 18:53:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:52 INFO - '_': '/tools/buildbot/bin/python'} 18:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:52 INFO - Running setup.py (path:/tmp/pip-PRWqaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:52 INFO - Running setup.py (path:/tmp/pip-tRpFEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:52 INFO - Running setup.py (path:/tmp/pip-_I2JIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:52 INFO - Running setup.py (path:/tmp/pip-rIVHdW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:52 INFO - Running setup.py (path:/tmp/pip-qFIhET-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:52 INFO - Running setup.py (path:/tmp/pip-JFrr4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:53 INFO - Running setup.py (path:/tmp/pip-gTklH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:53 INFO - Running setup.py (path:/tmp/pip-Iy6Abq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:53 INFO - Running setup.py (path:/tmp/pip-e32je_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:53 INFO - Running setup.py (path:/tmp/pip-YHmsgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:53 INFO - Running setup.py (path:/tmp/pip-nZRC70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:53 INFO - Running setup.py (path:/tmp/pip-_07V8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:53 INFO - Running setup.py (path:/tmp/pip-1DS2Su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:53 INFO - Running setup.py (path:/tmp/pip-Y7AaLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:53 INFO - Running setup.py (path:/tmp/pip-kszP5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:53 INFO - Running setup.py (path:/tmp/pip-h4ztcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:53 INFO - Running setup.py (path:/tmp/pip-01Ftf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:53 INFO - Running setup.py install for manifestparser 18:53:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:53:53 INFO - Running setup.py install for mozcrash 18:53:53 INFO - Running setup.py install for mozdebug 18:53:54 INFO - Running setup.py install for mozdevice 18:53:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for mozfile 18:53:54 INFO - Running setup.py install for mozhttpd 18:53:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for mozinfo 18:53:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for mozInstall 18:53:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for mozleak 18:53:54 INFO - Running setup.py install for mozlog 18:53:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for moznetwork 18:53:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:53:54 INFO - Running setup.py install for mozprocess 18:53:55 INFO - Running setup.py install for mozprofile 18:53:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Running setup.py install for mozrunner 18:53:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Running setup.py install for mozscreenshot 18:53:55 INFO - Running setup.py install for moztest 18:53:55 INFO - Running setup.py install for mozversion 18:53:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:55 INFO - Cleaning up... 18:53:55 INFO - Return code: 0 18:53:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:55 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')]} 18:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:55 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')]} 18:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:53:55 INFO - Using env: {'DISPLAY': ':0', 18:53:55 INFO - 'HOME': '/home/cltbld', 18:53:55 INFO - 'LANG': 'en_US.UTF-8', 18:53:55 INFO - 'LANGUAGE': 'en_US:en', 18:53:55 INFO - 'LOGNAME': 'cltbld', 18:53:55 INFO - 'MAIL': '/var/mail/cltbld', 18:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:55 INFO - 'MOZ_NO_REMOTE': '1', 18:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:55 INFO - 'NO_EM_RESTART': '1', 18:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:55 INFO - 'SHELL': '/bin/bash', 18:53:55 INFO - 'SHLVL': '1', 18:53:55 INFO - 'TERM': 'linux', 18:53:55 INFO - 'TMOUT': '86400', 18:53:55 INFO - 'USER': 'cltbld', 18:53:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:55 INFO - '_': '/tools/buildbot/bin/python'} 18:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:55 INFO - Running setup.py (path:/tmp/pip-YC8bdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:55 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)) 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:55 INFO - Running setup.py (path:/tmp/pip-0jDP6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:55 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)) 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:55 INFO - Running setup.py (path:/tmp/pip-ZJpWXK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:56 INFO - Running setup.py (path:/tmp/pip-XaF5oC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:56 INFO - Running setup.py (path:/tmp/pip-ICzhvw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:56 INFO - Running setup.py (path:/tmp/pip-Kamej6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:56 INFO - Running setup.py (path:/tmp/pip-eYC8qT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:56 INFO - Running setup.py (path:/tmp/pip-Vi4oPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:56 INFO - Running setup.py (path:/tmp/pip-bw_lfh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:56 INFO - Running setup.py (path:/tmp/pip-t6akuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:56 INFO - Running setup.py (path:/tmp/pip-jJzb8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:56 INFO - Running setup.py (path:/tmp/pip-I01xpx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:56 INFO - Running setup.py (path:/tmp/pip-6RCr5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:56 INFO - Running setup.py (path:/tmp/pip-qkMowc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:56 INFO - Running setup.py (path:/tmp/pip-xS9Fb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:56 INFO - Running setup.py (path:/tmp/pip-bRWgoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:56 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)) 18:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:56 INFO - Running setup.py (path:/tmp/pip-YzUpo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:57 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)) 18:53:57 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)) 18:53:57 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)) 18:53:57 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)) 18:53: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:57 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:58 INFO - Downloading blessings-1.6.tar.gz 18:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:53:58 INFO - Installing collected packages: blessings 18:53:58 INFO - Running setup.py install for blessings 18:53:58 INFO - Successfully installed blessings 18:53:58 INFO - Cleaning up... 18:53:59 INFO - Return code: 0 18:53:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:53:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:53:59 INFO - Reading from file tmpfile_stdout 18:53:59 INFO - Current package versions: 18:53:59 INFO - argparse == 1.2.1 18:53:59 INFO - blessings == 1.6 18:53:59 INFO - blobuploader == 1.2.4 18:53:59 INFO - docopt == 0.6.1 18:53:59 INFO - manifestparser == 1.1 18:53:59 INFO - mozInstall == 1.12 18:53:59 INFO - mozcrash == 0.16 18:53:59 INFO - mozdebug == 0.1 18:53:59 INFO - mozdevice == 0.48 18:53:59 INFO - mozfile == 1.2 18:53:59 INFO - mozhttpd == 0.7 18:53:59 INFO - mozinfo == 0.9 18:53:59 INFO - mozleak == 0.1 18:53:59 INFO - mozlog == 3.1 18:53:59 INFO - moznetwork == 0.27 18:53:59 INFO - mozprocess == 0.22 18:53:59 INFO - mozprofile == 0.28 18:53:59 INFO - mozrunner == 6.11 18:53:59 INFO - mozscreenshot == 0.1 18:53:59 INFO - mozsystemmonitor == 0.0 18:53:59 INFO - moztest == 0.7 18:53:59 INFO - mozversion == 1.4 18:53:59 INFO - psutil == 3.1.1 18:53:59 INFO - requests == 1.2.3 18:53:59 INFO - wsgiref == 0.1.2 18:53:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:53:59 INFO - Using env: {'DISPLAY': ':0', 18:53:59 INFO - 'HOME': '/home/cltbld', 18:53:59 INFO - 'LANG': 'en_US.UTF-8', 18:53:59 INFO - 'LANGUAGE': 'en_US:en', 18:53:59 INFO - 'LOGNAME': 'cltbld', 18:53:59 INFO - 'MAIL': '/var/mail/cltbld', 18:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:59 INFO - 'MOZ_NO_REMOTE': '1', 18:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:59 INFO - 'NO_EM_RESTART': '1', 18:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:59 INFO - 'SHELL': '/bin/bash', 18:53:59 INFO - 'SHLVL': '1', 18:53:59 INFO - 'TERM': 'linux', 18:53:59 INFO - 'TMOUT': '86400', 18:53:59 INFO - 'USER': 'cltbld', 18:53:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:59 INFO - '_': '/tools/buildbot/bin/python'} 18:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 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)) 18:53:59 INFO - Cleaning up... 18:53:59 INFO - Return code: 0 18:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:53:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:53:59 INFO - Using env: {'DISPLAY': ':0', 18:53:59 INFO - 'HOME': '/home/cltbld', 18:53:59 INFO - 'LANG': 'en_US.UTF-8', 18:53:59 INFO - 'LANGUAGE': 'en_US:en', 18:53:59 INFO - 'LOGNAME': 'cltbld', 18:53:59 INFO - 'MAIL': '/var/mail/cltbld', 18:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:59 INFO - 'MOZ_NO_REMOTE': '1', 18:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:59 INFO - 'NO_EM_RESTART': '1', 18:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:59 INFO - 'SHELL': '/bin/bash', 18:53:59 INFO - 'SHLVL': '1', 18:53:59 INFO - 'TERM': 'linux', 18:53:59 INFO - 'TMOUT': '86400', 18:53:59 INFO - 'USER': 'cltbld', 18:53:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:59 INFO - '_': '/tools/buildbot/bin/python'} 18:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:59 INFO - Downloading/unpacking jsonschema 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:54:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:01 INFO - Downloading/unpacking functools32 (from jsonschema) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:01 INFO - warning: no files found matching '*.txt' 18:54:01 INFO - no previously-included directories found matching 'build' 18:54:01 INFO - no previously-included directories found matching 'dist' 18:54:01 INFO - no previously-included directories found matching '.git*' 18:54:01 INFO - Installing collected packages: jsonschema, functools32 18:54:01 INFO - Running setup.py install for functools32 18:54:01 INFO - warning: no files found matching '*.txt' 18:54:01 INFO - no previously-included directories found matching 'build' 18:54:01 INFO - no previously-included directories found matching 'dist' 18:54:01 INFO - no previously-included directories found matching '.git*' 18:54:01 INFO - Successfully installed jsonschema functools32 18:54:01 INFO - Cleaning up... 18:54:01 INFO - Return code: 0 18:54:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f511587bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2790480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, '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': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', '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 18:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:54:01 INFO - Using env: {'DISPLAY': ':0', 18:54:01 INFO - 'HOME': '/home/cltbld', 18:54:01 INFO - 'LANG': 'en_US.UTF-8', 18:54:01 INFO - 'LANGUAGE': 'en_US:en', 18:54:01 INFO - 'LOGNAME': 'cltbld', 18:54:01 INFO - 'MAIL': '/var/mail/cltbld', 18:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:01 INFO - 'MOZ_NO_REMOTE': '1', 18:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:01 INFO - 'NO_EM_RESTART': '1', 18:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:01 INFO - 'SHELL': '/bin/bash', 18:54:01 INFO - 'SHLVL': '1', 18:54:01 INFO - 'TERM': 'linux', 18:54:01 INFO - 'TMOUT': '86400', 18:54:01 INFO - 'USER': 'cltbld', 18:54:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:01 INFO - '_': '/tools/buildbot/bin/python'} 18:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:02 INFO - Downloading/unpacking flake8 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:54:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:54:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:04 INFO - no previously-included directories found matching 'docs/_build' 18:54:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:54:04 INFO - Running setup.py install for pep8 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:04 INFO - no previously-included directories found matching 'docs/_build' 18:54:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:54:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:54:04 INFO - Cleaning up... 18:54:04 INFO - Return code: 0 18:54:04 INFO - Running post-action listener: _resource_record_post_action 18:54:04 INFO - Running post-action listener: _start_resource_monitoring 18:54:04 INFO - Starting resource monitoring. 18:54:04 INFO - ##### 18:54:04 INFO - ##### Running install step. 18:54:04 INFO - ##### 18:54:04 INFO - Running pre-action listener: _resource_record_pre_action 18:54:04 INFO - Running main action method: install 18:54:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Output received: 18:54:05 INFO - Usage: mozinstall [options] installer 18:54:05 INFO - Options: 18:54:05 INFO - -h, --help show this help message and exit 18:54:05 INFO - -d DEST, --destination=DEST 18:54:05 INFO - Directory to install application into. [default: 18:54:05 INFO - "/builds/slave/test-pgo"] 18:54:05 INFO - --app=APP Application being installed. [default: firefox] 18:54:05 INFO - mkdir: /builds/slave/test-pgo/build/application 18:54:05 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'] 18:54:05 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 18:54:21 INFO - Reading from file tmpfile_stdout 18:54:21 INFO - Output received: 18:54:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:54:21 INFO - Running post-action listener: _resource_record_post_action 18:54:21 INFO - ##### 18:54:21 INFO - ##### Running run-tests step. 18:54:21 INFO - ##### 18:54:21 INFO - Running pre-action listener: _resource_record_pre_action 18:54:21 INFO - Running main action method: run_tests 18:54:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:54:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:54:21 INFO - Python 2.7.3 18:54:21 INFO - Return code: 0 18:54:21 INFO - grabbing minidump binary from tooltool 18:54:21 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')]} 18:54:21 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 0x281f660>, '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 0x2820560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:54:21 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 18:54:21 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 18:54:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:21 INFO - Return code: 0 18:54:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:54:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:54:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:54:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:54:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:54:22 INFO - Return code: 0 18:54:22 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/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 18:54:22 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/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 18:54:22 INFO - Using env: {'DISPLAY': ':0', 18:54:22 INFO - 'HOME': '/home/cltbld', 18:54:22 INFO - 'LANG': 'en_US.UTF-8', 18:54:22 INFO - 'LANGUAGE': 'en_US:en', 18:54:22 INFO - 'LOGNAME': 'cltbld', 18:54:22 INFO - 'MAIL': '/var/mail/cltbld', 18:54:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:22 INFO - 'MOZ_NO_REMOTE': '1', 18:54:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:22 INFO - 'NO_EM_RESTART': '1', 18:54:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:22 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:54:22 INFO - 'SHELL': '/bin/bash', 18:54:22 INFO - 'SHLVL': '1', 18:54:22 INFO - 'TERM': 'linux', 18:54:22 INFO - 'TMOUT': '86400', 18:54:22 INFO - 'USER': 'cltbld', 18:54:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805', 18:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:22 INFO - '_': '/tools/buildbot/bin/python'} 18:54:22 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/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 18:54:22 INFO - mozversion application_buildid: 20160120143008 18:54:22 INFO - mozversion application_changeset: ca345be438249e308318379eca7eec7d6013ae93 18:54:22 INFO - mozversion application_display_name: Nightly 18:54:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:22 INFO - mozversion application_name: Firefox 18:54:22 INFO - mozversion application_remotingname: firefox 18:54:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:54:22 INFO - mozversion application_vendor: Mozilla 18:54:22 INFO - mozversion application_version: 46.0a1 18:54:22 INFO - mozversion platform_buildid: 20160120143008 18:54:22 INFO - mozversion platform_changeset: ca345be438249e308318379eca7eec7d6013ae93 18:54:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:54:22 INFO - mozversion platform_version: 46.0a1 18:54:22 INFO - using testdate: 1453344862 18:54:22 INFO - actual date: 1453344862 18:54:22 INFO - starting webserver on 'localhost:39774' 18:54:22 INFO - SUITE-START | Running 3 tests 18:54:22 INFO - TEST-START | dromaeo_css 18:54:22 INFO - operating with platform_type : linux_ 18:54:22 INFO - Initialising browser for dromaeo_css test... 18:54:22 INFO - TEST-INFO | started process 8978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzHyiv/profile http://localhost:39774/getInfo.html) 18:54:26 INFO - PROCESS | 8978 | 18:54:26 INFO - PROCESS | 8978 | (process:9058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:27 INFO - PROCESS | 8978 | __metrics Screen width/height:1600/1200 18:54:27 INFO - PROCESS | 8978 | colorDepth:24 18:54:27 INFO - PROCESS | 8978 | Browser inner width/height: 1024/697 18:54:27 INFO - PROCESS | 8978 | __metrics 18:54:27 INFO - PROCESS | 8978 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:54:28 INFO - TEST-INFO | 8978: exit 0 18:54:28 INFO - Browser initialized. 18:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:28 INFO - TEST-INFO | started process 9107 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzHyiv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:28 INFO - PROCESS | 9107 | -- checkerboarding starts below -- 18:54:28 INFO - PROCESS | 9107 | RENDERTRACE 0.045643 rect red 0 0 10 10 // viewport 18:54:28 INFO - PROCESS | 9107 | RENDERTRACE 56.921 rect brown 0 0 10 10 // page 18:54:28 INFO - PROCESS | 9107 | RENDERTRACE 56.9412 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 18:54:28 INFO - PROCESS | 9107 | Checkerboarded for 1 frames (57.883 ms), 100 peak, 1 severity. 18:54:29 INFO - PROCESS | 9107 | 18:54:29 INFO - PROCESS | 9107 | (process:9166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:40 INFO - PROCESS | 9107 | RSS: Main: 150372352 18:54:40 INFO - PROCESS | 9107 | 18:55:29 INFO - PROCESS | 9107 | 1453344929635 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] 18:57:38 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39774/tests/dromaeo/cssquery-ext.html) 18:57:39 INFO - PROCESS | 9107 | RSS: Main: 155127808 18:57:39 INFO - PROCESS | 9107 | 19:00:41 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-ext.html (next: http://localhost:39774/tests/dromaeo/cssquery-jquery.html) 19:00:42 INFO - PROCESS | 9107 | RSS: Main: 151633920 19:00:42 INFO - PROCESS | 9107 | 19:03:44 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39774/tests/dromaeo/cssquery-mootools.html) 19:03:44 INFO - PROCESS | 9107 | RSS: Main: 152719360 19:03:44 INFO - PROCESS | 9107 | 19:06:46 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39774/tests/dromaeo/cssquery-prototype.html) 19:06:47 INFO - PROCESS | 9107 | RSS: Main: 150106112 19:06:47 INFO - PROCESS | 9107 | 19:09:49 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39774/tests/dromaeo/cssquery-yui.html) 19:09:50 INFO - PROCESS | 9107 | RSS: Main: 150233088 19:09:50 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-yui.html (next: http://localhost:39774/tests/dromaeo/cssquery-dojo.html) 19:12:52 INFO - PROCESS | 9107 | RSS: Main: 152580096 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | __start_tp_report 19:12:52 INFO - PROCESS | 9107 | _x_x_mozilla_page_load 19:12:52 INFO - PROCESS | 9107 | _x_x_mozilla_page_load_details 19:12:52 INFO - PROCESS | 9107 | |i|pagename|runs| 19:12:52 INFO - PROCESS | 9107 | |0;dojo.html;3133.1697100268434;3170.207448137964;3204.4712622417296;3205.7755957083014;3214.1321843102364;5076.492350764931;5220.504052115043;5224.346956630421;5231.058409486296;5303.045451818671;5230.686158830473;5300.310959575259;5336.546393556543;5342.1452567589195;5357.223202635615;4492.52828453011;4742.288656701497;4992.326035985132;5006.774695138709;5015.3730783652045;4811.735354555498;4919.065377578248;4923.70457772533;4952.900941981158;4985.326980857592;4737.786799594027;4809.350737650408;4880.438749543812;4890.975545122287;4936.925946110811;4805.20714082176;4865.805367785284;4872.561469467765;4899.902001959977;4901.852944411673;4671.205894997858;4745.667803253774;4874.147024270738;4875.219964805649;4891.364122664067;5151.330327057496;5154.252633368141;5201.115810312256;5208.192730126836;5208.66143700662;5644.181593668936;5647.548196144339;5655.8586035349035;5664.376918538957;5707.942920570783;5537.833864984017;5609.943900560983;5690.516306113986;5714.285714285715;5799.101139323411;5287.603429742746;5292.947070529322;5309.734513274321;5318.042752304584;5354.384245811742;5709.628874123168;5749;5758.913616295759;5762.962666719946;5788.971055144697;5577.44225577439;5622.91565626516;5627.71861406928;5649.802256921071;5715.31416230055;5727.656340619576;5755.165501002331;5762.567807414377;5764.365919748824;5776.104703770922;5658.462446067617;5712.400197979236;5712.857178570569;5725;5725.3988331225455;5482.424345443751;5640.041192997201;5648.15277708347;5675.404082571271;5728.856778580569;4419;4430.911381772346;4436.866893993185;4464.531224221475;4493.146302202571;3916.2950668879876;3932.9213415731524;3965.960340396559;3974.582668819732;4016.859409920639;5285.603579731535;5289.312389389354;5329.493698098674;5339.359276886721;5427.0773968425465;5659.745311460994;5741.368449470555;5751.964646363695;5764.625299355528;5765.4811067004175;5273.472652734696;5287.894242115136;5298.867528311746;5366;5404.648697834628;4838.903221935541;4858.73276969763;4900.509949005071;4904.730239836772;4933.679310844784;5984.431479009487;5997.1304160896425;6012;6014.789482368096;6017.06735456005;5677.460641239076;5781.508571771446;5801.3038435388025;5801.361850196559;5802.709864506842;5772.076467765138;5814.912776308443;5856.795012174553;5862.882742345215;5896;5664.235328230636;5669.603127781016;5682.062459694104;5683.147527870852;5686.630369026;5635.549156067586;5674.886502270014;5720.542356611378;5730.770769169187;5745.023346031268;5421.2681288025615;5441.945580544302;5458.4814442627885;5463.644863083887;5503.284573005483;5478.123500239943;5496.862578435571;5511.779528818803;5517.751701173376;5536.335639723259;5414.75633596497;5423.538999185113;5436.809711660073;5462.153366228241;5483.7258137092185;5602.859928501657;5616.747246374005;5616.9327827712605;5622;5656.0667489865355;5456.918146227889;5465.836024919259;5483.890322193613;5485.451454854642;5485.561155107502 19:12:52 INFO - PROCESS | 9107 | |1;ext.html;508.37723788359267;541.5342805187539;552.2489414396417;560.6916196092149;577.2582231832097;28184.295392615193;35999.280014399694;36329.636703632954;36412.27175456489;36497.45253821195;38997.41503877444;39328;39364.803175984154;39395.40906886399;39567.40648890269;8390.496570205776;8501.14988501148;8516.06323304436;8520.318374530023;8527.31781457485;8307.169283071706;8361.83276334473;8408.747737567852;8414.78963025923;8427.957860210721;8301.211384918453;8472.576371181447;8480.321574274043;8484.32125429964;8485.490870547756;8332.125126861683;8367.874481882745;8418.368622353317;8622.396432249683;8626;8398.496090234545;8497.192766687154;8530.445521041112;8537.573121343908;8558.144185581454;39118.41322380167;39118.60881391178;39306.41040384396;39355.606443935765;39447.60552394497;3354.6142193647797;3371.359441706068;3431.4852772084137;3443.724502039831;3655.3785856404475;26760.330991725168;27128.45743085147;27204.1838744838;27416.588751168747;27941.580876286873;3574.7318951078773;3780.489633899416;3950.2297052074855;3989.1024519483176;4039.555648878621;274752.7574172778;276446;276958;277197.99999999796;277952;55083.44916550863;55701;60437.69781151154;60920;61684.38315616787;55850.72074639601;56194;56572.43427565754;56583.43416565864;56733;13795.724085518234;13876.167429954236;13924.51264205748;13930.721385572231;13932.58202253934;10288.074073333286;10295.588176473007;10316.43259620713;10358.482075896174;10377.481125943672;20035;20693.793062069486;20849.478763030744;20877.68683469749;20883.060262288232;8031.196880311922;8220.58897055145;8247.670093196324;8255.215754503313;8280.296174825087;886.8714036464677;947.0766003146877;987.9456629885425;1025.646152077532;1029.8043371759343;28275.293117671812;28345.43309133847;28440.8577957113;28534.571981420297;28901.132966011053;993.304686719285;1040.9843852342221;1042.5777560088177;1060.0883240413239;1158.4960542164185;14720.705585888436;14735.410583576751;14830.81353491718;14844.891830820034;14913.403463861325;324950;327740;327977;328352;329746;51287.74356128195;52171.47828521666;52480.73759631254;52619;52625.210621840706;1278.2011242973142;1286.6976260578756;1288.1884412819863;1289.548657969703;1429.5854202281223;27579.31051723723;27759.861200693867;27953;28287.302761834355;28329.433411331247;45996.08007839891;46394;46420;46495;46496.767516163556;260496;261215;262062;292701;293947;32501.18747031343;42403.15193696047;42670.78664606657;42810.571894280656;43206.35190472208;45629.54370456386;45989;46103.308450373945;46363.76818115888;46524.30213546732;33116.503252451716;33289.667103328655;33685.663143368256;33948.83025584856;34229.828850855585;38423.615763842005;40143.3978490317;42027.36958945679;42900.14199716051;43506.56493435025;36267.09332266715;36271.818640906626;36569.171541423355;38340;38968;29265.561016584343;32272.83863580761;33414.33171336608;33426.832865836484;35082.82458587691;23483.69657036705;23698.170564030177;25295.241142765746;25754.09860654868;25763.227103186935 19:12:52 INFO - PROCESS | 9107 | |2;jquery.html;324.8099861580975;325.6635766571475;328.32365327425504;336.2518396567636;351.5833737021628;16705.916470417662;16874.578135546617;17101.82898171018;17799.73300400495;17943.730844037334;15832.76250856238;16104.919475402607;16336.264868080934;16956.745648815246;16972.321107155698;4875.561199492045;5090.745462726867;5104.872378190538;5124.231365295198;5126.897462050757;4895.902081958358;4985.725785081819;5076.416212135597;5080.542751152396;5083.745812709368;4991.351124353829;5074.28959945606;5080.441151473335;5197;5210.062188806013;5133.640645154841;5165.328507294065;5170.663906846062;5413.296271484682;5993.670348130851;5313.6014798889855;5314.840554783363;5318.601104917108;5325.467453254682;5345.599080069011;14389.640258993504;19270.518237044187;19732.21071157152;20154;20191.89904050485;1927.296536764085;2054.6301665700166;2057.9794202057938;2081.253321809442;2278.384836094262;9547.809043819085;11128.777424451546;11626.476808543552;12778.552750653775;13229.338533073307;1776.111944027986;1828.7896891857474;1854.5827188882529;1873.4566975577065;1929.411529483521;54984;56956.71521642407;57019.71490142564;57073.71463142699;58056.12915806224;9812.950935245279;10124.190064794799;10258.17934565233;10279.794404112026;10282.383057016603;13303.071054697015;13359.866401336056;13424.798628020588;13470.730585388237;13483.865161348458;7039.049728286718;7044.22513523512;7088.2202957675645;7148.213696493382;7250.347468727734;6566.474682025427;6597.439217666456;6607;6618.7352505899225;6650.135482387259;4517.2772356423475;4532.1842068427995;4548.95451045492;4562.133194692998;4606.239970404846;1796.963132306398;1841.8710690251821;1855.396995976313;1889.6882014467733;1891.754071970635;779.4894344204555;799.8760192170223;908.7773495493647;980.764616492051;1048.8688913885765;15426.382944682311;15814.9209253953;16089.712822974134;16748.078855663054;17074.914625426794;882.8455020371409;907.5054095517959;922.294444749767;962.6630679262203;963.2486660404895;9326.813463730687;9360.344775865624;9533.809323813484;9825.950870245746;9896.109350158376;529690;546633;547185;557660;562276;66851.66574167195;71747.64126179335;72190;72779.63610182022;73616.63191684007;1129.9943500282445;1137.965861024154;1150.206357613261;1167.2937872587133;1167.3987896233446;13962.58112256634;14559.92720036393;14566.271686415424;15008.549743507712;15031.173285469404;29701.851490742407;30311.848440757654;30421.087367379016;30460.238494037825;30833.383332332778;35714.46428303525;35796.821015894755;35979.46030809592;35980.10049748777;36000;6837.863242735018;6996.965015174892;7102.680379383043;7221.169565500035;7277.636118194175;10194.388336699822;10411.375317480975;10447.791044178923;10740.570377184826;11045.83431248548;8580.785480363042;9454.101860323259;9517.571709272961;9556.139947404767;9579.473128977974;8939.955300223457;9097.727068187965;9469.431834089977;9622.085901839315;9822;2930.9448598504946;2942.23501889506;6230.470410015199;9201.055662188035;9506;7240.275972402717;7381.557106573623;7442.292982166686;7493.850122997618;7500.512466689648;7455.943063344003;8946.194842464209;9729.464879431416;9921.603135874484;10015.649452269136 19:12:52 INFO - PROCESS | 9107 | |3;mootools.html;1476.9409223631053;1497.4833682379576;1660.7176779947408;1776.9822301776978;1798.901060441676;7705.768826935187;7829.060512738472;7914.683412663501;8029.397795165364;8042.7185048523315;8055.1944805519415;8096.190380961901;8148.7147949821765;8154.592270386472;8176.632051557679;2341.8009469195094;2377.7503362146986;2380.500094980048;2383.92848214553;2391.4619210677547;2392.6530653055383;2421.9343488864843;2446.131623273739;2450.620153876152;2454.5949918263555;2302.2747834432184;2367.75138610446;2371.703537057868;2372.3594629450126;2377.049180327874;2334.323046316566;2341.473168537074;2371.893264803088;2374.2283757778705;2376.4771750214927;2383.332666853284;2386.2364043506086;2390.151496218852;2392.306231192952;2395.9161429350065;7633.122190948056;7719.189485104095;7729.188435214278;7735.535867847891;7741.264579864904;4724.244120940633;4847.079054979543;4866.58634016109;4868.683535570177;4880.267959806058;2948.395578906319;2958.778091643135;3055.6333240011118;3059.174023013796;3062.8667393064707;964.710586823957;965.75856035991;1911.8470522358177;1924.1052910396734;1937.680282753344;10788.190885683605;10851.51168197433;10857.728556786065;10874.401907895142;10933.289336193202;4293.892652683708;4340.934885976713;4361.890952726208;4366.847160349373;4408.647308215335;8749.1250874912;8773.254273386707;8827.337949653802;8833.69082082124;8834.602442890086;4781;4796;4805.6155507559315;4821.686590371614;4853.150698627726;4454.844080457233;4456.509783923766;4485.237509623306;4490.079533695584;4497.550244975541;3414.6585341466152;3494.842732077012;3508.7017603503477;3522.119470132467;3523.2601153757996;1063.3779239145033;1070.9089727373105;1087.342157994418;1093.3549205968516;1097.1277834121893;1013.8428543575758;1047.85330053791;1113.6881673131536;1125.5104029747085;1234.1237721218035;6770.898436523456;6848.246692863781;6850.965745171342;6857.142857142857;6971.58170509771;618.2858798088215;635.2440595691113;639.7536948274948;643.9484841212692;724.3734169942961;4739.881502962385;4878.707277563358;4884.560389564886;4888;4962.751862406865;8626;8723.563821809012;8742.562871856382;9340.252779777602;9770;8601.268892144113;8613.267872230805;8614.741557753277;8661.913380866237;8686.435381700168;7279.563226206338;7354.271746139653;7470.626468676544;7489.363404110712;7538.811529711801;6967.825804354931;7003.964980175067;7008.929910700827;7070.36366726997;7072.045273888165;8322.6670933162;8777.692780752643;8781.736547903318;8825.293976481995;8948.821023579621;8728.301735861243;9035.322350823846;9035.909640903506;9056.818863622822;9068.591913363782;6750.797476075725;7029.718811247493;7036.331548502884;7065.046218760402;7091.716331346688;7389.667464963982;7489.625518724151;7499.962500187682;7504.962475187589;7525.3227209551405;6326.114343991753;7103.786886393416;7245.529040612343;7274.6598850638275;7355.411567074728;6522.086907832812;6715.328467153246;6803.557768745016;6950.164590813759;7182.030425892438;7207.819804504929;7233.891491627524;7254.927450725425;7276.417886569167;7285.380742636935;6132.233470816148;6296.433321001132;6303.054541818764;6303.149074874833;6311.495080393649;6386.457151142019;6407.231132264158;6422.42198202164;6430.3891130342545;6431.614103153825 19:12:52 INFO - PROCESS | 9107 | |4;prototype.html;339.83857667607884;343.80403170192983;349.48974497234036;350.26968770114325;351.9155402703351;6281.780137695176;6291.087792270118;6300.21247344082;6301.086342480337;6498.122753428286;6301.590396624216;6307.3692630736905;6308.936910630892;6319.5576309658345;6348.6825658717;4757.429108506984;4764.071006153801;4765.499622539618;4766.2374020156785;4768.998510312838;4764.380630518028;4774.092922344744;4774.9761251193695;4775.355327030841;4779.426468823729;4626.884327891796;4702.576768090871;4733.242681171013;4744.928826067595;4745.335653008581;4727.881802954937;4732.100900828831;4735.337052812609;4736.621070314367;4737.8341758038305;4054.776987265699;4067.9796601016806;4071.97964010181;4074.7962601870086;4087.4277601135864;6003.969980150115;6008.579399442041;6015.578909476339;6017.2779266488305;6028.668423236721;5373.247745315659;5451.700156491392;5462.6995515246645;5511.338639363262;5513.574027427959;6658.13444252249;6680.565763225375;6684.097646817715;6687.063811066406;6699.598024118569;4474.910501789978;4487.39420178275;4495.752733599651;4497.100579884003;4509.503954564995;6812.965935170292;6941.757038503679;7014.088168538108;7018.75434359795;7029.648517574152;4629.930551041737;4659.207934651117;4672.719636821802;4676.836310729176;4677.859664210079;4719.457262414798;4723.716577005391;4730.053989202173;4731.432228132578;4734.881627959259;5495.2856128703015;5500.22996780451;5500.477454641803;5512.972435137799;5521.944780552223;6455.580387274906;6680.23177334603;6697.3637504437;6725.66371681414;6727.899081513781;1639.245946864432;1662.1772222749817;1683.8063622683303;1685.890417122883;1686.814450410454;1074.167520171873;1084.5499117865998;1093.6554985179644;1096.1231015187818;1097.3306283167262;6179.783707570214;6214.502839772807;6273.96863015682;6274.403931626488;6278.497720182374;6766.69549870257;6786.898196527056;6804.76183333581;6824.112865327475;6841.828954276083;6178.783742568989;6308.211473565804;6355.3644635536075;6360.618362898241;6374.745010199633;3696.907577310535;3715.64701353371;3735.290294843971;3737.0657335666083;3743.232637309345;7110.288971102848;7146.142462904485;7147.6068816214565;7156.642167891585;7157.463190260752;6906.827329316707;7014.22843487216;7036.366726994595;7041.4718896082995;7047.119110111236;7284.453665975073;7347.302006309499;7355.374793142536;7378.815529611696;7402.592857392895;6983.266756990442;6985.650717464208;7002.509824312453;7006.509544331848;7020.192677841909;6814.011968264673;6900.930990690029;6902.24075351721;6919.965400173169;6959.512834101564;7189.245129261352;7190.532615379983;7203.8919416207755;7207.13514378278;7213.350798428167;4574.290984897346;4577.267637178169;4588.564086411786;4590.334401511695;4598.402207712976;6891.896621550581;6984.650767461708;7024.051753013277;7036.612986285803;7042.119735033121;6825.1127353443735;6832;6856.588604683735;6897.62063086515;6924.238333783381;6774.661266936732;6801.319868013159;6802.115724955724;6842.55523390978;6865.27914568983;6538.640374779433;6647.60114393138;6669.366410191024;6701.597904125768;6714.429273511806;6786.8642627148165;6837.35045170708;6839.418649414656;6841.21326047491;6853.246142924374;6668.266490686117;6668.76659316941;6674.299198584079;6678.933210668026;6681.665916704243 19:12:52 INFO - PROCESS | 9107 | |5;yui.html;826.6941231744255;831.9542425166617;835.456952980563;838.1702114906244;866.2463656618743;12747.61757147286;12772.936135319334;12798.360081995887;12836.422360993754;12853.935730321347;12804.23174609524;14632.926835365808;14947.476838310662;14951;14958.252087395642;789.7235967411389;791.6516732637621;799.0291795468505;801.3428988229654;808.9110197878258;805.3034125481446;807.0638059850575;809.1665584448028;811.5414790643267;816.1634324817051;829.3862541719145;830.4519017448486;833.4166083741375;834.4242472693852;839.9412041157121;826.2604968553142;827.2430725885807;827.759949614614;829.274384913201;830.4726498673325;609.5580703989616;613.702354358136;613.7943788830747;615.8460384903774;616.1558664629441;13944.930275348659;14073.718525629532;14077.71844563103;14110.223937683424;14138.363773630108;12462.376881155906;12505.124641275115;12809.61571152867;12942.094053416266;12957.157784743962;10538.156947444262;10583.259171857973;10611.204159688054;10794.946025269903;10846;3524.8061356625376;3572.7499075064757;3582.3730847101915;3647.1976165243605;3696.667299943018;49012.75493622545;50085.49914500881;50240.24639630409;50540.49459505431;50692;9743.415395076318;9900.405975641484;9970.501474926225;10020.148287395506;10095.343802652951;17314.30742770275;17334;17359.21883515245;17460.126993650265;17517.912410437868;7215.891761623579;7425.814354641069;7654.502457340255;7689.115751688516;7918.326942209861;4105.137921036556;4191.559886211965;4227.7463352198965;4292.420523229386;4318.071614602813;3066.3560652262827;3094.4275309067893;3115.1900505868184;3116.5169398743233;3119.750419966397;585.2070444547662;586.8767558812611;590.4420322795004;598.7215944585702;608.8234412020464;574.3222996863741;601.9548533859978;602.1028667285713;622.8069298517474;693.0352450801932;8648.481091134552;8742.169493898069;8773.122687731176;8794.648214071365;8834.469931804113;529.8013245033112;619.5198720991177;653.2161406312445;657.5462930577886;668.2115104177118;3832.9425058624142;3844.3464611016193;3877.9224415512094;3986.063275130342;4052.3111071117983;51864.74067629638;52983.470165298626;53253;53308.46691533035;53336;48625.51374486281;49092.50907490951;49217.75391123093;49495.50504494909;49904;42235.577644223165;42582.78708606499;42739.14521709549;44252.557474424844;44635.77682111569;7635.389168866366;7807.063152421746;7857.960710196412;7882.566458844819;7956.761297161094;32409.51385729263;32873.34253314872;33026.83486582552;33078.50382244316;33441.163970900925;39507;42609.36085958651;43379.78310108429;44623;44641;9533.523323833919;9558.139767420966;9576.664816731382;9582.01853492473;9712.82229791912;10825.296355736851;10878.184136189659;10969.725756856142;11008.009279164913;11129.888701112885;9642.951785241028;9823;9839.901600983898;9983.60065597368;10272.845907311546;10217.897821021694;10326.690199294033;10357.274990750575;10484.475776211006;10506.632267870587;10008.749781255236;10058.295919285873;10123.24075694311;10145.695629130843;10477.161827053666;8279.710210142615;8302.83394332122;8354.832903342021;8385;8460.450070745383;7840.725574604861;8555.230029297392;8610.913890861262;8668.219860212612;8675.956620217112 19:12:52 INFO - PROCESS | 9107 | __end_tp_report 19:12:52 INFO - PROCESS | 9107 | __start_cc_report 19:12:52 INFO - PROCESS | 9107 | _x_x_mozilla_cycle_collect,317 19:12:52 INFO - PROCESS | 9107 | __end_cc_report 19:12:52 INFO - PROCESS | 9107 | __startTimestamp1453345972663__endTimestamp 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | ------- Summary: start ------- 19:12:52 INFO - PROCESS | 9107 | Number of tests: 6 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#0] dojo.html Cycles:165 Average:5288.89 Median:5462.15 stddev:580.82 (10.6%) stddev-sans-first:557.44 19:12:52 INFO - PROCESS | 9107 | Values: 3133.2 3170.2 3204.5 3205.8 3214.1 5076.5 5220.5 5224.3 5231.1 5303.0 5230.7 5300.3 5336.5 5342.1 5357.2 4492.5 4742.3 4992.3 5006.8 5015.4 4811.7 4919.1 4923.7 4952.9 4985.3 4737.8 4809.4 4880.4 4891.0 4936.9 4805.2 4865.8 4872.6 4899.9 4901.9 4671.2 4745.7 4874.1 4875.2 4891.4 5151.3 5154.3 5201.1 5208.2 5208.7 5644.2 5647.5 5655.9 5664.4 5707.9 5537.8 5609.9 5690.5 5714.3 5799.1 5287.6 5292.9 5309.7 5318.0 5354.4 5709.6 5749.0 5758.9 5763.0 5789.0 5577.4 5622.9 5627.7 5649.8 5715.3 5727.7 5755.2 5762.6 5764.4 5776.1 5658.5 5712.4 5712.9 5725.0 5725.4 5482.4 5640.0 5648.2 5675.4 5728.9 4419.0 4430.9 4436.9 4464.5 4493.1 3916.3 3932.9 3966.0 3974.6 4016.9 5285.6 5289.3 5329.5 5339.4 5427.1 5659.7 5741.4 5752.0 5764.6 5765.5 5273.5 5287.9 5298.9 5366.0 5404.6 4838.9 4858.7 4900.5 4904.7 4933.7 5984.4 5997.1 6012.0 6014.8 6017.1 5677.5 5781.5 5801.3 5801.4 5802.7 5772.1 5814.9 5856.8 5862.9 5896.0 5664.2 5669.6 5682.1 5683.1 5686.6 5635.5 5674.9 5720.5 5730.8 5745.0 5421.3 5441.9 5458.5 5463.6 5503.3 5478.1 5496.9 5511.8 5517.8 5536.3 5414.8 5423.5 5436.8 5462.2 5483.7 5602.9 5616.7 5616.9 5622.0 5656.1 5456.9 5465.8 5483.9 5485.5 5485.6 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#1] ext.html Cycles:180 Average:46316.36 Median:20174.83 stddev:76845.23 (380.9%) stddev-sans-first:76983.83 19:12:52 INFO - PROCESS | 9107 | Values: 508.4 541.5 552.2 560.7 577.3 28184.3 35999.3 36329.6 36412.3 36497.5 38997.4 39328.0 39364.8 39395.4 39567.4 8390.5 8501.1 8516.1 8520.3 8527.3 8307.2 8361.8 8408.7 8414.8 8428.0 8301.2 8472.6 8480.3 8484.3 8485.5 8332.1 8367.9 8418.4 8622.4 8626.0 8398.5 8497.2 8530.4 8537.6 8558.1 39118.4 39118.6 39306.4 39355.6 39447.6 3354.6 3371.4 3431.5 3443.7 3655.4 26760.3 27128.5 27204.2 27416.6 27941.6 3574.7 3780.5 3950.2 3989.1 4039.6 274752.8 276446.0 276958.0 277198.0 277952.0 55083.4 55701.0 60437.7 60920.0 61684.4 55850.7 56194.0 56572.4 56583.4 56733.0 13795.7 13876.2 13924.5 13930.7 13932.6 10288.1 10295.6 10316.4 10358.5 10377.5 20035.0 20693.8 20849.5 20877.7 20883.1 8031.2 8220.6 8247.7 8255.2 8280.3 886.9 947.1 987.9 1025.6 1029.8 28275.3 28345.4 28440.9 28534.6 28901.1 993.3 1041.0 1042.6 1060.1 1158.5 14720.7 14735.4 14830.8 14844.9 14913.4 324950.0 327740.0 327977.0 328352.0 329746.0 51287.7 52171.5 52480.7 52619.0 52625.2 1278.2 1286.7 1288.2 1289.5 1429.6 27579.3 27759.9 27953.0 28287.3 28329.4 45996.1 46394.0 46420.0 46495.0 46496.8 260496.0 261215.0 262062.0 292701.0 293947.0 32501.2 42403.2 42670.8 42810.6 43206.4 45629.5 45989.0 46103.3 46363.8 46524.3 33116.5 33289.7 33685.7 33948.8 34229.8 38423.6 40143.4 42027.4 42900.1 43506.6 36267.1 36271.8 36569.2 38340.0 38968.0 29265.6 32272.8 33414.3 33426.8 35082.8 23483.7 23698.2 25295.2 25754.1 25763.2 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#2] jquery.html Cycles:180 Average:27326.99 Median:5032.82 stddev:89622.83 (1780.8%) stddev-sans-first:89851.31 19:12:52 INFO - PROCESS | 9107 | Values: 324.8 325.7 328.3 336.3 351.6 16705.9 16874.6 17101.8 17799.7 17943.7 15832.8 16104.9 16336.3 16956.7 16972.3 4875.6 5090.7 5104.9 5124.2 5126.9 4895.9 4985.7 5076.4 5080.5 5083.7 4991.4 5074.3 5080.4 5197.0 5210.1 5133.6 5165.3 5170.7 5413.3 5993.7 5313.6 5314.8 5318.6 5325.5 5345.6 14389.6 19270.5 19732.2 20154.0 20191.9 1927.3 2054.6 2058.0 2081.3 2278.4 9547.8 11128.8 11626.5 12778.6 13229.3 1776.1 1828.8 1854.6 1873.5 1929.4 54984.0 56956.7 57019.7 57073.7 58056.1 9813.0 10124.2 10258.2 10279.8 10282.4 13303.1 13359.9 13424.8 13470.7 13483.9 7039.0 7044.2 7088.2 7148.2 7250.3 6566.5 6597.4 6607.0 6618.7 6650.1 4517.3 4532.2 4549.0 4562.1 4606.2 1797.0 1841.9 1855.4 1889.7 1891.8 779.5 799.9 908.8 980.8 1048.9 15426.4 15814.9 16089.7 16748.1 17074.9 882.8 907.5 922.3 962.7 963.2 9326.8 9360.3 9533.8 9826.0 9896.1 529690.0 546633.0 547185.0 557660.0 562276.0 66851.7 71747.6 72190.0 72779.6 73616.6 1130.0 1138.0 1150.2 1167.3 1167.4 13962.6 14559.9 14566.3 15008.5 15031.2 29701.9 30311.8 30421.1 30460.2 30833.4 35714.5 35796.8 35979.5 35980.1 36000.0 6837.9 6997.0 7102.7 7221.2 7277.6 10194.4 10411.4 10447.8 10740.6 11045.8 8580.8 9454.1 9517.6 9556.1 9579.5 8940.0 9097.7 9469.4 9622.1 9822.0 2930.9 2942.2 6230.5 9201.1 9506.0 7240.3 7381.6 7442.3 7493.9 7500.5 7455.9 8946.2 9729.5 9921.6 10015.6 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#3] mootools.html Cycles:180 Average:5450.56 Median:3510.85 stddev:2801.33 (79.8%) stddev-sans-first:2793.27 19:12:52 INFO - PROCESS | 9107 | Values: 1476.9 1497.5 1660.7 1777.0 1798.9 7705.8 7829.1 7914.7 8029.4 8042.7 8055.2 8096.2 8148.7 8154.6 8176.6 2341.8 2377.8 2380.5 2383.9 2391.5 2392.7 2421.9 2446.1 2450.6 2454.6 2302.3 2367.8 2371.7 2372.4 2377.0 2334.3 2341.5 2371.9 2374.2 2376.5 2383.3 2386.2 2390.2 2392.3 2395.9 7633.1 7719.2 7729.2 7735.5 7741.3 4724.2 4847.1 4866.6 4868.7 4880.3 2948.4 2958.8 3055.6 3059.2 3062.9 964.7 965.8 1911.8 1924.1 1937.7 10788.2 10851.5 10857.7 10874.4 10933.3 4293.9 4340.9 4361.9 4366.8 4408.6 8749.1 8773.3 8827.3 8833.7 8834.6 4781.0 4796.0 4805.6 4821.7 4853.2 4454.8 4456.5 4485.2 4490.1 4497.6 3414.7 3494.8 3508.7 3522.1 3523.3 1063.4 1070.9 1087.3 1093.4 1097.1 1013.8 1047.9 1113.7 1125.5 1234.1 6770.9 6848.2 6851.0 6857.1 6971.6 618.3 635.2 639.8 643.9 724.4 4739.9 4878.7 4884.6 4888.0 4962.8 8626.0 8723.6 8742.6 9340.3 9770.0 8601.3 8613.3 8614.7 8661.9 8686.4 7279.6 7354.3 7470.6 7489.4 7538.8 6967.8 7004.0 7008.9 7070.4 7072.0 8322.7 8777.7 8781.7 8825.3 8948.8 8728.3 9035.3 9035.9 9056.8 9068.6 6750.8 7029.7 7036.3 7065.0 7091.7 7389.7 7489.6 7500.0 7505.0 7525.3 6326.1 7103.8 7245.5 7274.7 7355.4 6522.1 6715.3 6803.6 6950.2 7182.0 7207.8 7233.9 7254.9 7276.4 7285.4 6132.2 6296.4 6303.1 6303.1 6311.5 6386.5 6407.2 6422.4 6430.4 6431.6 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#4] prototype.html Cycles:180 Average:5586.30 Median:6304.48 stddev:1723.47 (27.3%) stddev-sans-first:1682.71 19:12:52 INFO - PROCESS | 9107 | Values: 339.8 343.8 349.5 350.3 351.9 6281.8 6291.1 6300.2 6301.1 6498.1 6301.6 6307.4 6308.9 6319.6 6348.7 4757.4 4764.1 4765.5 4766.2 4769.0 4764.4 4774.1 4775.0 4775.4 4779.4 4626.9 4702.6 4733.2 4744.9 4745.3 4727.9 4732.1 4735.3 4736.6 4737.8 4054.8 4068.0 4072.0 4074.8 4087.4 6004.0 6008.6 6015.6 6017.3 6028.7 5373.2 5451.7 5462.7 5511.3 5513.6 6658.1 6680.6 6684.1 6687.1 6699.6 4474.9 4487.4 4495.8 4497.1 4509.5 6813.0 6941.8 7014.1 7018.8 7029.6 4629.9 4659.2 4672.7 4676.8 4677.9 4719.5 4723.7 4730.1 4731.4 4734.9 5495.3 5500.2 5500.5 5513.0 5521.9 6455.6 6680.2 6697.4 6725.7 6727.9 1639.2 1662.2 1683.8 1685.9 1686.8 1074.2 1084.5 1093.7 1096.1 1097.3 6179.8 6214.5 6274.0 6274.4 6278.5 6766.7 6786.9 6804.8 6824.1 6841.8 6178.8 6308.2 6355.4 6360.6 6374.7 3696.9 3715.6 3735.3 3737.1 3743.2 7110.3 7146.1 7147.6 7156.6 7157.5 6906.8 7014.2 7036.4 7041.5 7047.1 7284.5 7347.3 7355.4 7378.8 7402.6 6983.3 6985.7 7002.5 7006.5 7020.2 6814.0 6900.9 6902.2 6920.0 6959.5 7189.2 7190.5 7203.9 7207.1 7213.4 4574.3 4577.3 4588.6 4590.3 4598.4 6891.9 6984.7 7024.1 7036.6 7042.1 6825.1 6832.0 6856.6 6897.6 6924.2 6774.7 6801.3 6802.1 6842.6 6865.3 6538.6 6647.6 6669.4 6701.6 6714.4 6786.9 6837.4 6839.4 6841.2 6853.2 6668.3 6668.8 6674.3 6678.9 6681.7 19:12:52 INFO - PROCESS | 9107 | 19:12:52 INFO - PROCESS | 9107 | [#5] yui.html Cycles:180 Average:13251.04 Median:50390.37 stddev:15318.73 (30.4%) stddev-sans-first:15333.29 19:12:52 INFO - PROCESS | 9107 | Values: 826.7 832.0 835.5 838.2 866.2 12747.6 12772.9 12798.4 12836.4 12853.9 12804.2 14632.9 14947.5 14951.0 14958.3 789.7 791.7 799.0 801.3 808.9 805.3 807.1 809.2 811.5 816.2 829.4 830.5 833.4 834.4 839.9 826.3 827.2 827.8 829.3 830.5 609.6 613.7 613.8 615.8 616.2 13944.9 14073.7 14077.7 14110.2 14138.4 12462.4 12505.1 12809.6 12942.1 12957.2 10538.2 10583.3 10611.2 10794.9 10846.0 3524.8 3572.7 3582.4 3647.2 3696.7 49012.8 50085.5 50240.2 50540.5 50692.0 9743.4 9900.4 9970.5 10020.1 10095.3 17314.3 17334.0 17359.2 17460.1 17517.9 7215.9 7425.8 7654.5 7689.1 7918.3 4105.1 4191.6 4227.7 4292.4 4318.1 3066.4 3094.4 3115.2 3116.5 3119.8 585.2 586.9 590.4 598.7 608.8 574.3 602.0 602.1 622.8 693.0 8648.5 8742.2 8773.1 8794.6 8834.5 529.8 619.5 653.2 657.5 668.2 3832.9 3844.3 3877.9 3986.1 4052.3 51864.7 52983.5 53253.0 53308.5 53336.0 48625.5 49092.5 49217.8 49495.5 49904.0 42235.6 42582.8 42739.1 44252.6 44635.8 7635.4 7807.1 7858.0 7882.6 7956.8 32409.5 32873.3 33026.8 33078.5 33441.2 39507.0 42609.4 43379.8 44623.0 44641.0 9533.5 9558.1 9576.7 9582.0 9712.8 10825.3 10878.2 10969.7 11008.0 11129.9 9643.0 9823.0 9839.9 9983.6 10272.8 10217.9 10326.7 10357.3 10484.5 10506.6 10008.7 10058.3 10123.2 10145.7 10477.2 8279.7 8302.8 8354.8 8385.0 8460.5 7840.7 8555.2 8610.9 8668.2 8676.0 19:12:52 INFO - PROCESS | 9107 | -------- Summary: end -------- 19:12:52 INFO - PROCESS | 9107 | 19:12:53 INFO - TEST-INFO | 9107: exit 0 19:12:53 INFO - TEST-OK | dromaeo_css | took 1110927ms 19:12:53 INFO - TEST-START | kraken 19:12:53 INFO - operating with platform_type : linux_ 19:12:53 INFO - Initialising browser for kraken test... 19:12:53 INFO - TEST-INFO | started process 9349 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKtVl8A/profile http://localhost:39774/getInfo.html) 19:12:56 INFO - PROCESS | 9349 | 19:12:56 INFO - PROCESS | 9349 | (process:9418): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:12:57 INFO - PROCESS | 9349 | __metrics Screen width/height:1600/1200 19:12:57 INFO - PROCESS | 9349 | colorDepth:24 19:12:57 INFO - PROCESS | 9349 | Browser inner width/height: 1024/697 19:12:57 INFO - PROCESS | 9349 | __metrics 19:12:57 INFO - PROCESS | 9349 | 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:12:58 INFO - TEST-INFO | 9349: exit 0 19:12:58 INFO - Browser initialized. 19:12:58 INFO - Running cycle 1/1 for kraken test... 19:12:58 INFO - TEST-INFO | started process 9467 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKtVl8A/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:59 INFO - PROCESS | 9467 | -- checkerboarding starts below -- 19:12:59 INFO - PROCESS | 9467 | RENDERTRACE 0.052504 rect red 0 0 10 10 // viewport 19:12:59 INFO - PROCESS | 9467 | RENDERTRACE 39.4659 rect brown 0 0 10 10 // page 19:12:59 INFO - PROCESS | 9467 | RENDERTRACE 39.4877 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 19:12:59 INFO - PROCESS | 9467 | Checkerboarded for 1 frames (41.4527 ms), 100 peak, 1 severity. 19:12:59 INFO - PROCESS | 9467 | 19:12:59 INFO - PROCESS | 9467 | (process:9525): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:13:10 INFO - PROCESS | 9467 | RSS: Main: 149684224 19:13:10 INFO - PROCESS | 9467 | 19:13:12 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:13 INFO - PROCESS | 9467 | RSS: Main: 151126016 19:13:13 INFO - PROCESS | 9467 | 19:13:16 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-dft) 19:13:16 INFO - PROCESS | 9467 | RSS: Main: 153268224 19:13:16 INFO - PROCESS | 9467 | 19:13:19 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-fft) 19:13:20 INFO - PROCESS | 9467 | RSS: Main: 148701184 19:13:20 INFO - PROCESS | 9467 | 19:13:22 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-oscillator) 19:13:23 INFO - PROCESS | 9467 | RSS: Main: 148606976 19:13:23 INFO - PROCESS | 9467 | 19:13:25 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:25 INFO - PROCESS | 9467 | RSS: Main: 149635072 19:13:25 INFO - PROCESS | 9467 | 19:13:28 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:29 INFO - PROCESS | 9467 | RSS: Main: 147779584 19:13:29 INFO - PROCESS | 9467 | 19:13:32 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:33 INFO - PROCESS | 9467 | RSS: Main: 148078592 19:13:33 INFO - PROCESS | 9467 | 19:13:36 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39774/tests/kraken/driver.html?testName=json-parse-financial) 19:13:36 INFO - PROCESS | 9467 | RSS: Main: 148553728 19:13:36 INFO - PROCESS | 9467 | 19:13:38 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:39 INFO - PROCESS | 9467 | RSS: Main: 149467136 19:13:39 INFO - PROCESS | 9467 | 19:13:40 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:41 INFO - PROCESS | 9467 | RSS: Main: 149176320 19:13:41 INFO - PROCESS | 9467 | 19:13:43 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:44 INFO - PROCESS | 9467 | RSS: Main: 149901312 19:13:44 INFO - PROCESS | 9467 | 19:13:46 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:47 INFO - PROCESS | 9467 | RSS: Main: 149352448 19:13:47 INFO - PROCESS | 9467 | 19:13:49 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:50 INFO - PROCESS | 9467 | RSS: Main: 150532096 19:13:50 INFO - PROCESS | 9467 | 19:13:51 INFO - PROCESS | 9467 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39774/tests/kraken/driver.html?testName=ai-astar) 19:13:52 INFO - PROCESS | 9467 | RSS: Main: 149868544 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | __start_tp_report 19:13:52 INFO - PROCESS | 9467 | _x_x_mozilla_page_load 19:13:52 INFO - PROCESS | 9467 | _x_x_mozilla_page_load_details 19:13:52 INFO - PROCESS | 9467 | |i|pagename|runs| 19:13:52 INFO - PROCESS | 9467 | |0;ai-astar;111;106;112;110;111;122;111;110;111;112 19:13:52 INFO - PROCESS | 9467 | |1;audio-beat-detection;150;128;165;161;129;158;163;127;163;130 19:13:52 INFO - PROCESS | 9467 | |2;audio-dft;164;162;164;164;161;162;162;165;169;162 19:13:52 INFO - PROCESS | 9467 | |3;audio-fft;73;76;74;75;74;77;133;73;74;73 19:13:52 INFO - PROCESS | 9467 | |4;audio-oscillator;97;96;141;96;96;96;135;95;97;152 19:13:52 INFO - PROCESS | 9467 | |5;imaging-gaussian-blur;109;109;109;112;109;110;109;110;109;110 19:13:52 INFO - PROCESS | 9467 | |6;imaging-darkroom;147;146;146;146;147;147;146;147;147;146 19:13:52 INFO - PROCESS | 9467 | |7;imaging-desaturate;96;96;97;96;97;97;96;97;96;97 19:13:52 INFO - PROCESS | 9467 | |8;json-parse-financial;62;61;68;61;63;60;61;65;68;59 19:13:52 INFO - PROCESS | 9467 | |9;json-stringify-tinderbox;69;69;69;70;69;70;72;70;70;70 19:13:52 INFO - PROCESS | 9467 | |10;stanford-crypto-aes;85;84;93;85;86;86;84;84;87;86 19:13:52 INFO - PROCESS | 9467 | |11;stanford-crypto-ccm;125;119;116;120;120;127;117;124;121;125 19:13:52 INFO - PROCESS | 9467 | |12;stanford-crypto-pbkdf2;135;145;146;144;146;136;141;138;143;132 19:13:52 INFO - PROCESS | 9467 | |13;stanford-crypto-sha256-iterative;66;69;67;67;66;69;66;67;66;68 19:13:52 INFO - PROCESS | 9467 | __end_tp_report 19:13:52 INFO - PROCESS | 9467 | __start_cc_report 19:13:52 INFO - PROCESS | 9467 | _x_x_mozilla_cycle_collect,740 19:13:52 INFO - PROCESS | 9467 | __end_cc_report 19:13:52 INFO - PROCESS | 9467 | __startTimestamp1453346032152__endTimestamp 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | ------- Summary: start ------- 19:13:52 INFO - PROCESS | 9467 | Number of tests: 14 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 19:13:52 INFO - PROCESS | 9467 | Values: 111.0 106.0 112.0 110.0 111.0 122.0 111.0 110.0 111.0 112.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:159.50 stddev:16.78 (10.5%) stddev-sans-first:17.77 19:13:52 INFO - PROCESS | 9467 | Values: 150.0 128.0 165.0 161.0 129.0 158.0 163.0 127.0 163.0 130.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 19:13:52 INFO - PROCESS | 9467 | Values: 164.0 162.0 164.0 164.0 161.0 162.0 162.0 165.0 169.0 162.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:18.60 (25.1%) stddev-sans-first:19.54 19:13:52 INFO - PROCESS | 9467 | Values: 73.0 76.0 74.0 75.0 74.0 77.0 133.0 73.0 74.0 73.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.84 (23.8%) stddev-sans-first:23.73 19:13:52 INFO - PROCESS | 9467 | Values: 97.0 96.0 141.0 96.0 96.0 96.0 135.0 95.0 97.0 152.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 19:13:52 INFO - PROCESS | 9467 | Values: 109.0 109.0 109.0 112.0 109.0 110.0 109.0 110.0 109.0 110.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:13:52 INFO - PROCESS | 9467 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:13:52 INFO - PROCESS | 9467 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:62.50 stddev:3.19 (5.1%) stddev-sans-first:3.37 19:13:52 INFO - PROCESS | 9467 | Values: 62.0 61.0 68.0 61.0 63.0 60.0 61.0 65.0 68.0 59.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 19:13:52 INFO - PROCESS | 9467 | Values: 69.0 69.0 69.0 70.0 69.0 70.0 72.0 70.0 70.0 70.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.67 (3.1%) stddev-sans-first:2.80 19:13:52 INFO - PROCESS | 9467 | Values: 85.0 84.0 93.0 85.0 86.0 86.0 84.0 84.0 87.0 86.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:3.69 (3.0%) stddev-sans-first:3.67 19:13:52 INFO - PROCESS | 9467 | Values: 125.0 119.0 116.0 120.0 120.0 127.0 117.0 124.0 121.0 125.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:143.50 stddev:5.04 (3.5%) stddev-sans-first:4.92 19:13:52 INFO - PROCESS | 9467 | Values: 135.0 145.0 146.0 144.0 146.0 136.0 141.0 138.0 143.0 132.0 19:13:52 INFO - PROCESS | 9467 | 19:13:52 INFO - PROCESS | 9467 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 19:13:52 INFO - PROCESS | 9467 | Values: 66.0 69.0 67.0 67.0 66.0 69.0 66.0 67.0 66.0 68.0 19:13:52 INFO - PROCESS | 9467 | -------- Summary: end -------- 19:13:52 INFO - PROCESS | 9467 | 19:13:53 INFO - TEST-INFO | 9467: exit 0 19:13:53 INFO - TEST-OK | kraken | took 60020ms 19:13:53 INFO - TEST-START | v8_7 19:13:53 INFO - operating with platform_type : linux_ 19:13:53 INFO - Initialising browser for v8_7 test... 19:13:53 INFO - TEST-INFO | started process 9753 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_LK1WQ/profile http://localhost:39774/getInfo.html) 19:13:56 INFO - PROCESS | 9753 | 19:13:56 INFO - PROCESS | 9753 | (process:9822): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:13:57 INFO - PROCESS | 9753 | __metrics Screen width/height:1600/1200 19:13:57 INFO - PROCESS | 9753 | colorDepth:24 19:13:57 INFO - PROCESS | 9753 | Browser inner width/height: 1024/697 19:13:57 INFO - PROCESS | 9753 | __metrics 19:13:57 INFO - PROCESS | 9753 | 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:13:58 INFO - TEST-INFO | 9753: exit 0 19:13:58 INFO - Browser initialized. 19:13:58 INFO - Running cycle 1/1 for v8_7 test... 19:13:58 INFO - TEST-INFO | started process 9872 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_LK1WQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:59 INFO - PROCESS | 9872 | -- checkerboarding starts below -- 19:13:59 INFO - PROCESS | 9872 | RENDERTRACE 0.049885 rect red 0 0 10 10 // viewport 19:13:59 INFO - PROCESS | 9872 | RENDERTRACE 60.2829 rect brown 0 0 10 10 // page 19:13:59 INFO - PROCESS | 9872 | RENDERTRACE 60.3237 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 19:13:59 INFO - PROCESS | 9872 | Checkerboarded for 1 frames (66.5904 ms), 100 peak, 1 severity. 19:14:00 INFO - PROCESS | 9872 | 19:14:00 INFO - PROCESS | 9872 | (process:9929): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:14:10 INFO - PROCESS | 9872 | RSS: Main: 150298624 19:14:10 INFO - PROCESS | 9872 | 19:14:32 INFO - PROCESS | 9872 | Cycle 1(1): loaded http://localhost:39774/tests/v8_7/run.html (next: http://localhost:39774/tests/v8_7/run.html) 19:14:33 INFO - PROCESS | 9872 | RSS: Main: 144945152 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | __start_tp_report 19:14:33 INFO - PROCESS | 9872 | _x_x_mozilla_page_load 19:14:33 INFO - PROCESS | 9872 | _x_x_mozilla_page_load_details 19:14:33 INFO - PROCESS | 9872 | |i|pagename|runs| 19:14:33 INFO - PROCESS | 9872 | |0;Richards;170.41581458759373 19:14:33 INFO - PROCESS | 9872 | |1;DeltaBlue;188.14675446848543 19:14:33 INFO - PROCESS | 9872 | |2;Encrypt;279.56388034665923 19:14:33 INFO - PROCESS | 9872 | |3;Decrypt;5208.333333333333 19:14:33 INFO - PROCESS | 9872 | |4;RayTrace;1063.8297872340424 19:14:33 INFO - PROCESS | 9872 | |5;Earley;703.2348804500704 19:14:33 INFO - PROCESS | 9872 | |6;Boyer;12195.121951219513 19:14:33 INFO - PROCESS | 9872 | |7;RegExp;42000 19:14:33 INFO - PROCESS | 9872 | |8;Splay;573.2265446224256 19:14:33 INFO - PROCESS | 9872 | |9;NavierStokes;4826.923076923077 19:14:33 INFO - PROCESS | 9872 | __end_tp_report 19:14:33 INFO - PROCESS | 9872 | __startTimestamp1453346073186__endTimestamp 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | ------- Summary: start ------- 19:14:33 INFO - PROCESS | 9872 | Number of tests: 10 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#0] Richards Cycles:1 Average:170.42 Median:170.42 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 170.4 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 188.1 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 279.6 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 5208.3 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 1063.8 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#5] Earley Cycles:1 Average:703.23 Median:703.23 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 703.2 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 12195.1 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#7] RegExp Cycles:1 Average:42000.00 Median:42000.00 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 42000.0 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#8] Splay Cycles:1 Average:573.23 Median:573.23 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 573.2 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - PROCESS | 9872 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 19:14:33 INFO - PROCESS | 9872 | Values: 4826.9 19:14:33 INFO - PROCESS | 9872 | -------- Summary: end -------- 19:14:33 INFO - PROCESS | 9872 | 19:14:33 INFO - TEST-INFO | 9872: exit 0 19:14:34 INFO - TEST-OK | v8_7 | took 40704ms 19:14:34 INFO - SUITE-END | took 1211s 19:14:34 INFO - Completed test suite (00:20:11) 19:14:34 INFO - Working with test: dromaeo_css 19:14:34 INFO - Generating results file: dromaeo_css 19:14:34 INFO - Working with test: kraken 19:14:34 INFO - Generating results file: kraken 19:14:34 INFO - javascript benchmark 19:14:34 INFO - Working with test: v8_7 19:14:34 INFO - Generating results file: v8_7 19:14:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:14:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 19:14:34 INFO - process_Request line: dromaeo_css 6865.53 graph.html#tests=[[72,64,43]] 19:14:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:14:34 INFO - process_Request line: kraken 1513.10 graph.html#tests=[[232,64,43]] 19:14:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:14:34 INFO - process_Request line: v8_7 20448.96 graph.html#tests=[[230,64,43]] 19:14:34 INFO - RETURN: dromaeo_css: 6865.53 19:14:34 INFO - RETURN: kraken: 1513.10 19:14:34 INFO - RETURN: v8_7: 20448.96 19:14:34 INFO - javascript benchmark 19:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3133.1697100268434, 3170.207448137964, 3204.4712622417296, 3205.7755957083014, 3214.1321843102364, 5076.492350764931, 5220.504052115043, 5224.346956630421, 5231.058409486296, 5303.045451818671, 5230.686158830473, 5300.310959575259, 5336.546393556543, 5342.1452567589195, 5357.223202635615, 4492.52828453011, 4742.288656701497, 4992.326035985132, 5006.774695138709, 5015.3730783652045, 4811.735354555498, 4919.065377578248, 4923.70457772533, 4952.900941981158, 4985.326980857592, 4737.786799594027, 4809.350737650408, 4880.438749543812, 4890.975545122287, 4936.925946110811, 4805.20714082176, 4865.805367785284, 4872.561469467765, 4899.902001959977, 4901.852944411673, 4671.205894997858, 4745.667803253774, 4874.147024270738, 4875.219964805649, 4891.364122664067, 5151.330327057496, 5154.252633368141, 5201.115810312256, 5208.192730126836, 5208.66143700662, 5644.181593668936, 5647.548196144339, 5655.8586035349035, 5664.376918538957, 5707.942920570783, 5537.833864984017, 5609.943900560983, 5690.516306113986, 5714.285714285715, 5799.101139323411, 5287.603429742746, 5292.947070529322, 5309.734513274321, 5318.042752304584, 5354.384245811742, 5709.628874123168, 5749.0, 5758.913616295759, 5762.962666719946, 5788.971055144697, 5577.44225577439, 5622.91565626516, 5627.71861406928, 5649.802256921071, 5715.31416230055, 5727.656340619576, 5755.165501002331, 5762.567807414377, 5764.365919748824, 5776.104703770922, 5658.462446067617, 5712.400197979236, 5712.857178570569, 5725.0, 5725.3988331225455, 5482.424345443751, 5640.041192997201, 5648.15277708347, 5675.404082571271, 5728.856778580569, 4419.0, 4430.911381772346, 4436.866893993185, 4464.531224221475, 4493.146302202571, 3916.2950668879876, 3932.9213415731524, 3965.960340396559, 3974.582668819732, 4016.859409920639, 5285.603579731535, 5289.312389389354, 5329.493698098674, 5339.359276886721, 5427.0773968425465, 5659.745311460994, 5741.368449470555, 5751.964646363695, 5764.625299355528, 5765.4811067004175, 5273.472652734696, 5287.894242115136, 5298.867528311746, 5366.0, 5404.648697834628, 4838.903221935541, 4858.73276969763, 4900.509949005071, 4904.730239836772, 4933.679310844784, 5984.431479009487, 5997.1304160896425, 6012.0, 6014.789482368096, 6017.06735456005, 5677.460641239076, 5781.508571771446, 5801.3038435388025, 5801.361850196559, 5802.709864506842, 5772.076467765138, 5814.912776308443, 5856.795012174553, 5862.882742345215, 5896.0, 5664.235328230636, 5669.603127781016, 5682.062459694104, 5683.147527870852, 5686.630369026, 5635.549156067586, 5674.886502270014, 5720.542356611378, 5730.770769169187, 5745.023346031268, 5421.2681288025615, 5441.945580544302, 5458.4814442627885, 5463.644863083887, 5503.284573005483, 5478.123500239943, 5496.862578435571, 5511.779528818803, 5517.751701173376, 5536.335639723259, 5414.75633596497, 5423.538999185113, 5436.809711660073, 5462.153366228241, 5483.7258137092185, 5602.859928501657, 5616.747246374005, 5616.9327827712605, 5622.0, 5656.0667489865355, 5456.918146227889, 5465.836024919259, 5483.890322193613, 5485.451454854642, 5485.561155107502], "unit": "score", "name": "dojo.html", "value": 5251.790596410024}, {"lowerIsBetter": false, "replicates": [508.37723788359267, 541.5342805187539, 552.2489414396417, 560.6916196092149, 577.2582231832097, 28184.295392615193, 35999.280014399694, 36329.636703632954, 36412.27175456489, 36497.45253821195, 38997.41503877444, 39328.0, 39364.803175984154, 39395.40906886399, 39567.40648890269, 8390.496570205776, 8501.14988501148, 8516.06323304436, 8520.318374530023, 8527.31781457485, 8307.169283071706, 8361.83276334473, 8408.747737567852, 8414.78963025923, 8427.957860210721, 8301.211384918453, 8472.576371181447, 8480.321574274043, 8484.32125429964, 8485.490870547756, 8332.125126861683, 8367.874481882745, 8418.368622353317, 8622.396432249683, 8626.0, 8398.496090234545, 8497.192766687154, 8530.445521041112, 8537.573121343908, 8558.144185581454, 39118.41322380167, 39118.60881391178, 39306.41040384396, 39355.606443935765, 39447.60552394497, 3354.6142193647797, 3371.359441706068, 3431.4852772084137, 3443.724502039831, 3655.3785856404475, 26760.330991725168, 27128.45743085147, 27204.1838744838, 27416.588751168747, 27941.580876286873, 3574.7318951078773, 3780.489633899416, 3950.2297052074855, 3989.1024519483176, 4039.555648878621, 274752.7574172778, 276446.0, 276958.0, 277197.99999999796, 277952.0, 55083.44916550863, 55701.0, 60437.69781151154, 60920.0, 61684.38315616787, 55850.72074639601, 56194.0, 56572.43427565754, 56583.43416565864, 56733.0, 13795.724085518234, 13876.167429954236, 13924.51264205748, 13930.721385572231, 13932.58202253934, 10288.074073333286, 10295.588176473007, 10316.43259620713, 10358.482075896174, 10377.481125943672, 20035.0, 20693.793062069486, 20849.478763030744, 20877.68683469749, 20883.060262288232, 8031.196880311922, 8220.58897055145, 8247.670093196324, 8255.215754503313, 8280.296174825087, 886.8714036464677, 947.0766003146877, 987.9456629885425, 1025.646152077532, 1029.8043371759343, 28275.293117671812, 28345.43309133847, 28440.8577957113, 28534.571981420297, 28901.132966011053, 993.304686719285, 1040.9843852342221, 1042.5777560088177, 1060.0883240413239, 1158.4960542164185, 14720.705585888436, 14735.410583576751, 14830.81353491718, 14844.891830820034, 14913.403463861325, 324950.0, 327740.0, 327977.0, 328352.0, 329746.0, 51287.74356128195, 52171.47828521666, 52480.73759631254, 52619.0, 52625.210621840706, 1278.2011242973142, 1286.6976260578756, 1288.1884412819863, 1289.548657969703, 1429.5854202281223, 27579.31051723723, 27759.861200693867, 27953.0, 28287.302761834355, 28329.433411331247, 45996.08007839891, 46394.0, 46420.0, 46495.0, 46496.767516163556, 260496.0, 261215.0, 262062.0, 292701.0, 293947.0, 32501.18747031343, 42403.15193696047, 42670.78664606657, 42810.571894280656, 43206.35190472208, 45629.54370456386, 45989.0, 46103.308450373945, 46363.76818115888, 46524.30213546732, 33116.503252451716, 33289.667103328655, 33685.663143368256, 33948.83025584856, 34229.828850855585, 38423.615763842005, 40143.3978490317, 42027.36958945679, 42900.14199716051, 43506.56493435025, 36267.09332266715, 36271.818640906626, 36569.171541423355, 38340.0, 38968.0, 29265.561016584343, 32272.83863580761, 33414.33171336608, 33426.832865836484, 35082.82458587691, 23483.69657036705, 23698.170564030177, 25295.241142765746, 25754.09860654868, 25763.227103186935], "unit": "score", "name": "ext.html", "value": 18310.31984533858}, {"lowerIsBetter": false, "replicates": [324.8099861580975, 325.6635766571475, 328.32365327425504, 336.2518396567636, 351.5833737021628, 16705.916470417662, 16874.578135546617, 17101.82898171018, 17799.73300400495, 17943.730844037334, 15832.76250856238, 16104.919475402607, 16336.264868080934, 16956.745648815246, 16972.321107155698, 4875.561199492045, 5090.745462726867, 5104.872378190538, 5124.231365295198, 5126.897462050757, 4895.902081958358, 4985.725785081819, 5076.416212135597, 5080.542751152396, 5083.745812709368, 4991.351124353829, 5074.28959945606, 5080.441151473335, 5197.0, 5210.062188806013, 5133.640645154841, 5165.328507294065, 5170.663906846062, 5413.296271484682, 5993.670348130851, 5313.6014798889855, 5314.840554783363, 5318.601104917108, 5325.467453254682, 5345.599080069011, 14389.640258993504, 19270.518237044187, 19732.21071157152, 20154.0, 20191.89904050485, 1927.296536764085, 2054.6301665700166, 2057.9794202057938, 2081.253321809442, 2278.384836094262, 9547.809043819085, 11128.777424451546, 11626.476808543552, 12778.552750653775, 13229.338533073307, 1776.111944027986, 1828.7896891857474, 1854.5827188882529, 1873.4566975577065, 1929.411529483521, 54984.0, 56956.71521642407, 57019.71490142564, 57073.71463142699, 58056.12915806224, 9812.950935245279, 10124.190064794799, 10258.17934565233, 10279.794404112026, 10282.383057016603, 13303.071054697015, 13359.866401336056, 13424.798628020588, 13470.730585388237, 13483.865161348458, 7039.049728286718, 7044.22513523512, 7088.2202957675645, 7148.213696493382, 7250.347468727734, 6566.474682025427, 6597.439217666456, 6607.0, 6618.7352505899225, 6650.135482387259, 4517.2772356423475, 4532.1842068427995, 4548.95451045492, 4562.133194692998, 4606.239970404846, 1796.963132306398, 1841.8710690251821, 1855.396995976313, 1889.6882014467733, 1891.754071970635, 779.4894344204555, 799.8760192170223, 908.7773495493647, 980.764616492051, 1048.8688913885765, 15426.382944682311, 15814.9209253953, 16089.712822974134, 16748.078855663054, 17074.914625426794, 882.8455020371409, 907.5054095517959, 922.294444749767, 962.6630679262203, 963.2486660404895, 9326.813463730687, 9360.344775865624, 9533.809323813484, 9825.950870245746, 9896.109350158376, 529690.0, 546633.0, 547185.0, 557660.0, 562276.0, 66851.66574167195, 71747.64126179335, 72190.0, 72779.63610182022, 73616.63191684007, 1129.9943500282445, 1137.965861024154, 1150.206357613261, 1167.2937872587133, 1167.3987896233446, 13962.58112256634, 14559.92720036393, 14566.271686415424, 15008.549743507712, 15031.173285469404, 29701.851490742407, 30311.848440757654, 30421.087367379016, 30460.238494037825, 30833.383332332778, 35714.46428303525, 35796.821015894755, 35979.46030809592, 35980.10049748777, 36000.0, 6837.863242735018, 6996.965015174892, 7102.680379383043, 7221.169565500035, 7277.636118194175, 10194.388336699822, 10411.375317480975, 10447.791044178923, 10740.570377184826, 11045.83431248548, 8580.785480363042, 9454.101860323259, 9517.571709272961, 9556.139947404767, 9579.473128977974, 8939.955300223457, 9097.727068187965, 9469.431834089977, 9622.085901839315, 9822.0, 2930.9448598504946, 2942.23501889506, 6230.470410015199, 9201.055662188035, 9506.0, 7240.275972402717, 7381.557106573623, 7442.292982166686, 7493.850122997618, 7500.512466689648, 7455.943063344003, 8946.194842464209, 9729.464879431416, 9921.603135874484, 10015.649452269136], "unit": "score", "name": "jquery.html", "value": 7931.091843373946}, {"lowerIsBetter": false, "replicates": [1476.9409223631053, 1497.4833682379576, 1660.7176779947408, 1776.9822301776978, 1798.901060441676, 7705.768826935187, 7829.060512738472, 7914.683412663501, 8029.397795165364, 8042.7185048523315, 8055.1944805519415, 8096.190380961901, 8148.7147949821765, 8154.592270386472, 8176.632051557679, 2341.8009469195094, 2377.7503362146986, 2380.500094980048, 2383.92848214553, 2391.4619210677547, 2392.6530653055383, 2421.9343488864843, 2446.131623273739, 2450.620153876152, 2454.5949918263555, 2302.2747834432184, 2367.75138610446, 2371.703537057868, 2372.3594629450126, 2377.049180327874, 2334.323046316566, 2341.473168537074, 2371.893264803088, 2374.2283757778705, 2376.4771750214927, 2383.332666853284, 2386.2364043506086, 2390.151496218852, 2392.306231192952, 2395.9161429350065, 7633.122190948056, 7719.189485104095, 7729.188435214278, 7735.535867847891, 7741.264579864904, 4724.244120940633, 4847.079054979543, 4866.58634016109, 4868.683535570177, 4880.267959806058, 2948.395578906319, 2958.778091643135, 3055.6333240011118, 3059.174023013796, 3062.8667393064707, 964.710586823957, 965.75856035991, 1911.8470522358177, 1924.1052910396734, 1937.680282753344, 10788.190885683605, 10851.51168197433, 10857.728556786065, 10874.401907895142, 10933.289336193202, 4293.892652683708, 4340.934885976713, 4361.890952726208, 4366.847160349373, 4408.647308215335, 8749.1250874912, 8773.254273386707, 8827.337949653802, 8833.69082082124, 8834.602442890086, 4781.0, 4796.0, 4805.6155507559315, 4821.686590371614, 4853.150698627726, 4454.844080457233, 4456.509783923766, 4485.237509623306, 4490.079533695584, 4497.550244975541, 3414.6585341466152, 3494.842732077012, 3508.7017603503477, 3522.119470132467, 3523.2601153757996, 1063.3779239145033, 1070.9089727373105, 1087.342157994418, 1093.3549205968516, 1097.1277834121893, 1013.8428543575758, 1047.85330053791, 1113.6881673131536, 1125.5104029747085, 1234.1237721218035, 6770.898436523456, 6848.246692863781, 6850.965745171342, 6857.142857142857, 6971.58170509771, 618.2858798088215, 635.2440595691113, 639.7536948274948, 643.9484841212692, 724.3734169942961, 4739.881502962385, 4878.707277563358, 4884.560389564886, 4888.0, 4962.751862406865, 8626.0, 8723.563821809012, 8742.562871856382, 9340.252779777602, 9770.0, 8601.268892144113, 8613.267872230805, 8614.741557753277, 8661.913380866237, 8686.435381700168, 7279.563226206338, 7354.271746139653, 7470.626468676544, 7489.363404110712, 7538.811529711801, 6967.825804354931, 7003.964980175067, 7008.929910700827, 7070.36366726997, 7072.045273888165, 8322.6670933162, 8777.692780752643, 8781.736547903318, 8825.293976481995, 8948.821023579621, 8728.301735861243, 9035.322350823846, 9035.909640903506, 9056.818863622822, 9068.591913363782, 6750.797476075725, 7029.718811247493, 7036.331548502884, 7065.046218760402, 7091.716331346688, 7389.667464963982, 7489.625518724151, 7499.962500187682, 7504.962475187589, 7525.3227209551405, 6326.114343991753, 7103.786886393416, 7245.529040612343, 7274.6598850638275, 7355.411567074728, 6522.086907832812, 6715.328467153246, 6803.557768745016, 6950.164590813759, 7182.030425892438, 7207.819804504929, 7233.891491627524, 7254.927450725425, 7276.417886569167, 7285.380742636935, 6132.233470816148, 6296.433321001132, 6303.054541818764, 6303.149074874833, 6311.495080393649, 6386.457151142019, 6407.231132264158, 6422.42198202164, 6430.3891130342545, 6431.614103153825], "unit": "score", "name": "mootools.html", "value": 4476.461918615886}, {"lowerIsBetter": false, "replicates": [339.83857667607884, 343.80403170192983, 349.48974497234036, 350.26968770114325, 351.9155402703351, 6281.780137695176, 6291.087792270118, 6300.21247344082, 6301.086342480337, 6498.122753428286, 6301.590396624216, 6307.3692630736905, 6308.936910630892, 6319.5576309658345, 6348.6825658717, 4757.429108506984, 4764.071006153801, 4765.499622539618, 4766.2374020156785, 4768.998510312838, 4764.380630518028, 4774.092922344744, 4774.9761251193695, 4775.355327030841, 4779.426468823729, 4626.884327891796, 4702.576768090871, 4733.242681171013, 4744.928826067595, 4745.335653008581, 4727.881802954937, 4732.100900828831, 4735.337052812609, 4736.621070314367, 4737.8341758038305, 4054.776987265699, 4067.9796601016806, 4071.97964010181, 4074.7962601870086, 4087.4277601135864, 6003.969980150115, 6008.579399442041, 6015.578909476339, 6017.2779266488305, 6028.668423236721, 5373.247745315659, 5451.700156491392, 5462.6995515246645, 5511.338639363262, 5513.574027427959, 6658.13444252249, 6680.565763225375, 6684.097646817715, 6687.063811066406, 6699.598024118569, 4474.910501789978, 4487.39420178275, 4495.752733599651, 4497.100579884003, 4509.503954564995, 6812.965935170292, 6941.757038503679, 7014.088168538108, 7018.75434359795, 7029.648517574152, 4629.930551041737, 4659.207934651117, 4672.719636821802, 4676.836310729176, 4677.859664210079, 4719.457262414798, 4723.716577005391, 4730.053989202173, 4731.432228132578, 4734.881627959259, 5495.2856128703015, 5500.22996780451, 5500.477454641803, 5512.972435137799, 5521.944780552223, 6455.580387274906, 6680.23177334603, 6697.3637504437, 6725.66371681414, 6727.899081513781, 1639.245946864432, 1662.1772222749817, 1683.8063622683303, 1685.890417122883, 1686.814450410454, 1074.167520171873, 1084.5499117865998, 1093.6554985179644, 1096.1231015187818, 1097.3306283167262, 6179.783707570214, 6214.502839772807, 6273.96863015682, 6274.403931626488, 6278.497720182374, 6766.69549870257, 6786.898196527056, 6804.76183333581, 6824.112865327475, 6841.828954276083, 6178.783742568989, 6308.211473565804, 6355.3644635536075, 6360.618362898241, 6374.745010199633, 3696.907577310535, 3715.64701353371, 3735.290294843971, 3737.0657335666083, 3743.232637309345, 7110.288971102848, 7146.142462904485, 7147.6068816214565, 7156.642167891585, 7157.463190260752, 6906.827329316707, 7014.22843487216, 7036.366726994595, 7041.4718896082995, 7047.119110111236, 7284.453665975073, 7347.302006309499, 7355.374793142536, 7378.815529611696, 7402.592857392895, 6983.266756990442, 6985.650717464208, 7002.509824312453, 7006.509544331848, 7020.192677841909, 6814.011968264673, 6900.930990690029, 6902.24075351721, 6919.965400173169, 6959.512834101564, 7189.245129261352, 7190.532615379983, 7203.8919416207755, 7207.13514378278, 7213.350798428167, 4574.290984897346, 4577.267637178169, 4588.564086411786, 4590.334401511695, 4598.402207712976, 6891.896621550581, 6984.650767461708, 7024.051753013277, 7036.612986285803, 7042.119735033121, 6825.1127353443735, 6832.0, 6856.588604683735, 6897.62063086515, 6924.238333783381, 6774.661266936732, 6801.319868013159, 6802.115724955724, 6842.55523390978, 6865.27914568983, 6538.640374779433, 6647.60114393138, 6669.366410191024, 6701.597904125768, 6714.429273511806, 6786.8642627148165, 6837.35045170708, 6839.418649414656, 6841.21326047491, 6853.246142924374, 6668.266490686117, 6668.76659316941, 6674.299198584079, 6678.933210668026, 6681.665916704243], "unit": "score", "name": "prototype.html", "value": 5021.295538162708}, {"lowerIsBetter": false, "replicates": [826.6941231744255, 831.9542425166617, 835.456952980563, 838.1702114906244, 866.2463656618743, 12747.61757147286, 12772.936135319334, 12798.360081995887, 12836.422360993754, 12853.935730321347, 12804.23174609524, 14632.926835365808, 14947.476838310662, 14951.0, 14958.252087395642, 789.7235967411389, 791.6516732637621, 799.0291795468505, 801.3428988229654, 808.9110197878258, 805.3034125481446, 807.0638059850575, 809.1665584448028, 811.5414790643267, 816.1634324817051, 829.3862541719145, 830.4519017448486, 833.4166083741375, 834.4242472693852, 839.9412041157121, 826.2604968553142, 827.2430725885807, 827.759949614614, 829.274384913201, 830.4726498673325, 609.5580703989616, 613.702354358136, 613.7943788830747, 615.8460384903774, 616.1558664629441, 13944.930275348659, 14073.718525629532, 14077.71844563103, 14110.223937683424, 14138.363773630108, 12462.376881155906, 12505.124641275115, 12809.61571152867, 12942.094053416266, 12957.157784743962, 10538.156947444262, 10583.259171857973, 10611.204159688054, 10794.946025269903, 10846.0, 3524.8061356625376, 3572.7499075064757, 3582.3730847101915, 3647.1976165243605, 3696.667299943018, 49012.75493622545, 50085.49914500881, 50240.24639630409, 50540.49459505431, 50692.0, 9743.415395076318, 9900.405975641484, 9970.501474926225, 10020.148287395506, 10095.343802652951, 17314.30742770275, 17334.0, 17359.21883515245, 17460.126993650265, 17517.912410437868, 7215.891761623579, 7425.814354641069, 7654.502457340255, 7689.115751688516, 7918.326942209861, 4105.137921036556, 4191.559886211965, 4227.7463352198965, 4292.420523229386, 4318.071614602813, 3066.3560652262827, 3094.4275309067893, 3115.1900505868184, 3116.5169398743233, 3119.750419966397, 585.2070444547662, 586.8767558812611, 590.4420322795004, 598.7215944585702, 608.8234412020464, 574.3222996863741, 601.9548533859978, 602.1028667285713, 622.8069298517474, 693.0352450801932, 8648.481091134552, 8742.169493898069, 8773.122687731176, 8794.648214071365, 8834.469931804113, 529.8013245033112, 619.5198720991177, 653.2161406312445, 657.5462930577886, 668.2115104177118, 3832.9425058624142, 3844.3464611016193, 3877.9224415512094, 3986.063275130342, 4052.3111071117983, 51864.74067629638, 52983.470165298626, 53253.0, 53308.46691533035, 53336.0, 48625.51374486281, 49092.50907490951, 49217.75391123093, 49495.50504494909, 49904.0, 42235.577644223165, 42582.78708606499, 42739.14521709549, 44252.557474424844, 44635.77682111569, 7635.389168866366, 7807.063152421746, 7857.960710196412, 7882.566458844819, 7956.761297161094, 32409.51385729263, 32873.34253314872, 33026.83486582552, 33078.50382244316, 33441.163970900925, 39507.0, 42609.36085958651, 43379.78310108429, 44623.0, 44641.0, 9533.523323833919, 9558.139767420966, 9576.664816731382, 9582.01853492473, 9712.82229791912, 10825.296355736851, 10878.184136189659, 10969.725756856142, 11008.009279164913, 11129.888701112885, 9642.951785241028, 9823.0, 9839.901600983898, 9983.60065597368, 10272.845907311546, 10217.897821021694, 10326.690199294033, 10357.274990750575, 10484.475776211006, 10506.632267870587, 10008.749781255236, 10058.295919285873, 10123.24075694311, 10145.695629130843, 10477.161827053666, 8279.710210142615, 8302.83394332122, 8354.832903342021, 8385.0, 8460.450070745383, 7840.725574604861, 8555.230029297392, 8610.913890861262, 8668.219860212612, 8675.956620217112], "unit": "score", "name": "yui.html", "value": 6108.3131010427505}], "name": "dromaeo_css", "value": 6865.530234176797}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 110.0, 111.0, 122.0, 111.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 165.0, 161.0, 129.0, 158.0, 163.0, 127.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 164.0, 161.0, 162.0, 162.0, 165.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 75.0, 74.0, 77.0, 133.0, 73.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 96.0, 96.0, 96.0, 135.0, 95.0, 97.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 112.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 68.0, 61.0, 63.0, 60.0, 61.0, 65.0, 68.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 72.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 93.0, 85.0, 86.0, 86.0, 84.0, 84.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [125.0, 119.0, 116.0, 120.0, 120.0, 127.0, 117.0, 124.0, 121.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 146.0, 144.0, 146.0, 136.0, 141.0, 138.0, 143.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 67.0, 66.0, 69.0, 66.0, 67.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1513.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.41581458759373], "unit": "score", "name": "Richards", "value": 207.15213600000004}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [703.2348804500704], "unit": "score", "name": "Earley", "value": 947.7103860000001}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [42000.0], "unit": "score", "name": "RegExp", "value": 21.690119047619053}, {"lowerIsBetter": false, "replicates": [573.2265446224256], "unit": "score", "name": "Splay", "value": 142.1619441117765}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20448.955878772875}]} 19:14:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20448.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6865.53"}}} 19:14:34 INFO - Return code: 0 19:14:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:14:34 INFO - # TBPL SUCCESS # 19:14:34 INFO - Running post-action listener: _resource_record_post_action 19:14:34 INFO - Running post-run listener: _resource_record_post_run 19:14:35 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 159744; Write bytes: 315305984; Read time: 60; Write time: 255740 19:14:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1146880; Read time: 0; Write time: 52 19:14:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 159744; Write bytes: 314044416; Read time: 60; Write time: 255688 19:14:35 INFO - Running post-run listener: _upload_blobber_files 19:14:35 INFO - Blob upload gear active. 19:14:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:14:35 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 19:14:35 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'] 19:14:35 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 19:14:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:36 INFO - (blobuploader) - INFO - Done attempting. 19:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:37 INFO - (blobuploader) - INFO - Done attempting. 19:14:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:37 INFO - Return code: 0 19:14:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:14:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0402807f85505d7502f0aec6ab9b2bc78a99ad63bf50df48d672e2e81b78da3693ea4bce6cec1c3b68c3fc61bf37e1a54c7fc52a5d4d4c03d5c093f16328f26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bda2217238b3cb664146a623e7a74b17fa27352c40960f0f1f1ca47308ccdf7c1df9520af994f78bed2e0c8b812f1c3c52c0969582728b3fd784e9601142a75f"} 19:14:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:14:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:14:37 INFO - Contents: 19:14:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0402807f85505d7502f0aec6ab9b2bc78a99ad63bf50df48d672e2e81b78da3693ea4bce6cec1c3b68c3fc61bf37e1a54c7fc52a5d4d4c03d5c093f16328f26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bda2217238b3cb664146a623e7a74b17fa27352c40960f0f1f1ca47308ccdf7c1df9520af994f78bed2e0c8b812f1c3c52c0969582728b3fd784e9601142a75f"} 19:14:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:37 INFO - Copying logs to upload dir... 19:14:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:14:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.972757 ========= master_lag: 1.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-20 19:14:38.600927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 19:14:38.608013) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 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/0402807f85505d7502f0aec6ab9b2bc78a99ad63bf50df48d672e2e81b78da3693ea4bce6cec1c3b68c3fc61bf37e1a54c7fc52a5d4d4c03d5c093f16328f26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bda2217238b3cb664146a623e7a74b17fa27352c40960f0f1f1ca47308ccdf7c1df9520af994f78bed2e0c8b812f1c3c52c0969582728b3fd784e9601142a75f"} build_url:https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/ZKWsdik1Rz6t14BA3OD7jg/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/0402807f85505d7502f0aec6ab9b2bc78a99ad63bf50df48d672e2e81b78da3693ea4bce6cec1c3b68c3fc61bf37e1a54c7fc52a5d4d4c03d5c093f16328f26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bda2217238b3cb664146a623e7a74b17fa27352c40960f0f1f1ca47308ccdf7c1df9520af994f78bed2e0c8b812f1c3c52c0969582728b3fd784e9601142a75f"}' ========= master_lag: 0.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 19:14:38.829813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 19:14:38.830131) ========= 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=652eb03db935cfc1c15ebda0000001ad-1453342395.734513-714409805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 19:14:38.846356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 19:14:38.846672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 19:14:38.846935) ========= ========= Total master_lag: 1.39 =========