builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1450800231.1 results: success (0) buildid: 20151222053002 builduid: 0628565107134a4bada3deba2c715cc5 revision: 3cc8559d0d65d5704eedc72238a82c09b4b630cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.100362) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.100827) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.101142) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006360 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.126216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.126560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.139820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.140116) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.189187) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.189503) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.189904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.190224) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 08:03:51-- 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% 221M=0s 2015-12-22 08:03:51 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.303852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.304171) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.354131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.354566) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 08:03:51,585 truncating revision to first 12 chars 2015-12-22 08:03:51,585 Setting DEBUG logging. 2015-12-22 08:03:51,585 attempt 1/10 2015-12-22 08:03:51,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cc8559d0d65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 08:03:51,816 unpacking tar archive at: fx-team-3cc8559d0d65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.512945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.882274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.882631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.892195) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.892510) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:51.892927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-22 08:03:51.893267) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:52 INFO - MultiFileLogger online at 20151222 08:03:52 in /builds/slave/test-pgo 08:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:03:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:03:52 INFO - {'append_to_log': False, 08:03:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:03:52 INFO - 'blob_upload_branch': 'Fx-Team', 08:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:03:52 INFO - 'branch': 'Fx-Team', 08:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:52 INFO - 'config_files': ('talos/linux_config.py',), 08:03:52 INFO - 'default_actions': ('clobber', 08:03:52 INFO - 'read-buildbot-config', 08:03:52 INFO - 'download-and-extract', 08:03:52 INFO - 'populate-webroot', 08:03:52 INFO - 'create-virtualenv', 08:03:52 INFO - 'install', 08:03:52 INFO - 'run-tests'), 08:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:52 INFO - 'download_minidump_stackwalk': True, 08:03:52 INFO - 'download_symbols': 'ondemand', 08:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:52 INFO - 'installer_path': 'installer.exe', 08:03:52 INFO - 'log_level': 'info', 08:03:52 INFO - 'log_name': 'talos', 08:03:52 INFO - 'log_to_console': True, 08:03:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:52 INFO - 'opt_config_files': (), 08:03:52 INFO - 'pip_index': False, 08:03:52 INFO - 'sps_profile': False, 08:03:52 INFO - 'sps_profile_interval': 0, 08:03:52 INFO - 'suite': 'dromaeojs-e10s', 08:03:52 INFO - 'system_bits': '64', 08:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:52 INFO - 'title': 'talos-linux64-ix-019', 08:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:52 INFO - 'use_talos_json': True, 08:03:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:52 INFO - 'work_dir': 'build'} 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running clobber step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: clobber 08:03:52 INFO - rmtree: /builds/slave/test-pgo/build 08:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:03:52 INFO - Running post-action listener: _resource_record_post_action 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running read-buildbot-config step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: read_buildbot_config 08:03:52 INFO - Using buildbot properties: 08:03:52 INFO - { 08:03:52 INFO - "project": "", 08:03:52 INFO - "product": "firefox", 08:03:52 INFO - "script_repo_revision": "production", 08:03:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:03:52 INFO - "repository": "", 08:03:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:03:52 INFO - "buildid": "20151222053002", 08:03:52 INFO - "pgo_build": "True", 08:03:52 INFO - "basedir": "/builds/slave/test-pgo", 08:03:52 INFO - "buildnumber": 113, 08:03:52 INFO - "slavename": "talos-linux64-ix-019", 08:03:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:03:52 INFO - "platform": "ubuntu64_hw", 08:03:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:03:52 INFO - "branch": "fx-team", 08:03:52 INFO - "repo_path": "integration/fx-team", 08:03:52 INFO - "revision": "3cc8559d0d65d5704eedc72238a82c09b4b630cd", 08:03:52 INFO - "stage_platform": "linux64-pgo", 08:03:52 INFO - "builduid": "0628565107134a4bada3deba2c715cc5", 08:03:52 INFO - "slavebuilddir": "test" 08:03:52 INFO - } 08:03:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:03:52 INFO - Running post-action listener: _resource_record_post_action 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running download-and-extract step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: download_and_extract 08:03:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:03: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')]} 08:03:52 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:03:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json 08:03:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json 08:03:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:03:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:04:00 INFO - Downloaded 1302 bytes. 08:04:00 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:04:00 INFO - Using the following test package requirements: 08:04:00 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:00 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'jsshell-linux-x86_64.zip'], 08:04:00 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:00 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:00 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:00 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:00 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:00 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:06 INFO - Downloaded 23176552 bytes. 08:04:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:04:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:04:07 INFO - Return code: 0 08:04:07 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 08:04:07 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')]} 08:04:07 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:15 INFO - Downloaded 23176552 bytes. 08:04:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:04:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:04:16 INFO - Return code: 0 08:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:16 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:17 INFO - Downloaded 11132277 bytes. 08:04:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:04:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:04:17 INFO - Return code: 0 08:04:17 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')]} 08:04:17 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:20 INFO - Downloaded 54886189 bytes. 08:04:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:20 INFO - mkdir: /builds/slave/test-pgo/properties 08:04:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:04:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:04:20 INFO - Contents: 08:04:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:20 INFO - Running post-action listener: _resource_record_post_action 08:04:20 INFO - Running post-action listener: set_extra_try_arguments 08:04:20 INFO - ##### 08:04:20 INFO - ##### Running populate-webroot step. 08:04:20 INFO - ##### 08:04:20 INFO - Running pre-action listener: _resource_record_pre_action 08:04:20 INFO - Running main action method: populate_webroot 08:04:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:20 INFO - '--tppagecycles', 08:04:20 INFO - '7'], 08:04:20 INFO - 'tests': ['tsvgm']}}, 08:04:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:04:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'tests': ['damp', 'tps']}, 08:04:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['damp', 'tps']}, 08:04:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:04:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:20 INFO - 'other': {'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'other_l64': {'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'other_nol64': {'tests': ['a11yr', 08:04:20 INFO - 'ts_paint', 08:04:20 INFO - 'tpaint', 08:04:20 INFO - 'sessionrestore', 08:04:20 INFO - 'sessionrestore_no_auto_restore']}, 08:04:20 INFO - 'svgr': {'tests': ['tsvgx', 08:04:20 INFO - 'tsvgr_opacity', 08:04:20 INFO - 'tart', 08:04:20 INFO - 'tscrollx', 08:04:20 INFO - 'cart']}, 08:04:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['tsvgx', 08:04:20 INFO - 'tsvgr_opacity', 08:04:20 INFO - 'tart', 08:04:20 INFO - 'tscrollx', 08:04:20 INFO - 'cart']}, 08:04:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'tests': ['tp5o']}, 08:04:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'talos_options': ['--e10s'], 08:04:20 INFO - 'tests': ['tp5o']}, 08:04:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'talos_options': ['--xperf_path', 08:04:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:20 INFO - 'tests': ['tp5n']}, 08:04:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:20 INFO - 'talos_options': ['--e10s', 08:04:20 INFO - '--xperf_path', 08:04:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:20 INFO - 'tests': ['tp5n']}}, 08:04:20 INFO - 'talos.zip': {'path': '', 08:04:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:20 INFO - Running post-action listener: _resource_record_post_action 08:04:20 INFO - ##### 08:04:20 INFO - ##### Running create-virtualenv step. 08:04:20 INFO - ##### 08:04:20 INFO - Running pre-action listener: _resource_record_pre_action 08:04:20 INFO - Running main action method: create_virtualenv 08:04:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:04:20 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 08:04:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:04:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:20 INFO - Using real prefix '/usr' 08:04:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:04:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:23 INFO - Installing pip.................done. 08:04:23 INFO - Return code: 0 08:04:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:04:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:23 INFO - Using env: {'DISPLAY': ':0', 08:04:23 INFO - 'HOME': '/home/cltbld', 08:04:23 INFO - 'LANG': 'en_US.UTF-8', 08:04:23 INFO - 'LANGUAGE': 'en_US:en', 08:04:23 INFO - 'LOGNAME': 'cltbld', 08:04:23 INFO - 'MAIL': '/var/mail/cltbld', 08:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:23 INFO - 'MOZ_NO_REMOTE': '1', 08:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:23 INFO - 'NO_EM_RESTART': '1', 08:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:23 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:23 INFO - 'SHELL': '/bin/bash', 08:04:23 INFO - 'SHLVL': '1', 08:04:23 INFO - 'TERM': 'linux', 08:04:23 INFO - 'TMOUT': '86400', 08:04:23 INFO - 'USER': 'cltbld', 08:04:23 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:23 INFO - '_': '/tools/buildbot/bin/python'} 08:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:23 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 08:04:23 INFO - Cleaning up... 08:04:23 INFO - Return code: 0 08:04:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:04:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:04:23 INFO - Using env: {'DISPLAY': ':0', 08:04:23 INFO - 'HOME': '/home/cltbld', 08:04:23 INFO - 'LANG': 'en_US.UTF-8', 08:04:23 INFO - 'LANGUAGE': 'en_US:en', 08:04:23 INFO - 'LOGNAME': 'cltbld', 08:04:23 INFO - 'MAIL': '/var/mail/cltbld', 08:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:23 INFO - 'MOZ_NO_REMOTE': '1', 08:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:23 INFO - 'NO_EM_RESTART': '1', 08:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:23 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:23 INFO - 'SHELL': '/bin/bash', 08:04:23 INFO - 'SHLVL': '1', 08:04:23 INFO - 'TERM': 'linux', 08:04:23 INFO - 'TMOUT': '86400', 08:04:23 INFO - 'USER': 'cltbld', 08:04:23 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:23 INFO - '_': '/tools/buildbot/bin/python'} 08:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:23 INFO - Downloading/unpacking psutil>=0.7.1 08:04:23 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 08:04:23 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 08:04:23 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 08:04:23 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 08:04:23 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 08:04:23 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 08:04:28 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:04:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:28 INFO - Installing collected packages: psutil 08:04:28 INFO - Running setup.py install for psutil 08:04:28 INFO - building 'psutil._psutil_linux' extension 08:04:28 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 08:04:28 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 08:04:28 INFO - building 'psutil._psutil_posix' extension 08:04:28 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 08:04:28 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 08:04:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:29 INFO - Successfully installed psutil 08:04:29 INFO - Cleaning up... 08:04:29 INFO - Return code: 0 08:04:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:04:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:04:29 INFO - Using env: {'DISPLAY': ':0', 08:04:29 INFO - 'HOME': '/home/cltbld', 08:04:29 INFO - 'LANG': 'en_US.UTF-8', 08:04:29 INFO - 'LANGUAGE': 'en_US:en', 08:04:29 INFO - 'LOGNAME': 'cltbld', 08:04:29 INFO - 'MAIL': '/var/mail/cltbld', 08:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:29 INFO - 'MOZ_NO_REMOTE': '1', 08:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:29 INFO - 'NO_EM_RESTART': '1', 08:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:29 INFO - 'SHELL': '/bin/bash', 08:04:29 INFO - 'SHLVL': '1', 08:04:29 INFO - 'TERM': 'linux', 08:04:29 INFO - 'TMOUT': '86400', 08:04:29 INFO - 'USER': 'cltbld', 08:04:29 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:29 INFO - '_': '/tools/buildbot/bin/python'} 08:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:04:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:04:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:04:31 INFO - Installing collected packages: mozsystemmonitor 08:04:31 INFO - Running setup.py install for mozsystemmonitor 08:04:31 INFO - Successfully installed mozsystemmonitor 08:04:31 INFO - Cleaning up... 08:04:31 INFO - Return code: 0 08:04:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:04:31 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')]} 08:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:31 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')]} 08:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:04:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:04:31 INFO - Using env: {'DISPLAY': ':0', 08:04:31 INFO - 'HOME': '/home/cltbld', 08:04:31 INFO - 'LANG': 'en_US.UTF-8', 08:04:31 INFO - 'LANGUAGE': 'en_US:en', 08:04:31 INFO - 'LOGNAME': 'cltbld', 08:04:31 INFO - 'MAIL': '/var/mail/cltbld', 08:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:31 INFO - 'MOZ_NO_REMOTE': '1', 08:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:31 INFO - 'NO_EM_RESTART': '1', 08:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:31 INFO - 'SHELL': '/bin/bash', 08:04:31 INFO - 'SHLVL': '1', 08:04:31 INFO - 'TERM': 'linux', 08:04:31 INFO - 'TMOUT': '86400', 08:04:31 INFO - 'USER': 'cltbld', 08:04:31 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:31 INFO - '_': '/tools/buildbot/bin/python'} 08:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:04:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:04:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:04:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:33 INFO - Downloading docopt-0.6.1.tar.gz 08:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:04:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:33 INFO - Running setup.py install for blobuploader 08:04:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:04:34 INFO - Running setup.py install for requests 08:04:34 INFO - Running setup.py install for docopt 08:04:34 INFO - Successfully installed blobuploader requests docopt 08:04:34 INFO - Cleaning up... 08:04:34 INFO - Return code: 0 08:04:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:34 INFO - Using env: {'DISPLAY': ':0', 08:04:34 INFO - 'HOME': '/home/cltbld', 08:04:34 INFO - 'LANG': 'en_US.UTF-8', 08:04:34 INFO - 'LANGUAGE': 'en_US:en', 08:04:34 INFO - 'LOGNAME': 'cltbld', 08:04:34 INFO - 'MAIL': '/var/mail/cltbld', 08:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:34 INFO - 'MOZ_NO_REMOTE': '1', 08:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:34 INFO - 'NO_EM_RESTART': '1', 08:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:34 INFO - 'SHELL': '/bin/bash', 08:04:34 INFO - 'SHLVL': '1', 08:04:34 INFO - 'TERM': 'linux', 08:04:34 INFO - 'TMOUT': '86400', 08:04:34 INFO - 'USER': 'cltbld', 08:04:34 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:34 INFO - '_': '/tools/buildbot/bin/python'} 08:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:34 INFO - Running setup.py (path:/tmp/pip-asVaoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:34 INFO - Running setup.py (path:/tmp/pip-rW4xhC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:34 INFO - Running setup.py (path:/tmp/pip-2Yqjar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:35 INFO - Running setup.py (path:/tmp/pip-blFQvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:35 INFO - Running setup.py (path:/tmp/pip-Fmy07l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:35 INFO - Running setup.py (path:/tmp/pip-BLA2My-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:35 INFO - Running setup.py (path:/tmp/pip-10KxOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:35 INFO - Running setup.py (path:/tmp/pip-NvdDKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:35 INFO - Running setup.py (path:/tmp/pip-oWGceo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:35 INFO - Running setup.py (path:/tmp/pip-9NjOVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:35 INFO - Running setup.py (path:/tmp/pip-pvhbrP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:35 INFO - Running setup.py (path:/tmp/pip-uRAbS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:35 INFO - Running setup.py (path:/tmp/pip-pi2XEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:35 INFO - Running setup.py (path:/tmp/pip-rQRycY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:35 INFO - Running setup.py (path:/tmp/pip-fWRwDB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:35 INFO - Running setup.py (path:/tmp/pip-hy5oWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:35 INFO - Running setup.py (path:/tmp/pip-bRmLMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:36 INFO - Running setup.py install for manifestparser 08:04:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Running setup.py install for mozcrash 08:04:36 INFO - Running setup.py install for mozdebug 08:04:36 INFO - Running setup.py install for mozdevice 08:04:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Running setup.py install for mozfile 08:04:36 INFO - Running setup.py install for mozhttpd 08:04:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Running setup.py install for mozinfo 08:04:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Running setup.py install for mozInstall 08:04:36 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:04:36 INFO - Running setup.py install for mozleak 08:04:36 INFO - Running setup.py install for mozlog 08:04:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Running setup.py install for moznetwork 08:04:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Running setup.py install for mozprocess 08:04:37 INFO - Running setup.py install for mozprofile 08:04:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Running setup.py install for mozrunner 08:04:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Running setup.py install for mozscreenshot 08:04:37 INFO - Running setup.py install for moztest 08:04:37 INFO - Running setup.py install for mozversion 08:04:37 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:04:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:37 INFO - Cleaning up... 08:04:37 INFO - Return code: 0 08:04:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04: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')]} 08:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:37 INFO - Using env: {'DISPLAY': ':0', 08:04:37 INFO - 'HOME': '/home/cltbld', 08:04:37 INFO - 'LANG': 'en_US.UTF-8', 08:04:37 INFO - 'LANGUAGE': 'en_US:en', 08:04:37 INFO - 'LOGNAME': 'cltbld', 08:04:37 INFO - 'MAIL': '/var/mail/cltbld', 08:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:37 INFO - 'MOZ_NO_REMOTE': '1', 08:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:37 INFO - 'NO_EM_RESTART': '1', 08:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:37 INFO - 'SHELL': '/bin/bash', 08:04:37 INFO - 'SHLVL': '1', 08:04:37 INFO - 'TERM': 'linux', 08:04:37 INFO - 'TMOUT': '86400', 08:04:37 INFO - 'USER': 'cltbld', 08:04:37 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:37 INFO - '_': '/tools/buildbot/bin/python'} 08:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:38 INFO - Running setup.py (path:/tmp/pip-c3BfI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:38 INFO - Running setup.py (path:/tmp/pip-4RQXfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:38 INFO - Running setup.py (path:/tmp/pip-sbVG3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:38 INFO - Running setup.py (path:/tmp/pip-n8XCjf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:38 INFO - Running setup.py (path:/tmp/pip-enNzz_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:38 INFO - Running setup.py (path:/tmp/pip-5Tp6jY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:38 INFO - Running setup.py (path:/tmp/pip-kTsewR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:38 INFO - Running setup.py (path:/tmp/pip-H1eezX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:38 INFO - Running setup.py (path:/tmp/pip-h9Zn6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:38 INFO - Running setup.py (path:/tmp/pip-MEcR5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:38 INFO - Running setup.py (path:/tmp/pip-jtZ9I9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:38 INFO - Running setup.py (path:/tmp/pip-zk3yqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:38 INFO - Running setup.py (path:/tmp/pip-GvF5Wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:38 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)) 08:04:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:38 INFO - Running setup.py (path:/tmp/pip-gFTVzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:39 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)) 08:04:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:39 INFO - Running setup.py (path:/tmp/pip-vQP7NH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:39 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)) 08:04:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:39 INFO - Running setup.py (path:/tmp/pip-rg_rLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:39 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)) 08:04:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:39 INFO - Running setup.py (path:/tmp/pip-HNHtRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:39 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)) 08:04:39 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)) 08:04:39 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)) 08:04:39 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)) 08:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:40 INFO - Downloading blessings-1.5.1.tar.gz 08:04:40 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:04:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:40 INFO - Installing collected packages: blessings 08:04:40 INFO - Running setup.py install for blessings 08:04:41 INFO - Successfully installed blessings 08:04:41 INFO - Cleaning up... 08:04:41 INFO - Return code: 0 08:04:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:04:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:04:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:04:41 INFO - Reading from file tmpfile_stdout 08:04:41 INFO - Current package versions: 08:04:41 INFO - argparse == 1.2.1 08:04:41 INFO - blessings == 1.5.1 08:04:41 INFO - blobuploader == 1.2.4 08:04:41 INFO - docopt == 0.6.1 08:04:41 INFO - manifestparser == 1.1 08:04:41 INFO - mozInstall == 1.12 08:04:41 INFO - mozcrash == 0.16 08:04:41 INFO - mozdebug == 0.1 08:04:41 INFO - mozdevice == 0.47 08:04:41 INFO - mozfile == 1.2 08:04:41 INFO - mozhttpd == 0.7 08:04:41 INFO - mozinfo == 0.9 08:04:41 INFO - mozleak == 0.1 08:04:41 INFO - mozlog == 3.1 08:04:41 INFO - moznetwork == 0.27 08:04:41 INFO - mozprocess == 0.22 08:04:41 INFO - mozprofile == 0.28 08:04:41 INFO - mozrunner == 6.11 08:04:41 INFO - mozscreenshot == 0.1 08:04:41 INFO - mozsystemmonitor == 0.0 08:04:41 INFO - moztest == 0.7 08:04:41 INFO - mozversion == 1.4 08:04:41 INFO - psutil == 3.1.1 08:04:41 INFO - requests == 1.2.3 08:04:41 INFO - wsgiref == 0.1.2 08:04:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:04:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:41 INFO - Using env: {'DISPLAY': ':0', 08:04:41 INFO - 'HOME': '/home/cltbld', 08:04:41 INFO - 'LANG': 'en_US.UTF-8', 08:04:41 INFO - 'LANGUAGE': 'en_US:en', 08:04:41 INFO - 'LOGNAME': 'cltbld', 08:04:41 INFO - 'MAIL': '/var/mail/cltbld', 08:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:41 INFO - 'MOZ_NO_REMOTE': '1', 08:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:41 INFO - 'NO_EM_RESTART': '1', 08:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:41 INFO - 'SHELL': '/bin/bash', 08:04:41 INFO - 'SHLVL': '1', 08:04:41 INFO - 'TERM': 'linux', 08:04:41 INFO - 'TMOUT': '86400', 08:04:41 INFO - 'USER': 'cltbld', 08:04:41 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:41 INFO - '_': '/tools/buildbot/bin/python'} 08:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 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)) 08:04:41 INFO - Cleaning up... 08:04:41 INFO - Return code: 0 08:04:41 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:04:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:41 INFO - Using env: {'DISPLAY': ':0', 08:04:41 INFO - 'HOME': '/home/cltbld', 08:04:41 INFO - 'LANG': 'en_US.UTF-8', 08:04:41 INFO - 'LANGUAGE': 'en_US:en', 08:04:41 INFO - 'LOGNAME': 'cltbld', 08:04:41 INFO - 'MAIL': '/var/mail/cltbld', 08:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:41 INFO - 'MOZ_NO_REMOTE': '1', 08:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:41 INFO - 'NO_EM_RESTART': '1', 08:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:41 INFO - 'SHELL': '/bin/bash', 08:04:41 INFO - 'SHLVL': '1', 08:04:41 INFO - 'TERM': 'linux', 08:04:41 INFO - 'TMOUT': '86400', 08:04:41 INFO - 'USER': 'cltbld', 08:04:41 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:41 INFO - '_': '/tools/buildbot/bin/python'} 08:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:41 INFO - Downloading/unpacking jsonschema 08:04:41 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 08:04:41 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 08:04:41 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 08:04:41 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 08:04:41 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 08:04:41 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 08:04:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:04:43 INFO - Downloading/unpacking functools32 (from jsonschema) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:04:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:43 INFO - warning: no files found matching '*.txt' 08:04:43 INFO - no previously-included directories found matching 'build' 08:04:43 INFO - no previously-included directories found matching 'dist' 08:04:43 INFO - no previously-included directories found matching '.git*' 08:04:43 INFO - Installing collected packages: jsonschema, functools32 08:04:43 INFO - Running setup.py install for functools32 08:04:43 INFO - warning: no files found matching '*.txt' 08:04:43 INFO - no previously-included directories found matching 'build' 08:04:43 INFO - no previously-included directories found matching 'dist' 08:04:43 INFO - no previously-included directories found matching '.git*' 08:04:43 INFO - Successfully installed jsonschema functools32 08:04:43 INFO - Cleaning up... 08:04:43 INFO - Return code: 0 08:04:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:04: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')]} 08:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', '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 08:04:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:04:43 INFO - Using env: {'DISPLAY': ':0', 08:04:43 INFO - 'HOME': '/home/cltbld', 08:04:43 INFO - 'LANG': 'en_US.UTF-8', 08:04:43 INFO - 'LANGUAGE': 'en_US:en', 08:04:43 INFO - 'LOGNAME': 'cltbld', 08:04:43 INFO - 'MAIL': '/var/mail/cltbld', 08:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:43 INFO - 'MOZ_NO_REMOTE': '1', 08:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:43 INFO - 'NO_EM_RESTART': '1', 08:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:43 INFO - 'SHELL': '/bin/bash', 08:04:43 INFO - 'SHLVL': '1', 08:04:43 INFO - 'TERM': 'linux', 08:04:43 INFO - 'TMOUT': '86400', 08:04:43 INFO - 'USER': 'cltbld', 08:04:43 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:43 INFO - '_': '/tools/buildbot/bin/python'} 08:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:44 INFO - Downloading/unpacking flake8 08:04:44 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 08:04:44 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 08:04:44 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 08:04:44 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 08:04:44 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 08:04:44 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 08:04:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:04:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:04:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:04:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:46 INFO - no previously-included directories found matching 'docs/_build' 08:04:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:47 INFO - Running setup.py install for pep8 08:04:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:47 INFO - no previously-included directories found matching 'docs/_build' 08:04:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:04:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:47 INFO - Cleaning up... 08:04:47 INFO - Return code: 0 08:04:47 INFO - Running post-action listener: _resource_record_post_action 08:04:47 INFO - Running post-action listener: _start_resource_monitoring 08:04:47 INFO - Starting resource monitoring. 08:04:47 INFO - ##### 08:04:47 INFO - ##### Running install step. 08:04:47 INFO - ##### 08:04:47 INFO - Running pre-action listener: _resource_record_pre_action 08:04:47 INFO - Running main action method: install 08:04:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:04:47 INFO - Reading from file tmpfile_stdout 08:04:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:04:47 INFO - Reading from file tmpfile_stdout 08:04:47 INFO - Output received: 08:04:47 INFO - Usage: mozinstall [options] installer 08:04:47 INFO - Options: 08:04:47 INFO - -h, --help show this help message and exit 08:04:47 INFO - -d DEST, --destination=DEST 08:04:47 INFO - Directory to install application into. [default: 08:04:47 INFO - "/builds/slave/test-pgo"] 08:04:47 INFO - --app=APP Application being installed. [default: firefox] 08:04:47 INFO - mkdir: /builds/slave/test-pgo/build/application 08:04:47 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'] 08:04:47 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 08:05:03 INFO - Reading from file tmpfile_stdout 08:05:03 INFO - Output received: 08:05:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:05:03 INFO - Running post-action listener: _resource_record_post_action 08:05:03 INFO - ##### 08:05:03 INFO - ##### Running run-tests step. 08:05:03 INFO - ##### 08:05:03 INFO - Running pre-action listener: _resource_record_pre_action 08:05:03 INFO - Running main action method: run_tests 08:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:05:03 INFO - Python 2.7.3 08:05:03 INFO - Return code: 0 08:05:03 INFO - grabbing minidump binary from tooltool 08:05:03 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')]} 08:05:03 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 0x2ad3660>, '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 0x2ad4560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad4a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:05:03 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 08:05:03 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 08:05:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:03 INFO - Return code: 0 08:05:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:05:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:05:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:05:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:05:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:05:04 INFO - Return code: 0 08:05:04 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:05:04 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:05:04 INFO - Using env: {'DISPLAY': ':0', 08:05:04 INFO - 'HOME': '/home/cltbld', 08:05:04 INFO - 'LANG': 'en_US.UTF-8', 08:05:04 INFO - 'LANGUAGE': 'en_US:en', 08:05:04 INFO - 'LOGNAME': 'cltbld', 08:05:04 INFO - 'MAIL': '/var/mail/cltbld', 08:05:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:05:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:04 INFO - 'MOZ_NO_REMOTE': '1', 08:05:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:04 INFO - 'NO_EM_RESTART': '1', 08:05:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:05:04 INFO - 'SHELL': '/bin/bash', 08:05:04 INFO - 'SHLVL': '1', 08:05:04 INFO - 'TERM': 'linux', 08:05:04 INFO - 'TMOUT': '86400', 08:05:04 INFO - 'USER': 'cltbld', 08:05:04 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065', 08:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:04 INFO - '_': '/tools/buildbot/bin/python'} 08:05:04 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:05:04 INFO - mozversion application_buildid: 20151222053002 08:05:04 INFO - mozversion application_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 08:05:04 INFO - mozversion application_display_name: Nightly 08:05:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:04 INFO - mozversion application_name: Firefox 08:05:04 INFO - mozversion application_remotingname: firefox 08:05:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:05:04 INFO - mozversion application_vendor: Mozilla 08:05:04 INFO - mozversion application_version: 46.0a1 08:05:04 INFO - mozversion platform_buildid: 20151222053002 08:05:04 INFO - mozversion platform_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 08:05:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:05:04 INFO - mozversion platform_version: 46.0a1 08:05:04 INFO - using testdate: 1450800304 08:05:04 INFO - actual date: 1450800304 08:05:08 INFO - starting webserver on 'localhost:47099' 08:05:08 INFO - SUITE-START | Running 3 tests 08:05:08 INFO - TEST-START | dromaeo_css 08:05:08 INFO - operating with platform_type : linux_ 08:05:08 INFO - Initialising browser for dromaeo_css test... 08:05:08 INFO - TEST-INFO | started process 8968 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpznkjAp/profile http://localhost:47099/getInfo.html) 08:05:12 INFO - PROCESS | 8968 | __metrics Screen width/height:1600/1200 08:05:12 INFO - PROCESS | 8968 | colorDepth:24 08:05:12 INFO - PROCESS | 8968 | Browser inner width/height: 1024/697 08:05:12 INFO - PROCESS | 8968 | __metrics 08:05:12 INFO - PROCESS | 8968 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:05:13 INFO - TEST-INFO | 8968: exit 0 08:05:13 INFO - Browser initialized. 08:05:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:13 INFO - TEST-INFO | started process 9100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpznkjAp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:25 INFO - PROCESS | 9100 | RSS: Main: 151556096 08:05:25 INFO - PROCESS | 9100 | 08:06:15 INFO - PROCESS | 9100 | 1450800375063 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] 08:08:23 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47099/tests/dromaeo/cssquery-ext.html) 08:08:25 INFO - PROCESS | 9100 | RSS: Main: 157618176 08:08:25 INFO - PROCESS | 9100 | 08:11:27 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-ext.html (next: http://localhost:47099/tests/dromaeo/cssquery-jquery.html) 08:11:27 INFO - PROCESS | 9100 | RSS: Main: 153145344 08:11:27 INFO - PROCESS | 9100 | 08:14:29 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47099/tests/dromaeo/cssquery-mootools.html) 08:14:29 INFO - PROCESS | 9100 | RSS: Main: 153845760 08:14:29 INFO - PROCESS | 9100 | 08:17:31 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47099/tests/dromaeo/cssquery-prototype.html) 08:17:32 INFO - PROCESS | 9100 | RSS: Main: 152727552 08:17:32 INFO - PROCESS | 9100 | 08:20:34 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47099/tests/dromaeo/cssquery-yui.html) 08:20:35 INFO - PROCESS | 9100 | RSS: Main: 153235456 08:20:35 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | Cycle 1(1): loaded http://localhost:47099/tests/dromaeo/cssquery-yui.html (next: http://localhost:47099/tests/dromaeo/cssquery-dojo.html) 08:23:37 INFO - PROCESS | 9100 | RSS: Main: 155414528 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | __start_tp_report 08:23:37 INFO - PROCESS | 9100 | _x_x_mozilla_page_load 08:23:37 INFO - PROCESS | 9100 | _x_x_mozilla_page_load_details 08:23:37 INFO - PROCESS | 9100 | |i|pagename|runs| 08:23:37 INFO - PROCESS | 9100 | |0;dojo.html;3155.8264295463755;3196.2968147007664;3204.9839750801243;3231.418344697954;3237.870485180593;5286.603504737151;5394.6493477923905;5451.754671039807;5461.9453805461935;5495.148252020933;5298.072837253475;5350;5400.945990540094;5439.782408703657;5457.617966742329;4969.577585905194;4990.950090499085;5063.949360506403;5070.645054846163;5142.640015198937;5113.437521872591;5127.487251274862;5131.255967884655;5171.301874246985;5211.062008838408;4862.951370486286;4920.483349248331;4990.2265148901615;4995.950040499603;5000.849974500771;4976.651634385595;4986.601071914238;4988.476209997934;4992.450830408652;5055.9241611375855;4837;4977.527134922177;4982.725950072744;4987.226979818134;5016.924746128811;5199.532042116228;5213.296205012312;5223.399309079467;5242.318498595197;5359.3032905722;5623.49388555028;5849.356570777211;5849.5027922626205;5867.647941123546;5893.057110862284;5825.242718446617;5883.058710606282;5916.645001299936;5931.673757943311;5949.583529152961;5474.124140137598;5539.030669632838;5545.750441230154;5548.44515548446;5589.217509548666;5973.910391344133;5998.820035398945;6019.067044608005;6025.276966764016;6028.246469191351;5685.459881311269;5715.714214289352;5807.970960145172;5825.50483208932;5831.446012628793;5845.386234445407;5847.210626565445;5854.2096816930025;5860.941390586125;5884.146798714162;5757.510611597977;5770.5095066919785;5829.387914269026;5837.6497410155525;5839.065749480148;5656.490915817514;5804.970975145097;5816.82549523515;5868.941310586925;5961.612495187799;4514.187446259639;4520.909581808345;4527.705699129546;4538.341940418621;4555.271156614992;4007.979960100239;4023.114914718757;4032;4056.7363121397016;4067.145899361108;5444.50999410055;5448.182772584065;5540.639858409271;5574.968630803233;5577.135543990688;5852.4147585241135;5898.587098903035;5911.940880591225;5920.2007728956905;5949.970250148722;5543.750531226105;5576.386597474275;5581.49766521015;5592.384837667853;5600.159976003632;5048.040872234264;5063.012712521023;5115.514026167508;5135.640505164677;5155.432902380735;6055.7274922628585;6103.664298463627;6107.480864126599;6118.908216376758;6121.479674227651;5709;5991.700414979321;6015.6691381974415;6017.608855424383;6018.909716354346;5843.065109582446;5962.284525856925;5962.37395073511;5974.9402505974385;5999.940000599938;5708.772613888034;5802.1296805479515;5832.504237139721;5839.0949402842625;5848.94151058501;5809.2738407699035;5937;5944.613600115978;5949.375315591974;5955.493783028491;5756.971215143897;5766.452187042224;5837.620554663933;5849.8537536560225;5883.764649413975;5815.2149459822385;5828.0966450200285;5831.475167234969;5841.036229022334;5841.50347220491;5416.268803711606;5577.721113944368;5709.371969083314;5731.684757338387;5732.713364331683;5636;5644.125160600113;5768.740406681625;5773.653580785166;5814.912776308274;5690.914636280542;5705.857353566194;5714.628549144292;5734.283214598176;5753.280839895013 08:23:37 INFO - PROCESS | 9100 | |1;ext.html;600.072887388984;610.3713175429308;622.7975907829954;623.0840664223591;642.9871402571946;37645;38600;38651;38697.61302386975;38715.41926871095;38447.23105537888;38697.806510967406;38914.610853891456;39106;39242.41136382957;8400.453970491913;8603.225709686127;8627.913720862805;8635;8637.39538232324;8454.28138608219;8562;8594.054653988087;8614.44006139602;8620.181082797155;8533.104024077444;8603.741887743377;8660.783480413009;8675.045744968049;8695.347848911326;8380.539070351128;8450.915490845075;8488.490690558556;8496.277816385615;8518.190771876723;8356.080831108573;8469.74590762278;8519.574021298973;8530.317574594017;8532.6160322785;36797.81601091977;37055.81472092649;37381.43927841084;37437.43843842344;37494.437583435996;3318.2368055347165;3338.9499157512655;3363.445031569788;3392.6776956189124;3727.627237276278;28820.279493012633;29808.552871706943;30187.245318866986;30522.389552209053;30540.8472957636;3949.447077409165;4043.6158564936286;4098;4098.979505102485;4258.744475331459;266133;268543;269060.999999998;269339;269505;55220.17169742457;55869.72065139729;60480.69759651262;66841;68333;60709;61354;61668;61691.69154154201;61698.69150654308;14022.509212177525;14035.50875719345;14136.293185340692;14173.22047287409;14190.716185676229;10524.736881578021;10663.146948244277;10676.412797296069;10685.252032357661;10701.571937122584;20580.691289630668;20583.279585214445;20663.896680516802;20796.792032079484;20816.27143050016;7938.563379014095;8199.836003279901;8229;8260.752177434686;8272.545010024507;897.304588943574;903.5978989349808;984.3798407003542;1057.2335057083553;1064.1912146768511;27493.86253068762;27558.86220568884;27735.306617334325;28183;28283.717162828107;998.2662742883974;1017.6387382479113;1064.8296272596347;1090.5855774805682;1135.0295497349812;14548.49080282185;14626.488072917396;14662.413503459955;14674;14881.627959301104;384716;387133;387863;389269;390435;53853.461465385626;54088.45911540913;54211.999999999214;54288.72855635775;54397.72801136048;1300.0509627971444;1324.966875828112;1341.3829638366265;1342.2617560341969;1345.179440541269;26916.327091822863;27129.321766955985;27605.861970690017;27890.163295101178;27893.581596275668;43326;43405.78297108494;43664.781676091414;43670.781646091564;43891;289503;293909.5304523464;295798;296322;297264;32891;45502.91512417369;46383.304250436944;46767;46810.531894680615;43743.56256437395;43768.56231437772;44001.55998440103;44201;44426.333604996595;36975.630243698295;37115.8144209288;41887.581124189586;41966.16067678568;42067.7896610515;36184.81907590445;36815.63184368122;37166.814165929;37483;37705.245895081396;35646.82176589101;36072.4589131158;36313.818430907675;36597.268054638225;36687;31224.843875780476;31902.202444939063;33566.83216583901;34195.4870676945;34249.65750342465;25205.243842684748;25304.74695253024;25446.872765636796;25494.872525637253;25960.610590840774 08:23:37 INFO - PROCESS | 9100 | |2;jquery.html;314.0656546773348;321.31239148222795;337.9961514302522;358.8600445826128;359.8506619752803;16571.254293556787;16985;17805.198766055528;18241.723079384432;18517.44447666572;11152.776944461106;11227.831582526269;11370;11384.943075284613;11400.315981041143;4903.926441103386;4926.507349265063;5015.749212539358;5017.37282839645;5048.1670524363435;4992.07646585381;5008;5033.974830125844;5037.924431133536;5039.19372900336;5025.170846810291;5028.698278103326;5450.836474905759;5605.327360716699;5629.211910332557;5537.8061767837935;5572.3870374258795;5602.327720673505;5605.159226116095;5634.32388113427;5061.924071138936;5066.898662026776;5080.441151473335;5099.69401835891;5120.334356533627;12559.623211303675;13580;13584.864151358557;13622.114562553403;13642.386092625855;2005.9498512537157;2112.324056301984;2157.4067131538795;2190.912363505458;2199.3292045925987;9488.478133702643;9533.522304042885;9639.662611808553;9696.806063878683;9765.462899540522;1747.8951262924138;1800.8199180082017;1826.8995205263705;1846.3537761783268;1881.3791448821855;61797.6910115451;64471;64761.352386476006;65355.01967470539;65425;10308.072273495422;10491.370517768959;10507.684769456928;10520.894791052144;10555.261131720707;13467.528636497676;13482.191068535723;13487;13497.98765092622;13559.796603050961;7448.702051917862;7452.925470745223;7470.103587569418;7474.439417043744;7585.355244804143;7181.676824542908;7182.138143422718;7203.207647158808;7271.527350722186;7275.054242948383;4447.421835161408;4509.774511274423;4568.88577785558;4575.908481830411;4613.8846528836375;1871.5414723392855;1920.4814700030913;1961.8332441742612;1968.4586738646988;3119.2357872321427;863.9179277968583;901.454619954931;921.6728061538191;942.4062840410635;1013.5793645637126;16284.10437425953;16745.16274186286;16963.491095267163;17123.315067397412;17415.36539043233;874.2437791310471;901.7249738829589;1019.4953498018529;1031.6492392586406;1046.0951277145214;9727.951360243154;9797.951010245046;9804.705858824247;9807.852882206773;10019.699409017741;570398;575194;576349;581150;582966;77324;79294;82322;82575;83060.58469707613;1117.3072694929033;1124.533318672758;1131.6774719204986;1158.7798318319492;1161.0189389965465;15663.765043524585;15775.526734197992;15808.76286855721;15977.600559985629;16230.756538652166;36592.817035915716;36781.816090919376;38403;38437;38572.6142738569;48729.26906096482;49691.770034947614;50385.49614503955;51227.743861280454;52113.218301724744;9549.952250238704;9661.806763864824;9735.70792876215;9816.460094694861;9856.162226210565;12867.742645147231;17399.739003915205;17549.649007019532;17963.461096167135;17968.191431385356;14613.85386146125;14644.560663180122;14660.78008829847;14912.478063267734;15020.474283400028;14507.637309067357;14529.200893950934;14674.63313417173;14813.629659258604;15144.848551514344;14000;14154.150750954976;14621.122732636077;14902.925485372503;15376.615584610474;9469.384490008128;9590.712278631652;9597.040295970348;9688.079632434907;9694.709158725249;10234.33476824004;11625.825612615987;14762.114273143216;14941.477048303257;14992.625184370478 08:23:37 INFO - PROCESS | 9100 | |3;mootools.html;1531.7166324230025;1704.931802727891;1758.7186050231962;1775.8845675031123;1778.0842865924044;6595.175603049619;6784.050232967388;7181.605011724353;7296.7446139385065;7389.519681220717;7110.43116550676;7235.059442272497;7276.781696549112;7309.159446663635;7335.083114610674;2220.62249417599;2249.6850440938283;2274.3631783100677;2275.6814046033487;2279.8290128240365;2260.062074239189;2269.6595510673365;2336.3458231695154;2336.4509340305017;2340.1926335414255;2263.581237471065;2270.738865030526;2282.7488976212603;2285.90856365746;2287.3824067501846;2212.7012853264764;2232.743234528034;2244.5286489837154;2255.391044418014;2260.028187879211;2272.579572779041;2293.4266433391654;2293.5068960173644;2294.575503531852;2296.724393072842;7471.439642026816;7476.887846682304;7527.736529221451;7541;7543.886841697379;4496.685232033759;4555.157295900269;4570.7029043112425;4576.496585375606;4580.7938642761155;2990.2823322402683;2994.850257487117;3063.6170478690165;3079.337942342385;3096.8606412711256;971.489967766928;981.043482604455;1006.2654262388425;1017.4709151241387;1019.8674172357546;9762.170215531689;9814.803703925953;9847.409155450696;9914.355566888129;9923.503824808802;4043.353063509824;4085.8978525536504;4095.3242714952294;4155.667546596265;4177.665786737054;8527.829443411098;8552.657893684183;8554.486730796172;8563.700270490503;8609.870851937227;4504.166729155117;4506.459224892968;4520.638348932078;4522.88692782683;4530.592246697813;3742.66316031553;3831.731778775459;4107.979460102681;4119.711620186558;4142.730722503027;3586.9820650896577;3596.946045809315;3597.37046016946;3604.062943634621;3638.3450978824067;1179.8525184351956;1186.691460220349;1192.2488832035763;1195.9581414650445;1204.8614409342863;1327.734453109382;1328.0371730495312;1342.664333916521;1342.90599658023;1351.7904724767677;6904.827379315558;7090.92909070913;7137;7148.320909513588;7164.391026762679;1102.3771569063454;1117;1119.764849381639;1129.4804389980536;1153.140910022039;5553.527950124285;5605.103183490622;5621.18492818539;5629.211910332557;5637.323521177403;8683.305335573139;8698.695545655872;8956.507392093497;8962.641494340283;8977.775555611031;8792.47245165292;8795.208431241092;8809.471431714117;8809.823803523894;8818.559072046372;6844.041834143224;6918.827029324307;6981.825454363681;7035.155781306276;7084.43324534036;6827.829304267234;6864.073350097673;6881.277465866212;6882.414994725505;6886.10480637514;7638.961805190938;7945.920540794518;7975.601219939096;8052.396070294634;8179.79550511242;7965.402594805297;8205.302549283379;8240.175982401712;8256.298214651582;8258.42191046645;6518.282988871315;6847.486438517031;6857.451403887777;6857.691403886737;6867.278935711678;7302.853942921218;7325.084364454443;7341.632918353954;7341.816454588678;7344.339009489172;6666.699998499982;6869.965650171717;6875.3812156906115;6939.410150137295;6977.511574189961;6792.898106528505;6845;6876.106106206161;6890;6919.37725604698;6690.799276021728;6769.187697476137;6779.983002549657;6812.352826481477;6818.249992500921;6208.565400421927;6259.718312676032;6282.371762823681;6286.65423401699;6302.306746257999;6326.177596912372;6365.77719779824;6389.456896163878;6397.104405383157;6407.199100112486 08:23:37 INFO - PROCESS | 9100 | |4;prototype.html;329.823544403744;338.10402433551087;343.52421895674485;343.5568117128904;349.3781069695942;6366.777162799292;6386.8403289917715;6413.583117097392;6437.678116094194;6537;6309.684515774205;6314.431701146896;6327.683615819202;6340.080688300193;6363.586366886149;4779.545943135397;4780.90438191236;4781.880452988686;4786.497417771127;4788.449328327235;4765.952340476586;4786.042791441708;4790.736509491977;4793.2810078488155;4793.945332026949;4637.350770892078;4714.481407045222;4725.362076119732;4736.100140973222;4740.928886066712;4707.529247075282;4708.128996135726;4725.503822098682;4730.148573256813;4758.405199350082;4104.794760261975;4119.855805046839;4121.711480196387;4125.319322311815;4128.318827393477;6023.488003519706;6056.3338032816355;6057.969710151421;6064.423879731418;6066.514678825683;5452.482014208644;5539.279893613845;5562.16567514872;5575.303087114111;5591.30108736408;6711;6720.462363010996;6721.731130754764;6728.798136055926;6731.495137864631;4586.701864378838;4590.242609969351;4591.6556258280425;4604.6776725629215;4606.401167848192;6731.798046058626;6887.931120688779;6928.757493487754;6935.3411425914455;6994;4651.488336283006;4662.7668616569035;4675.13510000651;4675.205215113371;4684.578387945101;4705.529447055335;4708.976455117702;4714.104320179155;4721.055788842245;4735.21868891629;5504.119340905436;5511.118221084607;5528.889422211533;5537.141743029837;5543.307086614173;6632.801015969529;6741.966290168518;6743.797686069426;6767.578808450182;6775.254721980578;1623.6509150532456;1653.4791540664653;1665.691847008283;1666.983330166707;1669.1487341455702;1060.5863713151723;1099.142668718401;1112.7718817642365;1113.6714669172452;1122.320995797547;6423.678816059179;6427.58220715652;6437.0988061671405;6442.710078046499;6447.065175549519;6809.897851532231;6861.691223894937;6867.141607299088;6881.483888708367;6892.620905850126;6339.651319177489;6371.52213583983;6403.711832967528;6413.647249401234;6434.227892652912;3781.205946751158;3805.0867791729784;3808.619138086169;3808.8286027128847;3812.8284227209842;7145.1425828900865;7167.211606723256;7190;7195.856082878313;7227.951946967661;7095.645217739196;7177.282271772885;7224.13310402755;7247.9637601811655;7269.6728647211;7195.280471952763;7202.3517883389695;7209.747658831916;7215.422766178693;7222.566646001152;7015.123109611299;7057.717691292496;7061.082059332254;7062;7074.434045276468;6804.795856124324;6976.337247961435;6977.058097157022;6982.301769822977;6984;7173.677184526605;7186.856262874818;7193.640317983975;7197.71209151628;7201.747938822116;4583.060472603175;4605.756445759559;4610.446746390455;4633.698809577501;4635.212013957703;6706.195256569243;6890.758823441155;6909.412699920563;7024.227334993045;7051.858962820817;6669.966650166718;6817.931820681928;6818.590884546943;6828.556143850634;6869.175698915962;6793.320667933365;6808.319168083152;6814.488913331421;6819.5908245505425;6823.351781580742;6520.380563846427;6663.733450661919;6664.466842652673;6664.900026499703;6667.8666426670225;6787.185537735503;6838.692258848264;6843.555168914005;6846.760363387258;6850.417714494324;6617.636030018395;6637.767678131242;6641.169853768279;6658.1344425224415;6667 08:23:37 INFO - PROCESS | 9100 | |5;yui.html;652.3476523476523;680.3570625758658;737.9372753315968;771.8533478639055;809.6720828064632;13941.721165576682;14024.228667423287;14035.087719298239;14036.578902632911;14121.929390353047;13373.197608143519;13512.324383780797;13527.594172174826;13531.255780932044;13561.25413102279;826.8470332988417;832.4880198677815;847.1782371100023;847.8855354527121;848.0247715127591;838.2958315015386;852.5609311204735;856.0583358305876;856.1010938514565;860.5181098584782;878.8110556230409;897.0267260022883;897.2328658996562;898.2454738020061;901.1079031758545;885.5616469847434;886.2245535156737;886.4636894678691;886.8669699545055;888.5512816027897;645;648.2998361769278;651.8728847874667;653.0954627840475;655.4232275597444;13509.459621615124;13589.116707414085;13625;13631.591052268448;13660.316984150852;11770.117241206945;12017.63947081589;12286.815697764541;12310.199837010656;12572.874271257262;9611.423314601147;9708;9709.077637624414;9825.90174098257;10201.744956376077;3566.4293713005795;3591.7844929304324;3602.441621548664;3653.1232504199065;3720.0513868963512;48165.27752083722;48266.7586662068;48379.75810120962;48695.756521217525;48806.339524535804;8799.824003519894;9301.34890557668;9342.95328523353;9345.859812102824;9486.857697134548;17140.742888856676;17298.394556190724;17312.701547383997;17327.91336043312;17362.13189340553;7222.09723784527;7239.529430586995;7290.088738907637;7436.553806771502;7505.099388073466;4025.1748391579654;4033.878983630496;4042.6159514846045;4058.2086493133556;4071.77846646005;3082.352705931735;3110.331278775074;3115.8909438169553;3118.6881311868633;3128.124125244935;539.54947618738;552.7070652554153;554.1659801998047;555.9722013899288;567.3305499510535;497.19702680171264;619.8729260501586;658.9703463344161;659.7921654678761;728.0971595221993;8108.351331893435;8148.307393871469;8175;8180.9590952044855;8398.412111152284;636.9713362898681;675.2167485716545;678.1895634716565;695.7043256615918;703.8944158376182;3862.304785138646;4131.173765246963;4169.038062763254;4181.226473102486;4184.602462766033;56294.437055629736;56646.716766415906;57151.714241428526;57159;57287.713561432756;50118.74940625347;51771.48228517742;52178;52295;52296;47159.764201178776;47163.76418117956;47704.76147619309;47808;49741.502584973685;7999.800004999922;8224.42586643784;8264;8353.634890172856;8420;36092;36299.63700362963;36303;36621.450678240384;36823.44764828583;40384;44333;45756.542434575225;45869;46736.29895551637;10831;10837.729056773644;11015.559377625126;11156.49795759209;11218.270812397168;11821.645350639494;11962.760744784882;12092.879071209176;12261.080418968791;12662.176958497668;11082.279651822606;11127.276727012719;11270.549178032787;11426.828597570877;11641.152197984913;10613.198171337583;10676.946615267185;10738.677839664822;10804.67585972422;11607.245529040585;10093.949530252301;10200.489975501047;10664.626738064131;10690;11021.44892755375;9602.183814375856;9630.181434577858;9735.367201131903;9753.268504862022;10247.538860751432;9301.581428835583;9354.29842761782;9451.716448506555;9724;9923.40459572428 08:23:37 INFO - PROCESS | 9100 | __end_tp_report 08:23:37 INFO - PROCESS | 9100 | __start_cc_report 08:23:37 INFO - PROCESS | 9100 | _x_x_mozilla_cycle_collect,309 08:23:37 INFO - PROCESS | 9100 | __end_cc_report 08:23:37 INFO - PROCESS | 9100 | __startTimestamp1450801417702__endTimestamp 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | ------- Summary: start ------- 08:23:37 INFO - PROCESS | 9100 | Number of tests: 6 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#0] dojo.html Cycles:165 Average:5455.50 Median:5690.91 stddev:611.18 (10.7%) stddev-sans-first:585.82 08:23:37 INFO - PROCESS | 9100 | Values: 3155.8 3196.3 3205.0 3231.4 3237.9 5286.6 5394.6 5451.8 5461.9 5495.1 5298.1 5350.0 5400.9 5439.8 5457.6 4969.6 4991.0 5063.9 5070.6 5142.6 5113.4 5127.5 5131.3 5171.3 5211.1 4863.0 4920.5 4990.2 4996.0 5000.8 4976.7 4986.6 4988.5 4992.5 5055.9 4837.0 4977.5 4982.7 4987.2 5016.9 5199.5 5213.3 5223.4 5242.3 5359.3 5623.5 5849.4 5849.5 5867.6 5893.1 5825.2 5883.1 5916.6 5931.7 5949.6 5474.1 5539.0 5545.8 5548.4 5589.2 5973.9 5998.8 6019.1 6025.3 6028.2 5685.5 5715.7 5808.0 5825.5 5831.4 5845.4 5847.2 5854.2 5860.9 5884.1 5757.5 5770.5 5829.4 5837.6 5839.1 5656.5 5805.0 5816.8 5868.9 5961.6 4514.2 4520.9 4527.7 4538.3 4555.3 4008.0 4023.1 4032.0 4056.7 4067.1 5444.5 5448.2 5540.6 5575.0 5577.1 5852.4 5898.6 5911.9 5920.2 5950.0 5543.8 5576.4 5581.5 5592.4 5600.2 5048.0 5063.0 5115.5 5135.6 5155.4 6055.7 6103.7 6107.5 6118.9 6121.5 5709.0 5991.7 6015.7 6017.6 6018.9 5843.1 5962.3 5962.4 5974.9 5999.9 5708.8 5802.1 5832.5 5839.1 5848.9 5809.3 5937.0 5944.6 5949.4 5955.5 5757.0 5766.5 5837.6 5849.9 5883.8 5815.2 5828.1 5831.5 5841.0 5841.5 5416.3 5577.7 5709.4 5731.7 5732.7 5636.0 5644.1 5768.7 5773.7 5814.9 5690.9 5705.9 5714.6 5734.3 5753.3 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#1] ext.html Cycles:180 Average:48707.80 Median:211581.62 stddev:84309.00 (39.8%) stddev-sans-first:84468.13 08:23:37 INFO - PROCESS | 9100 | Values: 600.1 610.4 622.8 623.1 643.0 37645.0 38600.0 38651.0 38697.6 38715.4 38447.2 38697.8 38914.6 39106.0 39242.4 8400.5 8603.2 8627.9 8635.0 8637.4 8454.3 8562.0 8594.1 8614.4 8620.2 8533.1 8603.7 8660.8 8675.0 8695.3 8380.5 8450.9 8488.5 8496.3 8518.2 8356.1 8469.7 8519.6 8530.3 8532.6 36797.8 37055.8 37381.4 37437.4 37494.4 3318.2 3338.9 3363.4 3392.7 3727.6 28820.3 29808.6 30187.2 30522.4 30540.8 3949.4 4043.6 4098.0 4099.0 4258.7 266133.0 268543.0 269061.0 269339.0 269505.0 55220.2 55869.7 60480.7 66841.0 68333.0 60709.0 61354.0 61668.0 61691.7 61698.7 14022.5 14035.5 14136.3 14173.2 14190.7 10524.7 10663.1 10676.4 10685.3 10701.6 20580.7 20583.3 20663.9 20796.8 20816.3 7938.6 8199.8 8229.0 8260.8 8272.5 897.3 903.6 984.4 1057.2 1064.2 27493.9 27558.9 27735.3 28183.0 28283.7 998.3 1017.6 1064.8 1090.6 1135.0 14548.5 14626.5 14662.4 14674.0 14881.6 384716.0 387133.0 387863.0 389269.0 390435.0 53853.5 54088.5 54212.0 54288.7 54397.7 1300.1 1325.0 1341.4 1342.3 1345.2 26916.3 27129.3 27605.9 27890.2 27893.6 43326.0 43405.8 43664.8 43670.8 43891.0 289503.0 293909.5 295798.0 296322.0 297264.0 32891.0 45502.9 46383.3 46767.0 46810.5 43743.6 43768.6 44001.6 44201.0 44426.3 36975.6 37115.8 41887.6 41966.2 42067.8 36184.8 36815.6 37166.8 37483.0 37705.2 35646.8 36072.5 36313.8 36597.3 36687.0 31224.8 31902.2 33566.8 34195.5 34249.7 25205.2 25304.7 25446.9 25494.9 25960.6 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#2] jquery.html Cycles:180 Average:29931.28 Median:36687.32 stddev:94370.81 (257.2%) stddev-sans-first:94609.34 08:23:37 INFO - PROCESS | 9100 | Values: 314.1 321.3 338.0 358.9 359.9 16571.3 16985.0 17805.2 18241.7 18517.4 11152.8 11227.8 11370.0 11384.9 11400.3 4903.9 4926.5 5015.7 5017.4 5048.2 4992.1 5008.0 5034.0 5037.9 5039.2 5025.2 5028.7 5450.8 5605.3 5629.2 5537.8 5572.4 5602.3 5605.2 5634.3 5061.9 5066.9 5080.4 5099.7 5120.3 12559.6 13580.0 13584.9 13622.1 13642.4 2005.9 2112.3 2157.4 2190.9 2199.3 9488.5 9533.5 9639.7 9696.8 9765.5 1747.9 1800.8 1826.9 1846.4 1881.4 61797.7 64471.0 64761.4 65355.0 65425.0 10308.1 10491.4 10507.7 10520.9 10555.3 13467.5 13482.2 13487.0 13498.0 13559.8 7448.7 7452.9 7470.1 7474.4 7585.4 7181.7 7182.1 7203.2 7271.5 7275.1 4447.4 4509.8 4568.9 4575.9 4613.9 1871.5 1920.5 1961.8 1968.5 3119.2 863.9 901.5 921.7 942.4 1013.6 16284.1 16745.2 16963.5 17123.3 17415.4 874.2 901.7 1019.5 1031.6 1046.1 9728.0 9798.0 9804.7 9807.9 10019.7 570398.0 575194.0 576349.0 581150.0 582966.0 77324.0 79294.0 82322.0 82575.0 83060.6 1117.3 1124.5 1131.7 1158.8 1161.0 15663.8 15775.5 15808.8 15977.6 16230.8 36592.8 36781.8 38403.0 38437.0 38572.6 48729.3 49691.8 50385.5 51227.7 52113.2 9550.0 9661.8 9735.7 9816.5 9856.2 12867.7 17399.7 17549.6 17963.5 17968.2 14613.9 14644.6 14660.8 14912.5 15020.5 14507.6 14529.2 14674.6 14813.6 15144.8 14000.0 14154.2 14621.1 14902.9 15376.6 9469.4 9590.7 9597.0 9688.1 9694.7 10234.3 11625.8 14762.1 14941.5 14992.6 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#3] mootools.html Cycles:180 Average:5261.35 Median:6393.28 stddev:2627.33 (41.1%) stddev-sans-first:2619.75 08:23:37 INFO - PROCESS | 9100 | Values: 1531.7 1704.9 1758.7 1775.9 1778.1 6595.2 6784.1 7181.6 7296.7 7389.5 7110.4 7235.1 7276.8 7309.2 7335.1 2220.6 2249.7 2274.4 2275.7 2279.8 2260.1 2269.7 2336.3 2336.5 2340.2 2263.6 2270.7 2282.7 2285.9 2287.4 2212.7 2232.7 2244.5 2255.4 2260.0 2272.6 2293.4 2293.5 2294.6 2296.7 7471.4 7476.9 7527.7 7541.0 7543.9 4496.7 4555.2 4570.7 4576.5 4580.8 2990.3 2994.9 3063.6 3079.3 3096.9 971.5 981.0 1006.3 1017.5 1019.9 9762.2 9814.8 9847.4 9914.4 9923.5 4043.4 4085.9 4095.3 4155.7 4177.7 8527.8 8552.7 8554.5 8563.7 8609.9 4504.2 4506.5 4520.6 4522.9 4530.6 3742.7 3831.7 4108.0 4119.7 4142.7 3587.0 3596.9 3597.4 3604.1 3638.3 1179.9 1186.7 1192.2 1196.0 1204.9 1327.7 1328.0 1342.7 1342.9 1351.8 6904.8 7090.9 7137.0 7148.3 7164.4 1102.4 1117.0 1119.8 1129.5 1153.1 5553.5 5605.1 5621.2 5629.2 5637.3 8683.3 8698.7 8956.5 8962.6 8977.8 8792.5 8795.2 8809.5 8809.8 8818.6 6844.0 6918.8 6981.8 7035.2 7084.4 6827.8 6864.1 6881.3 6882.4 6886.1 7639.0 7945.9 7975.6 8052.4 8179.8 7965.4 8205.3 8240.2 8256.3 8258.4 6518.3 6847.5 6857.5 6857.7 6867.3 7302.9 7325.1 7341.6 7341.8 7344.3 6666.7 6870.0 6875.4 6939.4 6977.5 6792.9 6845.0 6876.1 6890.0 6919.4 6690.8 6769.2 6780.0 6812.4 6818.2 6208.6 6259.7 6282.4 6286.7 6302.3 6326.2 6365.8 6389.5 6397.1 6407.2 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#4] prototype.html Cycles:180 Average:5610.50 Median:6413.62 stddev:1724.47 (26.9%) stddev-sans-first:1683.15 08:23:37 INFO - PROCESS | 9100 | Values: 329.8 338.1 343.5 343.6 349.4 6366.8 6386.8 6413.6 6437.7 6537.0 6309.7 6314.4 6327.7 6340.1 6363.6 4779.5 4780.9 4781.9 4786.5 4788.4 4766.0 4786.0 4790.7 4793.3 4793.9 4637.4 4714.5 4725.4 4736.1 4740.9 4707.5 4708.1 4725.5 4730.1 4758.4 4104.8 4119.9 4121.7 4125.3 4128.3 6023.5 6056.3 6058.0 6064.4 6066.5 5452.5 5539.3 5562.2 5575.3 5591.3 6711.0 6720.5 6721.7 6728.8 6731.5 4586.7 4590.2 4591.7 4604.7 4606.4 6731.8 6887.9 6928.8 6935.3 6994.0 4651.5 4662.8 4675.1 4675.2 4684.6 4705.5 4709.0 4714.1 4721.1 4735.2 5504.1 5511.1 5528.9 5537.1 5543.3 6632.8 6742.0 6743.8 6767.6 6775.3 1623.7 1653.5 1665.7 1667.0 1669.1 1060.6 1099.1 1112.8 1113.7 1122.3 6423.7 6427.6 6437.1 6442.7 6447.1 6809.9 6861.7 6867.1 6881.5 6892.6 6339.7 6371.5 6403.7 6413.6 6434.2 3781.2 3805.1 3808.6 3808.8 3812.8 7145.1 7167.2 7190.0 7195.9 7228.0 7095.6 7177.3 7224.1 7248.0 7269.7 7195.3 7202.4 7209.7 7215.4 7222.6 7015.1 7057.7 7061.1 7062.0 7074.4 6804.8 6976.3 6977.1 6982.3 6984.0 7173.7 7186.9 7193.6 7197.7 7201.7 4583.1 4605.8 4610.4 4633.7 4635.2 6706.2 6890.8 6909.4 7024.2 7051.9 6670.0 6817.9 6818.6 6828.6 6869.2 6793.3 6808.3 6814.5 6819.6 6823.4 6520.4 6663.7 6664.5 6664.9 6667.9 6787.2 6838.7 6843.6 6846.8 6850.4 6617.6 6637.8 6641.2 6658.1 6667.0 08:23:37 INFO - PROCESS | 9100 | 08:23:37 INFO - PROCESS | 9100 | [#5] yui.html Cycles:180 Average:13788.79 Median:24651.77 stddev:16115.50 (65.4%) stddev-sans-first:16130.52 08:23:37 INFO - PROCESS | 9100 | Values: 652.3 680.4 737.9 771.9 809.7 13941.7 14024.2 14035.1 14036.6 14121.9 13373.2 13512.3 13527.6 13531.3 13561.3 826.8 832.5 847.2 847.9 848.0 838.3 852.6 856.1 856.1 860.5 878.8 897.0 897.2 898.2 901.1 885.6 886.2 886.5 886.9 888.6 645.0 648.3 651.9 653.1 655.4 13509.5 13589.1 13625.0 13631.6 13660.3 11770.1 12017.6 12286.8 12310.2 12572.9 9611.4 9708.0 9709.1 9825.9 10201.7 3566.4 3591.8 3602.4 3653.1 3720.1 48165.3 48266.8 48379.8 48695.8 48806.3 8799.8 9301.3 9343.0 9345.9 9486.9 17140.7 17298.4 17312.7 17327.9 17362.1 7222.1 7239.5 7290.1 7436.6 7505.1 4025.2 4033.9 4042.6 4058.2 4071.8 3082.4 3110.3 3115.9 3118.7 3128.1 539.5 552.7 554.2 556.0 567.3 497.2 619.9 659.0 659.8 728.1 8108.4 8148.3 8175.0 8181.0 8398.4 637.0 675.2 678.2 695.7 703.9 3862.3 4131.2 4169.0 4181.2 4184.6 56294.4 56646.7 57151.7 57159.0 57287.7 50118.7 51771.5 52178.0 52295.0 52296.0 47159.8 47163.8 47704.8 47808.0 49741.5 7999.8 8224.4 8264.0 8353.6 8420.0 36092.0 36299.6 36303.0 36621.5 36823.4 40384.0 44333.0 45756.5 45869.0 46736.3 10831.0 10837.7 11015.6 11156.5 11218.3 11821.6 11962.8 12092.9 12261.1 12662.2 11082.3 11127.3 11270.5 11426.8 11641.2 10613.2 10676.9 10738.7 10804.7 11607.2 10093.9 10200.5 10664.6 10690.0 11021.4 9602.2 9630.2 9735.4 9753.3 10247.5 9301.6 9354.3 9451.7 9724.0 9923.4 08:23:37 INFO - PROCESS | 9100 | -------- Summary: end -------- 08:23:37 INFO - PROCESS | 9100 | 08:23:38 INFO - TEST-INFO | 9100: exit 0 08:23:38 INFO - TEST-OK | dromaeo_css | took 1110406ms 08:23:38 INFO - TEST-START | kraken 08:23:38 INFO - operating with platform_type : linux_ 08:23:38 INFO - Initialising browser for kraken test... 08:23:38 INFO - TEST-INFO | started process 9347 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3RJpK5/profile http://localhost:47099/getInfo.html) 08:23:43 INFO - PROCESS | 9347 | __metrics Screen width/height:1600/1200 08:23:43 INFO - PROCESS | 9347 | colorDepth:24 08:23:43 INFO - PROCESS | 9347 | Browser inner width/height: 1024/697 08:23:43 INFO - PROCESS | 9347 | __metrics 08:23:43 INFO - PROCESS | 9347 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:23:43 INFO - TEST-INFO | 9347: exit 0 08:23:43 INFO - Browser initialized. 08:23:43 INFO - Running cycle 1/1 for kraken test... 08:23:44 INFO - TEST-INFO | started process 9470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3RJpK5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:55 INFO - PROCESS | 9470 | RSS: Main: 150990848 08:23:55 INFO - PROCESS | 9470 | 08:23:58 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47099/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:58 INFO - PROCESS | 9470 | RSS: Main: 152850432 08:23:58 INFO - PROCESS | 9470 | 08:24:01 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47099/tests/kraken/driver.html?testName=audio-dft) 08:24:02 INFO - PROCESS | 9470 | RSS: Main: 151683072 08:24:02 INFO - PROCESS | 9470 | 08:24:04 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47099/tests/kraken/driver.html?testName=audio-fft) 08:24:05 INFO - PROCESS | 9470 | RSS: Main: 146288640 08:24:05 INFO - PROCESS | 9470 | 08:24:07 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47099/tests/kraken/driver.html?testName=audio-oscillator) 08:24:08 INFO - PROCESS | 9470 | RSS: Main: 146370560 08:24:08 INFO - PROCESS | 9470 | 08:24:10 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:11 INFO - PROCESS | 9470 | RSS: Main: 147587072 08:24:11 INFO - PROCESS | 9470 | 08:24:14 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47099/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:14 INFO - PROCESS | 9470 | RSS: Main: 147939328 08:24:14 INFO - PROCESS | 9470 | 08:24:18 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47099/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:18 INFO - PROCESS | 9470 | RSS: Main: 148283392 08:24:18 INFO - PROCESS | 9470 | 08:24:21 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47099/tests/kraken/driver.html?testName=json-parse-financial) 08:24:22 INFO - PROCESS | 9470 | RSS: Main: 148246528 08:24:22 INFO - PROCESS | 9470 | 08:24:23 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:24 INFO - PROCESS | 9470 | RSS: Main: 149069824 08:24:24 INFO - PROCESS | 9470 | 08:24:26 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:26 INFO - PROCESS | 9470 | RSS: Main: 147828736 08:24:26 INFO - PROCESS | 9470 | 08:24:28 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:29 INFO - PROCESS | 9470 | RSS: Main: 148398080 08:24:29 INFO - PROCESS | 9470 | 08:24:31 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:32 INFO - PROCESS | 9470 | RSS: Main: 148205568 08:24:32 INFO - PROCESS | 9470 | 08:24:34 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:35 INFO - PROCESS | 9470 | RSS: Main: 149745664 08:24:35 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | Cycle 1(1): loaded http://localhost:47099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47099/tests/kraken/driver.html?testName=ai-astar) 08:24:37 INFO - PROCESS | 9470 | RSS: Main: 150294528 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | __start_tp_report 08:24:37 INFO - PROCESS | 9470 | _x_x_mozilla_page_load 08:24:37 INFO - PROCESS | 9470 | _x_x_mozilla_page_load_details 08:24:37 INFO - PROCESS | 9470 | |i|pagename|runs| 08:24:37 INFO - PROCESS | 9470 | |0;ai-astar;112;107;110;114;111;125;111;112;110;112 08:24:37 INFO - PROCESS | 9470 | |1;audio-beat-detection;152;123;153;159;128;149;159;126;168;124 08:24:37 INFO - PROCESS | 9470 | |2;audio-dft;161;163;161;165;162;161;160;164;167;165 08:24:37 INFO - PROCESS | 9470 | |3;audio-fft;71;71;73;71;71;72;132;72;72;75 08:24:37 INFO - PROCESS | 9470 | |4;audio-oscillator;93;93;146;94;95;93;135;93;93;141 08:24:37 INFO - PROCESS | 9470 | |5;imaging-gaussian-blur;110;111;111;110;111;111;111;111;110;110 08:24:37 INFO - PROCESS | 9470 | |6;imaging-darkroom;146;147;146;147;147;146;147;147;147;146 08:24:37 INFO - PROCESS | 9470 | |7;imaging-desaturate;96;97;96;96;97;97;96;96;96;96 08:24:37 INFO - PROCESS | 9470 | |8;json-parse-financial;62;59;62;60;59;59;60;58;56;59 08:24:37 INFO - PROCESS | 9470 | |9;json-stringify-tinderbox;67;72;68;69;69;69;69;68;69;70 08:24:37 INFO - PROCESS | 9470 | |10;stanford-crypto-aes;85;86;85;87;86;87;85;86;86;88 08:24:37 INFO - PROCESS | 9470 | |11;stanford-crypto-ccm;123;122;123;117;127;125;118;128;126;139 08:24:37 INFO - PROCESS | 9470 | |12;stanford-crypto-pbkdf2;150;156;141;147;141;141;153;147;151;140 08:24:37 INFO - PROCESS | 9470 | |13;stanford-crypto-sha256-iterative;69;66;71;70;67;70;66;69;66;68 08:24:37 INFO - PROCESS | 9470 | __end_tp_report 08:24:37 INFO - PROCESS | 9470 | __start_cc_report 08:24:37 INFO - PROCESS | 9470 | _x_x_mozilla_cycle_collect,727 08:24:37 INFO - PROCESS | 9470 | __end_cc_report 08:24:37 INFO - PROCESS | 9470 | __startTimestamp1450801477495__endTimestamp 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | ------- Summary: start ------- 08:24:37 INFO - PROCESS | 9470 | Number of tests: 14 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.79 (4.3%) stddev-sans-first:5.08 08:24:37 INFO - PROCESS | 9470 | Values: 112.0 107.0 110.0 114.0 111.0 125.0 111.0 112.0 110.0 112.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:152.50 stddev:17.05 (11.2%) stddev-sans-first:17.85 08:24:37 INFO - PROCESS | 9470 | Values: 152.0 123.0 153.0 159.0 128.0 149.0 159.0 126.0 168.0 124.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:2.28 (1.4%) stddev-sans-first:2.32 08:24:37 INFO - PROCESS | 9470 | Values: 161.0 163.0 161.0 165.0 162.0 161.0 160.0 164.0 167.0 165.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#3] audio-fft Cycles:10 Average:78.00 Median:72.00 stddev:19.01 (26.4%) stddev-sans-first:20.00 08:24:37 INFO - PROCESS | 9470 | Values: 71.0 71.0 73.0 71.0 71.0 72.0 132.0 72.0 72.0 75.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:22.97 (24.7%) stddev-sans-first:23.75 08:24:37 INFO - PROCESS | 9470 | Values: 93.0 93.0 146.0 94.0 95.0 93.0 135.0 93.0 93.0 141.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:24:37 INFO - PROCESS | 9470 | Values: 110.0 111.0 111.0 110.0 111.0 111.0 111.0 111.0 110.0 110.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:24:37 INFO - PROCESS | 9470 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:24:37 INFO - PROCESS | 9470 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.50 stddev:1.78 (3.0%) stddev-sans-first:1.62 08:24:37 INFO - PROCESS | 9470 | Values: 62.0 59.0 62.0 60.0 59.0 59.0 60.0 58.0 56.0 59.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.20 08:24:37 INFO - PROCESS | 9470 | Values: 67.0 72.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 70.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 08:24:37 INFO - PROCESS | 9470 | Values: 85.0 86.0 85.0 87.0 86.0 87.0 85.0 86.0 86.0 88.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:6.14 (4.9%) stddev-sans-first:6.48 08:24:37 INFO - PROCESS | 9470 | Values: 123.0 122.0 123.0 117.0 127.0 125.0 118.0 128.0 126.0 139.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:148.50 stddev:5.76 (3.9%) stddev-sans-first:5.98 08:24:37 INFO - PROCESS | 9470 | Values: 150.0 156.0 141.0 147.0 141.0 141.0 153.0 147.0 151.0 140.0 08:24:37 INFO - PROCESS | 9470 | 08:24:37 INFO - PROCESS | 9470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.87 (2.7%) stddev-sans-first:1.96 08:24:37 INFO - PROCESS | 9470 | Values: 69.0 66.0 71.0 70.0 67.0 70.0 66.0 69.0 66.0 68.0 08:24:37 INFO - PROCESS | 9470 | -------- Summary: end -------- 08:24:37 INFO - PROCESS | 9470 | 08:24:38 INFO - TEST-INFO | 9470: exit 0 08:24:38 INFO - TEST-OK | kraken | took 59956ms 08:24:38 INFO - TEST-START | v8_7 08:24:38 INFO - operating with platform_type : linux_ 08:24:38 INFO - Initialising browser for v8_7 test... 08:24:38 INFO - TEST-INFO | started process 9756 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqq3Cy5/profile http://localhost:47099/getInfo.html) 08:24:42 INFO - PROCESS | 9756 | __metrics Screen width/height:1600/1200 08:24:42 INFO - PROCESS | 9756 | colorDepth:24 08:24:42 INFO - PROCESS | 9756 | Browser inner width/height: 1024/697 08:24:42 INFO - PROCESS | 9756 | __metrics 08:24:42 INFO - PROCESS | 9756 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:24:43 INFO - TEST-INFO | 9756: exit 0 08:24:43 INFO - Browser initialized. 08:24:43 INFO - Running cycle 1/1 for v8_7 test... 08:24:43 INFO - TEST-INFO | started process 9875 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqq3Cy5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:55 INFO - PROCESS | 9875 | RSS: Main: 151228416 08:24:55 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | Cycle 1(1): loaded http://localhost:47099/tests/v8_7/run.html (next: http://localhost:47099/tests/v8_7/run.html) 08:25:17 INFO - PROCESS | 9875 | RSS: Main: 146808832 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | __start_tp_report 08:25:17 INFO - PROCESS | 9875 | _x_x_mozilla_page_load 08:25:17 INFO - PROCESS | 9875 | _x_x_mozilla_page_load_details 08:25:17 INFO - PROCESS | 9875 | |i|pagename|runs| 08:25:17 INFO - PROCESS | 9875 | |0;Richards;166.75004168751042 08:25:17 INFO - PROCESS | 9875 | |1;DeltaBlue;188.00526414739613 08:25:17 INFO - PROCESS | 9875 | |2;Encrypt;279.9552071668533 08:25:17 INFO - PROCESS | 9875 | |3;Decrypt;5196.891191709845 08:25:17 INFO - PROCESS | 9875 | |4;RayTrace;1081.081081081081 08:25:17 INFO - PROCESS | 9875 | |5;Earley;750.7507507507507 08:25:17 INFO - PROCESS | 9875 | |6;Boyer;11916.666666666666 08:25:17 INFO - PROCESS | 9875 | |7;RegExp;25025 08:25:17 INFO - PROCESS | 9875 | |8;Splay;681.0176125244618 08:25:17 INFO - PROCESS | 9875 | |9;NavierStokes;4826.923076923077 08:25:17 INFO - PROCESS | 9875 | __end_tp_report 08:25:17 INFO - PROCESS | 9875 | __startTimestamp1450801517317__endTimestamp 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | ------- Summary: start ------- 08:25:17 INFO - PROCESS | 9875 | Number of tests: 10 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 166.8 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#1] DeltaBlue Cycles:1 Average:188.01 Median:188.01 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 188.0 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 280.0 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 5196.9 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 1081.1 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#5] Earley Cycles:1 Average:750.75 Median:750.75 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 750.8 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 11916.7 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 25025.0 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#8] Splay Cycles:1 Average:681.02 Median:681.02 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 681.0 08:25:17 INFO - PROCESS | 9875 | 08:25:17 INFO - PROCESS | 9875 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:25:17 INFO - PROCESS | 9875 | Values: 4826.9 08:25:17 INFO - PROCESS | 9875 | -------- Summary: end -------- 08:25:17 INFO - PROCESS | 9875 | 08:25:18 INFO - TEST-INFO | 9875: exit 0 08:25:18 INFO - TEST-OK | v8_7 | took 39828ms 08:25:18 INFO - SUITE-END | took 1210s 08:25:18 INFO - Completed test suite (00:20:10) 08:25:18 INFO - Working with test: dromaeo_css 08:25:18 INFO - Generating results file: dromaeo_css 08:25:18 INFO - Working with test: kraken 08:25:18 INFO - Generating results file: kraken 08:25:18 INFO - javascript benchmark 08:25:18 INFO - Working with test: v8_7 08:25:18 INFO - Generating results file: v8_7 08:25:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:25:18 INFO - process_Request line: dromaeo_css 7062.34 graph.html#tests=[[72,64,43]] 08:25:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:18 INFO - process_Request line: kraken 1512.70 graph.html#tests=[[232,64,43]] 08:25:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:18 INFO - process_Request line: v8_7 21060.57 graph.html#tests=[[230,64,43]] 08:25:18 INFO - RETURN: dromaeo_css: 7062.34 08:25:18 INFO - RETURN: kraken: 1512.70 08:25:18 INFO - RETURN: v8_7: 21060.57 08:25:18 INFO - javascript benchmark 08:25:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.8264295463755, 3196.2968147007664, 3204.9839750801243, 3231.418344697954, 3237.870485180593, 5286.603504737151, 5394.6493477923905, 5451.754671039807, 5461.9453805461935, 5495.148252020933, 5298.072837253475, 5350.0, 5400.945990540094, 5439.782408703657, 5457.617966742329, 4969.577585905194, 4990.950090499085, 5063.949360506403, 5070.645054846163, 5142.640015198937, 5113.437521872591, 5127.487251274862, 5131.255967884655, 5171.301874246985, 5211.062008838408, 4862.951370486286, 4920.483349248331, 4990.2265148901615, 4995.950040499603, 5000.849974500771, 4976.651634385595, 4986.601071914238, 4988.476209997934, 4992.450830408652, 5055.9241611375855, 4837.0, 4977.527134922177, 4982.725950072744, 4987.226979818134, 5016.924746128811, 5199.532042116228, 5213.296205012312, 5223.399309079467, 5242.318498595197, 5359.3032905722, 5623.49388555028, 5849.356570777211, 5849.5027922626205, 5867.647941123546, 5893.057110862284, 5825.242718446617, 5883.058710606282, 5916.645001299936, 5931.673757943311, 5949.583529152961, 5474.124140137598, 5539.030669632838, 5545.750441230154, 5548.44515548446, 5589.217509548666, 5973.910391344133, 5998.820035398945, 6019.067044608005, 6025.276966764016, 6028.246469191351, 5685.459881311269, 5715.714214289352, 5807.970960145172, 5825.50483208932, 5831.446012628793, 5845.386234445407, 5847.210626565445, 5854.2096816930025, 5860.941390586125, 5884.146798714162, 5757.510611597977, 5770.5095066919785, 5829.387914269026, 5837.6497410155525, 5839.065749480148, 5656.490915817514, 5804.970975145097, 5816.82549523515, 5868.941310586925, 5961.612495187799, 4514.187446259639, 4520.909581808345, 4527.705699129546, 4538.341940418621, 4555.271156614992, 4007.979960100239, 4023.114914718757, 4032.0, 4056.7363121397016, 4067.145899361108, 5444.50999410055, 5448.182772584065, 5540.639858409271, 5574.968630803233, 5577.135543990688, 5852.4147585241135, 5898.587098903035, 5911.940880591225, 5920.2007728956905, 5949.970250148722, 5543.750531226105, 5576.386597474275, 5581.49766521015, 5592.384837667853, 5600.159976003632, 5048.040872234264, 5063.012712521023, 5115.514026167508, 5135.640505164677, 5155.432902380735, 6055.7274922628585, 6103.664298463627, 6107.480864126599, 6118.908216376758, 6121.479674227651, 5709.0, 5991.700414979321, 6015.6691381974415, 6017.608855424383, 6018.909716354346, 5843.065109582446, 5962.284525856925, 5962.37395073511, 5974.9402505974385, 5999.940000599938, 5708.772613888034, 5802.1296805479515, 5832.504237139721, 5839.0949402842625, 5848.94151058501, 5809.2738407699035, 5937.0, 5944.613600115978, 5949.375315591974, 5955.493783028491, 5756.971215143897, 5766.452187042224, 5837.620554663933, 5849.8537536560225, 5883.764649413975, 5815.2149459822385, 5828.0966450200285, 5831.475167234969, 5841.036229022334, 5841.50347220491, 5416.268803711606, 5577.721113944368, 5709.371969083314, 5731.684757338387, 5732.713364331683, 5636.0, 5644.125160600113, 5768.740406681625, 5773.653580785166, 5814.912776308274, 5690.914636280542, 5705.857353566194, 5714.628549144292, 5734.283214598176, 5753.280839895013], "unit": "score", "name": "dojo.html", "value": 5415.013550700246}, {"lowerIsBetter": false, "replicates": [600.072887388984, 610.3713175429308, 622.7975907829954, 623.0840664223591, 642.9871402571946, 37645.0, 38600.0, 38651.0, 38697.61302386975, 38715.41926871095, 38447.23105537888, 38697.806510967406, 38914.610853891456, 39106.0, 39242.41136382957, 8400.453970491913, 8603.225709686127, 8627.913720862805, 8635.0, 8637.39538232324, 8454.28138608219, 8562.0, 8594.054653988087, 8614.44006139602, 8620.181082797155, 8533.104024077444, 8603.741887743377, 8660.783480413009, 8675.045744968049, 8695.347848911326, 8380.539070351128, 8450.915490845075, 8488.490690558556, 8496.277816385615, 8518.190771876723, 8356.080831108573, 8469.74590762278, 8519.574021298973, 8530.317574594017, 8532.6160322785, 36797.81601091977, 37055.81472092649, 37381.43927841084, 37437.43843842344, 37494.437583435996, 3318.2368055347165, 3338.9499157512655, 3363.445031569788, 3392.6776956189124, 3727.627237276278, 28820.279493012633, 29808.552871706943, 30187.245318866986, 30522.389552209053, 30540.8472957636, 3949.447077409165, 4043.6158564936286, 4098.0, 4098.979505102485, 4258.744475331459, 266133.0, 268543.0, 269060.999999998, 269339.0, 269505.0, 55220.17169742457, 55869.72065139729, 60480.69759651262, 66841.0, 68333.0, 60709.0, 61354.0, 61668.0, 61691.69154154201, 61698.69150654308, 14022.509212177525, 14035.50875719345, 14136.293185340692, 14173.22047287409, 14190.716185676229, 10524.736881578021, 10663.146948244277, 10676.412797296069, 10685.252032357661, 10701.571937122584, 20580.691289630668, 20583.279585214445, 20663.896680516802, 20796.792032079484, 20816.27143050016, 7938.563379014095, 8199.836003279901, 8229.0, 8260.752177434686, 8272.545010024507, 897.304588943574, 903.5978989349808, 984.3798407003542, 1057.2335057083553, 1064.1912146768511, 27493.86253068762, 27558.86220568884, 27735.306617334325, 28183.0, 28283.717162828107, 998.2662742883974, 1017.6387382479113, 1064.8296272596347, 1090.5855774805682, 1135.0295497349812, 14548.49080282185, 14626.488072917396, 14662.413503459955, 14674.0, 14881.627959301104, 384716.0, 387133.0, 387863.0, 389269.0, 390435.0, 53853.461465385626, 54088.45911540913, 54211.999999999214, 54288.72855635775, 54397.72801136048, 1300.0509627971444, 1324.966875828112, 1341.3829638366265, 1342.2617560341969, 1345.179440541269, 26916.327091822863, 27129.321766955985, 27605.861970690017, 27890.163295101178, 27893.581596275668, 43326.0, 43405.78297108494, 43664.781676091414, 43670.781646091564, 43891.0, 289503.0, 293909.5304523464, 295798.0, 296322.0, 297264.0, 32891.0, 45502.91512417369, 46383.304250436944, 46767.0, 46810.531894680615, 43743.56256437395, 43768.56231437772, 44001.55998440103, 44201.0, 44426.333604996595, 36975.630243698295, 37115.8144209288, 41887.581124189586, 41966.16067678568, 42067.7896610515, 36184.81907590445, 36815.63184368122, 37166.814165929, 37483.0, 37705.245895081396, 35646.82176589101, 36072.4589131158, 36313.818430907675, 36597.268054638225, 36687.0, 31224.843875780476, 31902.202444939063, 33566.83216583901, 34195.4870676945, 34249.65750342465, 25205.243842684748, 25304.74695253024, 25446.872765636796, 25494.872525637253, 25960.610590840774], "unit": "score", "name": "ext.html", "value": 18711.478956796112}, {"lowerIsBetter": false, "replicates": [314.0656546773348, 321.31239148222795, 337.9961514302522, 358.8600445826128, 359.8506619752803, 16571.254293556787, 16985.0, 17805.198766055528, 18241.723079384432, 18517.44447666572, 11152.776944461106, 11227.831582526269, 11370.0, 11384.943075284613, 11400.315981041143, 4903.926441103386, 4926.507349265063, 5015.749212539358, 5017.37282839645, 5048.1670524363435, 4992.07646585381, 5008.0, 5033.974830125844, 5037.924431133536, 5039.19372900336, 5025.170846810291, 5028.698278103326, 5450.836474905759, 5605.327360716699, 5629.211910332557, 5537.8061767837935, 5572.3870374258795, 5602.327720673505, 5605.159226116095, 5634.32388113427, 5061.924071138936, 5066.898662026776, 5080.441151473335, 5099.69401835891, 5120.334356533627, 12559.623211303675, 13580.0, 13584.864151358557, 13622.114562553403, 13642.386092625855, 2005.9498512537157, 2112.324056301984, 2157.4067131538795, 2190.912363505458, 2199.3292045925987, 9488.478133702643, 9533.522304042885, 9639.662611808553, 9696.806063878683, 9765.462899540522, 1747.8951262924138, 1800.8199180082017, 1826.8995205263705, 1846.3537761783268, 1881.3791448821855, 61797.6910115451, 64471.0, 64761.352386476006, 65355.01967470539, 65425.0, 10308.072273495422, 10491.370517768959, 10507.684769456928, 10520.894791052144, 10555.261131720707, 13467.528636497676, 13482.191068535723, 13487.0, 13497.98765092622, 13559.796603050961, 7448.702051917862, 7452.925470745223, 7470.103587569418, 7474.439417043744, 7585.355244804143, 7181.676824542908, 7182.138143422718, 7203.207647158808, 7271.527350722186, 7275.054242948383, 4447.421835161408, 4509.774511274423, 4568.88577785558, 4575.908481830411, 4613.8846528836375, 1871.5414723392855, 1920.4814700030913, 1961.8332441742612, 1968.4586738646988, 3119.2357872321427, 863.9179277968583, 901.454619954931, 921.6728061538191, 942.4062840410635, 1013.5793645637126, 16284.10437425953, 16745.16274186286, 16963.491095267163, 17123.315067397412, 17415.36539043233, 874.2437791310471, 901.7249738829589, 1019.4953498018529, 1031.6492392586406, 1046.0951277145214, 9727.951360243154, 9797.951010245046, 9804.705858824247, 9807.852882206773, 10019.699409017741, 570398.0, 575194.0, 576349.0, 581150.0, 582966.0, 77324.0, 79294.0, 82322.0, 82575.0, 83060.58469707613, 1117.3072694929033, 1124.533318672758, 1131.6774719204986, 1158.7798318319492, 1161.0189389965465, 15663.765043524585, 15775.526734197992, 15808.76286855721, 15977.600559985629, 16230.756538652166, 36592.817035915716, 36781.816090919376, 38403.0, 38437.0, 38572.6142738569, 48729.26906096482, 49691.770034947614, 50385.49614503955, 51227.743861280454, 52113.218301724744, 9549.952250238704, 9661.806763864824, 9735.70792876215, 9816.460094694861, 9856.162226210565, 12867.742645147231, 17399.739003915205, 17549.649007019532, 17963.461096167135, 17968.191431385356, 14613.85386146125, 14644.560663180122, 14660.78008829847, 14912.478063267734, 15020.474283400028, 14507.637309067357, 14529.200893950934, 14674.63313417173, 14813.629659258604, 15144.848551514344, 14000.0, 14154.150750954976, 14621.122732636077, 14902.925485372503, 15376.615584610474, 9469.384490008128, 9590.712278631652, 9597.040295970348, 9688.079632434907, 9694.709158725249, 10234.33476824004, 11625.825612615987, 14762.114273143216, 14941.477048303257, 14992.625184370478], "unit": "score", "name": "jquery.html", "value": 8800.477315193692}, {"lowerIsBetter": false, "replicates": [1531.7166324230025, 1704.931802727891, 1758.7186050231962, 1775.8845675031123, 1778.0842865924044, 6595.175603049619, 6784.050232967388, 7181.605011724353, 7296.7446139385065, 7389.519681220717, 7110.43116550676, 7235.059442272497, 7276.781696549112, 7309.159446663635, 7335.083114610674, 2220.62249417599, 2249.6850440938283, 2274.3631783100677, 2275.6814046033487, 2279.8290128240365, 2260.062074239189, 2269.6595510673365, 2336.3458231695154, 2336.4509340305017, 2340.1926335414255, 2263.581237471065, 2270.738865030526, 2282.7488976212603, 2285.90856365746, 2287.3824067501846, 2212.7012853264764, 2232.743234528034, 2244.5286489837154, 2255.391044418014, 2260.028187879211, 2272.579572779041, 2293.4266433391654, 2293.5068960173644, 2294.575503531852, 2296.724393072842, 7471.439642026816, 7476.887846682304, 7527.736529221451, 7541.0, 7543.886841697379, 4496.685232033759, 4555.157295900269, 4570.7029043112425, 4576.496585375606, 4580.7938642761155, 2990.2823322402683, 2994.850257487117, 3063.6170478690165, 3079.337942342385, 3096.8606412711256, 971.489967766928, 981.043482604455, 1006.2654262388425, 1017.4709151241387, 1019.8674172357546, 9762.170215531689, 9814.803703925953, 9847.409155450696, 9914.355566888129, 9923.503824808802, 4043.353063509824, 4085.8978525536504, 4095.3242714952294, 4155.667546596265, 4177.665786737054, 8527.829443411098, 8552.657893684183, 8554.486730796172, 8563.700270490503, 8609.870851937227, 4504.166729155117, 4506.459224892968, 4520.638348932078, 4522.88692782683, 4530.592246697813, 3742.66316031553, 3831.731778775459, 4107.979460102681, 4119.711620186558, 4142.730722503027, 3586.9820650896577, 3596.946045809315, 3597.37046016946, 3604.062943634621, 3638.3450978824067, 1179.8525184351956, 1186.691460220349, 1192.2488832035763, 1195.9581414650445, 1204.8614409342863, 1327.734453109382, 1328.0371730495312, 1342.664333916521, 1342.90599658023, 1351.7904724767677, 6904.827379315558, 7090.92909070913, 7137.0, 7148.320909513588, 7164.391026762679, 1102.3771569063454, 1117.0, 1119.764849381639, 1129.4804389980536, 1153.140910022039, 5553.527950124285, 5605.103183490622, 5621.18492818539, 5629.211910332557, 5637.323521177403, 8683.305335573139, 8698.695545655872, 8956.507392093497, 8962.641494340283, 8977.775555611031, 8792.47245165292, 8795.208431241092, 8809.471431714117, 8809.823803523894, 8818.559072046372, 6844.041834143224, 6918.827029324307, 6981.825454363681, 7035.155781306276, 7084.43324534036, 6827.829304267234, 6864.073350097673, 6881.277465866212, 6882.414994725505, 6886.10480637514, 7638.961805190938, 7945.920540794518, 7975.601219939096, 8052.396070294634, 8179.79550511242, 7965.402594805297, 8205.302549283379, 8240.175982401712, 8256.298214651582, 8258.42191046645, 6518.282988871315, 6847.486438517031, 6857.451403887777, 6857.691403886737, 6867.278935711678, 7302.853942921218, 7325.084364454443, 7341.632918353954, 7341.816454588678, 7344.339009489172, 6666.699998499982, 6869.965650171717, 6875.3812156906115, 6939.410150137295, 6977.511574189961, 6792.898106528505, 6845.0, 6876.106106206161, 6890.0, 6919.37725604698, 6690.799276021728, 6769.187697476137, 6779.983002549657, 6812.352826481477, 6818.249992500921, 6208.565400421927, 6259.718312676032, 6282.371762823681, 6286.65423401699, 6302.306746257999, 6326.177596912372, 6365.77719779824, 6389.456896163878, 6397.104405383157, 6407.199100112486], "unit": "score", "name": "mootools.html", "value": 4393.344722154742}, {"lowerIsBetter": false, "replicates": [329.823544403744, 338.10402433551087, 343.52421895674485, 343.5568117128904, 349.3781069695942, 6366.777162799292, 6386.8403289917715, 6413.583117097392, 6437.678116094194, 6537.0, 6309.684515774205, 6314.431701146896, 6327.683615819202, 6340.080688300193, 6363.586366886149, 4779.545943135397, 4780.90438191236, 4781.880452988686, 4786.497417771127, 4788.449328327235, 4765.952340476586, 4786.042791441708, 4790.736509491977, 4793.2810078488155, 4793.945332026949, 4637.350770892078, 4714.481407045222, 4725.362076119732, 4736.100140973222, 4740.928886066712, 4707.529247075282, 4708.128996135726, 4725.503822098682, 4730.148573256813, 4758.405199350082, 4104.794760261975, 4119.855805046839, 4121.711480196387, 4125.319322311815, 4128.318827393477, 6023.488003519706, 6056.3338032816355, 6057.969710151421, 6064.423879731418, 6066.514678825683, 5452.482014208644, 5539.279893613845, 5562.16567514872, 5575.303087114111, 5591.30108736408, 6711.0, 6720.462363010996, 6721.731130754764, 6728.798136055926, 6731.495137864631, 4586.701864378838, 4590.242609969351, 4591.6556258280425, 4604.6776725629215, 4606.401167848192, 6731.798046058626, 6887.931120688779, 6928.757493487754, 6935.3411425914455, 6994.0, 4651.488336283006, 4662.7668616569035, 4675.13510000651, 4675.205215113371, 4684.578387945101, 4705.529447055335, 4708.976455117702, 4714.104320179155, 4721.055788842245, 4735.21868891629, 5504.119340905436, 5511.118221084607, 5528.889422211533, 5537.141743029837, 5543.307086614173, 6632.801015969529, 6741.966290168518, 6743.797686069426, 6767.578808450182, 6775.254721980578, 1623.6509150532456, 1653.4791540664653, 1665.691847008283, 1666.983330166707, 1669.1487341455702, 1060.5863713151723, 1099.142668718401, 1112.7718817642365, 1113.6714669172452, 1122.320995797547, 6423.678816059179, 6427.58220715652, 6437.0988061671405, 6442.710078046499, 6447.065175549519, 6809.897851532231, 6861.691223894937, 6867.141607299088, 6881.483888708367, 6892.620905850126, 6339.651319177489, 6371.52213583983, 6403.711832967528, 6413.647249401234, 6434.227892652912, 3781.205946751158, 3805.0867791729784, 3808.619138086169, 3808.8286027128847, 3812.8284227209842, 7145.1425828900865, 7167.211606723256, 7190.0, 7195.856082878313, 7227.951946967661, 7095.645217739196, 7177.282271772885, 7224.13310402755, 7247.9637601811655, 7269.6728647211, 7195.280471952763, 7202.3517883389695, 7209.747658831916, 7215.422766178693, 7222.566646001152, 7015.123109611299, 7057.717691292496, 7061.082059332254, 7062.0, 7074.434045276468, 6804.795856124324, 6976.337247961435, 6977.058097157022, 6982.301769822977, 6984.0, 7173.677184526605, 7186.856262874818, 7193.640317983975, 7197.71209151628, 7201.747938822116, 4583.060472603175, 4605.756445759559, 4610.446746390455, 4633.698809577501, 4635.212013957703, 6706.195256569243, 6890.758823441155, 6909.412699920563, 7024.227334993045, 7051.858962820817, 6669.966650166718, 6817.931820681928, 6818.590884546943, 6828.556143850634, 6869.175698915962, 6793.320667933365, 6808.319168083152, 6814.488913331421, 6819.5908245505425, 6823.351781580742, 6520.380563846427, 6663.733450661919, 6664.466842652673, 6664.900026499703, 6667.8666426670225, 6787.185537735503, 6838.692258848264, 6843.555168914005, 6846.760363387258, 6850.417714494324, 6617.636030018395, 6637.767678131242, 6641.169853768279, 6658.1344425224415, 6667.0], "unit": "score", "name": "prototype.html", "value": 5041.747095477141}, {"lowerIsBetter": false, "replicates": [652.3476523476523, 680.3570625758658, 737.9372753315968, 771.8533478639055, 809.6720828064632, 13941.721165576682, 14024.228667423287, 14035.087719298239, 14036.578902632911, 14121.929390353047, 13373.197608143519, 13512.324383780797, 13527.594172174826, 13531.255780932044, 13561.25413102279, 826.8470332988417, 832.4880198677815, 847.1782371100023, 847.8855354527121, 848.0247715127591, 838.2958315015386, 852.5609311204735, 856.0583358305876, 856.1010938514565, 860.5181098584782, 878.8110556230409, 897.0267260022883, 897.2328658996562, 898.2454738020061, 901.1079031758545, 885.5616469847434, 886.2245535156737, 886.4636894678691, 886.8669699545055, 888.5512816027897, 645.0, 648.2998361769278, 651.8728847874667, 653.0954627840475, 655.4232275597444, 13509.459621615124, 13589.116707414085, 13625.0, 13631.591052268448, 13660.316984150852, 11770.117241206945, 12017.63947081589, 12286.815697764541, 12310.199837010656, 12572.874271257262, 9611.423314601147, 9708.0, 9709.077637624414, 9825.90174098257, 10201.744956376077, 3566.4293713005795, 3591.7844929304324, 3602.441621548664, 3653.1232504199065, 3720.0513868963512, 48165.27752083722, 48266.7586662068, 48379.75810120962, 48695.756521217525, 48806.339524535804, 8799.824003519894, 9301.34890557668, 9342.95328523353, 9345.859812102824, 9486.857697134548, 17140.742888856676, 17298.394556190724, 17312.701547383997, 17327.91336043312, 17362.13189340553, 7222.09723784527, 7239.529430586995, 7290.088738907637, 7436.553806771502, 7505.099388073466, 4025.1748391579654, 4033.878983630496, 4042.6159514846045, 4058.2086493133556, 4071.77846646005, 3082.352705931735, 3110.331278775074, 3115.8909438169553, 3118.6881311868633, 3128.124125244935, 539.54947618738, 552.7070652554153, 554.1659801998047, 555.9722013899288, 567.3305499510535, 497.19702680171264, 619.8729260501586, 658.9703463344161, 659.7921654678761, 728.0971595221993, 8108.351331893435, 8148.307393871469, 8175.0, 8180.9590952044855, 8398.412111152284, 636.9713362898681, 675.2167485716545, 678.1895634716565, 695.7043256615918, 703.8944158376182, 3862.304785138646, 4131.173765246963, 4169.038062763254, 4181.226473102486, 4184.602462766033, 56294.437055629736, 56646.716766415906, 57151.714241428526, 57159.0, 57287.713561432756, 50118.74940625347, 51771.48228517742, 52178.0, 52295.0, 52296.0, 47159.764201178776, 47163.76418117956, 47704.76147619309, 47808.0, 49741.502584973685, 7999.800004999922, 8224.42586643784, 8264.0, 8353.634890172856, 8420.0, 36092.0, 36299.63700362963, 36303.0, 36621.450678240384, 36823.44764828583, 40384.0, 44333.0, 45756.542434575225, 45869.0, 46736.29895551637, 10831.0, 10837.729056773644, 11015.559377625126, 11156.49795759209, 11218.270812397168, 11821.645350639494, 11962.760744784882, 12092.879071209176, 12261.080418968791, 12662.176958497668, 11082.279651822606, 11127.276727012719, 11270.549178032787, 11426.828597570877, 11641.152197984913, 10613.198171337583, 10676.946615267185, 10738.677839664822, 10804.67585972422, 11607.245529040585, 10093.949530252301, 10200.489975501047, 10664.626738064131, 10690.0, 11021.44892755375, 9602.183814375856, 9630.181434577858, 9735.367201131903, 9753.268504862022, 10247.538860751432, 9301.581428835583, 9354.29842761782, 9451.716448506555, 9724.0, 9923.40459572428], "unit": "score", "name": "yui.html", "value": 6281.517851303241}], "name": "dromaeo_css", "value": 7062.342743014819}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 114.0, 111.0, 125.0, 111.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 153.0, 159.0, 128.0, 149.0, 159.0, 126.0, 168.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 165.0, 162.0, 161.0, 160.0, 164.0, 167.0, 165.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 71.0, 71.0, 72.0, 132.0, 72.0, 72.0, 75.0], "unit": "score", "name": "audio-fft", "value": 78.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 146.0, 94.0, 95.0, 93.0, 135.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 59.0, 62.0, 60.0, 59.0, 59.0, 60.0, 58.0, 56.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 87.0, 86.0, 87.0, 85.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 123.0, 117.0, 127.0, 125.0, 118.0, 128.0, 126.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [150.0, 156.0, 141.0, 147.0, 141.0, 141.0, 153.0, 147.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 71.0, 70.0, 67.0, 70.0, 66.0, 69.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1512.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [188.00526414739613], "unit": "score", "name": "DeltaBlue", "value": 351.68164199999995}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [750.7507507507507], "unit": "score", "name": "Earley", "value": 887.7287159999997}, {"lowerIsBetter": false, "replicates": [11916.666666666666], "unit": "score", "name": "Boyer", "value": 55.926965034964994}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [681.0176125244618], "unit": "score", "name": "Splay", "value": 119.66063505747125}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21060.565798077932}]} 08:25:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21060.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1512.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7062.34"}}} 08:25:18 INFO - Return code: 0 08:25:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:18 INFO - # TBPL SUCCESS # 08:25:18 INFO - Running post-action listener: _resource_record_post_action 08:25:18 INFO - Running post-run listener: _resource_record_post_run 08:25:19 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 12288; Write bytes: 477462528; Read time: 220; Write time: 449164 08:25:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99872768; Read time: 0; Write time: 123452 08:25:19 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 12288; Write bytes: 317546496; Read time: 220; Write time: 215640 08:25:19 INFO - Running post-run listener: _upload_blobber_files 08:25:19 INFO - Blob upload gear active. 08:25:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:25:19 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 08:25:19 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'] 08:25:19 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 08:25:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:21 INFO - (blobuploader) - INFO - Done attempting. 08:25:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:25:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:25:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:22 INFO - (blobuploader) - INFO - Done attempting. 08:25:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:22 INFO - Return code: 0 08:25:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:25:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c502b2f30d9610f71696468fdff8a752abdf912f6cc8e56ec972e89eb854eeff09a9e9fcd6fe08767f9d1cc96f5892846b5a6f0a2804c70f64bec6beeb04d012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/264e34930295817f9c167af9c8a72219574483e4a642677c0d1ebf51de1e9ea728f3c1187abdd1fd1f86252d515c695733cf92f11a5710bcb2a3779321d4c19f"} 08:25:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:25:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:25:22 INFO - Contents: 08:25:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c502b2f30d9610f71696468fdff8a752abdf912f6cc8e56ec972e89eb854eeff09a9e9fcd6fe08767f9d1cc96f5892846b5a6f0a2804c70f64bec6beeb04d012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/264e34930295817f9c167af9c8a72219574483e4a642677c0d1ebf51de1e9ea728f3c1187abdd1fd1f86252d515c695733cf92f11a5710bcb2a3779321d4c19f"} 08:25:22 INFO - Copying logs to upload dir... 08:25:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1290.028561 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-22 08:25:21.936611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:21.941822) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 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/c502b2f30d9610f71696468fdff8a752abdf912f6cc8e56ec972e89eb854eeff09a9e9fcd6fe08767f9d1cc96f5892846b5a6f0a2804c70f64bec6beeb04d012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/264e34930295817f9c167af9c8a72219574483e4a642677c0d1ebf51de1e9ea728f3c1187abdd1fd1f86252d515c695733cf92f11a5710bcb2a3779321d4c19f"} build_url:https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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/c502b2f30d9610f71696468fdff8a752abdf912f6cc8e56ec972e89eb854eeff09a9e9fcd6fe08767f9d1cc96f5892846b5a6f0a2804c70f64bec6beeb04d012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/264e34930295817f9c167af9c8a72219574483e4a642677c0d1ebf51de1e9ea728f3c1187abdd1fd1f86252d515c695733cf92f11a5710bcb2a3779321d4c19f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:21.965368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:21.965667) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450798611.301674-2085724065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:22.048093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 08:25:22.048399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 08:25:22.048697) ========= ========= Total master_lag: 0.23 =========